builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1477024258.81 results: success (0) buildid: 20161020185050 builduid: d643df0dba384192a90d393b16a49c37 revision: d69e6eb5d19f81e22ddd026857e2b5b7b57d37b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 21:30:58.812120) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 21:30:58.812549) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 21:30:58.812829) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 21:30:58.828201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:30:58.828476) ========= 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=7de08804244eb36560b44971000001c3-1477023635.243764-857392666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-20 21:30:58-- 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% 224M=0s 2016-10-20 21:30:59 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108370 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:30:58.964750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:30:58.965078) ========= 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=7de08804244eb36560b44971000001c3-1477023635.243764-857392666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014766 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:30:59.035040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:30:59.035452) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d69e6eb5d19f81e22ddd026857e2b5b7b57d37b5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d69e6eb5d19f81e22ddd026857e2b5b7b57d37b5 --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=7de08804244eb36560b44971000001c3-1477023635.243764-857392666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-20 21:30:59,164 truncating revision to first 12 chars 2016-10-20 21:30:59,164 Setting DEBUG logging. 2016-10-20 21:30:59,164 attempt 1/10 2016-10-20 21:30:59,164 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d69e6eb5d19f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 21:30:59,470 unpacking tar archive at: mozilla-beta-d69e6eb5d19f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633764 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:30:59.693212) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 21:30:59.693504) ========= script_repo_revision: d69e6eb5d19f81e22ddd026857e2b5b7b57d37b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 21:30:59.693878) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 21:30:59.694179) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 21:30:59.726258) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-10-20 21:30:59.726595) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=7de08804244eb36560b44971000001c3-1477023635.243764-857392666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:30:59 INFO - MultiFileLogger online at 20161020 21:30:59 in /builds/slave/test 21:30:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 21:30:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:30:59 INFO - {'append_to_log': False, 21:30:59 INFO - 'base_work_dir': '/builds/slave/test', 21:30:59 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:30:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:30:59 INFO - 'branch': 'Mozilla-Beta', 21:30:59 INFO - 'buildbot_json_path': 'buildprops.json', 21:30:59 INFO - 'config_files': ('talos/linux_config.py',), 21:30:59 INFO - 'default_actions': ('clobber', 21:30:59 INFO - 'read-buildbot-config', 21:30:59 INFO - 'download-and-extract', 21:30:59 INFO - 'populate-webroot', 21:30:59 INFO - 'create-virtualenv', 21:30:59 INFO - 'install', 21:30:59 INFO - 'run-tests'), 21:30:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:30:59 INFO - 'download_minidump_stackwalk': True, 21:30:59 INFO - 'download_symbols': 'ondemand', 21:30:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:30:59 INFO - 'tooltool.py': '/tools/tooltool.py', 21:30:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:30:59 INFO - '/tools/misc-python/virtualenv.py')}, 21:30:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:30:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:30:59 INFO - 'installer_path': 'installer.exe', 21:30:59 INFO - 'log_level': 'info', 21:30:59 INFO - 'log_name': 'talos', 21:30:59 INFO - 'log_to_console': True, 21:30:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:30:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:30:59 INFO - 'opt_config_files': (), 21:30:59 INFO - 'pip_index': False, 21:30:59 INFO - 'sps_profile': False, 21:30:59 INFO - 'sps_profile_interval': 0, 21:30:59 INFO - 'suite': 'dromaeojs-e10s', 21:30:59 INFO - 'system_bits': '32', 21:30:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:30:59 INFO - 'title': 'talos-linux64-ix-003', 21:30:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:30:59 INFO - 'use_talos_json': True, 21:30:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:30:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:30:59 INFO - 'work_dir': 'build'} 21:30:59 INFO - [mozharness: 2016-10-21 04:30:59.946768Z] Running clobber step. 21:30:59 INFO - Running pre-action listener: _resource_record_pre_action 21:30:59 INFO - Running main action method: clobber 21:30:59 INFO - rmtree: /builds/slave/test/build 21:30:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:31:00 INFO - Running post-action listener: _resource_record_post_action 21:31:00 INFO - [mozharness: 2016-10-21 04:31:00.413258Z] Finished clobber step (success) 21:31:00 INFO - [mozharness: 2016-10-21 04:31:00.413376Z] Running read-buildbot-config step. 21:31:00 INFO - Running pre-action listener: _resource_record_pre_action 21:31:00 INFO - Running main action method: read_buildbot_config 21:31:00 INFO - Using buildbot properties: 21:31:00 INFO - { 21:31:00 INFO - "project": "", 21:31:00 INFO - "product": "firefox", 21:31:00 INFO - "script_repo_revision": "production", 21:31:00 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 21:31:00 INFO - "repository": "", 21:31:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 21:31:00 INFO - "buildid": "20161020185050", 21:31:00 INFO - "pgo_build": "True", 21:31:00 INFO - "basedir": "/builds/slave/test", 21:31:00 INFO - "buildnumber": 203, 21:31:00 INFO - "slavename": "talos-linux64-ix-003", 21:31:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:31:00 INFO - "platform": "ubuntu64_hw", 21:31:00 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 21:31:00 INFO - "branch": "mozilla-beta", 21:31:00 INFO - "repo_path": "releases/mozilla-beta", 21:31:00 INFO - "revision": "d69e6eb5d19f81e22ddd026857e2b5b7b57d37b5", 21:31:00 INFO - "stage_platform": "linux64-pgo", 21:31:00 INFO - "builduid": "d643df0dba384192a90d393b16a49c37", 21:31:00 INFO - "slavebuilddir": "test" 21:31:00 INFO - } 21:31:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 21:31:00 INFO - Running post-action listener: _resource_record_post_action 21:31:00 INFO - [mozharness: 2016-10-21 04:31:00.415796Z] Finished read-buildbot-config step (success) 21:31:00 INFO - [mozharness: 2016-10-21 04:31:00.415884Z] Running download-and-extract step. 21:31:00 INFO - Running pre-action listener: _resource_record_pre_action 21:31:00 INFO - Running main action method: download_and_extract 21:31:00 INFO - mkdir: /builds/slave/test/build/tests 21:31:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:31:00 INFO - https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:31:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:31:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:31:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:31:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:31:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:31:00 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:31:00 INFO - retry: Failed, sleeping 30 seconds before retrying 21:31:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 21:31:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:31:30 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:31:30 INFO - retry: Failed, sleeping 60 seconds before retrying 21:32:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 21:32:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:32:30 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:32:30 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 21:32:30 INFO - Caught exception: HTTP Error 404: Not Found 21:32:30 INFO - Caught exception: HTTP Error 404: Not Found 21:32:30 INFO - Caught exception: HTTP Error 404: Not Found 21:32:30 INFO - trying https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:32:30 INFO - Downloading https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:32:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:32:31 INFO - Downloaded 1327 bytes. 21:32:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 21:32:31 INFO - Using the following test package requirements: 21:32:31 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 21:32:31 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:32:31 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 21:32:31 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:32:31 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 21:32:31 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:32:31 INFO - u'jsshell-linux-x86_64.zip'], 21:32:31 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:32:31 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 21:32:31 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 21:32:31 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:32:31 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 21:32:31 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:32:31 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 21:32:31 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:32:31 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 21:32:31 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 21:32:31 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 21:32:31 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:32:31 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:32:31 INFO - https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:32:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:32:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:32:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:32:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:32:31 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:32:31 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:32:31 INFO - retry: Failed, sleeping 30 seconds before retrying 21:33:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 21:33:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:33:01 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:33:01 INFO - retry: Failed, sleeping 60 seconds before retrying 21:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 21:34:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:34:01 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:34:01 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 21:34:01 INFO - Caught exception: HTTP Error 404: Not Found 21:34:01 INFO - Caught exception: HTTP Error 404: Not Found 21:34:01 INFO - Caught exception: HTTP Error 404: Not Found 21:34:01 INFO - trying https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:34:01 INFO - Downloading https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:34:02 INFO - Downloaded 21774592 bytes. 21:34:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:34:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:34:03 INFO - Return code: 0 21:34:03 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:34:03 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:34:03 INFO - https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:34:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:34:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:34:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:34:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:34:03 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:34:03 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:34:03 INFO - retry: Failed, sleeping 30 seconds before retrying 21:34:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 21:34:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:34:33 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:34:33 INFO - retry: Failed, sleeping 60 seconds before retrying 21:35:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 21:35:33 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:35:33 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:35:33 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 21:35:33 INFO - Caught exception: HTTP Error 404: Not Found 21:35:33 INFO - Caught exception: HTTP Error 404: Not Found 21:35:33 INFO - Caught exception: HTTP Error 404: Not Found 21:35:33 INFO - trying https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:35:33 INFO - Downloading https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 21:35:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:35:34 INFO - Downloaded 21774592 bytes. 21:35:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:35:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:35:35 INFO - Return code: 0 21:35:35 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:35:35 INFO - https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:35:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 21:35:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 21:35:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 21:35:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:35:35 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 21:35:35 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:35:35 INFO - retry: Failed, sleeping 30 seconds before retrying 21:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 21:36:05 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 21:36:05 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:36:05 INFO - retry: Failed, sleeping 60 seconds before retrying 21:37:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 21:37:05 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 21:37:05 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:37:05 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 21:37:05 INFO - Caught exception: HTTP Error 404: Not Found 21:37:05 INFO - Caught exception: HTTP Error 404: Not Found 21:37:05 INFO - Caught exception: HTTP Error 404: Not Found 21:37:05 INFO - trying https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 21:37:05 INFO - Downloading https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 21:37:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:37:06 INFO - Downloaded 14413762 bytes. 21:37:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:37:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:37:06 INFO - Return code: 0 21:37:06 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:37:06 INFO - https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:37:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:37:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:37:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:37:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:37:06 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:37:06 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 21:37:06 INFO - retry: Failed, sleeping 30 seconds before retrying 21:37:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 21:37:36 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:37:36 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 21:37:36 INFO - retry: Failed, sleeping 60 seconds before retrying 21:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 21:38:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:38:37 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 21:38:37 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 21:38:37 INFO - Caught exception: HTTP Error 404: Not Found 21:38:37 INFO - Caught exception: HTTP Error 404: Not Found 21:38:37 INFO - Caught exception: HTTP Error 404: Not Found 21:38:37 INFO - trying https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:38:37 INFO - Downloading https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:38:38 INFO - Downloaded 56798856 bytes. 21:38:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:38:38 INFO - mkdir: /builds/slave/test/properties 21:38:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:38:38 INFO - Writing to file /builds/slave/test/properties/build_url 21:38:38 INFO - Contents: 21:38:38 INFO - build_url:https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 21:38:39 INFO - Running post-action listener: _resource_record_post_action 21:38:39 INFO - Running post-action listener: set_extra_try_arguments 21:38:39 INFO - [mozharness: 2016-10-21 04:38:39.329900Z] Finished download-and-extract step (success) 21:38:39 INFO - [mozharness: 2016-10-21 04:38:39.330134Z] Running populate-webroot step. 21:38:39 INFO - Running pre-action listener: _resource_record_pre_action 21:38:39 INFO - Running main action method: populate_webroot 21:38:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:38:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:38:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:38:39 INFO - '--tppagecycles', 21:38:39 INFO - '7'], 21:38:39 INFO - 'tests': ['tsvgm']}}, 21:38:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:38:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:38:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:38:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:38:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:38:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:38:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:39 INFO - 'talos_options': ['--disable-e10s'], 21:38:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:38:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:39 INFO - 'talos_options': ['--disable-e10s'], 21:38:39 INFO - 'tests': ['damp', 'tps']}, 21:38:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:39 INFO - 'tests': ['damp', 'tps']}, 21:38:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:38:39 INFO - 'tests': ['dromaeo_dom']}, 21:38:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:38:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:38:39 INFO - 'tests': ['basic_compositor_video']}, 21:38:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:38:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:38:39 INFO - 'tests': ['a11yr', 21:38:39 INFO - 'ts_paint', 21:38:39 INFO - 'tpaint', 21:38:39 INFO - 'sessionrestore', 21:38:39 INFO - 'sessionrestore_no_auto_restore', 21:38:39 INFO - 'tabpaint']}, 21:38:39 INFO - 'other-e10s': {'tests': ['a11yr', 21:38:39 INFO - 'ts_paint', 21:38:39 INFO - 'tpaint', 21:38:39 INFO - 'sessionrestore', 21:38:39 INFO - 'sessionrestore_no_auto_restore', 21:38:39 INFO - 'tabpaint']}, 21:38:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:38:39 INFO - 'ts_paint', 21:38:39 INFO - 'tpaint', 21:38:39 INFO - 'sessionrestore', 21:38:39 INFO - 'sessionrestore_no_auto_restore', 21:38:39 INFO - 'tabpaint']}, 21:38:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:38:39 INFO - 'ts_paint', 21:38:39 INFO - 'tpaint', 21:38:39 INFO - 'sessionrestore', 21:38:39 INFO - 'sessionrestore_no_auto_restore', 21:38:39 INFO - 'tabpaint']}, 21:38:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:38:39 INFO - 'tests': ['a11yr', 21:38:39 INFO - 'ts_paint', 21:38:39 INFO - 'tpaint', 21:38:39 INFO - 'sessionrestore', 21:38:39 INFO - 'sessionrestore_no_auto_restore', 21:38:39 INFO - 'tabpaint']}, 21:38:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:38:39 INFO - 'tests': ['a11yr', 21:38:39 INFO - 'ts_paint', 21:38:39 INFO - 'tpaint', 21:38:39 INFO - 'sessionrestore', 21:38:39 INFO - 'sessionrestore_no_auto_restore', 21:38:39 INFO - 'tabpaint']}, 21:38:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:38:39 INFO - 'tests': ['tsvgx', 21:38:39 INFO - 'tsvgr_opacity', 21:38:39 INFO - 'tart', 21:38:39 INFO - 'tscrollx', 21:38:39 INFO - 'cart']}, 21:38:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:38:39 INFO - 'tsvgr_opacity', 21:38:39 INFO - 'tart', 21:38:39 INFO - 'tscrollx', 21:38:39 INFO - 'cart']}, 21:38:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:39 INFO - 'talos_options': ['--disable-e10s'], 21:38:39 INFO - 'tests': ['tp5o']}, 21:38:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:39 INFO - 'tests': ['tp5o']}, 21:38:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:39 INFO - 'talos_options': ['--disable-e10s', 21:38:39 INFO - '--xperf_path', 21:38:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:39 INFO - 'tests': ['tp5n']}, 21:38:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:38:39 INFO - 'talos_options': ['--xperf_path', 21:38:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:38:39 INFO - 'tests': ['tp5n']}}, 21:38:39 INFO - 'talos.zip': {'path': '', 21:38:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:38:39 INFO - Running post-action listener: _resource_record_post_action 21:38:39 INFO - [mozharness: 2016-10-21 04:38:39.350550Z] Finished populate-webroot step (success) 21:38:39 INFO - [mozharness: 2016-10-21 04:38:39.350638Z] Running create-virtualenv step. 21:38:39 INFO - Running pre-action listener: _resource_record_pre_action 21:38:39 INFO - Running main action method: create_virtualenv 21:38:39 INFO - Creating virtualenv /builds/slave/test/build/venv 21:38:39 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 21:38:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:38:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:38:39 INFO - Using real prefix '/usr' 21:38:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:38:39 INFO - Installing distribute.............................................................................................................................................................................................done. 21:38:41 INFO - Installing pip.................done. 21:38:41 INFO - Return code: 0 21:38:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:38:41 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:41 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:41 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 0x1a58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16570>, '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 0x1d17470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d17900>, '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': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', '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 21:38:41 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 21:38:41 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 21:38:41 INFO - Using env: {'DISPLAY': ':0', 21:38:41 INFO - 'HOME': '/home/cltbld', 21:38:41 INFO - 'LANG': 'en_US.UTF-8', 21:38:41 INFO - 'LANGUAGE': 'en_US:en', 21:38:41 INFO - 'LOGNAME': 'cltbld', 21:38:41 INFO - 'MAIL': '/var/mail/cltbld', 21:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:41 INFO - 'MOZ_NO_REMOTE': '1', 21:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:41 INFO - 'NO_EM_RESTART': '1', 21:38:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:41 INFO - 'PWD': '/builds/slave/test', 21:38:41 INFO - 'SHELL': '/bin/bash', 21:38:41 INFO - 'SHLVL': '1', 21:38:41 INFO - 'TERM': 'linux', 21:38:41 INFO - 'TMOUT': '86400', 21:38:41 INFO - 'USER': 'cltbld', 21:38:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', 21:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:41 INFO - '_': '/tools/buildbot/bin/python'} 21:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:42 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 21:38:42 INFO - Cleaning up... 21:38:42 INFO - Return code: 0 21:38:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:38:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:42 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 0x1a58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16570>, '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 0x1d17470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d17900>, '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': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', '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 21:38:42 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 21:38:42 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 21:38:42 INFO - Using env: {'DISPLAY': ':0', 21:38:42 INFO - 'HOME': '/home/cltbld', 21:38:42 INFO - 'LANG': 'en_US.UTF-8', 21:38:42 INFO - 'LANGUAGE': 'en_US:en', 21:38:42 INFO - 'LOGNAME': 'cltbld', 21:38:42 INFO - 'MAIL': '/var/mail/cltbld', 21:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:42 INFO - 'MOZ_NO_REMOTE': '1', 21:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:42 INFO - 'NO_EM_RESTART': '1', 21:38:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:42 INFO - 'PWD': '/builds/slave/test', 21:38:42 INFO - 'SHELL': '/bin/bash', 21:38:42 INFO - 'SHLVL': '1', 21:38:42 INFO - 'TERM': 'linux', 21:38:42 INFO - 'TMOUT': '86400', 21:38:42 INFO - 'USER': 'cltbld', 21:38:42 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', 21:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:42 INFO - '_': '/tools/buildbot/bin/python'} 21:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:42 INFO - Downloading/unpacking psutil>=3.1.1 21:38:42 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 21:38:42 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 21:38:42 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 21:38:42 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 21:38:42 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 21:38:42 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 21:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:38:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:38:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:38:44 INFO - Installing collected packages: psutil 21:38:44 INFO - Running setup.py install for psutil 21:38:44 INFO - building 'psutil._psutil_linux' extension 21:38:44 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 21:38:44 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 21:38:44 INFO - building 'psutil._psutil_posix' extension 21:38:44 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 21:38:44 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 21:38:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:38:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:38:44 INFO - Successfully installed psutil 21:38:44 INFO - Cleaning up... 21:38:44 INFO - Return code: 0 21:38:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:38:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:44 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 0x1a58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16570>, '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 0x1d17470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d17900>, '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': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', '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 21:38:44 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 21:38:44 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 21:38:44 INFO - Using env: {'DISPLAY': ':0', 21:38:44 INFO - 'HOME': '/home/cltbld', 21:38:44 INFO - 'LANG': 'en_US.UTF-8', 21:38:44 INFO - 'LANGUAGE': 'en_US:en', 21:38:44 INFO - 'LOGNAME': 'cltbld', 21:38:44 INFO - 'MAIL': '/var/mail/cltbld', 21:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:44 INFO - 'MOZ_NO_REMOTE': '1', 21:38:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:44 INFO - 'NO_EM_RESTART': '1', 21:38:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:44 INFO - 'PWD': '/builds/slave/test', 21:38:44 INFO - 'SHELL': '/bin/bash', 21:38:44 INFO - 'SHLVL': '1', 21:38:44 INFO - 'TERM': 'linux', 21:38:44 INFO - 'TMOUT': '86400', 21:38:44 INFO - 'USER': 'cltbld', 21:38:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', 21:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:44 INFO - '_': '/tools/buildbot/bin/python'} 21:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:38:45 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 21:38:45 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 21:38:45 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 21:38:45 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 21:38:45 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 21:38:45 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 21:38:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:38:47 INFO - Installing collected packages: mozsystemmonitor 21:38:47 INFO - Running setup.py install for mozsystemmonitor 21:38:47 INFO - Successfully installed mozsystemmonitor 21:38:47 INFO - Cleaning up... 21:38:47 INFO - Return code: 0 21:38:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:38:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:47 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 0x1a58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16570>, '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 0x1d17470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d17900>, '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': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', '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 21:38:47 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 21:38:47 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 21:38:47 INFO - Using env: {'DISPLAY': ':0', 21:38:47 INFO - 'HOME': '/home/cltbld', 21:38:47 INFO - 'LANG': 'en_US.UTF-8', 21:38:47 INFO - 'LANGUAGE': 'en_US:en', 21:38:47 INFO - 'LOGNAME': 'cltbld', 21:38:47 INFO - 'MAIL': '/var/mail/cltbld', 21:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:47 INFO - 'MOZ_NO_REMOTE': '1', 21:38:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:47 INFO - 'NO_EM_RESTART': '1', 21:38:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:47 INFO - 'PWD': '/builds/slave/test', 21:38:47 INFO - 'SHELL': '/bin/bash', 21:38:47 INFO - 'SHLVL': '1', 21:38:47 INFO - 'TERM': 'linux', 21:38:47 INFO - 'TMOUT': '86400', 21:38:47 INFO - 'USER': 'cltbld', 21:38:47 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', 21:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:47 INFO - '_': '/tools/buildbot/bin/python'} 21:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:47 INFO - Downloading/unpacking jsonschema==2.5.1 21:38:47 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 21:38:47 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 21:38:47 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 21:38:47 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 21:38:47 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 21:38:47 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 21:38:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:38:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:38:49 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 21:38:49 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 21:38:49 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 21:38:49 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 21:38:49 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 21:38:49 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 21:38:49 INFO - Downloading functools32-3.2.3-2.tar.gz 21:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:38:49 INFO - warning: no files found matching '*.txt' 21:38:49 INFO - no previously-included directories found matching 'build' 21:38:49 INFO - no previously-included directories found matching 'dist' 21:38:49 INFO - no previously-included directories found matching '.git*' 21:38:49 INFO - Installing collected packages: jsonschema, functools32 21:38:49 INFO - Running setup.py install for functools32 21:38:49 INFO - warning: no files found matching '*.txt' 21:38:49 INFO - no previously-included directories found matching 'build' 21:38:49 INFO - no previously-included directories found matching 'dist' 21:38:49 INFO - no previously-included directories found matching '.git*' 21:38:49 INFO - Successfully installed jsonschema functools32 21:38:49 INFO - Cleaning up... 21:38:49 INFO - Return code: 0 21:38:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:38:49 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:49 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:49 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 0x1a58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16570>, '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 0x1d17470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d17900>, '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': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', '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 21:38:49 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 21:38:49 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 21:38:49 INFO - Using env: {'DISPLAY': ':0', 21:38:49 INFO - 'HOME': '/home/cltbld', 21:38:49 INFO - 'LANG': 'en_US.UTF-8', 21:38:49 INFO - 'LANGUAGE': 'en_US:en', 21:38:49 INFO - 'LOGNAME': 'cltbld', 21:38:49 INFO - 'MAIL': '/var/mail/cltbld', 21:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:49 INFO - 'MOZ_NO_REMOTE': '1', 21:38:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:49 INFO - 'NO_EM_RESTART': '1', 21:38:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:49 INFO - 'PWD': '/builds/slave/test', 21:38:49 INFO - 'SHELL': '/bin/bash', 21:38:49 INFO - 'SHLVL': '1', 21:38:49 INFO - 'TERM': 'linux', 21:38:49 INFO - 'TMOUT': '86400', 21:38:49 INFO - 'USER': 'cltbld', 21:38:49 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', 21:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:49 INFO - '_': '/tools/buildbot/bin/python'} 21:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:38:50 INFO - Cleaning up... 21:38:50 INFO - Return code: 0 21:38:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:38:50 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:50 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:50 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 0x1a58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16570>, '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 0x1d17470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d17900>, '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': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', '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 21:38:50 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 21:38:50 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 21:38:50 INFO - Using env: {'DISPLAY': ':0', 21:38:50 INFO - 'HOME': '/home/cltbld', 21:38:50 INFO - 'LANG': 'en_US.UTF-8', 21:38:50 INFO - 'LANGUAGE': 'en_US:en', 21:38:50 INFO - 'LOGNAME': 'cltbld', 21:38:50 INFO - 'MAIL': '/var/mail/cltbld', 21:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:50 INFO - 'MOZ_NO_REMOTE': '1', 21:38:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:50 INFO - 'NO_EM_RESTART': '1', 21:38:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:50 INFO - 'PWD': '/builds/slave/test', 21:38:50 INFO - 'SHELL': '/bin/bash', 21:38:50 INFO - 'SHLVL': '1', 21:38:50 INFO - 'TERM': 'linux', 21:38:50 INFO - 'TMOUT': '86400', 21:38:50 INFO - 'USER': 'cltbld', 21:38:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', 21:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:50 INFO - '_': '/tools/buildbot/bin/python'} 21:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:50 INFO - Downloading/unpacking blobuploader==1.2.4 21:38:50 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 21:38:50 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 21:38:50 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 21:38:50 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 21:38:50 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 21:38:50 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 21:38:52 INFO - Downloading blobuploader-1.2.4.tar.gz 21:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:38:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:38:52 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 21:38:52 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 21:38:52 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 21:38:52 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 21:38:52 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 21:38:52 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 21:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:38:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:38:52 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 21:38:52 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 21:38:52 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 21:38:52 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 21:38:52 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 21:38:52 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 21:38:52 INFO - Downloading docopt-0.6.1.tar.gz 21:38:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:38:52 INFO - Installing collected packages: blobuploader, requests, docopt 21:38:52 INFO - Running setup.py install for blobuploader 21:38:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:38:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:38:53 INFO - Running setup.py install for requests 21:38:53 INFO - Running setup.py install for docopt 21:38:53 INFO - Successfully installed blobuploader requests docopt 21:38:53 INFO - Cleaning up... 21:38:53 INFO - Return code: 0 21:38:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:53 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 0x1a58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16570>, '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 0x1d17470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d17900>, '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': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', '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 21:38:53 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 21:38:53 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 21:38:53 INFO - Using env: {'DISPLAY': ':0', 21:38:53 INFO - 'HOME': '/home/cltbld', 21:38:53 INFO - 'LANG': 'en_US.UTF-8', 21:38:53 INFO - 'LANGUAGE': 'en_US:en', 21:38:53 INFO - 'LOGNAME': 'cltbld', 21:38:53 INFO - 'MAIL': '/var/mail/cltbld', 21:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:53 INFO - 'MOZ_NO_REMOTE': '1', 21:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:53 INFO - 'NO_EM_RESTART': '1', 21:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:53 INFO - 'PWD': '/builds/slave/test', 21:38:53 INFO - 'SHELL': '/bin/bash', 21:38:53 INFO - 'SHLVL': '1', 21:38:53 INFO - 'TERM': 'linux', 21:38:53 INFO - 'TMOUT': '86400', 21:38:53 INFO - 'USER': 'cltbld', 21:38:53 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', 21:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:53 INFO - '_': '/tools/buildbot/bin/python'} 21:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:53 INFO - Running setup.py (path:/tmp/pip-yULO9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:53 INFO - Running setup.py (path:/tmp/pip-p3P_tn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:53 INFO - Running setup.py (path:/tmp/pip-bsVxRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:54 INFO - Running setup.py (path:/tmp/pip-ZIqhpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:54 INFO - Running setup.py (path:/tmp/pip-chYSCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:54 INFO - Running setup.py (path:/tmp/pip-NUPzFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:54 INFO - Running setup.py (path:/tmp/pip-h9EwHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:54 INFO - Running setup.py (path:/tmp/pip-BsDTvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:54 INFO - Running setup.py (path:/tmp/pip-IcMkZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:54 INFO - Running setup.py (path:/tmp/pip-wH9pva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:54 INFO - Running setup.py (path:/tmp/pip-Vht5xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:54 INFO - Running setup.py (path:/tmp/pip-gFSOTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:54 INFO - Running setup.py (path:/tmp/pip-LJ3qGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:54 INFO - Running setup.py (path:/tmp/pip-TYJt98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:54 INFO - Running setup.py (path:/tmp/pip-nwzbXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:54 INFO - Running setup.py (path:/tmp/pip-KJ9Lg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:54 INFO - Running setup.py (path:/tmp/pip-n4a_UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:38:54 INFO - Running setup.py install for manifestparser 21:38:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:38:55 INFO - Running setup.py install for mozcrash 21:38:55 INFO - Running setup.py install for mozdebug 21:38:55 INFO - Running setup.py install for mozdevice 21:38:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:38:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:38:55 INFO - Running setup.py install for mozfile 21:38:55 INFO - Running setup.py install for mozhttpd 21:38:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:38:55 INFO - Running setup.py install for mozinfo 21:38:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:38:55 INFO - Running setup.py install for mozInstall 21:38:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:38:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:38:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:38:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:38:55 INFO - Running setup.py install for mozleak 21:38:55 INFO - Running setup.py install for mozlog 21:38:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:38:56 INFO - Running setup.py install for moznetwork 21:38:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:38:56 INFO - Running setup.py install for mozprocess 21:38:56 INFO - Running setup.py install for mozprofile 21:38:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:38:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:38:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:38:56 INFO - Running setup.py install for mozrunner 21:38:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:38:56 INFO - Running setup.py install for mozscreenshot 21:38:56 INFO - Running setup.py install for moztest 21:38:56 INFO - Running setup.py install for mozversion 21:38:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:38:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:38:56 INFO - Cleaning up... 21:38:56 INFO - Return code: 0 21:38:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:38:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:56 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:38:56 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 0x1a58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16570>, '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 0x1d17470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d17900>, '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': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', '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 21:38:56 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 21:38:56 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 21:38:56 INFO - Using env: {'DISPLAY': ':0', 21:38:56 INFO - 'HOME': '/home/cltbld', 21:38:56 INFO - 'LANG': 'en_US.UTF-8', 21:38:56 INFO - 'LANGUAGE': 'en_US:en', 21:38:56 INFO - 'LOGNAME': 'cltbld', 21:38:56 INFO - 'MAIL': '/var/mail/cltbld', 21:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:38:56 INFO - 'MOZ_NO_REMOTE': '1', 21:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:38:56 INFO - 'NO_EM_RESTART': '1', 21:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:38:56 INFO - 'PWD': '/builds/slave/test', 21:38:56 INFO - 'SHELL': '/bin/bash', 21:38:56 INFO - 'SHLVL': '1', 21:38:56 INFO - 'TERM': 'linux', 21:38:56 INFO - 'TMOUT': '86400', 21:38:56 INFO - 'USER': 'cltbld', 21:38:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', 21:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:38:56 INFO - '_': '/tools/buildbot/bin/python'} 21:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:38:56 INFO - Running setup.py (path:/tmp/pip-2O6JZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:38:57 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)) 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:38:57 INFO - Running setup.py (path:/tmp/pip-U0AEK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:38:57 INFO - Running setup.py (path:/tmp/pip-RFY7UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:38:57 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)) 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:38:57 INFO - Running setup.py (path:/tmp/pip-Xq6uJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:38:57 INFO - Running setup.py (path:/tmp/pip-4bnTUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:38:57 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)) 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:38:57 INFO - Running setup.py (path:/tmp/pip-_5u9rD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:38:57 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)) 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:38:57 INFO - Running setup.py (path:/tmp/pip-PhMZAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:38:57 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)) 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:38:57 INFO - Running setup.py (path:/tmp/pip-Nkp7De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:38:57 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)) 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:38:57 INFO - Running setup.py (path:/tmp/pip-rG09JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:38:57 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)) 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:38:57 INFO - Running setup.py (path:/tmp/pip-zA8HPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:38:57 INFO - Running setup.py (path:/tmp/pip-FLQ3Et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:38:57 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)) 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:38:57 INFO - Running setup.py (path:/tmp/pip-wxpoB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:38:57 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)) 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:38:57 INFO - Running setup.py (path:/tmp/pip-wtd5_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:38:57 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)) 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:38:57 INFO - Running setup.py (path:/tmp/pip-wzvJFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 21:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:57 INFO - Running setup.py (path:/tmp/pip-r3YxBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:38:58 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)) 21:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:38:58 INFO - Running setup.py (path:/tmp/pip-qPw2pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:38:58 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)) 21:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:38:58 INFO - Running setup.py (path:/tmp/pip-_EgcE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:38:58 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)) 21:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:38:58 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)) 21:38:58 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:38:58 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:38:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:38:58 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 21:38:58 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 21:38:58 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 21:38:58 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 21:38:58 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 21:38:58 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 21:39:00 INFO - Downloading blessings-1.6.tar.gz 21:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:39:00 INFO - Installing collected packages: blessings 21:39:00 INFO - Running setup.py install for blessings 21:39:00 INFO - Successfully installed blessings 21:39:00 INFO - Cleaning up... 21:39:00 INFO - Return code: 0 21:39:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:39:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:39:00 INFO - Reading from file tmpfile_stdout 21:39:00 INFO - Current package versions: 21:39:00 INFO - argparse == 1.2.1 21:39:00 INFO - blessings == 1.6 21:39:00 INFO - blobuploader == 1.2.4 21:39:00 INFO - docopt == 0.6.1 21:39:00 INFO - functools32 == 3.2.3-2 21:39:00 INFO - jsonschema == 2.5.1 21:39:00 INFO - manifestparser == 1.1 21:39:00 INFO - mozInstall == 1.12 21:39:00 INFO - mozcrash == 0.17 21:39:00 INFO - mozdebug == 0.1 21:39:00 INFO - mozdevice == 0.48 21:39:00 INFO - mozfile == 1.2 21:39:00 INFO - mozhttpd == 0.7 21:39:00 INFO - mozinfo == 0.9 21:39:00 INFO - mozleak == 0.1 21:39:00 INFO - mozlog == 3.3 21:39:00 INFO - moznetwork == 0.27 21:39:00 INFO - mozprocess == 0.23 21:39:00 INFO - mozprofile == 0.28 21:39:00 INFO - mozrunner == 6.12 21:39:00 INFO - mozscreenshot == 0.1 21:39:00 INFO - mozsystemmonitor == 0.3 21:39:00 INFO - moztest == 0.7 21:39:00 INFO - mozversion == 1.4 21:39:00 INFO - psutil == 3.1.1 21:39:00 INFO - requests == 1.2.3 21:39:00 INFO - wsgiref == 0.1.2 21:39:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:39:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:00 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 0x1a58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16570>, '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 0x1d17470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d17900>, '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': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', '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 21:39:00 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 21:39:00 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 21:39:00 INFO - Using env: {'DISPLAY': ':0', 21:39:00 INFO - 'HOME': '/home/cltbld', 21:39:00 INFO - 'LANG': 'en_US.UTF-8', 21:39:00 INFO - 'LANGUAGE': 'en_US:en', 21:39:00 INFO - 'LOGNAME': 'cltbld', 21:39:00 INFO - 'MAIL': '/var/mail/cltbld', 21:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:00 INFO - 'MOZ_NO_REMOTE': '1', 21:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:00 INFO - 'NO_EM_RESTART': '1', 21:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:00 INFO - 'PWD': '/builds/slave/test', 21:39:00 INFO - 'SHELL': '/bin/bash', 21:39:00 INFO - 'SHLVL': '1', 21:39:00 INFO - 'TERM': 'linux', 21:39:00 INFO - 'TMOUT': '86400', 21:39:00 INFO - 'USER': 'cltbld', 21:39:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', 21:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:00 INFO - '_': '/tools/buildbot/bin/python'} 21:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:00 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)) 21:39:00 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)) 21:39:00 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)) 21:39:00 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)) 21:39:00 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)) 21:39:00 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)) 21:39:00 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)) 21:39:00 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)) 21:39:00 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)) 21:39:00 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)) 21:39:00 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)) 21:39:00 INFO - Cleaning up... 21:39:00 INFO - Return code: 0 21:39:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:39:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:00 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 0x1a58030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c87400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d16570>, '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 0x1d17470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d17900>, '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': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', '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 21:39:00 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 21:39:00 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 21:39:00 INFO - Using env: {'DISPLAY': ':0', 21:39:00 INFO - 'HOME': '/home/cltbld', 21:39:00 INFO - 'LANG': 'en_US.UTF-8', 21:39:00 INFO - 'LANGUAGE': 'en_US:en', 21:39:00 INFO - 'LOGNAME': 'cltbld', 21:39:00 INFO - 'MAIL': '/var/mail/cltbld', 21:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:00 INFO - 'MOZ_NO_REMOTE': '1', 21:39:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:00 INFO - 'NO_EM_RESTART': '1', 21:39:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:00 INFO - 'PWD': '/builds/slave/test', 21:39:00 INFO - 'SHELL': '/bin/bash', 21:39:00 INFO - 'SHLVL': '1', 21:39:00 INFO - 'TERM': 'linux', 21:39:00 INFO - 'TMOUT': '86400', 21:39:00 INFO - 'USER': 'cltbld', 21:39:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', 21:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:00 INFO - '_': '/tools/buildbot/bin/python'} 21:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:39:01 INFO - Cleaning up... 21:39:01 INFO - Return code: 0 21:39:01 INFO - Running post-action listener: _resource_record_post_action 21:39:01 INFO - Running post-action listener: _start_resource_monitoring 21:39:01 INFO - Starting resource monitoring. 21:39:01 INFO - [mozharness: 2016-10-21 04:39:01.078602Z] Finished create-virtualenv step (success) 21:39:01 INFO - [mozharness: 2016-10-21 04:39:01.079076Z] Running install step. 21:39:01 INFO - Running pre-action listener: _resource_record_pre_action 21:39:01 INFO - Running main action method: install 21:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:39:01 INFO - Reading from file tmpfile_stdout 21:39:01 INFO - Detecting whether we're running mozinstall >=1.0... 21:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:39:01 INFO - Reading from file tmpfile_stdout 21:39:01 INFO - Output received: 21:39:01 INFO - Usage: mozinstall [options] installer 21:39:01 INFO - Options: 21:39:01 INFO - -h, --help show this help message and exit 21:39:01 INFO - -d DEST, --destination=DEST 21:39:01 INFO - Directory to install application into. [default: 21:39:01 INFO - "/builds/slave/test"] 21:39:01 INFO - --app=APP Application being installed. [default: firefox] 21:39:01 INFO - mkdir: /builds/slave/test/build/application 21:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:39:15 INFO - Reading from file tmpfile_stdout 21:39:15 INFO - Output received: 21:39:15 INFO - /builds/slave/test/build/application/firefox/firefox 21:39:15 INFO - Running post-action listener: _resource_record_post_action 21:39:15 INFO - [mozharness: 2016-10-21 04:39:15.320648Z] Finished install step (success) 21:39:15 INFO - [mozharness: 2016-10-21 04:39:15.320929Z] Running run-tests step. 21:39:15 INFO - Running pre-action listener: _resource_record_pre_action 21:39:15 INFO - Running main action method: run_tests 21:39:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:39:15 INFO - Python 2.7.3 21:39:15 INFO - Return code: 0 21:39:15 INFO - grabbing minidump binary from tooltool 21:39:15 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:39:15 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 0x1d16570>, '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 0x1d17470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d17900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:39:15 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 21:39:15 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 21:39:15 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 21:39:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:39:15 INFO - Return code: 0 21:39:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:39:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:39:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:39:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:39:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:39:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:39:15 INFO - Using env: {'DISPLAY': ':0', 21:39:15 INFO - 'HOME': '/home/cltbld', 21:39:15 INFO - 'LANG': 'en_US.UTF-8', 21:39:15 INFO - 'LANGUAGE': 'en_US:en', 21:39:15 INFO - 'LOGNAME': 'cltbld', 21:39:15 INFO - 'MAIL': '/var/mail/cltbld', 21:39:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:39:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:15 INFO - 'MOZ_NO_REMOTE': '1', 21:39:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:39:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:39:15 INFO - 'NO_EM_RESTART': '1', 21:39:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:15 INFO - 'PWD': '/builds/slave/test', 21:39:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:39:15 INFO - 'SHELL': '/bin/bash', 21:39:15 INFO - 'SHLVL': '1', 21:39:15 INFO - 'TERM': 'linux', 21:39:15 INFO - 'TMOUT': '86400', 21:39:15 INFO - 'USER': 'cltbld', 21:39:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477023635.243764-857392666', 21:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:15 INFO - '_': '/tools/buildbot/bin/python'} 21:39:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:39:15 INFO - mozversion application_buildid: 20161020185050 21:39:15 INFO - mozversion application_changeset: d69e6eb5d19f81e22ddd026857e2b5b7b57d37b5 21:39:15 INFO - mozversion application_display_name: Firefox 21:39:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:39:15 INFO - mozversion application_name: Firefox 21:39:15 INFO - mozversion application_remotingname: firefox 21:39:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 21:39:15 INFO - mozversion application_vendor: Mozilla 21:39:15 INFO - mozversion application_version: 50.0 21:39:15 INFO - mozversion platform_buildid: 20161020185050 21:39:15 INFO - mozversion platform_changeset: d69e6eb5d19f81e22ddd026857e2b5b7b57d37b5 21:39:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 21:39:15 INFO - mozversion platform_version: 50.0 21:39:15 INFO - using testdate: 1477024755 21:39:15 INFO - actual date: 1477024755 21:39:15 INFO - starting webserver on 'localhost:42732' 21:39:15 INFO - SUITE-START | Running 2 tests 21:39:15 INFO - TEST-START | dromaeo_css 21:39:15 INFO - operating with platform_type : linux_ 21:39:15 INFO - Initialising browser for dromaeo_css test... 21:39:15 INFO - TEST-INFO | started process 13778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFnw28c/profile http://localhost:42732/getInfo.html) 21:39:20 INFO - PROCESS | 13778 | __metrics Screen width/height:1600/1200 21:39:20 INFO - PROCESS | 13778 | colorDepth:24 21:39:20 INFO - PROCESS | 13778 | Browser inner width/height: 1024/697 21:39:20 INFO - PROCESS | 13778 | __metrics 21:39:20 ERROR - PROCESS | 13778 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 21:39:21 INFO - TEST-INFO | 13778: exit 0 21:39:21 INFO - Browser initialized. 21:39:21 INFO - Running cycle 1/1 for dromaeo_css test... 21:39:21 INFO - TEST-INFO | started process 13908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFnw28c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:39:33 INFO - PROCESS | 13908 | RSS: Main: 150568960 21:39:33 INFO - PROCESS | 13908 | 21:40:23 INFO - PROCESS | 13908 | 1477024823198 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] 21:42:31 INFO - PROCESS | 13908 | Cycle 1(1): loaded http://localhost:42732/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42732/tests/dromaeo/cssquery-ext.html) 21:42:32 INFO - PROCESS | 13908 | RSS: Main: 157986816 21:42:32 INFO - PROCESS | 13908 | 21:45:34 INFO - PROCESS | 13908 | Cycle 1(1): loaded http://localhost:42732/tests/dromaeo/cssquery-ext.html (next: http://localhost:42732/tests/dromaeo/cssquery-jquery.html) 21:45:35 INFO - PROCESS | 13908 | RSS: Main: 155811840 21:45:35 INFO - PROCESS | 13908 | 21:48:37 INFO - PROCESS | 13908 | Cycle 1(1): loaded http://localhost:42732/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42732/tests/dromaeo/cssquery-mootools.html) 21:48:37 INFO - PROCESS | 13908 | RSS: Main: 155148288 21:48:37 INFO - PROCESS | 13908 | 21:51:39 INFO - PROCESS | 13908 | Cycle 1(1): loaded http://localhost:42732/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42732/tests/dromaeo/cssquery-prototype.html) 21:51:40 INFO - PROCESS | 13908 | RSS: Main: 156495872 21:51:40 INFO - PROCESS | 13908 | 21:54:42 INFO - PROCESS | 13908 | Cycle 1(1): loaded http://localhost:42732/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42732/tests/dromaeo/cssquery-yui.html) 21:54:43 INFO - PROCESS | 13908 | RSS: Main: 157777920 21:54:43 INFO - PROCESS | 13908 | 21:57:45 INFO - PROCESS | 13908 | Cycle 1(1): loaded http://localhost:42732/tests/dromaeo/cssquery-yui.html (next: http://localhost:42732/tests/dromaeo/cssquery-dojo.html) 21:57:45 INFO - PROCESS | 13908 | RSS: Main: 157691904 21:57:45 INFO - PROCESS | 13908 | 21:57:45 INFO - PROCESS | 13908 | __start_tp_report 21:57:45 INFO - PROCESS | 13908 | _x_x_mozilla_page_load 21:57:45 INFO - PROCESS | 13908 | _x_x_mozilla_page_load_details 21:57:45 INFO - PROCESS | 13908 | |i|pagename|runs| 21:57:45 INFO - PROCESS | 13908 | |0;dojo.html;3279.70482656561;3289.3750187464366;3306.024722706801;3306.884259050933;3333.5666363372757;5590.608657393984;5765.913511297334;5795.797147099853;5798.130280457934;5839.678817665027;5855.853603659911;5928.911066334009;5930.822075337736;5932.169496270526;5946.01890688037;5340.092184328673;5389.51494365507;5393.514583687467;5420.430854760233;5474.91787623186;5439.156930675732;5442;5442.12925931851;5448.210009548613;5448.782048718066;5282.339707536558;5341.866453338659;5394.757235924393;5396.055690254209;5415.160650099221;5396.5952553558445;5465.371482279529;5481.588880833953;5488.890222195534;5510.1459273812625;5347.304850369466;5426.348838139409;5436.510714035716;5446.2647542582035;5459.262999495097;5708.600397972144;5821.476067153934;5897.174395584621;5943.197668314765;6031.909521357183;6307.400796924285;6415.93584064158;6417.037444383333;6422.614643121381;6423.582467139621;6404.071409645575;6404.807855764335;6406.583572067801;6423;6431.710573024178;5748.45389687979;5838.591298609056;5979.641221526679;6009.128676341906;6014.909776353358;6297.181366422427;6418.903716444257;6421.101045853584;6423.74305027803;6428.357164283534;6095.969520152371;6128.233970753656;6143.1706719592285;6150;6150.169727086875;6114.2357205349335;6148.200733904653;6159.5688301818445;6237.313895471494;6237.4698150656795;6133.059244993061;6242.781502647385;6312.52656050798;6314.179156709598;6327.272363678144;6199.070139479024;6205.751769929152;6272.749090036347;6283.37166283368;6284.842878928063;4663.463701674283;4700.529947005341;4801.4958429365115;4802.327674125625;4806.447258565309;4215.051613387025;4251.617354438115;4265.317549192115;4280.464941882265;4288.078063216361;6048.092786082035;6050.878982420327;6050.909236361458;6081.27024757032;6093.238345206849;6163.691815409212;6336.88686679456;6396.744130234832;6400.423961843363;6417.807465776034;5964;6013;6022.608530445507;6092.116643086728;6112.083187521907;5441.5102640762525;5452.073147564924;5453.400125986138;5461.672299662033;5485.862853428696;6455.096286519891;6644.900326495106;6676.46588272937;6679.799606011828;6680.265170831205;6314.589551679126;6376.617402955838;6376.808695739135;6473.805785826433;6478.708458119301;6581.572197807319;6647.6676166192465;6656.134702488645;6686.297938716365;6711.127553418024;6029.3669164737075;6243.500519958302;6284.120223168668;6332.30344662096;6349.746010159542;6154.692265386802;6160.014397696347;6170.876582468415;6286.811395658137;6287.465565426807;6049.364816694359;6079.513638908788;6095.085737139465;6129.693515324305;6134.631922084689;6008.939910600838;6091.819740995785;6093.421124993119;6105.633661980118;6135.969320153371;6028;6106.1146133811235;6120.693965301806;6155.076738489262;6167.136600875791;6106.938930610637;6146.692665366803;6186.536009799193;6217.844553886189;6238.095476156022;5933.525317974465;5997.640141591519;6060.273754099677;6080.0575910733905;6126.754929802758 21:57:45 INFO - PROCESS | 13908 | |1;ext.html;598.8143675460608;620.8540992866677;652.7389044382246;660.2308310817897;704.1268826654949;41380.37929431057;45795.77102114493;45865.312020319725;45997.7700111499;46274;45809.54190458095;46196;46516.767416162955;46572.53427465724;46634.53365466344;9135.634574617008;9249.907500925006;9261.536923153815;9262.120098590623;9309.162175404212;9199.724008279762;9200;9206.49364284964;9213.631454741802;9256.583453744564;9226.861597076017;9248.768780780501;9290.907090929071;9298.395604285733;9306.674266400678;9106.726798196032;9144.954275228647;9168.770780730469;9240.630374785;9254.814903701888;9108.407953483002;9243.26053915685;9246.537673116318;9256.537173141383;9279.21126704231;42486.150276994595;42611.57388426107;42730;42817;42868.785656071836;3712.6658600726064;3930.6658933990643;4004.799760012017;4036.2129384769983;4045.491874673352;34466.82766586176;34822.303553929036;35056.82471587626;35139.1215219619;35159.648403515894;4195.622393984526;4209.6421804146685;4225.133847561243;4247.09273432065;4280.657547396201;364174;364655;366588;367100;369203;60645.39354606398;61010.389896100474;61050.38949610536;61118.38881611216;61220.38779612236;41154.38268425976;41959.580404196175;42202;42290.788546057076;42308;15912.76130858038;16039.759403608956;16047.03717776937;16047.759283610756;16058.27737751804;12535.247885126739;12539.623811285675;12566.560170393992;12590.748185036247;12603.18079324841;20281;20377.592448150954;20447.795522044587;20473.385798426072;20619.07214175366;7355.963220183972;7385.593792341473;7544.924550754532;7614.390848732088;7691.653875575613;990.6582229130938;1079.8218293981406;1117.4245263689045;1158.472894832849;1209.7943349630407;32397;33791.83104084513;34059.31881362359;34134.317313653584;34451.82774086113;1118.949647265875;1122.9157813164045;1138.7893239750672;1161.4715304536417;1237.9442925068392;17005.149742512825;17859.196336164903;17899.28402863897;18080.276788928295;18343.17455714496;637166;642600;643363;643897;653184;63377;63441.68279158575;64022.67988660027;64322.67838660777;64415.67792161009;1422.530564913576;1431.1484666623342;1445.4001589340305;1447.8262608487048;1457.7813328000884;32363.51454728134;33508.329833402706;33807.15482112967;33877.322453551285;34197.70361328566;55811.72094139503;55850.72074639601;56307.71846140743;56350;56409.43590564042;452268;454763;457115;457969;458415;31122.22194445157;31159.22101947379;31327.84336078305;31434.68565314409;31451.370972580877;52532.212016820544;53123;53864;54220;54222.45777542174;44269.557304427835;44630.3305450412;44891;45231;46296.7685161572;44332.335954352464;45591.54408456005;46055.309170361805;46464;46506.30240546327;42731.35902961396;43235.35146972735;44318.77840610776;44357.778211108736;44518.55481445144;37546.624533754315;39797.40303895386;40231.798841005606;40685;40939.7953010233;29848.701512984593;29910.401791964476;30269.69730302757;30826;30940.381192376477 21:57:45 INFO - PROCESS | 13908 | |2;jquery.html;423.5816287147819;425.53616557951824;432.55014784623995;438.1434295951415;447.1794257537419;18924.24303027879;20614.587708245825;20821.68767468489;21667.34997950064;21739.891300543473;19923.402297931087;20573.27993520227;20929.47676308093;21048.473788155305;21067.68398474024;5399.892002159964;5599.580031497654;5913.201717768089;5920.407959204088;5923.970380148115;5910.911336329937;5921.970390148043;5931.169636250928;5938.910916336258;5945.256842894638;5866.501347385456;5869.85325366865;5894.410558944092;5900.232969713953;5911.645301281937;5808.6224395414165;5831.970840145794;5862.14998825168;5874.289800945617;5884.087966365178;5034.521720436553;5117.513836185556;5130.820421285274;5141.074606570815;5171.172612382038;13976.231307278096;15458.922705386514;21592.89203553988;22575.209867654718;22575.774242257532;2499.1627804685454;2527.7093134289607;2554.348641096527;2659.1091984185323;3021.501452260374;10541.209409294257;10567.947160264226;10643.680689579325;10672;11130.777384452265;2024.7975202479781;2054.3631474242884;2102.95794084119;2115.4922818523596;2177.967330490044;76764;85181.57409212977;85843.57078214631;87659.56170219171;88904.99999999936;11649.59226427071;11950.282983021047;12046.879531204751;12371.6907077322;12418.689532761573;17566.29734810619;17580.736288955675;17584.56038599045;17597.7360339595;17598.648027039388;8491.320694344438;8567.485950842969;8624.094470080676;8694.869576956351;8714.912850871537;8148.837023259502;8165.346772258205;8342.499450033018;8349.081601023883;8373.288270496954;5041.521055499722;5125.846224613268;5156.149235376196;5211.5830733541225;5225.790968361299;2012.7282816819543;2021.1713197588917;2074.2532688232222;2132.147141143524;2206.9558608827733;924.995375023134;1014.1430491234895;1021.5607288865859;1033.204432586904;1092.8743194532572;20271;20987.475313117295;21065.26271580518;21121.471963200736;21157.576848463254;1035.435687550287;1052.952617132231;1068.5031460370965;1094.8084085285043;1113.04834366617;11093.16801239894;11630.76738465226;11891.227070240408;11993.760124797454;12008.879911200776;577564;583194;585334;589639;598146;95650;97940.51029744948;98081;99554.5022274884;101093.49453252686;1015.4668798880647;1037.818381783185;1046.7383154211295;1047.3035431438161;1051.5636011055326;18175.727364089813;18458;18570.95719470884;18661.440156795317;18681.906590466962;43462.34806477969;44089;44304.778476107414;44810;46061.76969115133;59686;60585.39414605797;60713.392866070775;60809.39190608214;61062.69468652628;9328.720138395858;9444.669436569688;9467.95266023693;9498.85751713711;9565.617375305188;11568;13618.455261789417;13896.51362202318;14268.500602478864;14444.85555144477;11896.464659090534;12419.441125149571;12578;13006.414711337824;13423.731525369632;12298.20061695987;12398.752024959631;12869.742605147658;12876.420561074587;13035;5644.9435505644415;11727.706807329885;12452;12598.370081496072;12929.288889111189;9262;9370.437773733325;9386.95306523463;9604.471754053595;9669.806603868024;10820.4048777318;11168.385738784445;12769.872301276868;12830;12957.740845183233 21:57:45 INFO - PROCESS | 13908 | |3;mootools.html;1540.7765873948274;1559.8128224613044;1706.15545305074;1769.9115044247785;1800.162924240228;8628.223459888608;9201.81596368073;9340.626374944994;9885.555150018248;9910.653127140542;9242.30682698797;9544.80910381792;9602.711918642452;9612.18296444803;9621.134097931184;2476.4428003699113;2528.5575024370755;2529.3170843872235;2530.215633153719;2534.214393538;2434.1237154624323;2529.051605647882;2543.8855251513633;2551.9872400638064;2555.029088946207;2519.282004628681;2520.2565243253284;2547.821652484327;2560.50070236304;2560.513502434541;2487.4900645367748;2495.70051593809;2510.347309699482;2513.1078467144266;2516.19481765835;2474.6411770293385;2476.3561474016706;2485.465624890639;2486.527559763639;2516.509280690266;9777.560009799576;9791.118799308097;9835.262355323379;9836;9846.753831154278;5691.971540142315;5778.942210577925;5840.182374467578;5845.064789633639;5846.50304724099;3606.495090687306;3685.94471082934;3713.517242758451;3761.492198553188;3770.2082562661876;1272.9299888506127;1311.698309388846;1317.5520323090195;1326.098253187832;1349.5074297881301;13888.166709997433;13973.301334933212;13988.300584970813;14084.225367604779;14085.577432677037;4958.677685950402;4959.677620954626;5059.519345662156;5106.361704786902;5187.118189907725;11365.886341136647;11432.14258930567;11438.485268162953;11456.94271528637;11531.596394126165;5731.770729170787;5780.046292361797;5781.971090144522;5790.073588225948;5796.681182534917;5209.166533354645;5296.92054619181;5328.17413300939;5412.512873841373;5413.783448662089;4178.582141785858;4256.722983105056;4279.475109685301;4294.463192100988;4321.135772845443;1248.9375531223402;1255.6421419895469;1256.4032084759665;1263.557754785836;1265.702559898423;967.0136460809935;992.0674565908023;1029.629333439961;1030.5723124903081;1037.6264544763878;6267.843303917439;6321;6324.936750632527;6422.261439934374;6461.709223084972;494.49314452685564;497.04815278740807;510.3442076931126;512.5899280575525;519.3145048535896;4404.4494438195225;4481.708688935209;4558.931616025762;4562.201614717411;4604.217283061887;11888.762224755457;12329.815052774216;12349.444275007647;12367.62897113088;12369.443375048144;10917.945410272898;12232.327222002697;12275.2021118627;12284.14011019238;12286.75426491465;8698.73903782875;9064.274858011344;9064.592093355815;9083.909160908439;9083.954580227057;6616.470682345497;6741.797746067626;6766.695498702668;6789.89815152783;6937.063496427918;11014.1739369546;11019.283746556448;11346.319220846775;11451.713707157387;11534.884651153381;11299.943500282774;11395.145364097893;11420.600278990196;11522.251053681484;11588.072954163477;8159.592020399075;8442.788930276547;8455.577221138796;8565.100664430394;8705.564721764013;9677.516124193622;9715.417074975525;9724.27067969891;9728.951355243178;9805.558749856416;7582.924170758442;7638.656260468403;7820.413468989735;7858.646360913887;8083.434159609006;8434.662613495637;8499.235068843835;8501.744947651581;8563;8678.175573320525;7557.093148822177;7745.225477452435;7817.609119544114;7829.569373684502;7870.331021863206;5572.60991730575;5629.4652008059165;5725.398833122629;5804.100364443518;5937.495312898452;5696.487316141567;5773.04744717117;5866.149408335853;5912.532376967592;5985.072313791369 21:57:45 INFO - PROCESS | 13908 | |4;prototype.html;358.7542533364647;359.1577750175837;361.2684314263616;364.12246485968814;368.9151495156114;5661.490465858072;5794.913076303848;5795.246617939667;5816.389279125689;5865.155399631176;5773.220615216955;5805.535557155428;5809.6804675742815;5853.941460585393;5862.120681897717;4598.402207712993;4599.6320294376455;4608.400907881971;4631.791569379369;4656.5343465653505;4514.322851572274;4530.184566777979;4609.124266389392;4609.769511524427;4648.558386953251;4554.84058057968;4570;4571.725696458223;4583.72497650142;4585.610223131038;4383.452068491439;4597.126545956291;4597.747123908183;4638.536146385368;4638.97680511597;3999.7800120993334;4009.558948515661;4011.197760447893;4043.3126368517424;4054.513458384983;5655.632383895034;5679.432056794288;5684.602077854552;5714.028660112254;5748.5975981681295;5154.742262886841;5239.476052394768;5249.081410753103;5276.577873770089;5276.683398996072;6025;6036.185115009462;6064.484518815906;6069.211002569682;6171.783987560459;4414.955850441486;4425.5174516537;4433.536932812164;4451.799669014869;4457.175422546839;6196.225471816023;6351.809445716682;6420.646864422455;6423.42189202974;6425.967870160666;4532.297493888386;4538.500764915857;4554.544545545486;4560.589546940725;4562.520935301812;4629.055796565451;4643.349931009594;4649.5350464953235;4649.8840278332955;4652.185867473247;5148.4851514848215;5220.608454365938;5225.399079105876;5259.605529585297;5288.444713305124;5908.675022873783;6048;6071.180390647294;6082.300535438481;6083.817485475354;1562.3516240759957;1578.6053486628343;1584.9286782094835;1588.9046657200374;1595.170511334123;982.832918403873;1001.7645853224486;1013.2755080117752;1024.0067134879155;1024.4775164665925;5248.212768084818;5256.763445644955;5270.552003079704;5273.709945952933;5297.311349524537;5475;5506.229127922094;5528.391876893538;5543.447834606317;5582.218489411485;4948.90102197954;5159.974200128975;5196.454372290855;5206.9586082782835;5216.58267338612;2922.7954043217196;2923.3714751328566;2955.12823717004;2955.157780032723;2973.8513074346197;5625.803096891589;5687.60186786921;5702.885942281131;5775.306963164363;5795.262055973873;5990.550708696778;6419.422251997343;6463;6477.708503117371;6492.67536623167;6612.371824676648;6631.900521492182;6639.402453779183;6663.800085997428;6665;6180.45488627843;6337.4613157882095;6355.428011478989;6362.72745450921;6422.42198202164;6252.1559589456665;6257.092721555258;6300.527460440577;6307.463865571478;6324.335944725922;6339.619622822645;6578.2567619579895;6591.901121483085;6638.767643132467;6650.235222949423;4488.887777805581;4511.909761804811;4524.977375113103;4566.70316429431;4567.132244873464;6197.225346831646;6412.679366031586;6449.193850768654;6449.4840412765925;6457.6771161442675;6183.350748171557;6206.875862482815;6216;6217.595856269328;6240.438360547572;6051.273847138372;6222.81331560054;6246.312905580474;6261.372043268691;6294.905576416449;6200.3179650239335;6207.937920620917;6215.192025036717;6221.222347206599;6230.937690623035;6238.313785483502;6247.500999600196;6286.591371560834;6333.65164915934;6336.334684858023;5842.444967728059;6038.365971572922;6047.576669633084;6077;6138.4525421951175 21:57:45 INFO - PROCESS | 13908 | |5;yui.html;784.8351846112316;811.0105671081283;829.7966998085468;847.6312803930286;869.2263885142222;15202.847971520281;15696.764548531766;16123.516294511168;18005;18257.54356141097;16396.426125085625;16398.26207820648;16543.172841357915;16554.751678724828;16567.585810354718;839.9328053755685;846.5132548784443;855.247382303572;870.3211495033884;871.7123349294718;857.9270761985208;859.1537335724306;859.1837754133567;860.7977125375531;864.7016779211162;905.4069584422214;906.995465022674;908.5230254116576;912.069688917304;912.2246090822814;902.2466240689032;903.1239697493421;904.479924043671;906.1708536688922;907.6097278170417;665.3845193196274;667.0594461808874;667.9165104361955;669.1568623534333;670.24597328006;16313;16318;16531.91734041334;16549.83450165507;16644.58388540284;14380.137191768526;14512.637184070378;14519.927400363036;14645.853541464556;14795.482158124414;11852;11955.163138580303;12001.63995080149;12130.878691213064;12249.265044097383;4044.4135600337786;4085.2734811034898;4091.693123015756;4104.753714777123;4117.3206420940505;87499.56250218772;87663;88466.55766721189;88496.11503885007;88631;11817.172797904064;11830.349330786888;11862.940685296691;11934.761304773856;12087.153899227145;23071.653925191134;23224.954877030574;23273.650895236584;23303.41741456477;23431.41421464477;9165.633374665073;9371.953140234255;9447.338686291894;9483.715488535356;9619.27855410847;4845.878853028632;4885.877853053631;4993.101241776515;5046.84859454217;5102.107131252016;3712.406015037581;3843.7693738375788;3869.07142285855;3869.7871617061332;3873.0898238913833;581.3663107213158;682.1711620381261;686.8145600687886;689.8551304226069;690.1235431002699;618.3044075415158;674.4638012779852;710.7192658899705;712.1845486917554;713.3971793834305;9545.47499887499;10224;10325.63860264887;10423;10715.678529643967;711.6477343714894;712.803978905805;723.9203687594361;734.0090877315688;762.0931092000502;4843.39457567804;4892.217245240816;4987.875303117378;5048.242763585418;5103.591712663052;95613;124624;132584.33707831398;138550;139282;111763;117665;117819.41090294493;118200.40899795447;119028;101608;104754;105054.47472762587;106256.46871765592;107519;9222.538873056186;9284.118008789153;9447.14975652167;9467.715968520955;9694.660686875926;58886.705566471894;59403.702981484814;60135;60467.69766151141;62513.374866252576;81513.18486815294;88060;89822.55088724515;90498;91592;12355.505779769068;12423.875761242272;12489.18820276679;12508.624741257778;12583.433745481292;14285.214313212873;14450.566483005527;14495;14881.627959301104;15278.465253716067;15159.848401515843;15366.923165384549;15372.308246128727;15693.686126277182;16480.34078636841;15132.546023619308;15446.84553154499;15641.921790390976;15826.762598560801;16020.599485012968;12653.304068276333;12773.744525109632;13047.34763261814;14934.850651493345;15130.697386051997;12423.62729118128;13009.739805204032;13060.020498462463;13103.410346534238;13334.533291334757;13911.443542258601;13950.372233249325;14085.647858803612;14157.646058848199;14223 21:57:45 INFO - PROCESS | 13908 | __end_tp_report 21:57:45 INFO - PROCESS | 13908 | __start_cc_report 21:57:45 INFO - PROCESS | 13908 | _x_x_mozilla_cycle_collect,337 21:57:45 INFO - PROCESS | 13908 | __end_cc_report 21:57:45 INFO - PROCESS | 13908 | __startTimestamp1477025865676__endTimestamp 21:57:45 INFO - PROCESS | 13908 | 21:57:45 INFO - PROCESS | 13908 | ------- Summary: start ------- 21:57:45 INFO - PROCESS | 13908 | Number of tests: 6 21:57:45 INFO - PROCESS | 13908 | 21:57:45 INFO - PROCESS | 13908 | [#0] dojo.html Cycles:165 Average:5863.96 Median:6092.12 stddev:684.46 (11.2%) stddev-sans-first:655.85 21:57:45 INFO - PROCESS | 13908 | Values: 3279.7 3289.4 3306.0 3306.9 3333.6 5590.6 5765.9 5795.8 5798.1 5839.7 5855.9 5928.9 5930.8 5932.2 5946.0 5340.1 5389.5 5393.5 5420.4 5474.9 5439.2 5442.0 5442.1 5448.2 5448.8 5282.3 5341.9 5394.8 5396.1 5415.2 5396.6 5465.4 5481.6 5488.9 5510.1 5347.3 5426.3 5436.5 5446.3 5459.3 5708.6 5821.5 5897.2 5943.2 6031.9 6307.4 6415.9 6417.0 6422.6 6423.6 6404.1 6404.8 6406.6 6423.0 6431.7 5748.5 5838.6 5979.6 6009.1 6014.9 6297.2 6418.9 6421.1 6423.7 6428.4 6096.0 6128.2 6143.2 6150.0 6150.2 6114.2 6148.2 6159.6 6237.3 6237.5 6133.1 6242.8 6312.5 6314.2 6327.3 6199.1 6205.8 6272.7 6283.4 6284.8 4663.5 4700.5 4801.5 4802.3 4806.4 4215.1 4251.6 4265.3 4280.5 4288.1 6048.1 6050.9 6050.9 6081.3 6093.2 6163.7 6336.9 6396.7 6400.4 6417.8 5964.0 6013.0 6022.6 6092.1 6112.1 5441.5 5452.1 5453.4 5461.7 5485.9 6455.1 6644.9 6676.5 6679.8 6680.3 6314.6 6376.6 6376.8 6473.8 6478.7 6581.6 6647.7 6656.1 6686.3 6711.1 6029.4 6243.5 6284.1 6332.3 6349.7 6154.7 6160.0 6170.9 6286.8 6287.5 6049.4 6079.5 6095.1 6129.7 6134.6 6008.9 6091.8 6093.4 6105.6 6136.0 6028.0 6106.1 6120.7 6155.1 6167.1 6106.9 6146.7 6186.5 6217.8 6238.1 5933.5 5997.6 6060.3 6080.1 6126.8 21:57:45 INFO - PROCESS | 13908 | 21:57:45 INFO - PROCESS | 13908 | [#1] ext.html Cycles:180 Average:65242.79 Median:43052.07 stddev:133718.60 (310.6%) stddev-sans-first:134005.63 21:57:45 INFO - PROCESS | 13908 | Values: 598.8 620.9 652.7 660.2 704.1 41380.4 45795.8 45865.3 45997.8 46274.0 45809.5 46196.0 46516.8 46572.5 46634.5 9135.6 9249.9 9261.5 9262.1 9309.2 9199.7 9200.0 9206.5 9213.6 9256.6 9226.9 9248.8 9290.9 9298.4 9306.7 9106.7 9145.0 9168.8 9240.6 9254.8 9108.4 9243.3 9246.5 9256.5 9279.2 42486.2 42611.6 42730.0 42817.0 42868.8 3712.7 3930.7 4004.8 4036.2 4045.5 34466.8 34822.3 35056.8 35139.1 35159.6 4195.6 4209.6 4225.1 4247.1 4280.7 364174.0 364655.0 366588.0 367100.0 369203.0 60645.4 61010.4 61050.4 61118.4 61220.4 41154.4 41959.6 42202.0 42290.8 42308.0 15912.8 16039.8 16047.0 16047.8 16058.3 12535.2 12539.6 12566.6 12590.7 12603.2 20281.0 20377.6 20447.8 20473.4 20619.1 7356.0 7385.6 7544.9 7614.4 7691.7 990.7 1079.8 1117.4 1158.5 1209.8 32397.0 33791.8 34059.3 34134.3 34451.8 1118.9 1122.9 1138.8 1161.5 1237.9 17005.1 17859.2 17899.3 18080.3 18343.2 637166.0 642600.0 643363.0 643897.0 653184.0 63377.0 63441.7 64022.7 64322.7 64415.7 1422.5 1431.1 1445.4 1447.8 1457.8 32363.5 33508.3 33807.2 33877.3 34197.7 55811.7 55850.7 56307.7 56350.0 56409.4 452268.0 454763.0 457115.0 457969.0 458415.0 31122.2 31159.2 31327.8 31434.7 31451.4 52532.2 53123.0 53864.0 54220.0 54222.5 44269.6 44630.3 44891.0 45231.0 46296.8 44332.3 45591.5 46055.3 46464.0 46506.3 42731.4 43235.4 44318.8 44357.8 44518.6 37546.6 39797.4 40231.8 40685.0 40939.8 29848.7 29910.4 30269.7 30826.0 30940.4 21:57:45 INFO - PROCESS | 13908 | 21:57:45 INFO - PROCESS | 13908 | [#2] jquery.html Cycles:180 Average:32485.27 Median:2192.46 stddev:96442.95 (4398.8%) stddev-sans-first:96683.45 21:57:45 INFO - PROCESS | 13908 | Values: 423.6 425.5 432.6 438.1 447.2 18924.2 20614.6 20821.7 21667.3 21739.9 19923.4 20573.3 20929.5 21048.5 21067.7 5399.9 5599.6 5913.2 5920.4 5924.0 5910.9 5922.0 5931.2 5938.9 5945.3 5866.5 5869.9 5894.4 5900.2 5911.6 5808.6 5832.0 5862.1 5874.3 5884.1 5034.5 5117.5 5130.8 5141.1 5171.2 13976.2 15458.9 21592.9 22575.2 22575.8 2499.2 2527.7 2554.3 2659.1 3021.5 10541.2 10567.9 10643.7 10672.0 11130.8 2024.8 2054.4 2103.0 2115.5 2178.0 76764.0 85181.6 85843.6 87659.6 88905.0 11649.6 11950.3 12046.9 12371.7 12418.7 17566.3 17580.7 17584.6 17597.7 17598.6 8491.3 8567.5 8624.1 8694.9 8714.9 8148.8 8165.3 8342.5 8349.1 8373.3 5041.5 5125.8 5156.1 5211.6 5225.8 2012.7 2021.2 2074.3 2132.1 2207.0 925.0 1014.1 1021.6 1033.2 1092.9 20271.0 20987.5 21065.3 21121.5 21157.6 1035.4 1053.0 1068.5 1094.8 1113.0 11093.2 11630.8 11891.2 11993.8 12008.9 577564.0 583194.0 585334.0 589639.0 598146.0 95650.0 97940.5 98081.0 99554.5 101093.5 1015.5 1037.8 1046.7 1047.3 1051.6 18175.7 18458.0 18571.0 18661.4 18681.9 43462.3 44089.0 44304.8 44810.0 46061.8 59686.0 60585.4 60713.4 60809.4 61062.7 9328.7 9444.7 9468.0 9498.9 9565.6 11568.0 13618.5 13896.5 14268.5 14444.9 11896.5 12419.4 12578.0 13006.4 13423.7 12298.2 12398.8 12869.7 12876.4 13035.0 5644.9 11727.7 12452.0 12598.4 12929.3 9262.0 9370.4 9387.0 9604.5 9669.8 10820.4 11168.4 12769.9 12830.0 12957.7 21:57:45 INFO - PROCESS | 13908 | 21:57:45 INFO - PROCESS | 13908 | [#3] mootools.html Cycles:180 Average:6387.99 Median:2728.36 stddev:3713.36 (136.1%) stddev-sans-first:3705.92 21:57:45 INFO - PROCESS | 13908 | Values: 1540.8 1559.8 1706.2 1769.9 1800.2 8628.2 9201.8 9340.6 9885.6 9910.7 9242.3 9544.8 9602.7 9612.2 9621.1 2476.4 2528.6 2529.3 2530.2 2534.2 2434.1 2529.1 2543.9 2552.0 2555.0 2519.3 2520.3 2547.8 2560.5 2560.5 2487.5 2495.7 2510.3 2513.1 2516.2 2474.6 2476.4 2485.5 2486.5 2516.5 9777.6 9791.1 9835.3 9836.0 9846.8 5692.0 5778.9 5840.2 5845.1 5846.5 3606.5 3685.9 3713.5 3761.5 3770.2 1272.9 1311.7 1317.6 1326.1 1349.5 13888.2 13973.3 13988.3 14084.2 14085.6 4958.7 4959.7 5059.5 5106.4 5187.1 11365.9 11432.1 11438.5 11456.9 11531.6 5731.8 5780.0 5782.0 5790.1 5796.7 5209.2 5296.9 5328.2 5412.5 5413.8 4178.6 4256.7 4279.5 4294.5 4321.1 1248.9 1255.6 1256.4 1263.6 1265.7 967.0 992.1 1029.6 1030.6 1037.6 6267.8 6321.0 6324.9 6422.3 6461.7 494.5 497.0 510.3 512.6 519.3 4404.4 4481.7 4558.9 4562.2 4604.2 11888.8 12329.8 12349.4 12367.6 12369.4 10917.9 12232.3 12275.2 12284.1 12286.8 8698.7 9064.3 9064.6 9083.9 9084.0 6616.5 6741.8 6766.7 6789.9 6937.1 11014.2 11019.3 11346.3 11451.7 11534.9 11299.9 11395.1 11420.6 11522.3 11588.1 8159.6 8442.8 8455.6 8565.1 8705.6 9677.5 9715.4 9724.3 9729.0 9805.6 7582.9 7638.7 7820.4 7858.6 8083.4 8434.7 8499.2 8501.7 8563.0 8678.2 7557.1 7745.2 7817.6 7829.6 7870.3 5572.6 5629.5 5725.4 5804.1 5937.5 5696.5 5773.0 5866.1 5912.5 5985.1 21:57:45 INFO - PROCESS | 13908 | 21:57:45 INFO - PROCESS | 13908 | [#4] prototype.html Cycles:180 Average:5107.89 Median:5658.56 stddev:1512.95 (26.7%) stddev-sans-first:1474.61 21:57:45 INFO - PROCESS | 13908 | Values: 358.8 359.2 361.3 364.1 368.9 5661.5 5794.9 5795.2 5816.4 5865.2 5773.2 5805.5 5809.7 5853.9 5862.1 4598.4 4599.6 4608.4 4631.8 4656.5 4514.3 4530.2 4609.1 4609.8 4648.6 4554.8 4570.0 4571.7 4583.7 4585.6 4383.5 4597.1 4597.7 4638.5 4639.0 3999.8 4009.6 4011.2 4043.3 4054.5 5655.6 5679.4 5684.6 5714.0 5748.6 5154.7 5239.5 5249.1 5276.6 5276.7 6025.0 6036.2 6064.5 6069.2 6171.8 4415.0 4425.5 4433.5 4451.8 4457.2 6196.2 6351.8 6420.6 6423.4 6426.0 4532.3 4538.5 4554.5 4560.6 4562.5 4629.1 4643.3 4649.5 4649.9 4652.2 5148.5 5220.6 5225.4 5259.6 5288.4 5908.7 6048.0 6071.2 6082.3 6083.8 1562.4 1578.6 1584.9 1588.9 1595.2 982.8 1001.8 1013.3 1024.0 1024.5 5248.2 5256.8 5270.6 5273.7 5297.3 5475.0 5506.2 5528.4 5543.4 5582.2 4948.9 5160.0 5196.5 5207.0 5216.6 2922.8 2923.4 2955.1 2955.2 2973.9 5625.8 5687.6 5702.9 5775.3 5795.3 5990.6 6419.4 6463.0 6477.7 6492.7 6612.4 6631.9 6639.4 6663.8 6665.0 6180.5 6337.5 6355.4 6362.7 6422.4 6252.2 6257.1 6300.5 6307.5 6324.3 6339.6 6578.3 6591.9 6638.8 6650.2 4488.9 4511.9 4525.0 4566.7 4567.1 6197.2 6412.7 6449.2 6449.5 6457.7 6183.4 6206.9 6216.0 6217.6 6240.4 6051.3 6222.8 6246.3 6261.4 6294.9 6200.3 6207.9 6215.2 6221.2 6230.9 6238.3 6247.5 6286.6 6333.7 6336.3 5842.4 6038.4 6047.6 6077.0 6138.5 21:57:45 INFO - PROCESS | 13908 | 21:57:45 INFO - PROCESS | 13908 | [#5] yui.html Cycles:180 Average:23594.36 Median:3869.43 stddev:34937.56 (902.9%) stddev-sans-first:34993.59 21:57:45 INFO - PROCESS | 13908 | Values: 784.8 811.0 829.8 847.6 869.2 15202.8 15696.8 16123.5 18005.0 18257.5 16396.4 16398.3 16543.2 16554.8 16567.6 839.9 846.5 855.2 870.3 871.7 857.9 859.2 859.2 860.8 864.7 905.4 907.0 908.5 912.1 912.2 902.2 903.1 904.5 906.2 907.6 665.4 667.1 667.9 669.2 670.2 16313.0 16318.0 16531.9 16549.8 16644.6 14380.1 14512.6 14519.9 14645.9 14795.5 11852.0 11955.2 12001.6 12130.9 12249.3 4044.4 4085.3 4091.7 4104.8 4117.3 87499.6 87663.0 88466.6 88496.1 88631.0 11817.2 11830.3 11862.9 11934.8 12087.2 23071.7 23225.0 23273.7 23303.4 23431.4 9165.6 9372.0 9447.3 9483.7 9619.3 4845.9 4885.9 4993.1 5046.8 5102.1 3712.4 3843.8 3869.1 3869.8 3873.1 581.4 682.2 686.8 689.9 690.1 618.3 674.5 710.7 712.2 713.4 9545.5 10224.0 10325.6 10423.0 10715.7 711.6 712.8 723.9 734.0 762.1 4843.4 4892.2 4987.9 5048.2 5103.6 95613.0 124624.0 132584.3 138550.0 139282.0 111763.0 117665.0 117819.4 118200.4 119028.0 101608.0 104754.0 105054.5 106256.5 107519.0 9222.5 9284.1 9447.1 9467.7 9694.7 58886.7 59403.7 60135.0 60467.7 62513.4 81513.2 88060.0 89822.6 90498.0 91592.0 12355.5 12423.9 12489.2 12508.6 12583.4 14285.2 14450.6 14495.0 14881.6 15278.5 15159.8 15366.9 15372.3 15693.7 16480.3 15132.5 15446.8 15641.9 15826.8 16020.6 12653.3 12773.7 13047.3 14934.9 15130.7 12423.6 13009.7 13060.0 13103.4 13334.5 13911.4 13950.4 14085.6 14157.6 14223.0 21:57:45 INFO - PROCESS | 13908 | -------- Summary: end -------- 21:57:45 INFO - PROCESS | 13908 | 21:57:46 INFO - TEST-INFO | 13908: exit 0 21:57:46 INFO - TEST-OK | dromaeo_css | took 1110792ms 21:57:46 INFO - TEST-START | kraken 21:57:46 INFO - operating with platform_type : linux_ 21:57:46 INFO - Initialising browser for kraken test... 21:57:46 INFO - TEST-INFO | started process 14146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfirm40/profile http://localhost:42732/getInfo.html) 21:57:50 INFO - PROCESS | 14146 | __metrics Screen width/height:1600/1200 21:57:50 INFO - PROCESS | 14146 | colorDepth:24 21:57:50 INFO - PROCESS | 14146 | Browser inner width/height: 1024/697 21:57:50 INFO - PROCESS | 14146 | __metrics 21:57:51 ERROR - PROCESS | 14146 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 21:57:52 INFO - TEST-INFO | 14146: exit 0 21:57:52 INFO - Browser initialized. 21:57:52 INFO - Running cycle 1/1 for kraken test... 21:57:52 INFO - TEST-INFO | started process 14266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfirm40/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:58:04 INFO - PROCESS | 14266 | RSS: Main: 150548480 21:58:04 INFO - PROCESS | 14266 | 21:58:06 INFO - PROCESS | 14266 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42732/tests/kraken/driver.html?testName=audio-beat-detection) 21:58:07 INFO - PROCESS | 14266 | RSS: Main: 156946432 21:58:07 INFO - PROCESS | 14266 | 21:58:10 INFO - PROCESS | 14266 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42732/tests/kraken/driver.html?testName=audio-dft) 21:58:10 INFO - PROCESS | 14266 | RSS: Main: 155758592 21:58:10 INFO - PROCESS | 14266 | 21:58:13 INFO - PROCESS | 14266 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42732/tests/kraken/driver.html?testName=audio-fft) 21:58:14 INFO - PROCESS | 14266 | RSS: Main: 156508160 21:58:14 INFO - PROCESS | 14266 | 21:58:16 INFO - PROCESS | 14266 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42732/tests/kraken/driver.html?testName=audio-oscillator) 21:58:16 INFO - PROCESS | 14266 | RSS: Main: 155955200 21:58:16 INFO - PROCESS | 14266 | 21:58:19 INFO - PROCESS | 14266 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42732/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:58:19 INFO - PROCESS | 14266 | RSS: Main: 156352512 21:58:19 INFO - PROCESS | 14266 | 21:58:22 INFO - PROCESS | 14266 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42732/tests/kraken/driver.html?testName=imaging-darkroom) 21:58:23 INFO - PROCESS | 14266 | RSS: Main: 156229632 21:58:23 INFO - PROCESS | 14266 | 21:58:26 INFO - PROCESS | 14266 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42732/tests/kraken/driver.html?testName=imaging-desaturate) 21:58:27 INFO - PROCESS | 14266 | RSS: Main: 156594176 21:58:27 INFO - PROCESS | 14266 | 21:58:30 INFO - PROCESS | 14266 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42732/tests/kraken/driver.html?testName=json-parse-financial) 21:58:30 INFO - PROCESS | 14266 | RSS: Main: 156585984 21:58:30 INFO - PROCESS | 14266 | 21:58:32 INFO - PROCESS | 14266 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42732/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:58:33 INFO - PROCESS | 14266 | RSS: Main: 156061696 21:58:33 INFO - PROCESS | 14266 | 21:58:34 INFO - PROCESS | 14266 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:58:35 INFO - PROCESS | 14266 | RSS: Main: 156397568 21:58:35 INFO - PROCESS | 14266 | 21:58:37 INFO - PROCESS | 14266 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:58:38 INFO - PROCESS | 14266 | RSS: Main: 156815360 21:58:38 INFO - PROCESS | 14266 | 21:58:40 INFO - PROCESS | 14266 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:58:41 INFO - PROCESS | 14266 | RSS: Main: 156372992 21:58:41 INFO - PROCESS | 14266 | 21:58:43 INFO - PROCESS | 14266 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:58:44 INFO - PROCESS | 14266 | RSS: Main: 157151232 21:58:44 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42732/tests/kraken/driver.html?testName=ai-astar) 21:58:46 INFO - PROCESS | 14266 | RSS: Main: 158879744 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | __start_tp_report 21:58:46 INFO - PROCESS | 14266 | _x_x_mozilla_page_load 21:58:46 INFO - PROCESS | 14266 | _x_x_mozilla_page_load_details 21:58:46 INFO - PROCESS | 14266 | |i|pagename|runs| 21:58:46 INFO - PROCESS | 14266 | |0;ai-astar;100;111;104;109;112;110;109;109;110;110 21:58:46 INFO - PROCESS | 14266 | |1;audio-beat-detection;143;116;141;171;122;141;147;118;186;115 21:58:46 INFO - PROCESS | 14266 | |2;audio-dft;165;163;162;160;163;162;162;160;159;165 21:58:46 INFO - PROCESS | 14266 | |3;audio-fft;75;75;75;186;75;75;75;76;181;82 21:58:46 INFO - PROCESS | 14266 | |4;audio-oscillator;84;83;144;86;85;88;141;83;85;141 21:58:46 INFO - PROCESS | 14266 | |5;imaging-gaussian-blur;118;117;120;119;122;120;117;117;118;117 21:58:46 INFO - PROCESS | 14266 | |6;imaging-darkroom;147;146;147;146;146;147;146;146;146;147 21:58:46 INFO - PROCESS | 14266 | |7;imaging-desaturate;98;100;97;95;95;95;96;97;99;99 21:58:46 INFO - PROCESS | 14266 | |8;json-parse-financial;56;53;52;52;53;58;54;56;51;54 21:58:46 INFO - PROCESS | 14266 | |9;json-stringify-tinderbox;60;61;60;60;61;60;61;61;64;62 21:58:46 INFO - PROCESS | 14266 | |10;stanford-crypto-aes;75;74;75;75;73;74;73;73;81;74 21:58:46 INFO - PROCESS | 14266 | |11;stanford-crypto-ccm;120;123;120;132;134;124;127;125;174;122 21:58:46 INFO - PROCESS | 14266 | |12;stanford-crypto-pbkdf2;153;149;157;152;157;153;153;151;150;154 21:58:46 INFO - PROCESS | 14266 | |13;stanford-crypto-sha256-iterative;62;63;62;61;65;63;62;61;61;61 21:58:46 INFO - PROCESS | 14266 | __end_tp_report 21:58:46 INFO - PROCESS | 14266 | __start_cc_report 21:58:46 INFO - PROCESS | 14266 | _x_x_mozilla_cycle_collect,904 21:58:46 INFO - PROCESS | 14266 | __end_cc_report 21:58:46 INFO - PROCESS | 14266 | __startTimestamp1477025926491__endTimestamp 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | ------- Summary: start ------- 21:58:46 INFO - PROCESS | 14266 | Number of tests: 14 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:3.63 (3.3%) stddev-sans-first:2.24 21:58:46 INFO - PROCESS | 14266 | Values: 100.0 111.0 104.0 109.0 112.0 110.0 109.0 109.0 110.0 110.0 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:142.00 stddev:23.91 (16.8%) stddev-sans-first:25.34 21:58:46 INFO - PROCESS | 14266 | Values: 143.0 116.0 141.0 171.0 122.0 141.0 147.0 118.0 186.0 115.0 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:2.02 (1.2%) stddev-sans-first:1.86 21:58:46 INFO - PROCESS | 14266 | Values: 165.0 163.0 162.0 160.0 163.0 162.0 162.0 160.0 159.0 165.0 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | [#3] audio-fft Cycles:10 Average:97.50 Median:75.00 stddev:45.39 (60.5%) stddev-sans-first:47.41 21:58:46 INFO - PROCESS | 14266 | Values: 75.0 75.0 75.0 186.0 75.0 75.0 75.0 76.0 181.0 82.0 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:84.50 stddev:27.65 (32.7%) stddev-sans-first:28.55 21:58:46 INFO - PROCESS | 14266 | Values: 84.0 83.0 144.0 86.0 85.0 88.0 141.0 83.0 85.0 141.0 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.50 stddev:1.72 (1.4%) stddev-sans-first:1.81 21:58:46 INFO - PROCESS | 14266 | Values: 118.0 117.0 120.0 119.0 122.0 120.0 117.0 117.0 118.0 117.0 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 21:58:46 INFO - PROCESS | 14266 | Values: 147.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:97.00 stddev:1.85 (1.9%) stddev-sans-first:1.94 21:58:46 INFO - PROCESS | 14266 | Values: 98.0 100.0 97.0 95.0 95.0 95.0 96.0 97.0 99.0 99.0 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:2.18 (4.0%) stddev-sans-first:2.18 21:58:46 INFO - PROCESS | 14266 | Values: 56.0 53.0 52.0 52.0 53.0 58.0 54.0 56.0 51.0 54.0 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:1.25 (2.0%) stddev-sans-first:1.27 21:58:46 INFO - PROCESS | 14266 | Values: 60.0 61.0 60.0 60.0 61.0 60.0 61.0 61.0 64.0 62.0 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.50 stddev:2.36 (3.2%) stddev-sans-first:2.50 21:58:46 INFO - PROCESS | 14266 | Values: 75.0 74.0 75.0 75.0 73.0 74.0 73.0 73.0 81.0 74.0 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:126.00 stddev:16.12 (12.8%) stddev-sans-first:16.68 21:58:46 INFO - PROCESS | 14266 | Values: 120.0 123.0 120.0 132.0 134.0 124.0 127.0 125.0 174.0 122.0 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.90 Median:153.00 stddev:2.64 (1.7%) stddev-sans-first:2.80 21:58:46 INFO - PROCESS | 14266 | Values: 153.0 149.0 157.0 152.0 157.0 153.0 153.0 151.0 150.0 154.0 21:58:46 INFO - PROCESS | 14266 | 21:58:46 INFO - PROCESS | 14266 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.29 (2.1%) stddev-sans-first:1.36 21:58:46 INFO - PROCESS | 14266 | Values: 62.0 63.0 62.0 61.0 65.0 63.0 62.0 61.0 61.0 61.0 21:58:46 INFO - PROCESS | 14266 | -------- Summary: end -------- 21:58:46 INFO - PROCESS | 14266 | 21:58:47 INFO - TEST-INFO | 14266: exit 0 21:58:47 INFO - TEST-OK | kraken | took 61076ms 21:58:47 INFO - SUITE-END | took 1171s 21:58:47 INFO - Completed test suite (00:19:32) 21:58:47 INFO - javascript benchmark 21:58:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7801.30044425149, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.70482656561, 3289.3750187464366, 3306.024722706801, 3306.884259050933, 3333.5666363372757, 5590.608657393984, 5765.913511297334, 5795.797147099853, 5798.130280457934, 5839.678817665027, 5855.853603659911, 5928.911066334009, 5930.822075337736, 5932.169496270526, 5946.01890688037, 5340.092184328673, 5389.51494365507, 5393.514583687467, 5420.430854760233, 5474.91787623186, 5439.156930675732, 5442.0, 5442.12925931851, 5448.210009548613, 5448.782048718066, 5282.339707536558, 5341.866453338659, 5394.757235924393, 5396.055690254209, 5415.160650099221, 5396.5952553558445, 5465.371482279529, 5481.588880833953, 5488.890222195534, 5510.1459273812625, 5347.304850369466, 5426.348838139409, 5436.510714035716, 5446.2647542582035, 5459.262999495097, 5708.600397972144, 5821.476067153934, 5897.174395584621, 5943.197668314765, 6031.909521357183, 6307.400796924285, 6415.93584064158, 6417.037444383333, 6422.614643121381, 6423.582467139621, 6404.071409645575, 6404.807855764335, 6406.583572067801, 6423.0, 6431.710573024178, 5748.45389687979, 5838.591298609056, 5979.641221526679, 6009.128676341906, 6014.909776353358, 6297.181366422427, 6418.903716444257, 6421.101045853584, 6423.74305027803, 6428.357164283534, 6095.969520152371, 6128.233970753656, 6143.1706719592285, 6150.0, 6150.169727086875, 6114.2357205349335, 6148.200733904653, 6159.5688301818445, 6237.313895471494, 6237.4698150656795, 6133.059244993061, 6242.781502647385, 6312.52656050798, 6314.179156709598, 6327.272363678144, 6199.070139479024, 6205.751769929152, 6272.749090036347, 6283.37166283368, 6284.842878928063, 4663.463701674283, 4700.529947005341, 4801.4958429365115, 4802.327674125625, 4806.447258565309, 4215.051613387025, 4251.617354438115, 4265.317549192115, 4280.464941882265, 4288.078063216361, 6048.092786082035, 6050.878982420327, 6050.909236361458, 6081.27024757032, 6093.238345206849, 6163.691815409212, 6336.88686679456, 6396.744130234832, 6400.423961843363, 6417.807465776034, 5964.0, 6013.0, 6022.608530445507, 6092.116643086728, 6112.083187521907, 5441.5102640762525, 5452.073147564924, 5453.400125986138, 5461.672299662033, 5485.862853428696, 6455.096286519891, 6644.900326495106, 6676.46588272937, 6679.799606011828, 6680.265170831205, 6314.589551679126, 6376.617402955838, 6376.808695739135, 6473.805785826433, 6478.708458119301, 6581.572197807319, 6647.6676166192465, 6656.134702488645, 6686.297938716365, 6711.127553418024, 6029.3669164737075, 6243.500519958302, 6284.120223168668, 6332.30344662096, 6349.746010159542, 6154.692265386802, 6160.014397696347, 6170.876582468415, 6286.811395658137, 6287.465565426807, 6049.364816694359, 6079.513638908788, 6095.085737139465, 6129.693515324305, 6134.631922084689, 6008.939910600838, 6091.819740995785, 6093.421124993119, 6105.633661980118, 6135.969320153371, 6028.0, 6106.1146133811235, 6120.693965301806, 6155.076738489262, 6167.136600875791, 6106.938930610637, 6146.692665366803, 6186.536009799193, 6217.844553886189, 6238.095476156022, 5933.525317974465, 5997.640141591519, 6060.273754099677, 6080.0575910733905, 6126.754929802758], "value": 5815.710947755511, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.8143675460608, 620.8540992866677, 652.7389044382246, 660.2308310817897, 704.1268826654949, 41380.37929431057, 45795.77102114493, 45865.312020319725, 45997.7700111499, 46274.0, 45809.54190458095, 46196.0, 46516.767416162955, 46572.53427465724, 46634.53365466344, 9135.634574617008, 9249.907500925006, 9261.536923153815, 9262.120098590623, 9309.162175404212, 9199.724008279762, 9200.0, 9206.49364284964, 9213.631454741802, 9256.583453744564, 9226.861597076017, 9248.768780780501, 9290.907090929071, 9298.395604285733, 9306.674266400678, 9106.726798196032, 9144.954275228647, 9168.770780730469, 9240.630374785, 9254.814903701888, 9108.407953483002, 9243.26053915685, 9246.537673116318, 9256.537173141383, 9279.21126704231, 42486.150276994595, 42611.57388426107, 42730.0, 42817.0, 42868.785656071836, 3712.6658600726064, 3930.6658933990643, 4004.799760012017, 4036.2129384769983, 4045.491874673352, 34466.82766586176, 34822.303553929036, 35056.82471587626, 35139.1215219619, 35159.648403515894, 4195.622393984526, 4209.6421804146685, 4225.133847561243, 4247.09273432065, 4280.657547396201, 364174.0, 364655.0, 366588.0, 367100.0, 369203.0, 60645.39354606398, 61010.389896100474, 61050.38949610536, 61118.38881611216, 61220.38779612236, 41154.38268425976, 41959.580404196175, 42202.0, 42290.788546057076, 42308.0, 15912.76130858038, 16039.759403608956, 16047.03717776937, 16047.759283610756, 16058.27737751804, 12535.247885126739, 12539.623811285675, 12566.560170393992, 12590.748185036247, 12603.18079324841, 20281.0, 20377.592448150954, 20447.795522044587, 20473.385798426072, 20619.07214175366, 7355.963220183972, 7385.593792341473, 7544.924550754532, 7614.390848732088, 7691.653875575613, 990.6582229130938, 1079.8218293981406, 1117.4245263689045, 1158.472894832849, 1209.7943349630407, 32397.0, 33791.83104084513, 34059.31881362359, 34134.317313653584, 34451.82774086113, 1118.949647265875, 1122.9157813164045, 1138.7893239750672, 1161.4715304536417, 1237.9442925068392, 17005.149742512825, 17859.196336164903, 17899.28402863897, 18080.276788928295, 18343.17455714496, 637166.0, 642600.0, 643363.0, 643897.0, 653184.0, 63377.0, 63441.68279158575, 64022.67988660027, 64322.67838660777, 64415.67792161009, 1422.530564913576, 1431.1484666623342, 1445.4001589340305, 1447.8262608487048, 1457.7813328000884, 32363.51454728134, 33508.329833402706, 33807.15482112967, 33877.322453551285, 34197.70361328566, 55811.72094139503, 55850.72074639601, 56307.71846140743, 56350.0, 56409.43590564042, 452268.0, 454763.0, 457115.0, 457969.0, 458415.0, 31122.22194445157, 31159.22101947379, 31327.84336078305, 31434.68565314409, 31451.370972580877, 52532.212016820544, 53123.0, 53864.0, 54220.0, 54222.45777542174, 44269.557304427835, 44630.3305450412, 44891.0, 45231.0, 46296.7685161572, 44332.335954352464, 45591.54408456005, 46055.309170361805, 46464.0, 46506.30240546327, 42731.35902961396, 43235.35146972735, 44318.77840610776, 44357.778211108736, 44518.55481445144, 37546.624533754315, 39797.40303895386, 40231.798841005606, 40685.0, 40939.7953010233, 29848.701512984593, 29910.401791964476, 30269.69730302757, 30826.0, 30940.381192376477], "value": 21103.97060550022, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.5816287147819, 425.53616557951824, 432.55014784623995, 438.1434295951415, 447.1794257537419, 18924.24303027879, 20614.587708245825, 20821.68767468489, 21667.34997950064, 21739.891300543473, 19923.402297931087, 20573.27993520227, 20929.47676308093, 21048.473788155305, 21067.68398474024, 5399.892002159964, 5599.580031497654, 5913.201717768089, 5920.407959204088, 5923.970380148115, 5910.911336329937, 5921.970390148043, 5931.169636250928, 5938.910916336258, 5945.256842894638, 5866.501347385456, 5869.85325366865, 5894.410558944092, 5900.232969713953, 5911.645301281937, 5808.6224395414165, 5831.970840145794, 5862.14998825168, 5874.289800945617, 5884.087966365178, 5034.521720436553, 5117.513836185556, 5130.820421285274, 5141.074606570815, 5171.172612382038, 13976.231307278096, 15458.922705386514, 21592.89203553988, 22575.209867654718, 22575.774242257532, 2499.1627804685454, 2527.7093134289607, 2554.348641096527, 2659.1091984185323, 3021.501452260374, 10541.209409294257, 10567.947160264226, 10643.680689579325, 10672.0, 11130.777384452265, 2024.7975202479781, 2054.3631474242884, 2102.95794084119, 2115.4922818523596, 2177.967330490044, 76764.0, 85181.57409212977, 85843.57078214631, 87659.56170219171, 88904.99999999936, 11649.59226427071, 11950.282983021047, 12046.879531204751, 12371.6907077322, 12418.689532761573, 17566.29734810619, 17580.736288955675, 17584.56038599045, 17597.7360339595, 17598.648027039388, 8491.320694344438, 8567.485950842969, 8624.094470080676, 8694.869576956351, 8714.912850871537, 8148.837023259502, 8165.346772258205, 8342.499450033018, 8349.081601023883, 8373.288270496954, 5041.521055499722, 5125.846224613268, 5156.149235376196, 5211.5830733541225, 5225.790968361299, 2012.7282816819543, 2021.1713197588917, 2074.2532688232222, 2132.147141143524, 2206.9558608827733, 924.995375023134, 1014.1430491234895, 1021.5607288865859, 1033.204432586904, 1092.8743194532572, 20271.0, 20987.475313117295, 21065.26271580518, 21121.471963200736, 21157.576848463254, 1035.435687550287, 1052.952617132231, 1068.5031460370965, 1094.8084085285043, 1113.04834366617, 11093.16801239894, 11630.76738465226, 11891.227070240408, 11993.760124797454, 12008.879911200776, 577564.0, 583194.0, 585334.0, 589639.0, 598146.0, 95650.0, 97940.51029744948, 98081.0, 99554.5022274884, 101093.49453252686, 1015.4668798880647, 1037.818381783185, 1046.7383154211295, 1047.3035431438161, 1051.5636011055326, 18175.727364089813, 18458.0, 18570.95719470884, 18661.440156795317, 18681.906590466962, 43462.34806477969, 44089.0, 44304.778476107414, 44810.0, 46061.76969115133, 59686.0, 60585.39414605797, 60713.392866070775, 60809.39190608214, 61062.69468652628, 9328.720138395858, 9444.669436569688, 9467.95266023693, 9498.85751713711, 9565.617375305188, 11568.0, 13618.455261789417, 13896.51362202318, 14268.500602478864, 14444.85555144477, 11896.464659090534, 12419.441125149571, 12578.0, 13006.414711337824, 13423.731525369632, 12298.20061695987, 12398.752024959631, 12869.742605147658, 12876.420561074587, 13035.0, 5644.9435505644415, 11727.706807329885, 12452.0, 12598.370081496072, 12929.288889111189, 9262.0, 9370.437773733325, 9386.95306523463, 9604.471754053595, 9669.806603868024, 10820.4048777318, 11168.385738784445, 12769.872301276868, 12830.0, 12957.740845183233], "value": 9731.501217578538, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1540.7765873948274, 1559.8128224613044, 1706.15545305074, 1769.9115044247785, 1800.162924240228, 8628.223459888608, 9201.81596368073, 9340.626374944994, 9885.555150018248, 9910.653127140542, 9242.30682698797, 9544.80910381792, 9602.711918642452, 9612.18296444803, 9621.134097931184, 2476.4428003699113, 2528.5575024370755, 2529.3170843872235, 2530.215633153719, 2534.214393538, 2434.1237154624323, 2529.051605647882, 2543.8855251513633, 2551.9872400638064, 2555.029088946207, 2519.282004628681, 2520.2565243253284, 2547.821652484327, 2560.50070236304, 2560.513502434541, 2487.4900645367748, 2495.70051593809, 2510.347309699482, 2513.1078467144266, 2516.19481765835, 2474.6411770293385, 2476.3561474016706, 2485.465624890639, 2486.527559763639, 2516.509280690266, 9777.560009799576, 9791.118799308097, 9835.262355323379, 9836.0, 9846.753831154278, 5691.971540142315, 5778.942210577925, 5840.182374467578, 5845.064789633639, 5846.50304724099, 3606.495090687306, 3685.94471082934, 3713.517242758451, 3761.492198553188, 3770.2082562661876, 1272.9299888506127, 1311.698309388846, 1317.5520323090195, 1326.098253187832, 1349.5074297881301, 13888.166709997433, 13973.301334933212, 13988.300584970813, 14084.225367604779, 14085.577432677037, 4958.677685950402, 4959.677620954626, 5059.519345662156, 5106.361704786902, 5187.118189907725, 11365.886341136647, 11432.14258930567, 11438.485268162953, 11456.94271528637, 11531.596394126165, 5731.770729170787, 5780.046292361797, 5781.971090144522, 5790.073588225948, 5796.681182534917, 5209.166533354645, 5296.92054619181, 5328.17413300939, 5412.512873841373, 5413.783448662089, 4178.582141785858, 4256.722983105056, 4279.475109685301, 4294.463192100988, 4321.135772845443, 1248.9375531223402, 1255.6421419895469, 1256.4032084759665, 1263.557754785836, 1265.702559898423, 967.0136460809935, 992.0674565908023, 1029.629333439961, 1030.5723124903081, 1037.6264544763878, 6267.843303917439, 6321.0, 6324.936750632527, 6422.261439934374, 6461.709223084972, 494.49314452685564, 497.04815278740807, 510.3442076931126, 512.5899280575525, 519.3145048535896, 4404.4494438195225, 4481.708688935209, 4558.931616025762, 4562.201614717411, 4604.217283061887, 11888.762224755457, 12329.815052774216, 12349.444275007647, 12367.62897113088, 12369.443375048144, 10917.945410272898, 12232.327222002697, 12275.2021118627, 12284.14011019238, 12286.75426491465, 8698.73903782875, 9064.274858011344, 9064.592093355815, 9083.909160908439, 9083.954580227057, 6616.470682345497, 6741.797746067626, 6766.695498702668, 6789.89815152783, 6937.063496427918, 11014.1739369546, 11019.283746556448, 11346.319220846775, 11451.713707157387, 11534.884651153381, 11299.943500282774, 11395.145364097893, 11420.600278990196, 11522.251053681484, 11588.072954163477, 8159.592020399075, 8442.788930276547, 8455.577221138796, 8565.100664430394, 8705.564721764013, 9677.516124193622, 9715.417074975525, 9724.27067969891, 9728.951355243178, 9805.558749856416, 7582.924170758442, 7638.656260468403, 7820.413468989735, 7858.646360913887, 8083.434159609006, 8434.662613495637, 8499.235068843835, 8501.744947651581, 8563.0, 8678.175573320525, 7557.093148822177, 7745.225477452435, 7817.609119544114, 7829.569373684502, 7870.331021863206, 5572.60991730575, 5629.4652008059165, 5725.398833122629, 5804.100364443518, 5937.495312898452, 5696.487316141567, 5773.04744717117, 5866.149408335853, 5912.532376967592, 5985.072313791369], "value": 4991.624692299646, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.7542533364647, 359.1577750175837, 361.2684314263616, 364.12246485968814, 368.9151495156114, 5661.490465858072, 5794.913076303848, 5795.246617939667, 5816.389279125689, 5865.155399631176, 5773.220615216955, 5805.535557155428, 5809.6804675742815, 5853.941460585393, 5862.120681897717, 4598.402207712993, 4599.6320294376455, 4608.400907881971, 4631.791569379369, 4656.5343465653505, 4514.322851572274, 4530.184566777979, 4609.124266389392, 4609.769511524427, 4648.558386953251, 4554.84058057968, 4570.0, 4571.725696458223, 4583.72497650142, 4585.610223131038, 4383.452068491439, 4597.126545956291, 4597.747123908183, 4638.536146385368, 4638.97680511597, 3999.7800120993334, 4009.558948515661, 4011.197760447893, 4043.3126368517424, 4054.513458384983, 5655.632383895034, 5679.432056794288, 5684.602077854552, 5714.028660112254, 5748.5975981681295, 5154.742262886841, 5239.476052394768, 5249.081410753103, 5276.577873770089, 5276.683398996072, 6025.0, 6036.185115009462, 6064.484518815906, 6069.211002569682, 6171.783987560459, 4414.955850441486, 4425.5174516537, 4433.536932812164, 4451.799669014869, 4457.175422546839, 6196.225471816023, 6351.809445716682, 6420.646864422455, 6423.42189202974, 6425.967870160666, 4532.297493888386, 4538.500764915857, 4554.544545545486, 4560.589546940725, 4562.520935301812, 4629.055796565451, 4643.349931009594, 4649.5350464953235, 4649.8840278332955, 4652.185867473247, 5148.4851514848215, 5220.608454365938, 5225.399079105876, 5259.605529585297, 5288.444713305124, 5908.675022873783, 6048.0, 6071.180390647294, 6082.300535438481, 6083.817485475354, 1562.3516240759957, 1578.6053486628343, 1584.9286782094835, 1588.9046657200374, 1595.170511334123, 982.832918403873, 1001.7645853224486, 1013.2755080117752, 1024.0067134879155, 1024.4775164665925, 5248.212768084818, 5256.763445644955, 5270.552003079704, 5273.709945952933, 5297.311349524537, 5475.0, 5506.229127922094, 5528.391876893538, 5543.447834606317, 5582.218489411485, 4948.90102197954, 5159.974200128975, 5196.454372290855, 5206.9586082782835, 5216.58267338612, 2922.7954043217196, 2923.3714751328566, 2955.12823717004, 2955.157780032723, 2973.8513074346197, 5625.803096891589, 5687.60186786921, 5702.885942281131, 5775.306963164363, 5795.262055973873, 5990.550708696778, 6419.422251997343, 6463.0, 6477.708503117371, 6492.67536623167, 6612.371824676648, 6631.900521492182, 6639.402453779183, 6663.800085997428, 6665.0, 6180.45488627843, 6337.4613157882095, 6355.428011478989, 6362.72745450921, 6422.42198202164, 6252.1559589456665, 6257.092721555258, 6300.527460440577, 6307.463865571478, 6324.335944725922, 6339.619622822645, 6578.2567619579895, 6591.901121483085, 6638.767643132467, 6650.235222949423, 4488.887777805581, 4511.909761804811, 4524.977375113103, 4566.70316429431, 4567.132244873464, 6197.225346831646, 6412.679366031586, 6449.193850768654, 6449.4840412765925, 6457.6771161442675, 6183.350748171557, 6206.875862482815, 6216.0, 6217.595856269328, 6240.438360547572, 6051.273847138372, 6222.81331560054, 6246.312905580474, 6261.372043268691, 6294.905576416449, 6200.3179650239335, 6207.937920620917, 6215.192025036717, 6221.222347206599, 6230.937690623035, 6238.313785483502, 6247.500999600196, 6286.591371560834, 6333.65164915934, 6336.334684858023, 5842.444967728059, 6038.365971572922, 6047.576669633084, 6077.0, 6138.4525421951175], "value": 4624.215679262179, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.8351846112316, 811.0105671081283, 829.7966998085468, 847.6312803930286, 869.2263885142222, 15202.847971520281, 15696.764548531766, 16123.516294511168, 18005.0, 18257.54356141097, 16396.426125085625, 16398.26207820648, 16543.172841357915, 16554.751678724828, 16567.585810354718, 839.9328053755685, 846.5132548784443, 855.247382303572, 870.3211495033884, 871.7123349294718, 857.9270761985208, 859.1537335724306, 859.1837754133567, 860.7977125375531, 864.7016779211162, 905.4069584422214, 906.995465022674, 908.5230254116576, 912.069688917304, 912.2246090822814, 902.2466240689032, 903.1239697493421, 904.479924043671, 906.1708536688922, 907.6097278170417, 665.3845193196274, 667.0594461808874, 667.9165104361955, 669.1568623534333, 670.24597328006, 16313.0, 16318.0, 16531.91734041334, 16549.83450165507, 16644.58388540284, 14380.137191768526, 14512.637184070378, 14519.927400363036, 14645.853541464556, 14795.482158124414, 11852.0, 11955.163138580303, 12001.63995080149, 12130.878691213064, 12249.265044097383, 4044.4135600337786, 4085.2734811034898, 4091.693123015756, 4104.753714777123, 4117.3206420940505, 87499.56250218772, 87663.0, 88466.55766721189, 88496.11503885007, 88631.0, 11817.172797904064, 11830.349330786888, 11862.940685296691, 11934.761304773856, 12087.153899227145, 23071.653925191134, 23224.954877030574, 23273.650895236584, 23303.41741456477, 23431.41421464477, 9165.633374665073, 9371.953140234255, 9447.338686291894, 9483.715488535356, 9619.27855410847, 4845.878853028632, 4885.877853053631, 4993.101241776515, 5046.84859454217, 5102.107131252016, 3712.406015037581, 3843.7693738375788, 3869.07142285855, 3869.7871617061332, 3873.0898238913833, 581.3663107213158, 682.1711620381261, 686.8145600687886, 689.8551304226069, 690.1235431002699, 618.3044075415158, 674.4638012779852, 710.7192658899705, 712.1845486917554, 713.3971793834305, 9545.47499887499, 10224.0, 10325.63860264887, 10423.0, 10715.678529643967, 711.6477343714894, 712.803978905805, 723.9203687594361, 734.0090877315688, 762.0931092000502, 4843.39457567804, 4892.217245240816, 4987.875303117378, 5048.242763585418, 5103.591712663052, 95613.0, 124624.0, 132584.33707831398, 138550.0, 139282.0, 111763.0, 117665.0, 117819.41090294493, 118200.40899795447, 119028.0, 101608.0, 104754.0, 105054.47472762587, 106256.46871765592, 107519.0, 9222.538873056186, 9284.118008789153, 9447.14975652167, 9467.715968520955, 9694.660686875926, 58886.705566471894, 59403.702981484814, 60135.0, 60467.69766151141, 62513.374866252576, 81513.18486815294, 88060.0, 89822.55088724515, 90498.0, 91592.0, 12355.505779769068, 12423.875761242272, 12489.18820276679, 12508.624741257778, 12583.433745481292, 14285.214313212873, 14450.566483005527, 14495.0, 14881.627959301104, 15278.465253716067, 15159.848401515843, 15366.923165384549, 15372.308246128727, 15693.686126277182, 16480.34078636841, 15132.546023619308, 15446.84553154499, 15641.921790390976, 15826.762598560801, 16020.599485012968, 12653.304068276333, 12773.744525109632, 13047.34763261814, 14934.850651493345, 15130.697386051997, 12423.62729118128, 13009.739805204032, 13060.020498462463, 13103.410346534238, 13334.533291334757, 13911.443542258601, 13950.372233249325, 14085.647858803612, 14157.646058848199, 14223.0], "value": 8175.894751517684, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1506.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 104.0, 109.0, 112.0, 110.0, 109.0, 109.0, 110.0, 110.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 116.0, 141.0, 171.0, 122.0, 141.0, 147.0, 118.0, 186.0, 115.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 162.0, 160.0, 163.0, 162.0, 162.0, 160.0, 159.0, 165.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 186.0, 75.0, 75.0, 75.0, 76.0, 181.0, 82.0], "value": 97.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 144.0, 86.0, 85.0, 88.0, 141.0, 83.0, 85.0, 141.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 120.0, 119.0, 122.0, 120.0, 117.0, 117.0, 118.0, 117.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 100.0, 97.0, 95.0, 95.0, 95.0, 96.0, 97.0, 99.0, 99.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 52.0, 52.0, 53.0, 58.0, 54.0, 56.0, 51.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 64.0, 62.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 75.0, 73.0, 74.0, 73.0, 73.0, 81.0, 74.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 123.0, 120.0, 132.0, 134.0, 124.0, 127.0, 125.0, 174.0, 122.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 149.0, 157.0, 152.0, 157.0, 153.0, 153.0, 151.0, 150.0, 154.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 61.0, 65.0, 63.0, 62.0, 61.0, 61.0, 61.0], "value": 62.1, "unit": "score"}]}]} 21:58:47 INFO - Return code: 0 21:58:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:58:47 ERROR - # TBPL SUCCESS # 21:58:47 INFO - Running post-action listener: _resource_record_post_action 21:58:47 INFO - [mozharness: 2016-10-21 04:58:47.791666Z] Finished run-tests step (success) 21:58:47 INFO - Running post-run listener: _resource_record_post_run 21:58:47 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288731136; Read time: 16; Write time: 218124 21:58:47 INFO - TinderboxPrint: CPU usage
13.2% 21:58:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 21:58:47 INFO - TinderboxPrint: I/O write bytes / time
288,731,136 / 218,124 21:58:47 INFO - TinderboxPrint: CPU idle
8,214.5 (86.8%) 21:58:47 INFO - TinderboxPrint: CPU user
1,195.6 (12.6%) 21:58:47 INFO - TinderboxPrint: Swap in / out
0 / 0 21:58:47 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 71696384; Read time: 0; Write time: 78876 21:58:47 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 216457216; Read time: 0; Write time: 139244 21:58:48 INFO - Running post-run listener: _upload_blobber_files 21:58:48 INFO - Blob upload gear active. 21:58:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:58:48 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 21:58:48 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:58:48 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:58:48 INFO - (blobuploader) - INFO - Open directory for files ... 21:58:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:58:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:58:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:49 INFO - (blobuploader) - INFO - Done attempting. 21:58:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:58:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:58:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:50 INFO - (blobuploader) - INFO - Done attempting. 21:58:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:58:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:58:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:58:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:58:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:58:53 INFO - (blobuploader) - INFO - Done attempting. 21:58:53 INFO - (blobuploader) - INFO - Iteration through files over. 21:58:53 INFO - Return code: 0 21:58:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:58:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:58:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4d346d41420ce440cecb6af4088d57754d3c7a26515f499a35ae7e7a34213ba03ad96d4a0ad75fb47b5ddd25404251270ef28f01ed5dacdfa5c395a07c71b09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f62d2431ae462358a3251c5911962dd452f53e40e89a2d86d2bbadfef73dbba709559ce71cb62da32044855c990362dada6eb780b028429f0572b180021f13b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e23270559e7ee68a938435695227eb20d75ec9ac4a5768eafdc48eb318a7b83a1f13d89ae76cc750d692da28b35ae2e5ebb74611e966837394790b70a3ffc99"} 21:58:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:58:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:58:53 INFO - Contents: 21:58:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4d346d41420ce440cecb6af4088d57754d3c7a26515f499a35ae7e7a34213ba03ad96d4a0ad75fb47b5ddd25404251270ef28f01ed5dacdfa5c395a07c71b09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f62d2431ae462358a3251c5911962dd452f53e40e89a2d86d2bbadfef73dbba709559ce71cb62da32044855c990362dada6eb780b028429f0572b180021f13b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e23270559e7ee68a938435695227eb20d75ec9ac4a5768eafdc48eb318a7b83a1f13d89ae76cc750d692da28b35ae2e5ebb74611e966837394790b70a3ffc99"} 21:58:53 INFO - Running post-run listener: copy_logs_to_upload_dir 21:58:53 INFO - Copying logs to upload dir... 21:58:53 INFO - mkdir: /builds/slave/test/build/upload/logs 21:58:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1673.882989 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-10-20 21:58:53.631326) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 21:58:53.634741) ========= 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=7de08804244eb36560b44971000001c3-1477023635.243764-857392666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4d346d41420ce440cecb6af4088d57754d3c7a26515f499a35ae7e7a34213ba03ad96d4a0ad75fb47b5ddd25404251270ef28f01ed5dacdfa5c395a07c71b09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f62d2431ae462358a3251c5911962dd452f53e40e89a2d86d2bbadfef73dbba709559ce71cb62da32044855c990362dada6eb780b028429f0572b180021f13b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e23270559e7ee68a938435695227eb20d75ec9ac4a5768eafdc48eb318a7b83a1f13d89ae76cc750d692da28b35ae2e5ebb74611e966837394790b70a3ffc99"} build_url:https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/bwlu0zmBSsyZpm4qeJimlA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e4d346d41420ce440cecb6af4088d57754d3c7a26515f499a35ae7e7a34213ba03ad96d4a0ad75fb47b5ddd25404251270ef28f01ed5dacdfa5c395a07c71b09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1f62d2431ae462358a3251c5911962dd452f53e40e89a2d86d2bbadfef73dbba709559ce71cb62da32044855c990362dada6eb780b028429f0572b180021f13b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7e23270559e7ee68a938435695227eb20d75ec9ac4a5768eafdc48eb318a7b83a1f13d89ae76cc750d692da28b35ae2e5ebb74611e966837394790b70a3ffc99"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 21:58:53.660072) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:58:53.660441) ========= 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=7de08804244eb36560b44971000001c3-1477023635.243764-857392666 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 21:58:53.742286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 21:58:53.742621) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 21:58:53.742921) ========= ========= Total master_lag: 0.22 =========