builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1481643897.06 results: success (0) buildid: 20161213065402 builduid: 8d2b213e83244a0ba9816bb3dc0c8db2 revision: fee42adb860ed03be0de7dcb91cbfd2efcd8c01e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 07:44:57.060855) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-13 07:44:57.061341) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 07:44:57.061644) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-13 07:44:57.076591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 07:44:57.076924) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-13 07:44:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-12-13 07:44:57 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080752 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 07:44:57.171808) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 07:44:57.172136) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016630 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 07:44:57.221248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 07:44:57.221603) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fee42adb860ed03be0de7dcb91cbfd2efcd8c01e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fee42adb860ed03be0de7dcb91cbfd2efcd8c01e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-13 07:44:57,687 truncating revision to first 12 chars 2016-12-13 07:44:57,687 Setting DEBUG logging. 2016-12-13 07:44:57,687 attempt 1/10 2016-12-13 07:44:57,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fee42adb860e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-13 07:44:58,050 unpacking tar archive at: mozilla-central-fee42adb860e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660487 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 07:44:57.895971) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 07:44:57.896295) ========= script_repo_revision: fee42adb860ed03be0de7dcb91cbfd2efcd8c01e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-13 07:44:57.896753) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 07:44:57.897033) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-13 07:44:57.906021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-13 07:44:57.906317) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:44:58 INFO - MultiFileLogger online at 20161213 07:44:58 in /builds/slave/test 07:44:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:44:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:44:58 INFO - {'append_to_log': False, 07:44:58 INFO - 'base_work_dir': '/builds/slave/test', 07:44:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:44:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:44:58 INFO - 'branch': 'Firefox-Non-PGO', 07:44:58 INFO - 'buildbot_json_path': 'buildprops.json', 07:44:58 INFO - 'config_files': ('talos/linux_config.py',), 07:44:58 INFO - 'default_actions': ('clobber', 07:44:58 INFO - 'read-buildbot-config', 07:44:58 INFO - 'download-and-extract', 07:44:58 INFO - 'populate-webroot', 07:44:58 INFO - 'create-virtualenv', 07:44:58 INFO - 'install', 07:44:58 INFO - 'run-tests'), 07:44:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:44:58 INFO - 'download_minidump_stackwalk': True, 07:44:58 INFO - 'download_symbols': 'ondemand', 07:44:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:44:58 INFO - 'tooltool.py': '/tools/tooltool.py', 07:44:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:44:58 INFO - '/tools/misc-python/virtualenv.py')}, 07:44:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:44:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:44:58 INFO - 'installer_path': 'installer.exe', 07:44:58 INFO - 'log_level': 'info', 07:44:58 INFO - 'log_name': 'talos', 07:44:58 INFO - 'log_to_console': True, 07:44:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:44:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:44:58 INFO - 'opt_config_files': (), 07:44:58 INFO - 'pip_index': False, 07:44:58 INFO - 'sps_profile': False, 07:44:58 INFO - 'sps_profile_interval': 0, 07:44:58 INFO - 'suite': 'dromaeojs', 07:44:58 INFO - 'system_bits': '32', 07:44:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:44:58 INFO - 'title': 'talos-linux64-ix-051', 07:44:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:44:58 INFO - 'use_talos_json': True, 07:44:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:44:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:44:58 INFO - 'work_dir': 'build'} 07:44:58 INFO - [mozharness: 2016-12-13 15:44:58.465059Z] Running clobber step. 07:44:58 INFO - Running pre-action listener: _resource_record_pre_action 07:44:58 INFO - Running main action method: clobber 07:44:58 INFO - rmtree: /builds/slave/test/build 07:44:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:44:58 INFO - Running post-action listener: _resource_record_post_action 07:44:58 INFO - [mozharness: 2016-12-13 15:44:58.924293Z] Finished clobber step (success) 07:44:58 INFO - [mozharness: 2016-12-13 15:44:58.924393Z] Running read-buildbot-config step. 07:44:58 INFO - Running pre-action listener: _resource_record_pre_action 07:44:58 INFO - Running main action method: read_buildbot_config 07:44:58 INFO - Using buildbot properties: 07:44:58 INFO - { 07:44:58 INFO - "project": "", 07:44:58 INFO - "product": "firefox", 07:44:58 INFO - "script_repo_revision": "production", 07:44:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:44:58 INFO - "repository": "", 07:44:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:44:58 INFO - "buildid": "20161213065402", 07:44:58 INFO - "pgo_build": "False", 07:44:58 INFO - "basedir": "/builds/slave/test", 07:44:58 INFO - "buildnumber": 338, 07:44:58 INFO - "slavename": "talos-linux64-ix-051", 07:44:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:44:58 INFO - "platform": "ubuntu64_hw", 07:44:58 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:44:58 INFO - "branch": "mozilla-central", 07:44:58 INFO - "repo_path": "mozilla-central", 07:44:58 INFO - "revision": "fee42adb860ed03be0de7dcb91cbfd2efcd8c01e", 07:44:58 INFO - "stage_platform": "linux64", 07:44:58 INFO - "builduid": "8d2b213e83244a0ba9816bb3dc0c8db2", 07:44:58 INFO - "slavebuilddir": "test" 07:44:58 INFO - } 07:44:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:44:58 INFO - Running post-action listener: _resource_record_post_action 07:44:58 INFO - [mozharness: 2016-12-13 15:44:58.926832Z] Finished read-buildbot-config step (success) 07:44:58 INFO - [mozharness: 2016-12-13 15:44:58.926920Z] Running download-and-extract step. 07:44:58 INFO - Running pre-action listener: _resource_record_pre_action 07:44:58 INFO - Running main action method: download_and_extract 07:44:58 INFO - mkdir: /builds/slave/test/build/tests 07:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:44:58 INFO - trying https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:44:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:44:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:44:59 INFO - Downloaded 1361 bytes. 07:44:59 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:44:59 INFO - Using the following test package requirements: 07:44:59 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:44:59 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:44:59 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:44:59 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:59 INFO - u'jsshell-linux-x86_64.zip'], 07:44:59 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:44:59 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:44:59 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:44:59 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:44:59 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:44:59 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:44:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:44:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:44:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:44:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:44:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:45:00 INFO - Expected file size: 20211218 07:45:00 INFO - Obtained file size: 20211218 07:45:04 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:45:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:45:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:45:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:45:05 INFO - Expected file size: 20211218 07:45:05 INFO - Obtained file size: 20211218 07:45:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:45:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:45:09 INFO - Fetch https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:45:10 INFO - Expected file size: 14409734 07:45:10 INFO - Obtained file size: 14409734 07:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:11 INFO - trying https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:45:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:45:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:45:13 INFO - Downloaded 55771774 bytes. 07:45:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:45:13 INFO - mkdir: /builds/slave/test/properties 07:45:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:45:13 INFO - Writing to file /builds/slave/test/properties/build_url 07:45:13 INFO - Contents: 07:45:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:45:14 INFO - Running post-action listener: _resource_record_post_action 07:45:14 INFO - Running post-action listener: set_extra_try_arguments 07:45:14 INFO - [mozharness: 2016-12-13 15:45:14.191398Z] Finished download-and-extract step (success) 07:45:14 INFO - [mozharness: 2016-12-13 15:45:14.191622Z] Running populate-webroot step. 07:45:14 INFO - Running pre-action listener: _resource_record_pre_action 07:45:14 INFO - Running main action method: populate_webroot 07:45:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:45:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:45:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:45:14 INFO - '--tppagecycles', 07:45:14 INFO - '7'], 07:45:14 INFO - 'tests': ['tsvgm']}}, 07:45:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:45:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:45:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:45:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:45:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:45:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:45:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:45:14 INFO - 'talos_options': ['--disable-e10s'], 07:45:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:45:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:45:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:45:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:45:14 INFO - 'talos_options': ['--disable-e10s'], 07:45:14 INFO - 'tests': ['damp', 'tps']}, 07:45:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:45:14 INFO - 'tests': ['damp', 'tps']}, 07:45:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:45:14 INFO - 'tests': ['dromaeo_dom']}, 07:45:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:45:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:45:14 INFO - 'tests': ['basic_compositor_video']}, 07:45:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:45:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:45:14 INFO - 'tests': ['a11yr', 07:45:14 INFO - 'ts_paint', 07:45:14 INFO - 'tpaint', 07:45:14 INFO - 'sessionrestore', 07:45:14 INFO - 'sessionrestore_no_auto_restore', 07:45:14 INFO - 'tabpaint']}, 07:45:14 INFO - 'other-e10s': {'tests': ['a11yr', 07:45:14 INFO - 'ts_paint', 07:45:14 INFO - 'tpaint', 07:45:14 INFO - 'sessionrestore', 07:45:14 INFO - 'sessionrestore_no_auto_restore', 07:45:14 INFO - 'tabpaint']}, 07:45:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:45:14 INFO - 'ts_paint', 07:45:14 INFO - 'tpaint', 07:45:14 INFO - 'sessionrestore', 07:45:14 INFO - 'sessionrestore_no_auto_restore', 07:45:14 INFO - 'tabpaint']}, 07:45:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:45:14 INFO - 'ts_paint', 07:45:14 INFO - 'tpaint', 07:45:14 INFO - 'sessionrestore', 07:45:14 INFO - 'sessionrestore_no_auto_restore', 07:45:14 INFO - 'tabpaint']}, 07:45:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:45:14 INFO - 'tests': ['a11yr', 07:45:14 INFO - 'ts_paint', 07:45:14 INFO - 'tpaint', 07:45:14 INFO - 'sessionrestore', 07:45:14 INFO - 'sessionrestore_no_auto_restore', 07:45:14 INFO - 'tabpaint']}, 07:45:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:45:14 INFO - 'tests': ['a11yr', 07:45:14 INFO - 'ts_paint', 07:45:14 INFO - 'tpaint', 07:45:14 INFO - 'sessionrestore', 07:45:14 INFO - 'sessionrestore_no_auto_restore', 07:45:14 INFO - 'tabpaint']}, 07:45:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:45:14 INFO - 'tests': ['tsvgx', 07:45:14 INFO - 'tsvgr_opacity', 07:45:14 INFO - 'tart', 07:45:14 INFO - 'tscrollx', 07:45:14 INFO - 'cart', 07:45:14 INFO - 'tsvg_static']}, 07:45:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:45:14 INFO - 'tsvgr_opacity', 07:45:14 INFO - 'tart', 07:45:14 INFO - 'tscrollx', 07:45:14 INFO - 'cart', 07:45:14 INFO - 'tsvg_static']}, 07:45:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:45:14 INFO - 'talos_options': ['--disable-e10s'], 07:45:14 INFO - 'tests': ['tp5o']}, 07:45:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:45:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:45:14 INFO - 'talos_options': ['--disable-e10s', 07:45:14 INFO - '--xperf_path', 07:45:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:45:14 INFO - 'tests': ['tp5n']}, 07:45:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:45:14 INFO - 'talos_options': ['--xperf_path', 07:45:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:45:14 INFO - 'tests': ['tp5n']}}, 07:45:14 INFO - 'talos.zip': {'path': '', 07:45:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:45:14 INFO - Running post-action listener: _resource_record_post_action 07:45:14 INFO - [mozharness: 2016-12-13 15:45:14.212966Z] Finished populate-webroot step (success) 07:45:14 INFO - [mozharness: 2016-12-13 15:45:14.213054Z] Running create-virtualenv step. 07:45:14 INFO - Running pre-action listener: _resource_record_pre_action 07:45:14 INFO - Running main action method: create_virtualenv 07:45:14 INFO - Creating virtualenv /builds/slave/test/build/venv 07:45:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:45:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:45:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:45:14 INFO - Using real prefix '/usr' 07:45:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:45:14 INFO - Installing distribute.............................................................................................................................................................................................done. 07:45:16 INFO - Installing pip.................done. 07:45:16 INFO - Return code: 0 07:45:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:45:16 INFO - Reading from file tmpfile_stdout 07:45:16 INFO - Output received: 07:45:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:45:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8980e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d4f20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:45:17 INFO - Using env: {'DISPLAY': ':0', 07:45:17 INFO - 'HOME': '/home/cltbld', 07:45:17 INFO - 'LANG': 'en_US.UTF-8', 07:45:17 INFO - 'LANGUAGE': 'en_US:en', 07:45:17 INFO - 'LOGNAME': 'cltbld', 07:45:17 INFO - 'MAIL': '/var/mail/cltbld', 07:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:17 INFO - 'MOZ_NO_REMOTE': '1', 07:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:17 INFO - 'NO_EM_RESTART': '1', 07:45:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:17 INFO - 'PWD': '/builds/slave/test', 07:45:17 INFO - 'SHELL': '/bin/bash', 07:45:17 INFO - 'SHLVL': '1', 07:45:17 INFO - 'TERM': 'linux', 07:45:17 INFO - 'TMOUT': '86400', 07:45:17 INFO - 'USER': 'cltbld', 07:45:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 07:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:17 INFO - '_': '/tools/buildbot/bin/python'} 07:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:45:17 INFO - Cleaning up... 07:45:17 INFO - Return code: 0 07:45:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8980e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d4f20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:45:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:45:17 INFO - Using env: {'DISPLAY': ':0', 07:45:17 INFO - 'HOME': '/home/cltbld', 07:45:17 INFO - 'LANG': 'en_US.UTF-8', 07:45:17 INFO - 'LANGUAGE': 'en_US:en', 07:45:17 INFO - 'LOGNAME': 'cltbld', 07:45:17 INFO - 'MAIL': '/var/mail/cltbld', 07:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:17 INFO - 'MOZ_NO_REMOTE': '1', 07:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:17 INFO - 'NO_EM_RESTART': '1', 07:45:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:17 INFO - 'PWD': '/builds/slave/test', 07:45:17 INFO - 'SHELL': '/bin/bash', 07:45:17 INFO - 'SHLVL': '1', 07:45:17 INFO - 'TERM': 'linux', 07:45:17 INFO - 'TMOUT': '86400', 07:45:17 INFO - 'USER': 'cltbld', 07:45:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 07:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:17 INFO - '_': '/tools/buildbot/bin/python'} 07:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:17 INFO - Downloading/unpacking psutil>=3.1.1 07:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:45:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:45:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:45:19 INFO - Installing collected packages: psutil 07:45:19 INFO - Running setup.py install for psutil 07:45:19 INFO - building 'psutil._psutil_linux' extension 07:45:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:45:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:45:19 INFO - building 'psutil._psutil_posix' extension 07:45:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:45:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:45:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:45:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:45:20 INFO - Successfully installed psutil 07:45:20 INFO - Cleaning up... 07:45:20 INFO - Return code: 0 07:45:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8980e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d4f20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:45:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:45:20 INFO - Using env: {'DISPLAY': ':0', 07:45:20 INFO - 'HOME': '/home/cltbld', 07:45:20 INFO - 'LANG': 'en_US.UTF-8', 07:45:20 INFO - 'LANGUAGE': 'en_US:en', 07:45:20 INFO - 'LOGNAME': 'cltbld', 07:45:20 INFO - 'MAIL': '/var/mail/cltbld', 07:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:20 INFO - 'MOZ_NO_REMOTE': '1', 07:45:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:20 INFO - 'NO_EM_RESTART': '1', 07:45:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:20 INFO - 'PWD': '/builds/slave/test', 07:45:20 INFO - 'SHELL': '/bin/bash', 07:45:20 INFO - 'SHLVL': '1', 07:45:20 INFO - 'TERM': 'linux', 07:45:20 INFO - 'TMOUT': '86400', 07:45:20 INFO - 'USER': 'cltbld', 07:45:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 07:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:20 INFO - '_': '/tools/buildbot/bin/python'} 07:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:45:22 INFO - Installing collected packages: mozsystemmonitor 07:45:22 INFO - Running setup.py install for mozsystemmonitor 07:45:22 INFO - Successfully installed mozsystemmonitor 07:45:22 INFO - Cleaning up... 07:45:22 INFO - Return code: 0 07:45:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8980e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d4f20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:45:22 INFO - Using env: {'DISPLAY': ':0', 07:45:22 INFO - 'HOME': '/home/cltbld', 07:45:22 INFO - 'LANG': 'en_US.UTF-8', 07:45:22 INFO - 'LANGUAGE': 'en_US:en', 07:45:22 INFO - 'LOGNAME': 'cltbld', 07:45:22 INFO - 'MAIL': '/var/mail/cltbld', 07:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:22 INFO - 'MOZ_NO_REMOTE': '1', 07:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:22 INFO - 'NO_EM_RESTART': '1', 07:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:22 INFO - 'PWD': '/builds/slave/test', 07:45:22 INFO - 'SHELL': '/bin/bash', 07:45:22 INFO - 'SHLVL': '1', 07:45:22 INFO - 'TERM': 'linux', 07:45:22 INFO - 'TMOUT': '86400', 07:45:22 INFO - 'USER': 'cltbld', 07:45:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 07:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:22 INFO - '_': '/tools/buildbot/bin/python'} 07:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:22 INFO - Downloading/unpacking jsonschema==2.5.1 07:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:45:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:24 INFO - Downloading functools32-3.2.3-2.tar.gz 07:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:45:25 INFO - warning: no files found matching '*.txt' 07:45:25 INFO - no previously-included directories found matching 'build' 07:45:25 INFO - no previously-included directories found matching 'dist' 07:45:25 INFO - no previously-included directories found matching '.git*' 07:45:25 INFO - Installing collected packages: jsonschema, functools32 07:45:25 INFO - Running setup.py install for functools32 07:45:25 INFO - warning: no files found matching '*.txt' 07:45:25 INFO - no previously-included directories found matching 'build' 07:45:25 INFO - no previously-included directories found matching 'dist' 07:45:25 INFO - no previously-included directories found matching '.git*' 07:45:25 INFO - Successfully installed jsonschema functools32 07:45:25 INFO - Cleaning up... 07:45:25 INFO - Return code: 0 07:45:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8980e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d4f20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:45:25 INFO - Using env: {'DISPLAY': ':0', 07:45:25 INFO - 'HOME': '/home/cltbld', 07:45:25 INFO - 'LANG': 'en_US.UTF-8', 07:45:25 INFO - 'LANGUAGE': 'en_US:en', 07:45:25 INFO - 'LOGNAME': 'cltbld', 07:45:25 INFO - 'MAIL': '/var/mail/cltbld', 07:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:25 INFO - 'MOZ_NO_REMOTE': '1', 07:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:25 INFO - 'NO_EM_RESTART': '1', 07:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:25 INFO - 'PWD': '/builds/slave/test', 07:45:25 INFO - 'SHELL': '/bin/bash', 07:45:25 INFO - 'SHLVL': '1', 07:45:25 INFO - 'TERM': 'linux', 07:45:25 INFO - 'TMOUT': '86400', 07:45:25 INFO - 'USER': 'cltbld', 07:45:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 07:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:25 INFO - '_': '/tools/buildbot/bin/python'} 07:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:45:25 INFO - Cleaning up... 07:45:25 INFO - Return code: 0 07:45:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8980e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d4f20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:45:25 INFO - Using env: {'DISPLAY': ':0', 07:45:25 INFO - 'HOME': '/home/cltbld', 07:45:25 INFO - 'LANG': 'en_US.UTF-8', 07:45:25 INFO - 'LANGUAGE': 'en_US:en', 07:45:25 INFO - 'LOGNAME': 'cltbld', 07:45:25 INFO - 'MAIL': '/var/mail/cltbld', 07:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:25 INFO - 'MOZ_NO_REMOTE': '1', 07:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:25 INFO - 'NO_EM_RESTART': '1', 07:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:25 INFO - 'PWD': '/builds/slave/test', 07:45:25 INFO - 'SHELL': '/bin/bash', 07:45:25 INFO - 'SHLVL': '1', 07:45:25 INFO - 'TERM': 'linux', 07:45:25 INFO - 'TMOUT': '86400', 07:45:25 INFO - 'USER': 'cltbld', 07:45:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 07:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:25 INFO - '_': '/tools/buildbot/bin/python'} 07:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:25 INFO - Downloading/unpacking blobuploader==1.2.4 07:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:27 INFO - Downloading blobuploader-1.2.4.tar.gz 07:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:45:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:45:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:28 INFO - Downloading docopt-0.6.1.tar.gz 07:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:45:28 INFO - Installing collected packages: blobuploader, requests, docopt 07:45:28 INFO - Running setup.py install for blobuploader 07:45:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:45:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:45:28 INFO - Running setup.py install for requests 07:45:29 INFO - Running setup.py install for docopt 07:45:29 INFO - Successfully installed blobuploader requests docopt 07:45:29 INFO - Cleaning up... 07:45:29 INFO - Return code: 0 07:45:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8980e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d4f20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:45:29 INFO - Using env: {'DISPLAY': ':0', 07:45:29 INFO - 'HOME': '/home/cltbld', 07:45:29 INFO - 'LANG': 'en_US.UTF-8', 07:45:29 INFO - 'LANGUAGE': 'en_US:en', 07:45:29 INFO - 'LOGNAME': 'cltbld', 07:45:29 INFO - 'MAIL': '/var/mail/cltbld', 07:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:29 INFO - 'MOZ_NO_REMOTE': '1', 07:45:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:29 INFO - 'NO_EM_RESTART': '1', 07:45:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:29 INFO - 'PWD': '/builds/slave/test', 07:45:29 INFO - 'SHELL': '/bin/bash', 07:45:29 INFO - 'SHLVL': '1', 07:45:29 INFO - 'TERM': 'linux', 07:45:29 INFO - 'TMOUT': '86400', 07:45:29 INFO - 'USER': 'cltbld', 07:45:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 07:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:29 INFO - '_': '/tools/buildbot/bin/python'} 07:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:45:29 INFO - Running setup.py (path:/tmp/pip-BIC9gL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:45:29 INFO - Running setup.py (path:/tmp/pip-qGqzkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:45:29 INFO - Running setup.py (path:/tmp/pip-Poncf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:45:29 INFO - Running setup.py (path:/tmp/pip-456xrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:45:29 INFO - Running setup.py (path:/tmp/pip-A73YNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:45:29 INFO - Running setup.py (path:/tmp/pip-3QGs61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:45:29 INFO - Running setup.py (path:/tmp/pip-PG7703-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:45:29 INFO - Running setup.py (path:/tmp/pip-WrILXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:45:30 INFO - Running setup.py (path:/tmp/pip-nfk2XD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:45:30 INFO - Running setup.py (path:/tmp/pip-5epoEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:45:30 INFO - Running setup.py (path:/tmp/pip-Qdd4Uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:45:30 INFO - Running setup.py (path:/tmp/pip-yEJefa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:45:30 INFO - Running setup.py (path:/tmp/pip-iqQVp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:45:30 INFO - Running setup.py (path:/tmp/pip-H7Kqjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:30 INFO - Running setup.py (path:/tmp/pip-Fap147-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:45:30 INFO - Running setup.py (path:/tmp/pip-XH1TUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:45:30 INFO - Running setup.py (path:/tmp/pip-YP0T7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:45:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:45:30 INFO - Running setup.py install for manifestparser 07:45:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:45:30 INFO - Running setup.py install for mozcrash 07:45:30 INFO - Running setup.py install for mozdebug 07:45:30 INFO - Running setup.py install for mozdevice 07:45:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:45:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:45:31 INFO - Running setup.py install for mozfile 07:45:31 INFO - Running setup.py install for mozhttpd 07:45:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:45:31 INFO - Running setup.py install for mozinfo 07:45:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:45:31 INFO - Running setup.py install for mozInstall 07:45:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:45:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:45:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:45:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:45:31 INFO - Running setup.py install for mozleak 07:45:31 INFO - Running setup.py install for mozlog 07:45:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:45:31 INFO - Running setup.py install for moznetwork 07:45:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:45:31 INFO - Running setup.py install for mozprocess 07:45:31 INFO - Running setup.py install for mozprofile 07:45:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:45:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:45:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:45:32 INFO - Running setup.py install for mozrunner 07:45:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:45:32 INFO - Running setup.py install for mozscreenshot 07:45:32 INFO - Running setup.py install for moztest 07:45:32 INFO - Running setup.py install for mozversion 07:45:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:45:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:45:32 INFO - Cleaning up... 07:45:32 INFO - Return code: 0 07:45:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8980e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d4f20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:45:32 INFO - Using env: {'DISPLAY': ':0', 07:45:32 INFO - 'HOME': '/home/cltbld', 07:45:32 INFO - 'LANG': 'en_US.UTF-8', 07:45:32 INFO - 'LANGUAGE': 'en_US:en', 07:45:32 INFO - 'LOGNAME': 'cltbld', 07:45:32 INFO - 'MAIL': '/var/mail/cltbld', 07:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:32 INFO - 'MOZ_NO_REMOTE': '1', 07:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:32 INFO - 'NO_EM_RESTART': '1', 07:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:32 INFO - 'PWD': '/builds/slave/test', 07:45:32 INFO - 'SHELL': '/bin/bash', 07:45:32 INFO - 'SHLVL': '1', 07:45:32 INFO - 'TERM': 'linux', 07:45:32 INFO - 'TMOUT': '86400', 07:45:32 INFO - 'USER': 'cltbld', 07:45:32 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 07:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:32 INFO - '_': '/tools/buildbot/bin/python'} 07:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:45:32 INFO - Running setup.py (path:/tmp/pip-c7mZNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:45:32 INFO - Running setup.py (path:/tmp/pip-iT4Jbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:45:32 INFO - Running setup.py (path:/tmp/pip-goDYMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:45:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:45:32 INFO - Running setup.py (path:/tmp/pip-u4Q5fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:45:33 INFO - Running setup.py (path:/tmp/pip-sW_2_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:45:33 INFO - Running setup.py (path:/tmp/pip-0ebdrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:45:33 INFO - Running setup.py (path:/tmp/pip-ac147B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:45:33 INFO - Running setup.py (path:/tmp/pip-s58XGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:45:33 INFO - Running setup.py (path:/tmp/pip-OnJc_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:45:33 INFO - Running setup.py (path:/tmp/pip-F13QqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:45:33 INFO - Running setup.py (path:/tmp/pip-NVqj_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:45:33 INFO - Running setup.py (path:/tmp/pip-dfoWtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:45:33 INFO - Running setup.py (path:/tmp/pip-71Kydv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:45:33 INFO - Running setup.py (path:/tmp/pip-lBRAJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:33 INFO - Running setup.py (path:/tmp/pip-4g_8ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:45:33 INFO - Running setup.py (path:/tmp/pip-hqHVqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:45:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:45:33 INFO - Running setup.py (path:/tmp/pip-cCKr0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:45:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:45:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:45:35 INFO - Downloading blessings-1.6.tar.gz 07:45:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:45:36 INFO - Installing collected packages: blessings 07:45:36 INFO - Running setup.py install for blessings 07:45:36 INFO - Successfully installed blessings 07:45:36 INFO - Cleaning up... 07:45:36 INFO - Return code: 0 07:45:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:45:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:45:36 INFO - Reading from file tmpfile_stdout 07:45:36 INFO - Current package versions: 07:45:36 INFO - argparse == 1.2.1 07:45:36 INFO - blessings == 1.6 07:45:36 INFO - blobuploader == 1.2.4 07:45:36 INFO - docopt == 0.6.1 07:45:36 INFO - functools32 == 3.2.3-2 07:45:36 INFO - jsonschema == 2.5.1 07:45:36 INFO - manifestparser == 1.1 07:45:36 INFO - mozInstall == 1.12 07:45:36 INFO - mozcrash == 1.0 07:45:36 INFO - mozdebug == 0.1 07:45:36 INFO - mozdevice == 0.49 07:45:36 INFO - mozfile == 1.2 07:45:36 INFO - mozhttpd == 0.7 07:45:36 INFO - mozinfo == 0.9 07:45:36 INFO - mozleak == 0.1 07:45:36 INFO - mozlog == 3.4 07:45:36 INFO - moznetwork == 0.27 07:45:36 INFO - mozprocess == 0.23 07:45:36 INFO - mozprofile == 0.28 07:45:36 INFO - mozrunner == 6.13 07:45:36 INFO - mozscreenshot == 0.1 07:45:36 INFO - mozsystemmonitor == 0.3 07:45:36 INFO - moztest == 0.7 07:45:36 INFO - mozversion == 1.4 07:45:36 INFO - psutil == 3.1.1 07:45:36 INFO - requests == 1.2.3 07:45:36 INFO - wsgiref == 0.1.2 07:45:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8980e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d4f20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:45:36 INFO - Using env: {'DISPLAY': ':0', 07:45:36 INFO - 'HOME': '/home/cltbld', 07:45:36 INFO - 'LANG': 'en_US.UTF-8', 07:45:36 INFO - 'LANGUAGE': 'en_US:en', 07:45:36 INFO - 'LOGNAME': 'cltbld', 07:45:36 INFO - 'MAIL': '/var/mail/cltbld', 07:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:36 INFO - 'MOZ_NO_REMOTE': '1', 07:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:36 INFO - 'NO_EM_RESTART': '1', 07:45:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:36 INFO - 'PWD': '/builds/slave/test', 07:45:36 INFO - 'SHELL': '/bin/bash', 07:45:36 INFO - 'SHLVL': '1', 07:45:36 INFO - 'TERM': 'linux', 07:45:36 INFO - 'TMOUT': '86400', 07:45:36 INFO - 'USER': 'cltbld', 07:45:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 07:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:36 INFO - '_': '/tools/buildbot/bin/python'} 07:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:45:36 INFO - Cleaning up... 07:45:36 INFO - Return code: 0 07:45:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:45:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b8980e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2844120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d4f20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:45:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:45:36 INFO - Using env: {'DISPLAY': ':0', 07:45:36 INFO - 'HOME': '/home/cltbld', 07:45:36 INFO - 'LANG': 'en_US.UTF-8', 07:45:36 INFO - 'LANGUAGE': 'en_US:en', 07:45:36 INFO - 'LOGNAME': 'cltbld', 07:45:36 INFO - 'MAIL': '/var/mail/cltbld', 07:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:36 INFO - 'MOZ_NO_REMOTE': '1', 07:45:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:36 INFO - 'NO_EM_RESTART': '1', 07:45:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:36 INFO - 'PWD': '/builds/slave/test', 07:45:36 INFO - 'SHELL': '/bin/bash', 07:45:36 INFO - 'SHLVL': '1', 07:45:36 INFO - 'TERM': 'linux', 07:45:36 INFO - 'TMOUT': '86400', 07:45:36 INFO - 'USER': 'cltbld', 07:45:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 07:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:36 INFO - '_': '/tools/buildbot/bin/python'} 07:45:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:45:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:45:36 INFO - Cleaning up... 07:45:36 INFO - Return code: 0 07:45:36 INFO - Running post-action listener: _resource_record_post_action 07:45:36 INFO - Running post-action listener: _start_resource_monitoring 07:45:36 INFO - Starting resource monitoring. 07:45:36 INFO - [mozharness: 2016-12-13 15:45:36.901623Z] Finished create-virtualenv step (success) 07:45:36 INFO - [mozharness: 2016-12-13 15:45:36.902097Z] Running install step. 07:45:36 INFO - Running pre-action listener: _resource_record_pre_action 07:45:36 INFO - Running main action method: install 07:45:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:45:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:45:37 INFO - Reading from file tmpfile_stdout 07:45:37 INFO - Detecting whether we're running mozinstall >=1.0... 07:45:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:45:37 INFO - Reading from file tmpfile_stdout 07:45:37 INFO - Output received: 07:45:37 INFO - Usage: mozinstall [options] installer 07:45:37 INFO - Options: 07:45:37 INFO - -h, --help show this help message and exit 07:45:37 INFO - -d DEST, --destination=DEST 07:45:37 INFO - Directory to install application into. [default: 07:45:37 INFO - "/builds/slave/test"] 07:45:37 INFO - --app=APP Application being installed. [default: firefox] 07:45:37 INFO - mkdir: /builds/slave/test/build/application 07:45:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:45:53 INFO - Reading from file tmpfile_stdout 07:45:53 INFO - Output received: 07:45:53 INFO - /builds/slave/test/build/application/firefox/firefox 07:45:53 INFO - Running post-action listener: _resource_record_post_action 07:45:53 INFO - [mozharness: 2016-12-13 15:45:53.421936Z] Finished install step (success) 07:45:53 INFO - [mozharness: 2016-12-13 15:45:53.422178Z] Running run-tests step. 07:45:53 INFO - Running pre-action listener: _resource_record_pre_action 07:45:53 INFO - Running main action method: run_tests 07:45:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:45:53 INFO - Python 2.7.3 07:45:53 INFO - Return code: 0 07:45:53 INFO - grabbing minidump binary from tooltool 07:45:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28d4f20>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2841c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2841f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:45:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:45:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:45:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:45:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:45:53 INFO - Return code: 0 07:45:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:45:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:45:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:45:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:45:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:45:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:45:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:45:53 INFO - Using env: {'DISPLAY': ':0', 07:45:53 INFO - 'HOME': '/home/cltbld', 07:45:53 INFO - 'LANG': 'en_US.UTF-8', 07:45:53 INFO - 'LANGUAGE': 'en_US:en', 07:45:53 INFO - 'LOGNAME': 'cltbld', 07:45:53 INFO - 'MAIL': '/var/mail/cltbld', 07:45:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:45:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:45:53 INFO - 'MOZ_NO_REMOTE': '1', 07:45:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:45:53 INFO - 'NO_EM_RESTART': '1', 07:45:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:45:53 INFO - 'PWD': '/builds/slave/test', 07:45:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:45:53 INFO - 'SHELL': '/bin/bash', 07:45:53 INFO - 'SHLVL': '1', 07:45:53 INFO - 'TERM': 'linux', 07:45:53 INFO - 'TMOUT': '86400', 07:45:53 INFO - 'USER': 'cltbld', 07:45:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245', 07:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:45:53 INFO - '_': '/tools/buildbot/bin/python'} 07:45:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:45:53 INFO - mozversion application_buildid: 20161213065402 07:45:53 INFO - mozversion application_changeset: fee42adb860ed03be0de7dcb91cbfd2efcd8c01e 07:45:53 INFO - mozversion application_display_name: Nightly 07:45:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:45:53 INFO - mozversion application_name: Firefox 07:45:53 INFO - mozversion application_remotingname: firefox 07:45:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:45:53 INFO - mozversion application_vendor: Mozilla 07:45:53 INFO - mozversion application_version: 53.0a1 07:45:53 INFO - mozversion platform_buildid: 20161213065402 07:45:53 INFO - mozversion platform_changeset: fee42adb860ed03be0de7dcb91cbfd2efcd8c01e 07:45:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:45:53 INFO - mozversion platform_version: 53.0a1 07:45:53 INFO - using testdate: 1481643953 07:45:53 INFO - actual date: 1481643953 07:45:53 INFO - starting webserver on 'localhost:55652' 07:45:53 INFO - SUITE-START | Running 2 tests 07:45:53 INFO - TEST-START | dromaeo_css 07:45:53 INFO - operating with platform_type : linux_ 07:45:53 INFO - Initialising browser for dromaeo_css test... 07:45:53 INFO - TEST-INFO | started process 8809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBRykAp/profile http://localhost:55652/getInfo.html) 07:45:57 INFO - PROCESS | 8809 | __metrics Screen width/height:1600/1200 07:45:57 INFO - PROCESS | 8809 | colorDepth:24 07:45:57 INFO - PROCESS | 8809 | Browser inner width/height: 1024/697 07:45:57 INFO - PROCESS | 8809 | __metrics 07:45:58 INFO - PROCESS | 8809 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:45:58 INFO - PROCESS | 8809 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:45:59 INFO - PROCESS | 8809 | console.error: PushService: 07:45:59 INFO - PROCESS | 8809 | stateChangeProcessEnqueue: Error transitioning state 07:45:59 INFO - PROCESS | 8809 | UnknownError 07:45:59 INFO - TEST-INFO | 8809: exit 0 07:45:59 INFO - Browser initialized. 07:45:59 INFO - Running cycle 1/1 for dromaeo_css test... 07:45:59 INFO - TEST-INFO | started process 8891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBRykAp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:46:12 INFO - PROCESS | 8891 | RSS: Main: 173617152 07:46:12 INFO - PROCESS | 8891 | 07:47:03 INFO - PROCESS | 8891 | 1481644023115 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:49:17 INFO - PROCESS | 8891 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55652/tests/dromaeo/cssquery-ext.html) 07:49:18 INFO - PROCESS | 8891 | RSS: Main: 287084544 07:49:18 INFO - PROCESS | 8891 | 07:52:21 INFO - PROCESS | 8891 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-ext.html (next: http://localhost:55652/tests/dromaeo/cssquery-jquery.html) 07:52:22 INFO - PROCESS | 8891 | RSS: Main: 287993856 07:52:22 INFO - PROCESS | 8891 | 07:55:24 INFO - PROCESS | 8891 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55652/tests/dromaeo/cssquery-mootools.html) 07:55:25 INFO - PROCESS | 8891 | RSS: Main: 280399872 07:55:25 INFO - PROCESS | 8891 | 07:58:27 INFO - PROCESS | 8891 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55652/tests/dromaeo/cssquery-prototype.html) 07:58:28 INFO - PROCESS | 8891 | RSS: Main: 220327936 07:58:28 INFO - PROCESS | 8891 | 08:01:31 INFO - PROCESS | 8891 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55652/tests/dromaeo/cssquery-yui.html) 08:01:32 INFO - PROCESS | 8891 | RSS: Main: 219652096 08:01:32 INFO - PROCESS | 8891 | 08:04:35 INFO - PROCESS | 8891 | Cycle 1(1): loaded http://localhost:55652/tests/dromaeo/cssquery-yui.html (next: http://localhost:55652/tests/dromaeo/cssquery-dojo.html) 08:04:35 INFO - PROCESS | 8891 | RSS: Main: 314560512 08:04:35 INFO - PROCESS | 8891 | 08:04:35 INFO - PROCESS | 8891 | __start_tp_report 08:04:35 INFO - PROCESS | 8891 | _x_x_mozilla_page_load 08:04:35 INFO - PROCESS | 8891 | _x_x_mozilla_page_load_details 08:04:35 INFO - PROCESS | 8891 | |i|pagename|runs| 08:04:35 INFO - PROCESS | 8891 | |0;dojo.html;2592.3648706067015;2609.882555285012;2635.3016450640584;2645.246104860114;2647.4308023774875;4619.86140415788;4637.258038713807;4726.172919739045;4744.312074749164;4746.691465054769;4718.4809670936165;4725.740084295362;4726.810927562902;4734.621230301576;4852.854414367565;4352.695311328208;4366.08312254427;4374.4531933508315;4387.276099443588;4394.274944634131;4360.542143074979;4391.385206071152;4441.311596702516;4485.035717320776;4490.438695163105;4421.07157496926;4428.512863585019;4439.644828413735;4468.75421851798;4487.977560112195;4229.767362795045;4233.428487154226;4237.470316210473;4313.072689371768;4388.89027774305;4264.189803937242;4273.059926816127;4276.957230427687;4279.144171165748;4286.164197981395;4646.4191976003;4649.721016739007;4661.347411362412;4676.625869930397;4680.812767489297;4943.505649435064;5006.424261209971;5007.774650140753;5017.37282839645;5045.520675535819;5131.538161565477;5164.845054648366;5169.405518365398;5172.301739265189;5175.585953123778;4767.42790865095;4767.523247675274;4768.6661933665;4772.379590653262;4814.735189564608;4980.402351717817;5222.086134926372;5222.3472065991755;5223.347081614798;5271.130263506555;4861;4903.705777653352;4941.011797640414;4943.72809495474;4947.678400903929;5018.4981501849525;5021.246812978083;5022.171341728574;5023.547880690682;5027.371578552681;4973.502649734997;4976.0794253063295;4978.303037574742;4981.103401387712;4998.625103117281;4962.8759281018265;4970.403551573834;5004.424491183488;5020.59835213182;5034.924476132861;4405.163019026375;4445.333200020023;4446.510883802844;4447.955520444754;4454.554544545519;3821.9235615288094;3864.1305706215876;3878.9612103879163;3892.591277915835;3921.784301863425;4304.053108316165;4407.294832826732;4412.095520418371;4413.13943780966;4450.532694067077;5047.4447810740785;5097.209932460474;5101.0308041472;5120.718360490208;5133.640645154878;4422.668299877522;4430.047539778963;4433.069055498317;4460.821567137343;4463.419755431773;4653.464851542049;4660.231061874752;4661.906761864744;4662.137504561599;4706.670533062653;4575.954240457553;4603.240465323184;4612.238980568169;4710.811567537397;4762.666613337033;5080.593552515864;5152.330197074356;5152.433232344514;5194.1429664105;5205.713685747169;4754.096721622881;4756.643251756063;4762.119007983534;4767.141914455431;4806.47128815837;4910.091633047898;5084.466131056186;5086.821961231339;5089.13484707608;5136.922946155885;4991.226359914219;5066.645334826674;5078.492150784892;5091.210862316347;5190.351206099238;4998.525140111684;5001.374828146481;5002.2496625506465;5007.5993920487;5008.2738002988635;5005.049040682259;5009.173486374707;5017.172166592617;5019.623528235324;5020.312973948749;4738.8341408050555;4747.548982846624;4750.07373562152;4782.187028205283;4806.423229212517;4969.105560998911;4979.875503112451;4980.452150263541;4995.850124496271;5006.123928312603;4824.372831531879;4841.878953026203;4848.9757551212015;4875.24433712775;4905.3623029006 08:04:35 INFO - PROCESS | 8891 | |1;ext.html;510.68848002718335;525.9447757985413;536.554659632505;537.9435159308271;570.7688386203589;27663;37055.629443705555;38647.227055458876;38674.61325386745;42417.78791106048;39165.41251881224;39311.80344098275;39346.01634959127;39557;39563.802180989056;7424.703011879532;7655.808604784897;7656.923430765704;7659.808504787397;7660.540367577935;7375.631218439084;7578.242175782433;7605;9552.42685438876;9783.19010982967;9797.657082002132;9884.55519501624;9890.15933645641;9892.802143957117;9898.554565044555;9739.659111931083;9793.412395256308;9801.362911410735;9803.166730827888;9807.950960245225;9656.71029869105;9725.221982241404;9730.318877678565;9732.75668108296;9739.659111931049;37035.81482092599;37060.25879482422;37181.256374872624;37226.4416033757;37258.06854828651;2844.843533605651;2866.312085099582;2881.8270903745843;2978.4638765022287;3326.6839650233187;27491.587626185625;27754.167374978784;27770.81423864851;28789.424211515863;28979.56530652042;3293.769436139471;3323.8171900545703;3369.5956485221686;3411.522386865841;3432.828358582086;194650;244826;245585;245704;245752.08495830162;44830.775846121214;45365.54634453679;45421.54578454173;45439.318410223874;45445.318320225226;43878.561214387446;43912.560874391485;43988.3401748974;44035;44253.114937701066;11745.823812642817;12134.453949572115;12139.271643701406;12142.392880355947;12146.271223726604;8491.787705307417;9257.259419246444;9321.254299656011;9334.71995840126;9343.626254949862;12537;14932.25338733059;15282.694346113016;15294.541163765105;15517.922410387875;5936.762529498858;6115.724792384353;6222.968885155636;6343.397377249154;6426.35736426363;714.678394722377;820.6389188756928;836.3351135847016;840.3991146330403;909.0636644256426;25812.612810807852;27179;27214.727852721615;27343.316417089733;27456.176314710592;822.9876551851727;862.2024627219797;903.3405613901889;914.2914241462787;929.5212965322729;13710.931445342909;14171.149731015967;14231.715365692628;14674.853251467563;14755.336009879582;372791;375143;375683;376368;376485;42183.36724949128;42912;46818.5318146821;47157;47212.5278747215;1084.2410312781085;1107.2747350485445;1120.176670147441;1124.4265424633331;1129.5312445335258;26718.59922101131;27820.721792781813;27908.86045569759;28537.714622853506;28891.85554072216;40800.79599601983;40992.385114222714;41402.79298603608;41420.378694319006;41477.1704565913;308884;311294;311946;314087;314738;24201.75798241995;24649;24655.38361540976;24663.63004554969;24668.13661521838;39462.80268598639;39628;40145.59854401419;40241.59758402496;41654.79172604118;34162.65837341595;34283.4857477143;34423.31153376868;34458.48312275368;34884.47673284852;33664.326713466085;34110.829445852614;34142.658573413944;34371.48442773311;35390.11524711903;34097.31805363928;34353.65646343504;34405.139871503416;34483.655163449046;34498.48252276268;29965.70034299629;31007.379852403275;31417.072865891765;31559.684403155676;31564.684353157092;24122.276331710076;24283.39291517726;24378.390540236636;24648.630270546313;24753.62869556922 08:04:35 INFO - PROCESS | 8891 | |2;jquery.html;344.79829299859597;347.2967241336292;361.0684434159867;368.4859620828943;381.875890335641;12418.751624967495;13257.7348453031;13294.46822127115;16157.272922718477;16174.676506469863;15534.766978495332;15693.136877471734;15960.441384551543;15963.281652325644;15993;4916.80332786689;5121.28302037715;5127.820526281581;5130.127878260686;5134.948650513503;3623.9456408153897;3830.4254361845806;5606.074997625407;5851.824445266649;5892.911606325909;5878.5003274721485;5930.466258036776;5938.198343223653;5939.406059394069;5941.316748573904;5855.151003104547;6000.159977603139;6019.939800602026;6025.035994240944;6028.879422411571;5049.091163590552;5201.427842937273;5284.5243928046275;5291.629585928987;5291.920621190685;19593;19715.309964151187;19801.306954256677;19805;19824.306149284705;1734.8438640522413;1816.4823025437686;1831.8809277396927;1875.7186422036668;2492.314613481289;11691.181617286793;12603.117781755282;12750.489980400773;13032.934835325857;13092.970589558634;1662.908540030298;1699.6090899093278;1713.9314427422887;1719.6818588561157;1732.7314266288745;57435.425645743424;59402.40597594055;62421.68789156025;63062;63980.36019639791;8146.551939643258;8410.915890841014;8544.359173062045;8592.613332400057;8790.648374065093;11613.535458581731;11672.70818229551;11674.182807203584;11676.941615292038;11688.064954803594;6156.8768624627255;6468.6442245676;6557.409833115043;6593.72516481813;6596.901046484307;5930.169776231331;6024.126501657235;6081.270247570232;6313.326968353298;6471.449926756184;3673.1368128489785;3693.464447655129;3703.962960370362;3798.3163030654196;3820.6370394812448;1765.5409593505524;1856.1276200185891;1857.7027675571844;1865.0861078071648;1867.8225568570963;773.934215591681;778.2178910195217;787.7400457848896;814.352589691197;872.912708729122;14863.33115009827;15964.600884977735;16006.119663418624;16025.919870400574;16669.583260418585;762.7384804056001;783.7570353190529;790.9564973926374;805.1425232127765;818.2431251092715;7983.880241796378;8347.749567512863;8521.190486903733;8926.821463570692;8952.552372381486;371625;373204;379100;379243;380162;53447;72251.27748722445;73011.63494182494;73578.26421735821;75345;897.8967418746928;899.5637115998735;927.6428574998539;930.7114794413753;933.5612262236738;11090.833637495283;14011.229382384066;14875.851241487446;14930.328135233724;15041.924790375979;33333.49999750054;33706.8314658435;36153;36370.8181459091;38445;45428.545714543754;46508.30237546372;46580.45076893153;48703;48951.75524122357;6857;7298.854022919618;7311.4150867929375;7333.083364579427;7519.548827070394;10181.185505159718;10630.681079567625;11009.229353945148;11228.719282018015;11357.920997505224;4933.988532350932;5077.162268225701;5109.437961824122;5182.844514664566;8577.313814894918;8970.596323165342;9173.954130229573;9516.714498565054;9981;10275.177985761271;8649.394542381973;9197.540122993958;9582.856257156009;9870;10131.037551432602;7024.824379390352;7183.604901730246;7357.337839594248;7428.034355533746;7568.697252109854;9071.365004449624;9301.534923253676;9637.518124093627;9717.951410242904;10138.847917281098 08:04:35 INFO - PROCESS | 8891 | |3;mootools.html;1308.1823860087445;1334.592949150509;1380.7652699041168;1664.11801745075;1677.1362748184679;6269.968650156743;6498.512611554129;6879.828004299895;7282.344588986996;7304.233055529173;6826.283240259776;7069.257727938557;7073.858522829553;7243.637818109087;7247.130344358671;2034.074496104269;2081.927132550361;2088.2899814063217;2088.9895550522224;2094.8219401350902;1793.0944872839264;1853.33280019193;2053.2916143930393;2066.1735305877696;2093.633614117531;1969.773476050251;2042.2647846775149;2046.9078891449847;2048.4878780304925;2060.3509894383296;2047.2118234479758;2069.844761642883;2079.812816846491;2079.9480012999643;2101.4956410461377;2063.4222417723063;2069.927552535654;2106.2101711858054;2107.6627739561595;2111.5037966077957;7231.240719724406;7257.165425976027;7281.417486601059;7281.963590182015;7291.963540182318;4231.936520952188;4383.276759334706;4385.912281754379;4390.319500477431;4394.143142087294;2722.6052222427834;2760.5721113227482;2926.1367896470592;2931.457680329146;2937.0307798426684;903.4443817052531;912.5619702542816;918.3020904112923;941.1670671455811;960.9807803843884;9589.712308630753;9599.808003839884;9604.759881002961;9613.654088427626;9643.662471813454;3889.2804831106337;3952.2293152834923;3954.149857780591;3974.82113304902;4031.9395209071886;8127.146649601825;8141.185881411811;8143.063547691972;8145.470544414594;8154.551499667576;4308.159908817751;4345.8261669533495;4367.912641747147;4384.298512238027;4385.912281754411;3823.388257878726;3885.1258466844733;3989.5212574491247;3998.100427403811;4002.8999275017777;3323.4184017797274;3333.8333083345738;3426.5716785401823;3437.089171369589;3437.845296961643;996.0885789502669;1023.0638965346773;1080.173667144635;1113.9387333696725;1115.9330440173615;600.099850224663;631.6178711879339;638.9265234497999;664.6543797225512;801.9518828870287;4593.908121837545;4788.760561971888;4854.199057155601;4973.875653108701;5052.343195384577;761.8285885675679;790.1742678900563;831.0733532111652;834.4284165346756;836.5148214035967;3129.640091389474;3247.285597168619;3306.437905556061;3347.615024272191;3452.3267962747527;8385.119562445856;8425.115362886809;8534.70128545498;8547.658093676184;8560.48637081777;8485.0666426693;8490.448120872123;8491.660333586711;8492.660293588311;8507.064222935473;6372.458341041063;6684.9331506685285;6687.6321802301345;6802.421794147553;6831.11195544576;4682.976585117052;4738.715677059249;4856.077345304381;4978.975105124451;5083.822066227664;7753.340966017951;7760.3791696663;7816.4137689674635;7908.130105688255;7922.7227047053075;7941.285284324438;8121.553314567519;8124.553149576594;8145.674173033012;8150.388720845842;5688.516476099412;5861.824145275648;5915.733791979285;6060.6969651516365;6064.06007068905;6848.383645471931;6902.792916212522;6918.169819621678;6928.341807528277;6936.965315173594;6223.844403889939;6266.342034086538;6293.685315734287;6301.6219026858535;6459.257185423737;6114.113453549122;6230.283517395557;6263.906041409474;6273.811785646255;6364.299927007933;5622.971885140548;5713;5716.828495145152;5730.598858080061;5736.397678243724;4139.79301034941;4224.662027037891;4267.93598096035;4321.135772845506;4402.845900393599;4130.421740956329;4298.742075475481;4308.590683885026;4355.62977146946;4371 08:04:35 INFO - PROCESS | 8891 | |4;prototype.html;342.9057009322436;343.60142235007396;350.0007478648458;351.73444049742443;352.24443568545456;4878.585320247778;4899.926501102477;4903.509649035094;4915.410150781902;4925.605951523883;4790;4820.252860806572;4860.562549370556;4863.221884498481;4870.172070747973;3635.2547727715755;3748.850045998157;3769.6230376962358;3826.7180494534364;3840.2319536092755;3852.9614703852885;3855.4602355670227;3857.3635350167187;3873.786941718204;3889.9611003890022;3816.9045773855737;3839.462475253467;3845.5962123977;3868.4390763339297;3869.032741814546;3612.4761909523104;3727.04960235141;3750.624937506255;3849.2301539692035;3863.690904727615;3424.4007298722872;3430.691237788586;3431.2965842002577;3434.278801451673;3435.381631306364;4725.76371181443;4735.57932620216;4739.957209413923;4743.928841067387;4747.074320507502;4268.615824575772;4412.286443837049;4414.293713005904;4424.40270563473;4426.84506042287;5044.872179248852;5056.570191533724;5060.2662613920775;5102.260172275;5115.948840511622;3705.94441083384;3729.216864458467;3731.8320675569666;3748.756330838487;3754.7747135171703;5130;5293.841184764463;5298.470152984709;5315.388730296027;5341.385740639798;3733.607971163043;3756.4876840154543;3769.2838360711376;3778.6977041836585;3788.337041017811;3797.867074652429;3802.9429558556644;3808.40047180185;3811.390177571631;3822.675072618803;4308.655307575386;4310.956890431055;4313.676474264443;4329.895876551459;4329.978350108229;4848.442429120626;5029.471905449948;5053.242013697901;5069.645124841226;5088.796448142107;1324.3047400114824;1333.3533236380347;1339.5244688135767;1346.7710489216856;1348.7504811609883;860.7073594977612;923.6997975657938;950.4819873169139;956.6795123633522;963.2919803944095;4205.843393066931;4419.911601767946;4468.664850136252;4500.3249512573375;4524.547545245449;5204.505571970657;5232.659877107976;5260.973695131576;5273.419923808378;5284.709340986283;4521.344405061248;4522.34426008227;4523.6881304422;4525.710172600793;4527.47933987589;2572.0740533407957;2700.9324766880986;2705.594160875845;2718.225305787841;2718.904838330649;4711.882202944954;4715.81136754526;4729.219678753036;4736.407949006374;4736.478987311393;5058.367704036996;5249.895002099936;5253.921191182136;5261.447548007481;5284.471552844761;4829.6860704054125;4849.684770489906;4867.902641947141;4868.294097355934;4875.756212189447;5252.606054545848;5269;5270.341207349082;5271.235670827785;5291.259223708761;4895.53492418234;5095.87260318495;5145.202493613496;5154;5165.870853228699;4829.613630909589;4837.612990960785;4838.491958344323;4851.9514804852915;4858.58702010333;3908.3746600543777;3939.5666476688116;3944.881653550398;3946.131850992777;3965.4448377226636;4981.726005069756;5197.7141257229705;5228.215767634885;5233.895322093613;5296.602754793329;5060.3927528696795;5067.822626208213;5076.670016448919;5082.237664350377;5085.745712714275;5017.222330538626;5056.342675452315;5068.898622027613;5077.492250774893;5090.421969189415;4799.400074990626;4979.751012449291;4994.653582099929;5010.123228435083;5012.8496145115705;4889.217725163957;4993.725345105909;5034.0686972910125;5134.666246693953;5158.845234642967;5026.346574945233;5032.547070763649;5043.571296439697;5048.419431765247;5051.848444546669 08:04:35 INFO - PROCESS | 8891 | |5;yui.html;618.2333905956615;631.2992578238155;637.9712912918918;722.2705067881442;743.962801859907;12592.370381480923;13154.210747355166;13204.141730787493;13266.336683165851;13281.867181328184;12944.676383090427;13044.73910521789;13067.411966461508;13094.47622095115;13116.606501804961;611.68803910006;629.1380808292646;742.5359150530918;750.4034292737286;767.9424043196755;751.6392131776751;769.1923480345642;770.4760762681375;770.710983381232;770.7764748223009;822.8148666550038;823.5964377455034;824.6124321568853;825.1871906172445;825.2902503846688;644.4103645164669;661.3617858766314;781.7693780334758;814.2549567146054;815.2255357410484;588.5879884081161;593.8218534439651;596.31126049413;597.5637784417399;598.0252188932056;12481.251124932533;12552.246865188117;12620.81068783969;12630.242185468902;12647.49410023598;12501.812472812915;12772.36138193096;12773.169743966613;12846.614601561969;12888.677783055406;10640.521176546996;10683.252172347939;11053.392063436508;11130.888691113067;11214.831777523344;4040.2525532776235;4066.9796651016554;4067.9796601016806;4119.649829764474;4121.443605113332;67042;68053.31946680519;69186.3081369185;69901;70062.64968675125;9746.756331091638;10122.746931326628;10291.382517049002;10403.323783954018;10415.843762343571;17355.392561260294;18034;18377.448676539727;18440.17019234138;18603.25586976533;6453.193350831146;6721.462283017347;6770.69531871067;6777.356151165632;6847.554908930903;3597.5503062117236;3623.3296840084668;3684.6868016218386;3779.433085037266;3795.525559305087;2792.4554711831406;2846.9715302846707;2869.196624945019;2870.0098466029185;2876.2377969838008;476.50443538719344;478.3852749217239;478.6745013390928;482.3584632438848;485.4102265747134;495.89338292267337;512.4260827872732;528.6840815599111;545.664416383921;559.2115117684046;7354.448416368687;7505.174430812606;7509.9249007509225;7680.5391676499585;7768.53388796674;422.9196452673982;548.2051026012218;555.6332820338638;570.4637640617806;578.2511647416605;3403.5575375201065;3568.429051351823;3569.910752231215;3590.263995880838;3629.256002519477;65520;66130.33869661242;67029;67044.66477667581;67280.6635966817;55816.441835581936;56906.430935690114;58666.706666466394;59038;60163.699181504686;53206;53375.466245337826;53410.73294633502;53456.73271633617;53773.46226537763;7979.800504987422;8531.274841638282;8711.346649001223;8808.383413161017;8865.601047952987;34959.12602184965;35054.12364690903;35278.11804704903;36038.639613603526;36084.63915360813;43310.13379732451;44607.776961114985;44752.55247447484;45080.549194508945;45500.54499454963;10419.166466682496;10561.10230630405;11007.504662290055;11323;11341.546338146381;11120.388378639253;11124.443777810915;11301;11562.710932226762;12168.20906641101;11949.283043017447;12082;12115.515379384726;12650.224527794811;12831.358432078172;11244.493997769956;11319.151063670422;11477.770444591228;11540.596079137189;11979.760404791681;11785.646430607096;11907.82138267944;12046.879531204575;12093.637190884288;12472.189307694971;8351.457155284887;8551.828963420821;8775.824483510167;8855.512946787989;9087.591058402255;8789.472631642122;9665.9033409665;9956.352837065568;10022.799544009225;10082.848757268794 08:04:35 INFO - PROCESS | 8891 | __end_tp_report 08:04:35 INFO - PROCESS | 8891 | __start_cc_report 08:04:35 INFO - PROCESS | 8891 | _x_x_mozilla_cycle_collect,1099 08:04:35 INFO - PROCESS | 8891 | __end_cc_report 08:04:35 INFO - PROCESS | 8891 | __startTimestamp1481645075498__endTimestamp 08:04:35 INFO - PROCESS | 8891 | 08:04:35 INFO - PROCESS | 8891 | ------- Summary: start ------- 08:04:35 INFO - PROCESS | 8891 | Number of tests: 6 08:04:35 INFO - PROCESS | 8891 | 08:04:35 INFO - PROCESS | 8891 | [#0] dojo.html Cycles:165 Average:4693.27 Median:4767.52 stddev:483.93 (10.2%) stddev-sans-first:456.49 08:04:35 INFO - PROCESS | 8891 | Values: 2592.4 2609.9 2635.3 2645.2 2647.4 4619.9 4637.3 4726.2 4744.3 4746.7 4718.5 4725.7 4726.8 4734.6 4852.9 4352.7 4366.1 4374.5 4387.3 4394.3 4360.5 4391.4 4441.3 4485.0 4490.4 4421.1 4428.5 4439.6 4468.8 4488.0 4229.8 4233.4 4237.5 4313.1 4388.9 4264.2 4273.1 4277.0 4279.1 4286.2 4646.4 4649.7 4661.3 4676.6 4680.8 4943.5 5006.4 5007.8 5017.4 5045.5 5131.5 5164.8 5169.4 5172.3 5175.6 4767.4 4767.5 4768.7 4772.4 4814.7 4980.4 5222.1 5222.3 5223.3 5271.1 4861.0 4903.7 4941.0 4943.7 4947.7 5018.5 5021.2 5022.2 5023.5 5027.4 4973.5 4976.1 4978.3 4981.1 4998.6 4962.9 4970.4 5004.4 5020.6 5034.9 4405.2 4445.3 4446.5 4448.0 4454.6 3821.9 3864.1 3879.0 3892.6 3921.8 4304.1 4407.3 4412.1 4413.1 4450.5 5047.4 5097.2 5101.0 5120.7 5133.6 4422.7 4430.0 4433.1 4460.8 4463.4 4653.5 4660.2 4661.9 4662.1 4706.7 4576.0 4603.2 4612.2 4710.8 4762.7 5080.6 5152.3 5152.4 5194.1 5205.7 4754.1 4756.6 4762.1 4767.1 4806.5 4910.1 5084.5 5086.8 5089.1 5136.9 4991.2 5066.6 5078.5 5091.2 5190.4 4998.5 5001.4 5002.2 5007.6 5008.3 5005.0 5009.2 5017.2 5019.6 5020.3 4738.8 4747.5 4750.1 4782.2 4806.4 4969.1 4979.9 4980.5 4995.9 5006.1 4824.4 4841.9 4849.0 4875.2 4905.4 08:04:35 INFO - PROCESS | 8891 | 08:04:35 INFO - PROCESS | 8891 | [#1] ext.html Cycles:180 Average:45281.70 Median:37242.26 stddev:82406.05 (221.3%) stddev-sans-first:82568.66 08:04:35 INFO - PROCESS | 8891 | Values: 510.7 525.9 536.6 537.9 570.8 27663.0 37055.6 38647.2 38674.6 42417.8 39165.4 39311.8 39346.0 39557.0 39563.8 7424.7 7655.8 7656.9 7659.8 7660.5 7375.6 7578.2 7605.0 9552.4 9783.2 9797.7 9884.6 9890.2 9892.8 9898.6 9739.7 9793.4 9801.4 9803.2 9808.0 9656.7 9725.2 9730.3 9732.8 9739.7 37035.8 37060.3 37181.3 37226.4 37258.1 2844.8 2866.3 2881.8 2978.5 3326.7 27491.6 27754.2 27770.8 28789.4 28979.6 3293.8 3323.8 3369.6 3411.5 3432.8 194650.0 244826.0 245585.0 245704.0 245752.1 44830.8 45365.5 45421.5 45439.3 45445.3 43878.6 43912.6 43988.3 44035.0 44253.1 11745.8 12134.5 12139.3 12142.4 12146.3 8491.8 9257.3 9321.3 9334.7 9343.6 12537.0 14932.3 15282.7 15294.5 15517.9 5936.8 6115.7 6223.0 6343.4 6426.4 714.7 820.6 836.3 840.4 909.1 25812.6 27179.0 27214.7 27343.3 27456.2 823.0 862.2 903.3 914.3 929.5 13710.9 14171.1 14231.7 14674.9 14755.3 372791.0 375143.0 375683.0 376368.0 376485.0 42183.4 42912.0 46818.5 47157.0 47212.5 1084.2 1107.3 1120.2 1124.4 1129.5 26718.6 27820.7 27908.9 28537.7 28891.9 40800.8 40992.4 41402.8 41420.4 41477.2 308884.0 311294.0 311946.0 314087.0 314738.0 24201.8 24649.0 24655.4 24663.6 24668.1 39462.8 39628.0 40145.6 40241.6 41654.8 34162.7 34283.5 34423.3 34458.5 34884.5 33664.3 34110.8 34142.7 34371.5 35390.1 34097.3 34353.7 34405.1 34483.7 34498.5 29965.7 31007.4 31417.1 31559.7 31564.7 24122.3 24283.4 24378.4 24648.6 24753.6 08:04:35 INFO - PROCESS | 8891 | 08:04:35 INFO - PROCESS | 8891 | [#2] jquery.html Cycles:180 Average:22866.03 Median:5124.55 stddev:62032.53 (1210.5%) stddev-sans-first:62183.50 08:04:35 INFO - PROCESS | 8891 | Values: 344.8 347.3 361.1 368.5 381.9 12418.8 13257.7 13294.5 16157.3 16174.7 15534.8 15693.1 15960.4 15963.3 15993.0 4916.8 5121.3 5127.8 5130.1 5134.9 3623.9 3830.4 5606.1 5851.8 5892.9 5878.5 5930.5 5938.2 5939.4 5941.3 5855.2 6000.2 6019.9 6025.0 6028.9 5049.1 5201.4 5284.5 5291.6 5291.9 19593.0 19715.3 19801.3 19805.0 19824.3 1734.8 1816.5 1831.9 1875.7 2492.3 11691.2 12603.1 12750.5 13032.9 13093.0 1662.9 1699.6 1713.9 1719.7 1732.7 57435.4 59402.4 62421.7 63062.0 63980.4 8146.6 8410.9 8544.4 8592.6 8790.6 11613.5 11672.7 11674.2 11676.9 11688.1 6156.9 6468.6 6557.4 6593.7 6596.9 5930.2 6024.1 6081.3 6313.3 6471.4 3673.1 3693.5 3704.0 3798.3 3820.6 1765.5 1856.1 1857.7 1865.1 1867.8 773.9 778.2 787.7 814.4 872.9 14863.3 15964.6 16006.1 16025.9 16669.6 762.7 783.8 791.0 805.1 818.2 7983.9 8347.7 8521.2 8926.8 8952.6 371625.0 373204.0 379100.0 379243.0 380162.0 53447.0 72251.3 73011.6 73578.3 75345.0 897.9 899.6 927.6 930.7 933.6 11090.8 14011.2 14875.9 14930.3 15041.9 33333.5 33706.8 36153.0 36370.8 38445.0 45428.5 46508.3 46580.5 48703.0 48951.8 6857.0 7298.9 7311.4 7333.1 7519.5 10181.2 10630.7 11009.2 11228.7 11357.9 4934.0 5077.2 5109.4 5182.8 8577.3 8970.6 9174.0 9516.7 9981.0 10275.2 8649.4 9197.5 9582.9 9870.0 10131.0 7024.8 7183.6 7357.3 7428.0 7568.7 9071.4 9301.5 9637.5 9718.0 10138.8 08:04:35 INFO - PROCESS | 8891 | 08:04:35 INFO - PROCESS | 8891 | [#3] mootools.html Cycles:180 Average:4702.10 Median:5700.76 stddev:2550.49 (44.7%) stddev-sans-first:2544.89 08:04:35 INFO - PROCESS | 8891 | Values: 1308.2 1334.6 1380.8 1664.1 1677.1 6270.0 6498.5 6879.8 7282.3 7304.2 6826.3 7069.3 7073.9 7243.6 7247.1 2034.1 2081.9 2088.3 2089.0 2094.8 1793.1 1853.3 2053.3 2066.2 2093.6 1969.8 2042.3 2046.9 2048.5 2060.4 2047.2 2069.8 2079.8 2079.9 2101.5 2063.4 2069.9 2106.2 2107.7 2111.5 7231.2 7257.2 7281.4 7282.0 7292.0 4231.9 4383.3 4385.9 4390.3 4394.1 2722.6 2760.6 2926.1 2931.5 2937.0 903.4 912.6 918.3 941.2 961.0 9589.7 9599.8 9604.8 9613.7 9643.7 3889.3 3952.2 3954.1 3974.8 4031.9 8127.1 8141.2 8143.1 8145.5 8154.6 4308.2 4345.8 4367.9 4384.3 4385.9 3823.4 3885.1 3989.5 3998.1 4002.9 3323.4 3333.8 3426.6 3437.1 3437.8 996.1 1023.1 1080.2 1113.9 1115.9 600.1 631.6 638.9 664.7 802.0 4593.9 4788.8 4854.2 4973.9 5052.3 761.8 790.2 831.1 834.4 836.5 3129.6 3247.3 3306.4 3347.6 3452.3 8385.1 8425.1 8534.7 8547.7 8560.5 8485.1 8490.4 8491.7 8492.7 8507.1 6372.5 6684.9 6687.6 6802.4 6831.1 4683.0 4738.7 4856.1 4979.0 5083.8 7753.3 7760.4 7816.4 7908.1 7922.7 7941.3 8121.6 8124.6 8145.7 8150.4 5688.5 5861.8 5915.7 6060.7 6064.1 6848.4 6902.8 6918.2 6928.3 6937.0 6223.8 6266.3 6293.7 6301.6 6459.3 6114.1 6230.3 6263.9 6273.8 6364.3 5623.0 5713.0 5716.8 5730.6 5736.4 4139.8 4224.7 4267.9 4321.1 4402.8 4130.4 4298.7 4308.6 4355.6 4371.0 08:04:35 INFO - PROCESS | 8891 | 08:04:35 INFO - PROCESS | 8891 | [#4] prototype.html Cycles:180 Average:4232.16 Median:4794.70 stddev:1200.51 (25.0%) stddev-sans-first:1167.85 08:04:35 INFO - PROCESS | 8891 | Values: 342.9 343.6 350.0 351.7 352.2 4878.6 4899.9 4903.5 4915.4 4925.6 4790.0 4820.3 4860.6 4863.2 4870.2 3635.3 3748.9 3769.6 3826.7 3840.2 3853.0 3855.5 3857.4 3873.8 3890.0 3816.9 3839.5 3845.6 3868.4 3869.0 3612.5 3727.0 3750.6 3849.2 3863.7 3424.4 3430.7 3431.3 3434.3 3435.4 4725.8 4735.6 4740.0 4743.9 4747.1 4268.6 4412.3 4414.3 4424.4 4426.8 5044.9 5056.6 5060.3 5102.3 5115.9 3705.9 3729.2 3731.8 3748.8 3754.8 5130.0 5293.8 5298.5 5315.4 5341.4 3733.6 3756.5 3769.3 3778.7 3788.3 3797.9 3802.9 3808.4 3811.4 3822.7 4308.7 4311.0 4313.7 4329.9 4330.0 4848.4 5029.5 5053.2 5069.6 5088.8 1324.3 1333.4 1339.5 1346.8 1348.8 860.7 923.7 950.5 956.7 963.3 4205.8 4419.9 4468.7 4500.3 4524.5 5204.5 5232.7 5261.0 5273.4 5284.7 4521.3 4522.3 4523.7 4525.7 4527.5 2572.1 2700.9 2705.6 2718.2 2718.9 4711.9 4715.8 4729.2 4736.4 4736.5 5058.4 5249.9 5253.9 5261.4 5284.5 4829.7 4849.7 4867.9 4868.3 4875.8 5252.6 5269.0 5270.3 5271.2 5291.3 4895.5 5095.9 5145.2 5154.0 5165.9 4829.6 4837.6 4838.5 4852.0 4858.6 3908.4 3939.6 3944.9 3946.1 3965.4 4981.7 5197.7 5228.2 5233.9 5296.6 5060.4 5067.8 5076.7 5082.2 5085.7 5017.2 5056.3 5068.9 5077.5 5090.4 4799.4 4979.8 4994.7 5010.1 5012.8 4889.2 4993.7 5034.1 5134.7 5158.8 5026.3 5032.5 5043.6 5048.4 5051.8 08:04:35 INFO - PROCESS | 8891 | 08:04:35 INFO - PROCESS | 8891 | [#5] yui.html Cycles:180 Average:14931.71 Median:45290.55 stddev:19012.74 (42.0%) stddev-sans-first:19035.70 08:04:35 INFO - PROCESS | 8891 | Values: 618.2 631.3 638.0 722.3 744.0 12592.4 13154.2 13204.1 13266.3 13281.9 12944.7 13044.7 13067.4 13094.5 13116.6 611.7 629.1 742.5 750.4 767.9 751.6 769.2 770.5 770.7 770.8 822.8 823.6 824.6 825.2 825.3 644.4 661.4 781.8 814.3 815.2 588.6 593.8 596.3 597.6 598.0 12481.3 12552.2 12620.8 12630.2 12647.5 12501.8 12772.4 12773.2 12846.6 12888.7 10640.5 10683.3 11053.4 11130.9 11214.8 4040.3 4067.0 4068.0 4119.6 4121.4 67042.0 68053.3 69186.3 69901.0 70062.6 9746.8 10122.7 10291.4 10403.3 10415.8 17355.4 18034.0 18377.4 18440.2 18603.3 6453.2 6721.5 6770.7 6777.4 6847.6 3597.6 3623.3 3684.7 3779.4 3795.5 2792.5 2847.0 2869.2 2870.0 2876.2 476.5 478.4 478.7 482.4 485.4 495.9 512.4 528.7 545.7 559.2 7354.4 7505.2 7509.9 7680.5 7768.5 422.9 548.2 555.6 570.5 578.3 3403.6 3568.4 3569.9 3590.3 3629.3 65520.0 66130.3 67029.0 67044.7 67280.7 55816.4 56906.4 58666.7 59038.0 60163.7 53206.0 53375.5 53410.7 53456.7 53773.5 7979.8 8531.3 8711.3 8808.4 8865.6 34959.1 35054.1 35278.1 36038.6 36084.6 43310.1 44607.8 44752.6 45080.5 45500.5 10419.2 10561.1 11007.5 11323.0 11341.5 11120.4 11124.4 11301.0 11562.7 12168.2 11949.3 12082.0 12115.5 12650.2 12831.4 11244.5 11319.2 11477.8 11540.6 11979.8 11785.6 11907.8 12046.9 12093.6 12472.2 8351.5 8551.8 8775.8 8855.5 9087.6 8789.5 9665.9 9956.4 10022.8 10082.8 08:04:35 INFO - PROCESS | 8891 | -------- Summary: end -------- 08:04:35 INFO - PROCESS | 8891 | 08:04:36 INFO - TEST-INFO | 8891: exit 0 08:04:36 INFO - TEST-OK | dromaeo_css | took 1122774ms 08:04:36 INFO - TEST-START | kraken 08:04:36 INFO - operating with platform_type : linux_ 08:04:36 INFO - Initialising browser for kraken test... 08:04:36 INFO - TEST-INFO | started process 9196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaepQHo/profile http://localhost:55652/getInfo.html) 08:04:40 INFO - PROCESS | 9196 | __metrics Screen width/height:1600/1200 08:04:40 INFO - PROCESS | 9196 | colorDepth:24 08:04:40 INFO - PROCESS | 9196 | Browser inner width/height: 1024/697 08:04:40 INFO - PROCESS | 9196 | __metrics 08:04:41 INFO - PROCESS | 9196 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:04:41 INFO - PROCESS | 9196 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:04:41 INFO - PROCESS | 9196 | console.error: PushService: 08:04:41 INFO - PROCESS | 9196 | stateChangeProcessEnqueue: Error transitioning state 08:04:41 INFO - PROCESS | 9196 | UnknownError 08:04:42 INFO - TEST-INFO | 9196: exit 0 08:04:42 INFO - Browser initialized. 08:04:42 INFO - Running cycle 1/1 for kraken test... 08:04:42 INFO - TEST-INFO | started process 9277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaepQHo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:04:55 INFO - PROCESS | 9277 | RSS: Main: 173375488 08:04:55 INFO - PROCESS | 9277 | 08:04:57 INFO - PROCESS | 9277 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55652/tests/kraken/driver.html?testName=audio-beat-detection) 08:04:58 INFO - PROCESS | 9277 | RSS: Main: 235851776 08:04:58 INFO - PROCESS | 9277 | 08:05:01 INFO - PROCESS | 9277 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55652/tests/kraken/driver.html?testName=audio-dft) 08:05:02 INFO - PROCESS | 9277 | RSS: Main: 217980928 08:05:02 INFO - PROCESS | 9277 | 08:05:05 INFO - PROCESS | 9277 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55652/tests/kraken/driver.html?testName=audio-fft) 08:05:05 INFO - PROCESS | 9277 | RSS: Main: 300273664 08:05:05 INFO - PROCESS | 9277 | 08:05:08 INFO - PROCESS | 9277 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55652/tests/kraken/driver.html?testName=audio-oscillator) 08:05:08 INFO - PROCESS | 9277 | RSS: Main: 211644416 08:05:08 INFO - PROCESS | 9277 | 08:05:11 INFO - PROCESS | 9277 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55652/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:05:11 INFO - PROCESS | 9277 | RSS: Main: 214519808 08:05:11 INFO - PROCESS | 9277 | 08:05:14 INFO - PROCESS | 9277 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55652/tests/kraken/driver.html?testName=imaging-darkroom) 08:05:15 INFO - PROCESS | 9277 | RSS: Main: 253775872 08:05:15 INFO - PROCESS | 9277 | 08:05:19 INFO - PROCESS | 9277 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55652/tests/kraken/driver.html?testName=imaging-desaturate) 08:05:19 INFO - PROCESS | 9277 | RSS: Main: 248000512 08:05:19 INFO - PROCESS | 9277 | 08:05:22 INFO - PROCESS | 9277 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55652/tests/kraken/driver.html?testName=json-parse-financial) 08:05:23 INFO - PROCESS | 9277 | RSS: Main: 250548224 08:05:23 INFO - PROCESS | 9277 | 08:05:24 INFO - PROCESS | 9277 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55652/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:05:25 INFO - PROCESS | 9277 | RSS: Main: 213889024 08:05:25 INFO - PROCESS | 9277 | 08:05:27 INFO - PROCESS | 9277 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:05:28 INFO - PROCESS | 9277 | RSS: Main: 220811264 08:05:28 INFO - PROCESS | 9277 | 08:05:30 INFO - PROCESS | 9277 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:05:30 INFO - PROCESS | 9277 | RSS: Main: 229457920 08:05:30 INFO - PROCESS | 9277 | 08:05:33 INFO - PROCESS | 9277 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:05:34 INFO - PROCESS | 9277 | RSS: Main: 238276608 08:05:34 INFO - PROCESS | 9277 | 08:05:37 INFO - PROCESS | 9277 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:05:38 INFO - PROCESS | 9277 | RSS: Main: 235143168 08:05:38 INFO - PROCESS | 9277 | 08:05:39 INFO - PROCESS | 9277 | Cycle 1(1): loaded http://localhost:55652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55652/tests/kraken/driver.html?testName=ai-astar) 08:05:40 INFO - PROCESS | 9277 | RSS: Main: 288264192 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | __start_tp_report 08:05:40 INFO - PROCESS | 9277 | _x_x_mozilla_page_load 08:05:40 INFO - PROCESS | 9277 | _x_x_mozilla_page_load_details 08:05:40 INFO - PROCESS | 9277 | |i|pagename|runs| 08:05:40 INFO - PROCESS | 9277 | |0;ai-astar;110;118;118;119;120;121;117;118;119;117 08:05:40 INFO - PROCESS | 9277 | |1;audio-beat-detection;165;128;130;171;136;137;127;129;149;129 08:05:40 INFO - PROCESS | 9277 | |2;audio-dft;161;160;163;162;163;163;160;161;161;161 08:05:40 INFO - PROCESS | 9277 | |3;audio-fft;77;76;77;103;83;78;76;77;90;76 08:05:40 INFO - PROCESS | 9277 | |4;audio-oscillator;85;86;112;85;86;85;110;84;84;114 08:05:40 INFO - PROCESS | 9277 | |5;imaging-gaussian-blur;127;127;128;127;127;127;127;127;127;127 08:05:40 INFO - PROCESS | 9277 | |6;imaging-darkroom;147;147;147;147;147;147;146;146;147;147 08:05:40 INFO - PROCESS | 9277 | |7;imaging-desaturate;95;95;96;95;95;95;96;96;95;94 08:05:40 INFO - PROCESS | 9277 | |8;json-parse-financial;64;62;63;62;64;63;76;64;64;66 08:05:40 INFO - PROCESS | 9277 | |9;json-stringify-tinderbox;65;66;66;66;66;67;71;66;67;66 08:05:40 INFO - PROCESS | 9277 | |10;stanford-crypto-aes;95;88;87;84;84;86;84;84;97;84 08:05:40 INFO - PROCESS | 9277 | |11;stanford-crypto-ccm;148;143;141;142;151;139;144;139;183;141 08:05:40 INFO - PROCESS | 9277 | |12;stanford-crypto-pbkdf2;178;182;181;178;189;179;179;183;178;178 08:05:40 INFO - PROCESS | 9277 | |13;stanford-crypto-sha256-iterative;70;69;70;70;68;69;68;68;73;69 08:05:40 INFO - PROCESS | 9277 | __end_tp_report 08:05:40 INFO - PROCESS | 9277 | __start_cc_report 08:05:40 INFO - PROCESS | 9277 | _x_x_mozilla_cycle_collect,1958 08:05:40 INFO - PROCESS | 9277 | __end_cc_report 08:05:40 INFO - PROCESS | 9277 | __startTimestamp1481645140187__endTimestamp 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | ------- Summary: start ------- 08:05:40 INFO - PROCESS | 9277 | Number of tests: 14 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | [#0] ai-astar Cycles:10 Average:117.70 Median:118.50 stddev:2.98 (2.5%) stddev-sans-first:1.33 08:05:40 INFO - PROCESS | 9277 | Values: 110.0 118.0 118.0 119.0 120.0 121.0 117.0 118.0 119.0 117.0 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:136.50 stddev:16.15 (11.8%) stddev-sans-first:14.40 08:05:40 INFO - PROCESS | 9277 | Values: 165.0 128.0 130.0 171.0 136.0 137.0 127.0 129.0 149.0 129.0 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.18 (0.7%) stddev-sans-first:1.24 08:05:40 INFO - PROCESS | 9277 | Values: 161.0 160.0 163.0 162.0 163.0 163.0 160.0 161.0 161.0 161.0 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | [#3] audio-fft Cycles:10 Average:81.30 Median:77.00 stddev:8.82 (11.5%) stddev-sans-first:9.22 08:05:40 INFO - PROCESS | 9277 | Values: 77.0 76.0 77.0 103.0 83.0 78.0 76.0 77.0 90.0 76.0 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:85.00 stddev:13.09 (15.4%) stddev-sans-first:13.56 08:05:40 INFO - PROCESS | 9277 | Values: 85.0 86.0 112.0 85.0 86.0 85.0 110.0 84.0 84.0 114.0 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | [#5] imaging-gaussian-blur Cycles:10 Average:127.10 Median:127.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:05:40 INFO - PROCESS | 9277 | Values: 127.0 127.0 128.0 127.0 127.0 127.0 127.0 127.0 127.0 127.0 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 08:05:40 INFO - PROCESS | 9277 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:05:40 INFO - PROCESS | 9277 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 94.0 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:64.00 stddev:4.10 (6.4%) stddev-sans-first:4.34 08:05:40 INFO - PROCESS | 9277 | Values: 64.0 62.0 63.0 62.0 64.0 63.0 76.0 64.0 64.0 66.0 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.00 stddev:1.65 (2.5%) stddev-sans-first:1.64 08:05:40 INFO - PROCESS | 9277 | Values: 65.0 66.0 66.0 66.0 66.0 67.0 71.0 66.0 67.0 66.0 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:86.50 stddev:4.83 (5.6%) stddev-sans-first:4.25 08:05:40 INFO - PROCESS | 9277 | Values: 95.0 88.0 87.0 84.0 84.0 86.0 84.0 84.0 97.0 84.0 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:143.50 stddev:13.18 (9.2%) stddev-sans-first:13.97 08:05:40 INFO - PROCESS | 9277 | Values: 148.0 143.0 141.0 142.0 151.0 139.0 144.0 139.0 183.0 141.0 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.50 Median:180.00 stddev:3.50 (1.9%) stddev-sans-first:3.60 08:05:40 INFO - PROCESS | 9277 | Values: 178.0 182.0 181.0 178.0 189.0 179.0 179.0 183.0 178.0 178.0 08:05:40 INFO - PROCESS | 9277 | 08:05:40 INFO - PROCESS | 9277 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.51 (2.2%) stddev-sans-first:1.58 08:05:40 INFO - PROCESS | 9277 | Values: 70.0 69.0 70.0 70.0 68.0 69.0 68.0 68.0 73.0 69.0 08:05:40 INFO - PROCESS | 9277 | -------- Summary: end -------- 08:05:40 INFO - PROCESS | 9277 | 08:05:41 INFO - TEST-INFO | 9277: exit 0 08:05:41 INFO - TEST-OK | kraken | took 64965ms 08:05:41 INFO - SUITE-END | took 1187s 08:05:41 INFO - Completed test suite (00:19:48) 08:05:41 INFO - javascript benchmark 08:05:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2592.3648706067015, 2609.882555285012, 2635.3016450640584, 2645.246104860114, 2647.4308023774875, 4619.86140415788, 4637.258038713807, 4726.172919739045, 4744.312074749164, 4746.691465054769, 4718.4809670936165, 4725.740084295362, 4726.810927562902, 4734.621230301576, 4852.854414367565, 4352.695311328208, 4366.08312254427, 4374.4531933508315, 4387.276099443588, 4394.274944634131, 4360.542143074979, 4391.385206071152, 4441.311596702516, 4485.035717320776, 4490.438695163105, 4421.07157496926, 4428.512863585019, 4439.644828413735, 4468.75421851798, 4487.977560112195, 4229.767362795045, 4233.428487154226, 4237.470316210473, 4313.072689371768, 4388.89027774305, 4264.189803937242, 4273.059926816127, 4276.957230427687, 4279.144171165748, 4286.164197981395, 4646.4191976003, 4649.721016739007, 4661.347411362412, 4676.625869930397, 4680.812767489297, 4943.505649435064, 5006.424261209971, 5007.774650140753, 5017.37282839645, 5045.520675535819, 5131.538161565477, 5164.845054648366, 5169.405518365398, 5172.301739265189, 5175.585953123778, 4767.42790865095, 4767.523247675274, 4768.6661933665, 4772.379590653262, 4814.735189564608, 4980.402351717817, 5222.086134926372, 5222.3472065991755, 5223.347081614798, 5271.130263506555, 4861.0, 4903.705777653352, 4941.011797640414, 4943.72809495474, 4947.678400903929, 5018.4981501849525, 5021.246812978083, 5022.171341728574, 5023.547880690682, 5027.371578552681, 4973.502649734997, 4976.0794253063295, 4978.303037574742, 4981.103401387712, 4998.625103117281, 4962.8759281018265, 4970.403551573834, 5004.424491183488, 5020.59835213182, 5034.924476132861, 4405.163019026375, 4445.333200020023, 4446.510883802844, 4447.955520444754, 4454.554544545519, 3821.9235615288094, 3864.1305706215876, 3878.9612103879163, 3892.591277915835, 3921.784301863425, 4304.053108316165, 4407.294832826732, 4412.095520418371, 4413.13943780966, 4450.532694067077, 5047.4447810740785, 5097.209932460474, 5101.0308041472, 5120.718360490208, 5133.640645154878, 4422.668299877522, 4430.047539778963, 4433.069055498317, 4460.821567137343, 4463.419755431773, 4653.464851542049, 4660.231061874752, 4661.906761864744, 4662.137504561599, 4706.670533062653, 4575.954240457553, 4603.240465323184, 4612.238980568169, 4710.811567537397, 4762.666613337033, 5080.593552515864, 5152.330197074356, 5152.433232344514, 5194.1429664105, 5205.713685747169, 4754.096721622881, 4756.643251756063, 4762.119007983534, 4767.141914455431, 4806.47128815837, 4910.091633047898, 5084.466131056186, 5086.821961231339, 5089.13484707608, 5136.922946155885, 4991.226359914219, 5066.645334826674, 5078.492150784892, 5091.210862316347, 5190.351206099238, 4998.525140111684, 5001.374828146481, 5002.2496625506465, 5007.5993920487, 5008.2738002988635, 5005.049040682259, 5009.173486374707, 5017.172166592617, 5019.623528235324, 5020.312973948749, 4738.8341408050555, 4747.548982846624, 4750.07373562152, 4782.187028205283, 4806.423229212517, 4969.105560998911, 4979.875503112451, 4980.452150263541, 4995.850124496271, 5006.123928312603, 4824.372831531879, 4841.878953026203, 4848.9757551212015, 4875.24433712775, 4905.3623029006], "value": 4662.500056463749, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.68848002718335, 525.9447757985413, 536.554659632505, 537.9435159308271, 570.7688386203589, 27663.0, 37055.629443705555, 38647.227055458876, 38674.61325386745, 42417.78791106048, 39165.41251881224, 39311.80344098275, 39346.01634959127, 39557.0, 39563.802180989056, 7424.703011879532, 7655.808604784897, 7656.923430765704, 7659.808504787397, 7660.540367577935, 7375.631218439084, 7578.242175782433, 7605.0, 9552.42685438876, 9783.19010982967, 9797.657082002132, 9884.55519501624, 9890.15933645641, 9892.802143957117, 9898.554565044555, 9739.659111931083, 9793.412395256308, 9801.362911410735, 9803.166730827888, 9807.950960245225, 9656.71029869105, 9725.221982241404, 9730.318877678565, 9732.75668108296, 9739.659111931049, 37035.81482092599, 37060.25879482422, 37181.256374872624, 37226.4416033757, 37258.06854828651, 2844.843533605651, 2866.312085099582, 2881.8270903745843, 2978.4638765022287, 3326.6839650233187, 27491.587626185625, 27754.167374978784, 27770.81423864851, 28789.424211515863, 28979.56530652042, 3293.769436139471, 3323.8171900545703, 3369.5956485221686, 3411.522386865841, 3432.828358582086, 194650.0, 244826.0, 245585.0, 245704.0, 245752.08495830162, 44830.775846121214, 45365.54634453679, 45421.54578454173, 45439.318410223874, 45445.318320225226, 43878.561214387446, 43912.560874391485, 43988.3401748974, 44035.0, 44253.114937701066, 11745.823812642817, 12134.453949572115, 12139.271643701406, 12142.392880355947, 12146.271223726604, 8491.787705307417, 9257.259419246444, 9321.254299656011, 9334.71995840126, 9343.626254949862, 12537.0, 14932.25338733059, 15282.694346113016, 15294.541163765105, 15517.922410387875, 5936.762529498858, 6115.724792384353, 6222.968885155636, 6343.397377249154, 6426.35736426363, 714.678394722377, 820.6389188756928, 836.3351135847016, 840.3991146330403, 909.0636644256426, 25812.612810807852, 27179.0, 27214.727852721615, 27343.316417089733, 27456.176314710592, 822.9876551851727, 862.2024627219797, 903.3405613901889, 914.2914241462787, 929.5212965322729, 13710.931445342909, 14171.149731015967, 14231.715365692628, 14674.853251467563, 14755.336009879582, 372791.0, 375143.0, 375683.0, 376368.0, 376485.0, 42183.36724949128, 42912.0, 46818.5318146821, 47157.0, 47212.5278747215, 1084.2410312781085, 1107.2747350485445, 1120.176670147441, 1124.4265424633331, 1129.5312445335258, 26718.59922101131, 27820.721792781813, 27908.86045569759, 28537.714622853506, 28891.85554072216, 40800.79599601983, 40992.385114222714, 41402.79298603608, 41420.378694319006, 41477.1704565913, 308884.0, 311294.0, 311946.0, 314087.0, 314738.0, 24201.75798241995, 24649.0, 24655.38361540976, 24663.63004554969, 24668.13661521838, 39462.80268598639, 39628.0, 40145.59854401419, 40241.59758402496, 41654.79172604118, 34162.65837341595, 34283.4857477143, 34423.31153376868, 34458.48312275368, 34884.47673284852, 33664.326713466085, 34110.829445852614, 34142.658573413944, 34371.48442773311, 35390.11524711903, 34097.31805363928, 34353.65646343504, 34405.139871503416, 34483.655163449046, 34498.48252276268, 29965.70034299629, 31007.379852403275, 31417.072865891765, 31559.684403155676, 31564.684353157092, 24122.276331710076, 24283.39291517726, 24378.390540236636, 24648.630270546313, 24753.62869556922], "value": 16826.132921591114, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.79829299859597, 347.2967241336292, 361.0684434159867, 368.4859620828943, 381.875890335641, 12418.751624967495, 13257.7348453031, 13294.46822127115, 16157.272922718477, 16174.676506469863, 15534.766978495332, 15693.136877471734, 15960.441384551543, 15963.281652325644, 15993.0, 4916.80332786689, 5121.28302037715, 5127.820526281581, 5130.127878260686, 5134.948650513503, 3623.9456408153897, 3830.4254361845806, 5606.074997625407, 5851.824445266649, 5892.911606325909, 5878.5003274721485, 5930.466258036776, 5938.198343223653, 5939.406059394069, 5941.316748573904, 5855.151003104547, 6000.159977603139, 6019.939800602026, 6025.035994240944, 6028.879422411571, 5049.091163590552, 5201.427842937273, 5284.5243928046275, 5291.629585928987, 5291.920621190685, 19593.0, 19715.309964151187, 19801.306954256677, 19805.0, 19824.306149284705, 1734.8438640522413, 1816.4823025437686, 1831.8809277396927, 1875.7186422036668, 2492.314613481289, 11691.181617286793, 12603.117781755282, 12750.489980400773, 13032.934835325857, 13092.970589558634, 1662.908540030298, 1699.6090899093278, 1713.9314427422887, 1719.6818588561157, 1732.7314266288745, 57435.425645743424, 59402.40597594055, 62421.68789156025, 63062.0, 63980.36019639791, 8146.551939643258, 8410.915890841014, 8544.359173062045, 8592.613332400057, 8790.648374065093, 11613.535458581731, 11672.70818229551, 11674.182807203584, 11676.941615292038, 11688.064954803594, 6156.8768624627255, 6468.6442245676, 6557.409833115043, 6593.72516481813, 6596.901046484307, 5930.169776231331, 6024.126501657235, 6081.270247570232, 6313.326968353298, 6471.449926756184, 3673.1368128489785, 3693.464447655129, 3703.962960370362, 3798.3163030654196, 3820.6370394812448, 1765.5409593505524, 1856.1276200185891, 1857.7027675571844, 1865.0861078071648, 1867.8225568570963, 773.934215591681, 778.2178910195217, 787.7400457848896, 814.352589691197, 872.912708729122, 14863.33115009827, 15964.600884977735, 16006.119663418624, 16025.919870400574, 16669.583260418585, 762.7384804056001, 783.7570353190529, 790.9564973926374, 805.1425232127765, 818.2431251092715, 7983.880241796378, 8347.749567512863, 8521.190486903733, 8926.821463570692, 8952.552372381486, 371625.0, 373204.0, 379100.0, 379243.0, 380162.0, 53447.0, 72251.27748722445, 73011.63494182494, 73578.26421735821, 75345.0, 897.8967418746928, 899.5637115998735, 927.6428574998539, 930.7114794413753, 933.5612262236738, 11090.833637495283, 14011.229382384066, 14875.851241487446, 14930.328135233724, 15041.924790375979, 33333.49999750054, 33706.8314658435, 36153.0, 36370.8181459091, 38445.0, 45428.545714543754, 46508.30237546372, 46580.45076893153, 48703.0, 48951.75524122357, 6857.0, 7298.854022919618, 7311.4150867929375, 7333.083364579427, 7519.548827070394, 10181.185505159718, 10630.681079567625, 11009.229353945148, 11228.719282018015, 11357.920997505224, 4933.988532350932, 5077.162268225701, 5109.437961824122, 5182.844514664566, 8577.313814894918, 8970.596323165342, 9173.954130229573, 9516.714498565054, 9981.0, 10275.177985761271, 8649.394542381973, 9197.540122993958, 9582.856257156009, 9870.0, 10131.037551432602, 7024.824379390352, 7183.604901730246, 7357.337839594248, 7428.034355533746, 7568.697252109854, 9071.365004449624, 9301.534923253676, 9637.518124093627, 9717.951410242904, 10138.847917281098], "value": 7682.828442660223, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.1823860087445, 1334.592949150509, 1380.7652699041168, 1664.11801745075, 1677.1362748184679, 6269.968650156743, 6498.512611554129, 6879.828004299895, 7282.344588986996, 7304.233055529173, 6826.283240259776, 7069.257727938557, 7073.858522829553, 7243.637818109087, 7247.130344358671, 2034.074496104269, 2081.927132550361, 2088.2899814063217, 2088.9895550522224, 2094.8219401350902, 1793.0944872839264, 1853.33280019193, 2053.2916143930393, 2066.1735305877696, 2093.633614117531, 1969.773476050251, 2042.2647846775149, 2046.9078891449847, 2048.4878780304925, 2060.3509894383296, 2047.2118234479758, 2069.844761642883, 2079.812816846491, 2079.9480012999643, 2101.4956410461377, 2063.4222417723063, 2069.927552535654, 2106.2101711858054, 2107.6627739561595, 2111.5037966077957, 7231.240719724406, 7257.165425976027, 7281.417486601059, 7281.963590182015, 7291.963540182318, 4231.936520952188, 4383.276759334706, 4385.912281754379, 4390.319500477431, 4394.143142087294, 2722.6052222427834, 2760.5721113227482, 2926.1367896470592, 2931.457680329146, 2937.0307798426684, 903.4443817052531, 912.5619702542816, 918.3020904112923, 941.1670671455811, 960.9807803843884, 9589.712308630753, 9599.808003839884, 9604.759881002961, 9613.654088427626, 9643.662471813454, 3889.2804831106337, 3952.2293152834923, 3954.149857780591, 3974.82113304902, 4031.9395209071886, 8127.146649601825, 8141.185881411811, 8143.063547691972, 8145.470544414594, 8154.551499667576, 4308.159908817751, 4345.8261669533495, 4367.912641747147, 4384.298512238027, 4385.912281754411, 3823.388257878726, 3885.1258466844733, 3989.5212574491247, 3998.100427403811, 4002.8999275017777, 3323.4184017797274, 3333.8333083345738, 3426.5716785401823, 3437.089171369589, 3437.845296961643, 996.0885789502669, 1023.0638965346773, 1080.173667144635, 1113.9387333696725, 1115.9330440173615, 600.099850224663, 631.6178711879339, 638.9265234497999, 664.6543797225512, 801.9518828870287, 4593.908121837545, 4788.760561971888, 4854.199057155601, 4973.875653108701, 5052.343195384577, 761.8285885675679, 790.1742678900563, 831.0733532111652, 834.4284165346756, 836.5148214035967, 3129.640091389474, 3247.285597168619, 3306.437905556061, 3347.615024272191, 3452.3267962747527, 8385.119562445856, 8425.115362886809, 8534.70128545498, 8547.658093676184, 8560.48637081777, 8485.0666426693, 8490.448120872123, 8491.660333586711, 8492.660293588311, 8507.064222935473, 6372.458341041063, 6684.9331506685285, 6687.6321802301345, 6802.421794147553, 6831.11195544576, 4682.976585117052, 4738.715677059249, 4856.077345304381, 4978.975105124451, 5083.822066227664, 7753.340966017951, 7760.3791696663, 7816.4137689674635, 7908.130105688255, 7922.7227047053075, 7941.285284324438, 8121.553314567519, 8124.553149576594, 8145.674173033012, 8150.388720845842, 5688.516476099412, 5861.824145275648, 5915.733791979285, 6060.6969651516365, 6064.06007068905, 6848.383645471931, 6902.792916212522, 6918.169819621678, 6928.341807528277, 6936.965315173594, 6223.844403889939, 6266.342034086538, 6293.685315734287, 6301.6219026858535, 6459.257185423737, 6114.113453549122, 6230.283517395557, 6263.906041409474, 6273.811785646255, 6364.299927007933, 5622.971885140548, 5713.0, 5716.828495145152, 5730.598858080061, 5736.397678243724, 4139.79301034941, 4224.662027037891, 4267.93598096035, 4321.135772845506, 4402.845900393599, 4130.421740956329, 4298.742075475481, 4308.590683885026, 4355.62977146946, 4371.0], "value": 3820.95661771992, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.9057009322436, 343.60142235007396, 350.0007478648458, 351.73444049742443, 352.24443568545456, 4878.585320247778, 4899.926501102477, 4903.509649035094, 4915.410150781902, 4925.605951523883, 4790.0, 4820.252860806572, 4860.562549370556, 4863.221884498481, 4870.172070747973, 3635.2547727715755, 3748.850045998157, 3769.6230376962358, 3826.7180494534364, 3840.2319536092755, 3852.9614703852885, 3855.4602355670227, 3857.3635350167187, 3873.786941718204, 3889.9611003890022, 3816.9045773855737, 3839.462475253467, 3845.5962123977, 3868.4390763339297, 3869.032741814546, 3612.4761909523104, 3727.04960235141, 3750.624937506255, 3849.2301539692035, 3863.690904727615, 3424.4007298722872, 3430.691237788586, 3431.2965842002577, 3434.278801451673, 3435.381631306364, 4725.76371181443, 4735.57932620216, 4739.957209413923, 4743.928841067387, 4747.074320507502, 4268.615824575772, 4412.286443837049, 4414.293713005904, 4424.40270563473, 4426.84506042287, 5044.872179248852, 5056.570191533724, 5060.2662613920775, 5102.260172275, 5115.948840511622, 3705.94441083384, 3729.216864458467, 3731.8320675569666, 3748.756330838487, 3754.7747135171703, 5130.0, 5293.841184764463, 5298.470152984709, 5315.388730296027, 5341.385740639798, 3733.607971163043, 3756.4876840154543, 3769.2838360711376, 3778.6977041836585, 3788.337041017811, 3797.867074652429, 3802.9429558556644, 3808.40047180185, 3811.390177571631, 3822.675072618803, 4308.655307575386, 4310.956890431055, 4313.676474264443, 4329.895876551459, 4329.978350108229, 4848.442429120626, 5029.471905449948, 5053.242013697901, 5069.645124841226, 5088.796448142107, 1324.3047400114824, 1333.3533236380347, 1339.5244688135767, 1346.7710489216856, 1348.7504811609883, 860.7073594977612, 923.6997975657938, 950.4819873169139, 956.6795123633522, 963.2919803944095, 4205.843393066931, 4419.911601767946, 4468.664850136252, 4500.3249512573375, 4524.547545245449, 5204.505571970657, 5232.659877107976, 5260.973695131576, 5273.419923808378, 5284.709340986283, 4521.344405061248, 4522.34426008227, 4523.6881304422, 4525.710172600793, 4527.47933987589, 2572.0740533407957, 2700.9324766880986, 2705.594160875845, 2718.225305787841, 2718.904838330649, 4711.882202944954, 4715.81136754526, 4729.219678753036, 4736.407949006374, 4736.478987311393, 5058.367704036996, 5249.895002099936, 5253.921191182136, 5261.447548007481, 5284.471552844761, 4829.6860704054125, 4849.684770489906, 4867.902641947141, 4868.294097355934, 4875.756212189447, 5252.606054545848, 5269.0, 5270.341207349082, 5271.235670827785, 5291.259223708761, 4895.53492418234, 5095.87260318495, 5145.202493613496, 5154.0, 5165.870853228699, 4829.613630909589, 4837.612990960785, 4838.491958344323, 4851.9514804852915, 4858.58702010333, 3908.3746600543777, 3939.5666476688116, 3944.881653550398, 3946.131850992777, 3965.4448377226636, 4981.726005069756, 5197.7141257229705, 5228.215767634885, 5233.895322093613, 5296.602754793329, 5060.3927528696795, 5067.822626208213, 5076.670016448919, 5082.237664350377, 5085.745712714275, 5017.222330538626, 5056.342675452315, 5068.898622027613, 5077.492250774893, 5090.421969189415, 4799.400074990626, 4979.751012449291, 4994.653582099929, 5010.123228435083, 5012.8496145115705, 4889.217725163957, 4993.725345105909, 5034.0686972910125, 5134.666246693953, 5158.845234642967, 5026.346574945233, 5032.547070763649, 5043.571296439697, 5048.419431765247, 5051.848444546669], "value": 3867.3811075512294, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.2333905956615, 631.2992578238155, 637.9712912918918, 722.2705067881442, 743.962801859907, 12592.370381480923, 13154.210747355166, 13204.141730787493, 13266.336683165851, 13281.867181328184, 12944.676383090427, 13044.73910521789, 13067.411966461508, 13094.47622095115, 13116.606501804961, 611.68803910006, 629.1380808292646, 742.5359150530918, 750.4034292737286, 767.9424043196755, 751.6392131776751, 769.1923480345642, 770.4760762681375, 770.710983381232, 770.7764748223009, 822.8148666550038, 823.5964377455034, 824.6124321568853, 825.1871906172445, 825.2902503846688, 644.4103645164669, 661.3617858766314, 781.7693780334758, 814.2549567146054, 815.2255357410484, 588.5879884081161, 593.8218534439651, 596.31126049413, 597.5637784417399, 598.0252188932056, 12481.251124932533, 12552.246865188117, 12620.81068783969, 12630.242185468902, 12647.49410023598, 12501.812472812915, 12772.36138193096, 12773.169743966613, 12846.614601561969, 12888.677783055406, 10640.521176546996, 10683.252172347939, 11053.392063436508, 11130.888691113067, 11214.831777523344, 4040.2525532776235, 4066.9796651016554, 4067.9796601016806, 4119.649829764474, 4121.443605113332, 67042.0, 68053.31946680519, 69186.3081369185, 69901.0, 70062.64968675125, 9746.756331091638, 10122.746931326628, 10291.382517049002, 10403.323783954018, 10415.843762343571, 17355.392561260294, 18034.0, 18377.448676539727, 18440.17019234138, 18603.25586976533, 6453.193350831146, 6721.462283017347, 6770.69531871067, 6777.356151165632, 6847.554908930903, 3597.5503062117236, 3623.3296840084668, 3684.6868016218386, 3779.433085037266, 3795.525559305087, 2792.4554711831406, 2846.9715302846707, 2869.196624945019, 2870.0098466029185, 2876.2377969838008, 476.50443538719344, 478.3852749217239, 478.6745013390928, 482.3584632438848, 485.4102265747134, 495.89338292267337, 512.4260827872732, 528.6840815599111, 545.664416383921, 559.2115117684046, 7354.448416368687, 7505.174430812606, 7509.9249007509225, 7680.5391676499585, 7768.53388796674, 422.9196452673982, 548.2051026012218, 555.6332820338638, 570.4637640617806, 578.2511647416605, 3403.5575375201065, 3568.429051351823, 3569.910752231215, 3590.263995880838, 3629.256002519477, 65520.0, 66130.33869661242, 67029.0, 67044.66477667581, 67280.6635966817, 55816.441835581936, 56906.430935690114, 58666.706666466394, 59038.0, 60163.699181504686, 53206.0, 53375.466245337826, 53410.73294633502, 53456.73271633617, 53773.46226537763, 7979.800504987422, 8531.274841638282, 8711.346649001223, 8808.383413161017, 8865.601047952987, 34959.12602184965, 35054.12364690903, 35278.11804704903, 36038.639613603526, 36084.63915360813, 43310.13379732451, 44607.776961114985, 44752.55247447484, 45080.549194508945, 45500.54499454963, 10419.166466682496, 10561.10230630405, 11007.504662290055, 11323.0, 11341.546338146381, 11120.388378639253, 11124.443777810915, 11301.0, 11562.710932226762, 12168.20906641101, 11949.283043017447, 12082.0, 12115.515379384726, 12650.224527794811, 12831.358432078172, 11244.493997769956, 11319.151063670422, 11477.770444591228, 11540.596079137189, 11979.760404791681, 11785.646430607096, 11907.82138267944, 12046.879531204575, 12093.637190884288, 12472.189307694971, 8351.457155284887, 8551.828963420821, 8775.824483510167, 8855.512946787989, 9087.591058402255, 8789.472631642122, 9665.9033409665, 9956.352837065568, 10022.799544009225, 10082.848757268794], "value": 6164.717927297705, "unit": "score"}], "name": "dromaeo_css", "value": 6165.182936791011, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 118.0, 118.0, 119.0, 120.0, 121.0, 117.0, 118.0, 119.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 128.0, 130.0, 171.0, 136.0, 137.0, 127.0, 129.0, 149.0, 129.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 163.0, 162.0, 163.0, 163.0, 160.0, 161.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 103.0, 83.0, 78.0, 76.0, 77.0, 90.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 112.0, 85.0, 86.0, 85.0, 110.0, 84.0, 84.0, 114.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 128.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0], "value": 127.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 62.0, 64.0, 63.0, 76.0, 64.0, 64.0, 66.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 67.0, 71.0, 66.0, 67.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 88.0, 87.0, 84.0, 84.0, 86.0, 84.0, 84.0, 97.0, 84.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 143.0, 141.0, 142.0, 151.0, 139.0, 144.0, 139.0, 183.0, 141.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 182.0, 181.0, 178.0, 189.0, 179.0, 179.0, 183.0, 178.0, 178.0], "value": 180.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 70.0, 68.0, 69.0, 68.0, 68.0, 73.0, 69.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1578.5, "alertThreshold": 2.0}]} 08:05:41 INFO - Return code: 0 08:05:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:05:41 INFO - # TBPL SUCCESS # 08:05:41 INFO - Running post-action listener: _resource_record_post_action 08:05:41 INFO - [mozharness: 2016-12-13 16:05:41.967602Z] Finished run-tests step (success) 08:05:41 INFO - Running post-run listener: _resource_record_post_run 08:05:42 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403038208; Read time: 12; Write time: 247380 08:05:42 INFO - TinderboxPrint: CPU usage
13.1% 08:05:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:05:42 INFO - TinderboxPrint: I/O write bytes / time
403,038,208 / 247,380 08:05:42 INFO - TinderboxPrint: CPU idle
8,345.4 (86.9%) 08:05:42 INFO - TinderboxPrint: CPU user
1,211.8 (12.6%) 08:05:42 INFO - TinderboxPrint: Swap in / out
0 / 0 08:05:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99995648; Read time: 0; Write time: 57808 08:05:42 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 291733504; Read time: 0; Write time: 187628 08:05:42 INFO - Running post-run listener: _upload_blobber_files 08:05:42 INFO - Blob upload gear active. 08:05:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:05:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:05:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:05:43 INFO - (blobuploader) - INFO - Open directory for files ... 08:05:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:05:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:05:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:43 INFO - (blobuploader) - INFO - Done attempting. 08:05:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:05:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:05:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:44 INFO - (blobuploader) - INFO - Done attempting. 08:05:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:05:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:05:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:05:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:05:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:05:48 INFO - (blobuploader) - INFO - Done attempting. 08:05:48 INFO - (blobuploader) - INFO - Iteration through files over. 08:05:48 INFO - Return code: 0 08:05:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:05:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:05:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49e8ddc8b9c0d64e60e8d248200fc7230ee691ecdeb689a8044f229495e7d1e529953dcfe02b8f1ed6c552466b1af8901dd5ef70aaa9570feb1385ea7bf32326", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dcf43f4fdfba6e4fb0cb6c09ac276f38fc6e6e34520f6dc6273d264b625afe9025d10b25f0b12173b852a79576ee9eb05099b2778a4f0bf78efb0dc53301812", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/614359c59995e07f9d981f73f94c7229a54a99f80c40acb1db984fc56b601e517eca3a7b97f9b205b9975e00da404cee6a50399aead365e6ea1a3722a28d2508"} 08:05:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:05:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:05:48 INFO - Contents: 08:05:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49e8ddc8b9c0d64e60e8d248200fc7230ee691ecdeb689a8044f229495e7d1e529953dcfe02b8f1ed6c552466b1af8901dd5ef70aaa9570feb1385ea7bf32326", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dcf43f4fdfba6e4fb0cb6c09ac276f38fc6e6e34520f6dc6273d264b625afe9025d10b25f0b12173b852a79576ee9eb05099b2778a4f0bf78efb0dc53301812", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/614359c59995e07f9d981f73f94c7229a54a99f80c40acb1db984fc56b601e517eca3a7b97f9b205b9975e00da404cee6a50399aead365e6ea1a3722a28d2508"} 08:05:48 INFO - Running post-run listener: copy_logs_to_upload_dir 08:05:48 INFO - Copying logs to upload dir... 08:05:48 INFO - mkdir: /builds/slave/test/build/upload/logs 08:05:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.934819 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-12-13 08:05:47.862629) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 08:05:47.869992) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49e8ddc8b9c0d64e60e8d248200fc7230ee691ecdeb689a8044f229495e7d1e529953dcfe02b8f1ed6c552466b1af8901dd5ef70aaa9570feb1385ea7bf32326", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dcf43f4fdfba6e4fb0cb6c09ac276f38fc6e6e34520f6dc6273d264b625afe9025d10b25f0b12173b852a79576ee9eb05099b2778a4f0bf78efb0dc53301812", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/614359c59995e07f9d981f73f94c7229a54a99f80c40acb1db984fc56b601e517eca3a7b97f9b205b9975e00da404cee6a50399aead365e6ea1a3722a28d2508"} build_url:https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/Du6sYBi4R367wO5NEu543Q/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/49e8ddc8b9c0d64e60e8d248200fc7230ee691ecdeb689a8044f229495e7d1e529953dcfe02b8f1ed6c552466b1af8901dd5ef70aaa9570feb1385ea7bf32326", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dcf43f4fdfba6e4fb0cb6c09ac276f38fc6e6e34520f6dc6273d264b625afe9025d10b25f0b12173b852a79576ee9eb05099b2778a4f0bf78efb0dc53301812", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/614359c59995e07f9d981f73f94c7229a54a99f80c40acb1db984fc56b601e517eca3a7b97f9b205b9975e00da404cee6a50399aead365e6ea1a3722a28d2508"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-13 08:05:47.898487) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:05:47.898834) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1481642886.560412-1196932245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-13 08:05:47.979281) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 08:05:47.981642) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-13 08:05:47.981960) ========= ========= Total master_lag: 0.17 =========