builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1476795764.82 results: success (0) buildid: 20161018030521 builduid: 0090e1c9cb69429d85fa77d3434b6f65 revision: 62da552138459e86a7c25b1f2836e410454c5e5c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.820433) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.821186) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.821682) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.839294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.839839) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-18 06:02:45-- 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% 212M=0s 2016-10-18 06:02:45 (212 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.072962 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.934315) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.934958) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021627 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.991921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:44.992489) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 62da552138459e86a7c25b1f2836e410454c5e5c --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 62da552138459e86a7c25b1f2836e410454c5e5c --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=934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-18 06:02:45,445 truncating revision to first 12 chars 2016-10-18 06:02:45,445 Setting DEBUG logging. 2016-10-18 06:02:45,445 attempt 1/10 2016-10-18 06:02:45,445 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/62da55213845?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 06:02:45,750 unpacking tar archive at: mozilla-beta-62da55213845/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638582 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:45.647923) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:45.648382) ========= script_repo_revision: 62da552138459e86a7c25b1f2836e410454c5e5c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:45.648967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:45.649347) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 06:02:45.660253) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-10-18 06:02:45.660816) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:02:46 INFO - MultiFileLogger online at 20161018 06:02:46 in /builds/slave/test 06:02:46 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 06:02:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:02:46 INFO - {'append_to_log': False, 06:02:46 INFO - 'base_work_dir': '/builds/slave/test', 06:02:46 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:02:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:02:46 INFO - 'branch': 'Mozilla-Beta', 06:02:46 INFO - 'buildbot_json_path': 'buildprops.json', 06:02:46 INFO - 'config_files': ('talos/linux_config.py',), 06:02:46 INFO - 'default_actions': ('clobber', 06:02:46 INFO - 'read-buildbot-config', 06:02:46 INFO - 'download-and-extract', 06:02:46 INFO - 'populate-webroot', 06:02:46 INFO - 'create-virtualenv', 06:02:46 INFO - 'install', 06:02:46 INFO - 'run-tests'), 06:02:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:02:46 INFO - 'download_minidump_stackwalk': True, 06:02:46 INFO - 'download_symbols': 'ondemand', 06:02:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:02:46 INFO - 'tooltool.py': '/tools/tooltool.py', 06:02:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:02:46 INFO - '/tools/misc-python/virtualenv.py')}, 06:02:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:02:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:02:46 INFO - 'installer_path': 'installer.exe', 06:02:46 INFO - 'log_level': 'info', 06:02:46 INFO - 'log_name': 'talos', 06:02:46 INFO - 'log_to_console': True, 06:02:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:02:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:02:46 INFO - 'opt_config_files': (), 06:02:46 INFO - 'pip_index': False, 06:02:46 INFO - 'sps_profile': False, 06:02:46 INFO - 'sps_profile_interval': 0, 06:02:46 INFO - 'suite': 'dromaeojs-e10s', 06:02:46 INFO - 'system_bits': '32', 06:02:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:02:46 INFO - 'title': 'talos-linux64-ix-057', 06:02:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:02:46 INFO - 'use_talos_json': True, 06:02:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:02:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:02:46 INFO - 'work_dir': 'build'} 06:02:46 INFO - [mozharness: 2016-10-18 13:02:46.212749Z] Running clobber step. 06:02:46 INFO - Running pre-action listener: _resource_record_pre_action 06:02:46 INFO - Running main action method: clobber 06:02:46 INFO - rmtree: /builds/slave/test/build 06:02:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:02:46 INFO - Running post-action listener: _resource_record_post_action 06:02:46 INFO - [mozharness: 2016-10-18 13:02:46.673977Z] Finished clobber step (success) 06:02:46 INFO - [mozharness: 2016-10-18 13:02:46.674078Z] Running read-buildbot-config step. 06:02:46 INFO - Running pre-action listener: _resource_record_pre_action 06:02:46 INFO - Running main action method: read_buildbot_config 06:02:46 INFO - Using buildbot properties: 06:02:46 INFO - { 06:02:46 INFO - "project": "", 06:02:46 INFO - "product": "firefox", 06:02:46 INFO - "script_repo_revision": "production", 06:02:46 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 06:02:46 INFO - "repository": "", 06:02:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 06:02:46 INFO - "buildid": "20161018030521", 06:02:46 INFO - "pgo_build": "True", 06:02:46 INFO - "basedir": "/builds/slave/test", 06:02:46 INFO - "buildnumber": 286, 06:02:46 INFO - "slavename": "talos-linux64-ix-057", 06:02:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:02:46 INFO - "platform": "ubuntu64_hw", 06:02:46 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:02:46 INFO - "branch": "mozilla-beta", 06:02:46 INFO - "repo_path": "releases/mozilla-beta", 06:02:46 INFO - "revision": "62da552138459e86a7c25b1f2836e410454c5e5c", 06:02:46 INFO - "stage_platform": "linux64-pgo", 06:02:46 INFO - "builduid": "0090e1c9cb69429d85fa77d3434b6f65", 06:02:46 INFO - "slavebuilddir": "test" 06:02:46 INFO - } 06:02:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 06:02:46 INFO - Running post-action listener: _resource_record_post_action 06:02:46 INFO - [mozharness: 2016-10-18 13:02:46.676545Z] Finished read-buildbot-config step (success) 06:02:46 INFO - [mozharness: 2016-10-18 13:02:46.676634Z] Running download-and-extract step. 06:02:46 INFO - Running pre-action listener: _resource_record_pre_action 06:02:46 INFO - Running main action method: download_and_extract 06:02:46 INFO - mkdir: /builds/slave/test/build/tests 06:02:46 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')]} 06:02:46 INFO - https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:02:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:02:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:02:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:02:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:02:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:02:46 INFO - retry: Failed, sleeping 30 seconds before retrying 06:03:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:03:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:03:16 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:03:16 INFO - retry: Failed, sleeping 60 seconds before retrying 06:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:04:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:04:16 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:04:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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! 06:04:16 INFO - Caught exception: HTTP Error 404: Not Found 06:04:16 INFO - Caught exception: HTTP Error 404: Not Found 06:04:16 INFO - Caught exception: HTTP Error 404: Not Found 06:04:16 INFO - trying https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:04:16 INFO - Downloading https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:04:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:04:17 INFO - Downloaded 1327 bytes. 06:04:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:04:17 INFO - Using the following test package requirements: 06:04:17 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 06:04:17 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:17 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:04:17 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:17 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 06:04:17 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:17 INFO - u'jsshell-linux-x86_64.zip'], 06:04:17 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:17 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:04:17 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 06:04:17 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:17 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 06:04:17 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:17 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 06:04:17 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:17 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:04:17 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:04:17 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:04:17 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:04:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:04:17 INFO - https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:04:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:04:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:04:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:04:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:04:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:04:17 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:04:17 INFO - retry: Failed, sleeping 30 seconds before retrying 06:04:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:04:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:04:47 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:04:47 INFO - retry: Failed, sleeping 60 seconds before retrying 06:05:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:05:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:05:47 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:05:47 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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! 06:05:47 INFO - Caught exception: HTTP Error 404: Not Found 06:05:47 INFO - Caught exception: HTTP Error 404: Not Found 06:05:47 INFO - Caught exception: HTTP Error 404: Not Found 06:05:47 INFO - trying https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:05:47 INFO - Downloading https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:05:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:05:48 INFO - Downloaded 21774616 bytes. 06:05:48 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'] 06:05:48 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 06:05:49 INFO - Return code: 0 06:05:49 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 06:05: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')]} 06:05:49 INFO - https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:05:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:05:49 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:05:49 INFO - retry: Failed, sleeping 30 seconds before retrying 06:06:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:06:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:06:19 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:06:19 INFO - retry: Failed, sleeping 60 seconds before retrying 06:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:07:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:07:20 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:07:20 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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! 06:07:20 INFO - Caught exception: HTTP Error 404: Not Found 06:07:20 INFO - Caught exception: HTTP Error 404: Not Found 06:07:20 INFO - Caught exception: HTTP Error 404: Not Found 06:07:20 INFO - trying https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:07:20 INFO - Downloading https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:07:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:07:20 INFO - Downloaded 21774616 bytes. 06:07:20 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'] 06:07:20 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 06:07:22 INFO - Return code: 0 06:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:07:22 INFO - https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:07:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:07:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:07:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:07:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:07:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:07:22 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:07:22 INFO - retry: Failed, sleeping 30 seconds before retrying 06:07:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:07:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:07:52 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:07:52 INFO - retry: Failed, sleeping 60 seconds before retrying 06:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:08:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:08:52 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:08:52 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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! 06:08:52 INFO - Caught exception: HTTP Error 404: Not Found 06:08:52 INFO - Caught exception: HTTP Error 404: Not Found 06:08:52 INFO - Caught exception: HTTP Error 404: Not Found 06:08:52 INFO - trying https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:08:52 INFO - Downloading https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:08:53 INFO - Downloaded 14413762 bytes. 06:08:53 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'] 06:08:53 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 06:08:54 INFO - Return code: 0 06:08:54 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')]} 06:08:54 INFO - https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:08:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:08:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:08:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:08:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:08:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:08:54 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:08:54 INFO - retry: Failed, sleeping 30 seconds before retrying 06:09:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:09:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:09:24 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:09:24 INFO - retry: Failed, sleeping 60 seconds before retrying 06:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:10:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:10:24 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:10:24 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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! 06:10:24 INFO - Caught exception: HTTP Error 404: Not Found 06:10:24 INFO - Caught exception: HTTP Error 404: Not Found 06:10:24 INFO - Caught exception: HTTP Error 404: Not Found 06:10:24 INFO - trying https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:10:24 INFO - Downloading https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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 06:10:25 INFO - Downloaded 56809543 bytes. 06:10:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:10:25 INFO - mkdir: /builds/slave/test/properties 06:10:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:10:25 INFO - Writing to file /builds/slave/test/properties/build_url 06:10:25 INFO - Contents: 06:10:25 INFO - build_url:https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:10:26 INFO - Running post-action listener: _resource_record_post_action 06:10:26 INFO - Running post-action listener: set_extra_try_arguments 06:10:26 INFO - [mozharness: 2016-10-18 13:10:26.165595Z] Finished download-and-extract step (success) 06:10:26 INFO - [mozharness: 2016-10-18 13:10:26.165826Z] Running populate-webroot step. 06:10:26 INFO - Running pre-action listener: _resource_record_pre_action 06:10:26 INFO - Running main action method: populate_webroot 06:10:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:10:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:10:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:10:26 INFO - '--tppagecycles', 06:10:26 INFO - '7'], 06:10:26 INFO - 'tests': ['tsvgm']}}, 06:10:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:10:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:10:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:10:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:10:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:10:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:10:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['damp', 'tps']}, 06:10:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'tests': ['damp', 'tps']}, 06:10:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['dromaeo_dom']}, 06:10:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:10:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['basic_compositor_video']}, 06:10:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:10:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['a11yr', 06:10:26 INFO - 'ts_paint', 06:10:26 INFO - 'tpaint', 06:10:26 INFO - 'sessionrestore', 06:10:26 INFO - 'sessionrestore_no_auto_restore', 06:10:26 INFO - 'tabpaint']}, 06:10:26 INFO - 'other-e10s': {'tests': ['a11yr', 06:10:26 INFO - 'ts_paint', 06:10:26 INFO - 'tpaint', 06:10:26 INFO - 'sessionrestore', 06:10:26 INFO - 'sessionrestore_no_auto_restore', 06:10:26 INFO - 'tabpaint']}, 06:10:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:10:26 INFO - 'ts_paint', 06:10:26 INFO - 'tpaint', 06:10:26 INFO - 'sessionrestore', 06:10:26 INFO - 'sessionrestore_no_auto_restore', 06:10:26 INFO - 'tabpaint']}, 06:10:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:10:26 INFO - 'ts_paint', 06:10:26 INFO - 'tpaint', 06:10:26 INFO - 'sessionrestore', 06:10:26 INFO - 'sessionrestore_no_auto_restore', 06:10:26 INFO - 'tabpaint']}, 06:10:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['a11yr', 06:10:26 INFO - 'ts_paint', 06:10:26 INFO - 'tpaint', 06:10:26 INFO - 'sessionrestore', 06:10:26 INFO - 'sessionrestore_no_auto_restore', 06:10:26 INFO - 'tabpaint']}, 06:10:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['a11yr', 06:10:26 INFO - 'ts_paint', 06:10:26 INFO - 'tpaint', 06:10:26 INFO - 'sessionrestore', 06:10:26 INFO - 'sessionrestore_no_auto_restore', 06:10:26 INFO - 'tabpaint']}, 06:10:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['tsvgx', 06:10:26 INFO - 'tsvgr_opacity', 06:10:26 INFO - 'tart', 06:10:26 INFO - 'tscrollx', 06:10:26 INFO - 'cart']}, 06:10:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:10:26 INFO - 'tsvgr_opacity', 06:10:26 INFO - 'tart', 06:10:26 INFO - 'tscrollx', 06:10:26 INFO - 'cart']}, 06:10:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'talos_options': ['--disable-e10s'], 06:10:26 INFO - 'tests': ['tp5o']}, 06:10:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'tests': ['tp5o']}, 06:10:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'talos_options': ['--disable-e10s', 06:10:26 INFO - '--xperf_path', 06:10:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:10:26 INFO - 'tests': ['tp5n']}, 06:10:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:10:26 INFO - 'talos_options': ['--xperf_path', 06:10:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:10:26 INFO - 'tests': ['tp5n']}}, 06:10:26 INFO - 'talos.zip': {'path': '', 06:10:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:10:26 INFO - Running post-action listener: _resource_record_post_action 06:10:26 INFO - [mozharness: 2016-10-18 13:10:26.182982Z] Finished populate-webroot step (success) 06:10:26 INFO - [mozharness: 2016-10-18 13:10:26.183071Z] Running create-virtualenv step. 06:10:26 INFO - Running pre-action listener: _resource_record_pre_action 06:10:26 INFO - Running main action method: create_virtualenv 06:10:26 INFO - Creating virtualenv /builds/slave/test/build/venv 06:10:26 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 06:10:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:10:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:10:26 INFO - Using real prefix '/usr' 06:10:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:10:26 INFO - Installing distribute.............................................................................................................................................................................................done. 06:10:28 INFO - Installing pip.................done. 06:10:28 INFO - Return code: 0 06:10:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:10:28 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')]} 06:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:28 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')]} 06:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:28 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 0xe98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156570>, '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 0x1157470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1157900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', '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 06:10:28 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 06:10:28 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 06:10:28 INFO - Using env: {'DISPLAY': ':0', 06:10:28 INFO - 'HOME': '/home/cltbld', 06:10:28 INFO - 'LANG': 'en_US.UTF-8', 06:10:28 INFO - 'LANGUAGE': 'en_US:en', 06:10:28 INFO - 'LOGNAME': 'cltbld', 06:10:28 INFO - 'MAIL': '/var/mail/cltbld', 06:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:28 INFO - 'MOZ_NO_REMOTE': '1', 06:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:28 INFO - 'NO_EM_RESTART': '1', 06:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:28 INFO - 'PWD': '/builds/slave/test', 06:10:28 INFO - 'SHELL': '/bin/bash', 06:10:28 INFO - 'SHLVL': '1', 06:10:28 INFO - 'TERM': 'linux', 06:10:28 INFO - 'TMOUT': '86400', 06:10:28 INFO - 'USER': 'cltbld', 06:10:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', 06:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:28 INFO - '_': '/tools/buildbot/bin/python'} 06:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:28 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 06:10:28 INFO - Cleaning up... 06:10:28 INFO - Return code: 0 06:10:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:10:28 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')]} 06:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:28 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')]} 06:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:28 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 0xe98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156570>, '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 0x1157470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1157900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', '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 06:10:28 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 06:10:28 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 06:10:28 INFO - Using env: {'DISPLAY': ':0', 06:10:28 INFO - 'HOME': '/home/cltbld', 06:10:28 INFO - 'LANG': 'en_US.UTF-8', 06:10:28 INFO - 'LANGUAGE': 'en_US:en', 06:10:28 INFO - 'LOGNAME': 'cltbld', 06:10:28 INFO - 'MAIL': '/var/mail/cltbld', 06:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:28 INFO - 'MOZ_NO_REMOTE': '1', 06:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:28 INFO - 'NO_EM_RESTART': '1', 06:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:28 INFO - 'PWD': '/builds/slave/test', 06:10:28 INFO - 'SHELL': '/bin/bash', 06:10:28 INFO - 'SHLVL': '1', 06:10:28 INFO - 'TERM': 'linux', 06:10:28 INFO - 'TMOUT': '86400', 06:10:28 INFO - 'USER': 'cltbld', 06:10:28 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', 06:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:28 INFO - '_': '/tools/buildbot/bin/python'} 06:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:29 INFO - Downloading/unpacking psutil>=3.1.1 06:10:29 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 06:10:29 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 06:10:29 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 06:10:29 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 06:10:29 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 06:10:29 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 06:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:10:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:10:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:10:31 INFO - Installing collected packages: psutil 06:10:31 INFO - Running setup.py install for psutil 06:10:31 INFO - building 'psutil._psutil_linux' extension 06:10:31 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 06:10:31 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 06:10:31 INFO - building 'psutil._psutil_posix' extension 06:10:31 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 06:10:31 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 06:10:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:10:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:10:31 INFO - Successfully installed psutil 06:10:31 INFO - Cleaning up... 06:10:31 INFO - Return code: 0 06:10:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:10: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')]} 06:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10: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')]} 06:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:31 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 0xe98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156570>, '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 0x1157470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1157900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', '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 06:10:31 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 06:10:31 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 06:10:31 INFO - Using env: {'DISPLAY': ':0', 06:10:31 INFO - 'HOME': '/home/cltbld', 06:10:31 INFO - 'LANG': 'en_US.UTF-8', 06:10:31 INFO - 'LANGUAGE': 'en_US:en', 06:10:31 INFO - 'LOGNAME': 'cltbld', 06:10:31 INFO - 'MAIL': '/var/mail/cltbld', 06:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:31 INFO - 'MOZ_NO_REMOTE': '1', 06:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:31 INFO - 'NO_EM_RESTART': '1', 06:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:31 INFO - 'PWD': '/builds/slave/test', 06:10:31 INFO - 'SHELL': '/bin/bash', 06:10:31 INFO - 'SHLVL': '1', 06:10:31 INFO - 'TERM': 'linux', 06:10:31 INFO - 'TMOUT': '86400', 06:10:31 INFO - 'USER': 'cltbld', 06:10:31 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', 06:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:31 INFO - '_': '/tools/buildbot/bin/python'} 06:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:10:31 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 06:10:31 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 06:10:31 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 06:10:31 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 06:10:31 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 06:10:31 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 06:10:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:10:33 INFO - Installing collected packages: mozsystemmonitor 06:10:33 INFO - Running setup.py install for mozsystemmonitor 06:10:34 INFO - Successfully installed mozsystemmonitor 06:10:34 INFO - Cleaning up... 06:10:34 INFO - Return code: 0 06:10:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:10:34 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')]} 06:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:34 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')]} 06:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:34 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 0xe98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156570>, '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 0x1157470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1157900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', '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 06:10:34 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 06:10:34 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 06:10:34 INFO - Using env: {'DISPLAY': ':0', 06:10:34 INFO - 'HOME': '/home/cltbld', 06:10:34 INFO - 'LANG': 'en_US.UTF-8', 06:10:34 INFO - 'LANGUAGE': 'en_US:en', 06:10:34 INFO - 'LOGNAME': 'cltbld', 06:10:34 INFO - 'MAIL': '/var/mail/cltbld', 06:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:34 INFO - 'MOZ_NO_REMOTE': '1', 06:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:34 INFO - 'NO_EM_RESTART': '1', 06:10:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:34 INFO - 'PWD': '/builds/slave/test', 06:10:34 INFO - 'SHELL': '/bin/bash', 06:10:34 INFO - 'SHLVL': '1', 06:10:34 INFO - 'TERM': 'linux', 06:10:34 INFO - 'TMOUT': '86400', 06:10:34 INFO - 'USER': 'cltbld', 06:10:34 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', 06:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:34 INFO - '_': '/tools/buildbot/bin/python'} 06:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:34 INFO - Downloading/unpacking jsonschema==2.5.1 06:10:34 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 06:10:34 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 06:10:34 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 06:10:34 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 06:10:34 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 06:10:34 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 06:10:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:10:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:10:36 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 06:10:36 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 06:10:36 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 06:10:36 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 06:10:36 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 06:10:36 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 06:10:36 INFO - Downloading functools32-3.2.3-2.tar.gz 06:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:10:36 INFO - warning: no files found matching '*.txt' 06:10:36 INFO - no previously-included directories found matching 'build' 06:10:36 INFO - no previously-included directories found matching 'dist' 06:10:36 INFO - no previously-included directories found matching '.git*' 06:10:36 INFO - Installing collected packages: jsonschema, functools32 06:10:36 INFO - Running setup.py install for functools32 06:10:36 INFO - warning: no files found matching '*.txt' 06:10:36 INFO - no previously-included directories found matching 'build' 06:10:36 INFO - no previously-included directories found matching 'dist' 06:10:36 INFO - no previously-included directories found matching '.git*' 06:10:36 INFO - Successfully installed jsonschema functools32 06:10:36 INFO - Cleaning up... 06:10:36 INFO - Return code: 0 06:10:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156570>, '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 0x1157470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1157900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', '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 06:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:10:36 INFO - Using env: {'DISPLAY': ':0', 06:10:36 INFO - 'HOME': '/home/cltbld', 06:10:36 INFO - 'LANG': 'en_US.UTF-8', 06:10:36 INFO - 'LANGUAGE': 'en_US:en', 06:10:36 INFO - 'LOGNAME': 'cltbld', 06:10:36 INFO - 'MAIL': '/var/mail/cltbld', 06:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:36 INFO - 'MOZ_NO_REMOTE': '1', 06:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:36 INFO - 'NO_EM_RESTART': '1', 06:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:36 INFO - 'PWD': '/builds/slave/test', 06:10:36 INFO - 'SHELL': '/bin/bash', 06:10:36 INFO - 'SHLVL': '1', 06:10:36 INFO - 'TERM': 'linux', 06:10:36 INFO - 'TMOUT': '86400', 06:10:36 INFO - 'USER': 'cltbld', 06:10:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', 06:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:36 INFO - '_': '/tools/buildbot/bin/python'} 06:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:10:36 INFO - Cleaning up... 06:10:36 INFO - Return code: 0 06:10:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156570>, '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 0x1157470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1157900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', '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 06:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:10:36 INFO - Using env: {'DISPLAY': ':0', 06:10:36 INFO - 'HOME': '/home/cltbld', 06:10:36 INFO - 'LANG': 'en_US.UTF-8', 06:10:36 INFO - 'LANGUAGE': 'en_US:en', 06:10:36 INFO - 'LOGNAME': 'cltbld', 06:10:36 INFO - 'MAIL': '/var/mail/cltbld', 06:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:36 INFO - 'MOZ_NO_REMOTE': '1', 06:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:36 INFO - 'NO_EM_RESTART': '1', 06:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:36 INFO - 'PWD': '/builds/slave/test', 06:10:36 INFO - 'SHELL': '/bin/bash', 06:10:36 INFO - 'SHLVL': '1', 06:10:36 INFO - 'TERM': 'linux', 06:10:36 INFO - 'TMOUT': '86400', 06:10:36 INFO - 'USER': 'cltbld', 06:10:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', 06:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:36 INFO - '_': '/tools/buildbot/bin/python'} 06:10:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:37 INFO - Downloading/unpacking blobuploader==1.2.4 06:10:37 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 06:10:37 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 06:10:37 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 06:10:37 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 06:10:37 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 06:10:37 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 06:10:38 INFO - Downloading blobuploader-1.2.4.tar.gz 06:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:10:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:10:39 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 06:10:39 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 06:10:39 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 06:10:39 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 06:10:39 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 06:10:39 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 06:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:10:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:10:39 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 06:10:39 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 06:10:39 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 06:10:39 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 06:10:39 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 06:10:39 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 06:10:39 INFO - Downloading docopt-0.6.1.tar.gz 06:10:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:10:39 INFO - Installing collected packages: blobuploader, requests, docopt 06:10:39 INFO - Running setup.py install for blobuploader 06:10:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:10:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:10:39 INFO - Running setup.py install for requests 06:10:40 INFO - Running setup.py install for docopt 06:10:40 INFO - Successfully installed blobuploader requests docopt 06:10:40 INFO - Cleaning up... 06:10:40 INFO - Return code: 0 06:10:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:40 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')]} 06:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:40 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')]} 06:10:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:40 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 0xe98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156570>, '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 0x1157470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1157900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', '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 06:10:40 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 06:10:40 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 06:10:40 INFO - Using env: {'DISPLAY': ':0', 06:10:40 INFO - 'HOME': '/home/cltbld', 06:10:40 INFO - 'LANG': 'en_US.UTF-8', 06:10:40 INFO - 'LANGUAGE': 'en_US:en', 06:10:40 INFO - 'LOGNAME': 'cltbld', 06:10:40 INFO - 'MAIL': '/var/mail/cltbld', 06:10:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:40 INFO - 'MOZ_NO_REMOTE': '1', 06:10:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:40 INFO - 'NO_EM_RESTART': '1', 06:10:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:40 INFO - 'PWD': '/builds/slave/test', 06:10:40 INFO - 'SHELL': '/bin/bash', 06:10:40 INFO - 'SHLVL': '1', 06:10:40 INFO - 'TERM': 'linux', 06:10:40 INFO - 'TMOUT': '86400', 06:10:40 INFO - 'USER': 'cltbld', 06:10:40 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', 06:10:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:40 INFO - '_': '/tools/buildbot/bin/python'} 06:10:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:10:40 INFO - Running setup.py (path:/tmp/pip-yYeBOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:10:40 INFO - Running setup.py (path:/tmp/pip-C9G8Yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:10:40 INFO - Running setup.py (path:/tmp/pip-m7BHwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:10:40 INFO - Running setup.py (path:/tmp/pip-2G2IDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:10:40 INFO - Running setup.py (path:/tmp/pip-iq4QAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:10:41 INFO - Running setup.py (path:/tmp/pip-M1Luqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:10:41 INFO - Running setup.py (path:/tmp/pip-DDz90h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:10:41 INFO - Running setup.py (path:/tmp/pip-Hp47lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:10:41 INFO - Running setup.py (path:/tmp/pip-9coRye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:10:41 INFO - Running setup.py (path:/tmp/pip-U3fR60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:10:41 INFO - Running setup.py (path:/tmp/pip-Cx5Gi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:10:41 INFO - Running setup.py (path:/tmp/pip-1HVwqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:10:41 INFO - Running setup.py (path:/tmp/pip-Idk0th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:10:41 INFO - Running setup.py (path:/tmp/pip-uyOXwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:41 INFO - Running setup.py (path:/tmp/pip-qlSGPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:10:41 INFO - Running setup.py (path:/tmp/pip-a4HolZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:10:41 INFO - Running setup.py (path:/tmp/pip-TA7nlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:10:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:10:41 INFO - Running setup.py install for manifestparser 06:10:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:10:41 INFO - Running setup.py install for mozcrash 06:10:42 INFO - Running setup.py install for mozdebug 06:10:42 INFO - Running setup.py install for mozdevice 06:10:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:10:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:10:42 INFO - Running setup.py install for mozfile 06:10:42 INFO - Running setup.py install for mozhttpd 06:10:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:10:42 INFO - Running setup.py install for mozinfo 06:10:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:10:42 INFO - Running setup.py install for mozInstall 06:10:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:10:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:10:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:10:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:10:42 INFO - Running setup.py install for mozleak 06:10:42 INFO - Running setup.py install for mozlog 06:10:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:10:42 INFO - Running setup.py install for moznetwork 06:10:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:10:42 INFO - Running setup.py install for mozprocess 06:10:43 INFO - Running setup.py install for mozprofile 06:10:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:10:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:10:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:10:43 INFO - Running setup.py install for mozrunner 06:10:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:10:43 INFO - Running setup.py install for mozscreenshot 06:10:43 INFO - Running setup.py install for moztest 06:10:43 INFO - Running setup.py install for mozversion 06:10:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:10:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:10:43 INFO - Cleaning up... 06:10:43 INFO - Return code: 0 06:10:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:43 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')]} 06:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:43 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')]} 06:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:43 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 0xe98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156570>, '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 0x1157470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1157900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', '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 06:10:43 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 06:10:43 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 06:10:43 INFO - Using env: {'DISPLAY': ':0', 06:10:43 INFO - 'HOME': '/home/cltbld', 06:10:43 INFO - 'LANG': 'en_US.UTF-8', 06:10:43 INFO - 'LANGUAGE': 'en_US:en', 06:10:43 INFO - 'LOGNAME': 'cltbld', 06:10:43 INFO - 'MAIL': '/var/mail/cltbld', 06:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:43 INFO - 'MOZ_NO_REMOTE': '1', 06:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:43 INFO - 'NO_EM_RESTART': '1', 06:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:43 INFO - 'PWD': '/builds/slave/test', 06:10:43 INFO - 'SHELL': '/bin/bash', 06:10:43 INFO - 'SHLVL': '1', 06:10:43 INFO - 'TERM': 'linux', 06:10:43 INFO - 'TMOUT': '86400', 06:10:43 INFO - 'USER': 'cltbld', 06:10:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', 06:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:43 INFO - '_': '/tools/buildbot/bin/python'} 06:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:10:43 INFO - Running setup.py (path:/tmp/pip-SNWOGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:10:43 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)) 06:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:10:43 INFO - Running setup.py (path:/tmp/pip-2C5HjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:10:44 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)) 06:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:10:44 INFO - Running setup.py (path:/tmp/pip-iK7lqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:10:44 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)) 06:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:10:44 INFO - Running setup.py (path:/tmp/pip-198JOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:10:44 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)) 06:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:10:44 INFO - Running setup.py (path:/tmp/pip-oWuimk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:10:44 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)) 06:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:10:44 INFO - Running setup.py (path:/tmp/pip-pmWpzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:10:44 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)) 06:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:10:44 INFO - Running setup.py (path:/tmp/pip-oXHLvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:10:44 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)) 06:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:10:44 INFO - Running setup.py (path:/tmp/pip-qwgiqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:10:44 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)) 06:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:10:44 INFO - Running setup.py (path:/tmp/pip-2seXTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:10:44 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)) 06:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:10:44 INFO - Running setup.py (path:/tmp/pip-yN5pIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:10:44 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)) 06:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:10:44 INFO - Running setup.py (path:/tmp/pip-dYujeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:10:44 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)) 06:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:10:44 INFO - Running setup.py (path:/tmp/pip-3TmSKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:10:44 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)) 06:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:10:44 INFO - Running setup.py (path:/tmp/pip-os4zlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:10:44 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)) 06:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:10:44 INFO - Running setup.py (path:/tmp/pip-NgYLQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:10:44 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)) 06:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:44 INFO - Running setup.py (path:/tmp/pip-RhIjEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:44 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)) 06:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:10:44 INFO - Running setup.py (path:/tmp/pip-RD12Gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:10:45 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)) 06:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:10:45 INFO - Running setup.py (path:/tmp/pip-VOOVvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:10:45 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)) 06:10:45 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)) 06:10:45 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)) 06:10:45 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)) 06:10:45 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)) 06:10:45 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)) 06:10:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:10: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 06:10: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 06:10: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 06:10: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 06:10: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 06:10: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 06:10:47 INFO - Downloading blessings-1.6.tar.gz 06:10:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:10:47 INFO - Installing collected packages: blessings 06:10:47 INFO - Running setup.py install for blessings 06:10:47 INFO - Successfully installed blessings 06:10:47 INFO - Cleaning up... 06:10:47 INFO - Return code: 0 06:10:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:10:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:10:47 INFO - Reading from file tmpfile_stdout 06:10:47 INFO - Current package versions: 06:10:47 INFO - argparse == 1.2.1 06:10:47 INFO - blessings == 1.6 06:10:47 INFO - blobuploader == 1.2.4 06:10:47 INFO - docopt == 0.6.1 06:10:47 INFO - functools32 == 3.2.3-2 06:10:47 INFO - jsonschema == 2.5.1 06:10:47 INFO - manifestparser == 1.1 06:10:47 INFO - mozInstall == 1.12 06:10:47 INFO - mozcrash == 0.17 06:10:47 INFO - mozdebug == 0.1 06:10:47 INFO - mozdevice == 0.48 06:10:47 INFO - mozfile == 1.2 06:10:47 INFO - mozhttpd == 0.7 06:10:47 INFO - mozinfo == 0.9 06:10:47 INFO - mozleak == 0.1 06:10:47 INFO - mozlog == 3.3 06:10:47 INFO - moznetwork == 0.27 06:10:47 INFO - mozprocess == 0.23 06:10:47 INFO - mozprofile == 0.28 06:10:47 INFO - mozrunner == 6.12 06:10:47 INFO - mozscreenshot == 0.1 06:10:47 INFO - mozsystemmonitor == 0.3 06:10:47 INFO - moztest == 0.7 06:10:47 INFO - mozversion == 1.4 06:10:47 INFO - psutil == 3.1.1 06:10:47 INFO - requests == 1.2.3 06:10:47 INFO - wsgiref == 0.1.2 06:10:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10: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')]} 06:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10: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')]} 06:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:47 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 0xe98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156570>, '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 0x1157470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1157900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', '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 06:10:47 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 06:10:47 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 06:10:47 INFO - Using env: {'DISPLAY': ':0', 06:10:47 INFO - 'HOME': '/home/cltbld', 06:10:47 INFO - 'LANG': 'en_US.UTF-8', 06:10:47 INFO - 'LANGUAGE': 'en_US:en', 06:10:47 INFO - 'LOGNAME': 'cltbld', 06:10:47 INFO - 'MAIL': '/var/mail/cltbld', 06:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:47 INFO - 'MOZ_NO_REMOTE': '1', 06:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:47 INFO - 'NO_EM_RESTART': '1', 06:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:47 INFO - 'PWD': '/builds/slave/test', 06:10:47 INFO - 'SHELL': '/bin/bash', 06:10:47 INFO - 'SHLVL': '1', 06:10:47 INFO - 'TERM': 'linux', 06:10:47 INFO - 'TMOUT': '86400', 06:10:47 INFO - 'USER': 'cltbld', 06:10:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', 06:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:47 INFO - '_': '/tools/buildbot/bin/python'} 06:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:47 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)) 06:10:47 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)) 06:10:47 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)) 06:10:47 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)) 06:10:47 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)) 06:10:47 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)) 06:10:47 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)) 06:10:47 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)) 06:10:47 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)) 06:10:47 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)) 06:10:47 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)) 06:10:47 INFO - Cleaning up... 06:10:47 INFO - Return code: 0 06:10:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:10: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')]} 06:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10: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')]} 06:10:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe98030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1156570>, '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 0x1157470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1157900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', '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 06:10: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'] in /builds/slave/test/build 06:10: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 06:10:47 INFO - Using env: {'DISPLAY': ':0', 06:10:47 INFO - 'HOME': '/home/cltbld', 06:10:47 INFO - 'LANG': 'en_US.UTF-8', 06:10:47 INFO - 'LANGUAGE': 'en_US:en', 06:10:47 INFO - 'LOGNAME': 'cltbld', 06:10:47 INFO - 'MAIL': '/var/mail/cltbld', 06:10:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:47 INFO - 'MOZ_NO_REMOTE': '1', 06:10:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:47 INFO - 'NO_EM_RESTART': '1', 06:10:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:47 INFO - 'PWD': '/builds/slave/test', 06:10:47 INFO - 'SHELL': '/bin/bash', 06:10:47 INFO - 'SHLVL': '1', 06:10:47 INFO - 'TERM': 'linux', 06:10:47 INFO - 'TMOUT': '86400', 06:10:47 INFO - 'USER': 'cltbld', 06:10:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', 06:10:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:47 INFO - '_': '/tools/buildbot/bin/python'} 06:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:10:47 INFO - Cleaning up... 06:10:47 INFO - Return code: 0 06:10:47 INFO - Running post-action listener: _resource_record_post_action 06:10:47 INFO - Running post-action listener: _start_resource_monitoring 06:10:47 INFO - Starting resource monitoring. 06:10:47 INFO - [mozharness: 2016-10-18 13:10:47.942803Z] Finished create-virtualenv step (success) 06:10:47 INFO - [mozharness: 2016-10-18 13:10:47.943271Z] Running install step. 06:10:47 INFO - Running pre-action listener: _resource_record_pre_action 06:10:47 INFO - Running main action method: install 06:10:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:10:48 INFO - Reading from file tmpfile_stdout 06:10:48 INFO - Detecting whether we're running mozinstall >=1.0... 06:10:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:10:48 INFO - Reading from file tmpfile_stdout 06:10:48 INFO - Output received: 06:10:48 INFO - Usage: mozinstall [options] installer 06:10:48 INFO - Options: 06:10:48 INFO - -h, --help show this help message and exit 06:10:48 INFO - -d DEST, --destination=DEST 06:10:48 INFO - Directory to install application into. [default: 06:10:48 INFO - "/builds/slave/test"] 06:10:48 INFO - --app=APP Application being installed. [default: firefox] 06:10:48 INFO - mkdir: /builds/slave/test/build/application 06:10:48 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'] 06:10:48 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 06:11:01 INFO - Reading from file tmpfile_stdout 06:11:01 INFO - Output received: 06:11:01 INFO - /builds/slave/test/build/application/firefox/firefox 06:11:01 INFO - Running post-action listener: _resource_record_post_action 06:11:01 INFO - [mozharness: 2016-10-18 13:11:01.744620Z] Finished install step (success) 06:11:01 INFO - [mozharness: 2016-10-18 13:11:01.744895Z] Running run-tests step. 06:11:01 INFO - Running pre-action listener: _resource_record_pre_action 06:11:01 INFO - Running main action method: run_tests 06:11:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:11:01 INFO - Python 2.7.3 06:11:01 INFO - Return code: 0 06:11:01 INFO - grabbing minidump binary from tooltool 06:11:01 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')]} 06:11:01 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 0x1156570>, '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 0x1157470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1157900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:11:01 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 06:11:01 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 06:11:01 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 06:11:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:11:01 INFO - Return code: 0 06:11:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:11:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:11:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:11:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:11:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:11:01 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/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 06:11:01 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/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 06:11:01 INFO - Using env: {'DISPLAY': ':0', 06:11:01 INFO - 'HOME': '/home/cltbld', 06:11:01 INFO - 'LANG': 'en_US.UTF-8', 06:11:01 INFO - 'LANGUAGE': 'en_US:en', 06:11:01 INFO - 'LOGNAME': 'cltbld', 06:11:01 INFO - 'MAIL': '/var/mail/cltbld', 06:11:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:11:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:11:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:11:01 INFO - 'MOZ_NO_REMOTE': '1', 06:11:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:11:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:11:01 INFO - 'NO_EM_RESTART': '1', 06:11:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:11:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:11:01 INFO - 'PWD': '/builds/slave/test', 06:11:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:11:01 INFO - 'SHELL': '/bin/bash', 06:11:01 INFO - 'SHLVL': '1', 06:11:01 INFO - 'TERM': 'linux', 06:11:01 INFO - 'TMOUT': '86400', 06:11:01 INFO - 'USER': 'cltbld', 06:11:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787', 06:11:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:11:01 INFO - '_': '/tools/buildbot/bin/python'} 06:11:01 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/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 06:11:02 INFO - mozversion application_buildid: 20161018030521 06:11:02 INFO - mozversion application_changeset: 62da552138459e86a7c25b1f2836e410454c5e5c 06:11:02 INFO - mozversion application_display_name: Firefox 06:11:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:11:02 INFO - mozversion application_name: Firefox 06:11:02 INFO - mozversion application_remotingname: firefox 06:11:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:11:02 INFO - mozversion application_vendor: Mozilla 06:11:02 INFO - mozversion application_version: 50.0 06:11:02 INFO - mozversion platform_buildid: 20161018030521 06:11:02 INFO - mozversion platform_changeset: 62da552138459e86a7c25b1f2836e410454c5e5c 06:11:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:11:02 INFO - mozversion platform_version: 50.0 06:11:02 INFO - using testdate: 1476796262 06:11:02 INFO - actual date: 1476796262 06:11:02 INFO - starting webserver on 'localhost:38705' 06:11:02 INFO - SUITE-START | Running 2 tests 06:11:02 INFO - TEST-START | dromaeo_css 06:11:02 INFO - operating with platform_type : linux_ 06:11:02 INFO - Initialising browser for dromaeo_css test... 06:11:02 INFO - TEST-INFO | started process 8508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHZKAh/profile http://localhost:38705/getInfo.html) 06:11:06 INFO - PROCESS | 8508 | __metrics Screen width/height:1600/1200 06:11:06 INFO - PROCESS | 8508 | colorDepth:24 06:11:06 INFO - PROCESS | 8508 | Browser inner width/height: 1024/697 06:11:06 INFO - PROCESS | 8508 | __metrics 06:11:07 ERROR - PROCESS | 8508 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:11:08 INFO - TEST-INFO | 8508: exit 0 06:11:08 INFO - Browser initialized. 06:11:08 INFO - Running cycle 1/1 for dromaeo_css test... 06:11:08 INFO - TEST-INFO | started process 8635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZHZKAh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:19 INFO - PROCESS | 8635 | RSS: Main: 149856256 06:11:19 INFO - PROCESS | 8635 | 06:12:09 INFO - PROCESS | 8635 | 1476796329592 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] 06:14:17 INFO - PROCESS | 8635 | Cycle 1(1): loaded http://localhost:38705/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38705/tests/dromaeo/cssquery-ext.html) 06:14:18 INFO - PROCESS | 8635 | RSS: Main: 158466048 06:14:18 INFO - PROCESS | 8635 | 06:17:20 INFO - PROCESS | 8635 | Cycle 1(1): loaded http://localhost:38705/tests/dromaeo/cssquery-ext.html (next: http://localhost:38705/tests/dromaeo/cssquery-jquery.html) 06:17:21 INFO - PROCESS | 8635 | RSS: Main: 155418624 06:17:21 INFO - PROCESS | 8635 | 06:20:23 INFO - PROCESS | 8635 | Cycle 1(1): loaded http://localhost:38705/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38705/tests/dromaeo/cssquery-mootools.html) 06:20:23 INFO - PROCESS | 8635 | RSS: Main: 155074560 06:20:23 INFO - PROCESS | 8635 | 06:23:25 INFO - PROCESS | 8635 | Cycle 1(1): loaded http://localhost:38705/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38705/tests/dromaeo/cssquery-prototype.html) 06:23:26 INFO - PROCESS | 8635 | RSS: Main: 156499968 06:23:26 INFO - PROCESS | 8635 | 06:26:28 INFO - PROCESS | 8635 | Cycle 1(1): loaded http://localhost:38705/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38705/tests/dromaeo/cssquery-yui.html) 06:26:29 INFO - PROCESS | 8635 | RSS: Main: 158035968 06:26:29 INFO - PROCESS | 8635 | 06:29:31 INFO - PROCESS | 8635 | Cycle 1(1): loaded http://localhost:38705/tests/dromaeo/cssquery-yui.html (next: http://localhost:38705/tests/dromaeo/cssquery-dojo.html) 06:29:31 INFO - PROCESS | 8635 | RSS: Main: 157761536 06:29:31 INFO - PROCESS | 8635 | 06:29:31 INFO - PROCESS | 8635 | __start_tp_report 06:29:31 INFO - PROCESS | 8635 | _x_x_mozilla_page_load 06:29:31 INFO - PROCESS | 8635 | _x_x_mozilla_page_load_details 06:29:31 INFO - PROCESS | 8635 | |i|pagename|runs| 06:29:31 INFO - PROCESS | 8635 | |0;dojo.html;3265.1837040739815;3286.5891763529576;3299.5215693724404;3301.867925282989;3307.9503807442893;5729.369769325376;5733.111367738002;5742.39704830993;5825.8252252432385;5827.067669172928;5722.399148089443;5738.31140263169;5764.164196191549;5774.855628609287;5806.912896306549;5192.480751924796;5213;5246.37043554772;5297.046531624306;5315.123004704219;5226.372835259775;5268.604854635899;5300.814471493499;5301.787928482856;5309.787608495655;5192.818251361203;5198.2982297389935;5275.0768615492325;5307.363116426034;5315.760790764425;5240.397354304266;5283.233931079972;5295;5334.813281535127;5402.51377376038;5242.5281724644965;5322.973385133049;5327.440618735054;5336.066188417011;5347.54545863602;5784.363719990798;5803.680797556132;5828.912566311508;5843.123531470271;5903.232579764646;5915.556333275022;6089.177960975256;6114.814446323758;6119.112728654365;6226.25284965807;6251.624902505819;6253.78111766086;6254;6255.562110652256;6271.059341098871;5785.768569257225;5804.738786754606;5812;5828.98514542504;5830.883382332329;6138.449706860497;6256.624602523863;6289.874202516015;6316.242050953915;6403.263624683128;6108.725107370179;6128.662923539159;6149.600275982047;6152.723127459275;6164.044573091178;6214.098955651405;6225.8132256032395;6275.090111933744;6285.560010799291;6291.182146320949;6031;6128.417800308964;6138.419052470195;6156.784512542129;6236.438720515175;6165.938340616536;6168.660723660242;6168.9691551541955;6169.598976066542;6224.657643829632;4740.549647783455;4742.928856067162;4753.35829662998;4763.666543341933;4765.7140571565815;4085.080856807254;4156.854510092132;4161.91676166475;4194.8112334945;4250.53244143144;5855.824325270249;6014.36849130835;6023.247094113236;6024.036154215304;6026.0659597762415;6261.311255761862;6266.624002559861;6289.496840252768;6295.622262664255;6302.432781049636;5724.713764311768;5880.500157486662;5947.49446297061;5955.196048533479;6027.969860150672;5342.6260161788305;5360.892782144335;5363.19552067193;5365.3293338332705;5377.650452720639;6255.56211065221;6493.188351456068;6499.252585952581;6512;6517.3808488193545;6130.214697154933;6135.601185922901;6143.416375444236;6235.127082208403;6235.501159907106;6368.968155159195;6403.655232401248;6409.198850143732;6418.1656384669695;6426.068220108152;5839.620424672383;6105.511559075352;6109.358517355614;6109.48069414087;6117.418845209698;6085.513158947185;6122.306673174842;6183.907241391293;6263;6277;6081.118237855575;6094.421030002142;6099.207103076749;6099.75600975956;6110.022396416552;5989.041753319448;6094.13321526467;6106.542009349228;6106.908396374147;6137.723802428812;5971.343152253162;5988.730507127277;6048.4858787003595;6093.268807743099;6123.14276001369;6119.418655227746;6123.050927106127;6146.139540464428;6187.690615469299;6208.379162083756;5843.532517398683;5927.673977931255;6010.519158467225;6011.6393016417405;6021.277446706424 06:29:31 INFO - PROCESS | 8635 | |1;ext.html;591.801746414951;630.2153818495972;660.5211221864148;664.7208172567524;713.247523862325;41263.381049284246;46457.53542464574;46464.07071858565;46508.534914650845;46529.06941861165;46100.769496152556;46594.534054659445;46679;46684.53315466845;46788;8996.865047024283;9184.816303673922;9190.72427827163;9194.264458843276;9208.355415120945;9151.267898568132;9157.130072643089;9230.492322922237;9241.537923103851;9251;9213.309001824857;9220.262379009697;9236.6305347786;9240;9282.257419406465;9144.817103657922;9181.495017774054;9186.58660360282;9191.264698824078;9221.861672074925;9156.816863662689;9222.631094756201;9251.306152038556;9253.907460925371;9279.628814847398;43589.346159807625;43830.780846095884;43923;44073.338899916525;44137.558624413985;3791.298609757176;3948.9802550987347;3985.860494882665;4071.1654110907193;4234.026173980002;34898;34917.12707182341;35451.82274088639;35634.10914727153;36325.27349453023;4626.768661566908;4712.976435117836;4715.858524244278;4725.125851717409;4761.904761904777;380155;380501;381096.0945195284;381571;381906;61199.69400152971;61462.692686536284;61569.692151538955;61585;61716.074258886154;40334.39498407526;41159.38260926089;41309.586904131174;42505.36241956311;64951.675241624434;19124;19296.8070319295;19364.515887102934;19370.903145484463;19390.4182874514;14960.551183464513;15034.323455444532;15071.54785356441;15073.246337683073;15093.924530377497;20238.190472381233;20287.79712202859;20415;20521.897390512953;20533.17867285292;7252.818679533054;7392.519486233377;7534.246575342422;7610.1628820829665;7641.579713115832;998.6305067125065;1095.1129585036147;1180.9940950295193;1186.9169158159018;1204.349651188366;31431.842840785648;32867.34265314681;32892.83553582265;33222.50166247508;33587.16032099168;1136.3466007045981;1171.6602185366319;1201.3152503073165;1245.0350977991948;1293.5407930184838;17119;17638.206280717397;18408.17163227658;18949.33677321287;19131.61736765257;629194;629844;631710;632548;634123;64937;65194;65228.347716523174;65491;65717.67141164359;1486.3905798622297;1490.2921112471706;1495.4093133212539;1500.129924643704;1524.542637208833;33262.5010624836;34605.653943460246;34625.96122116341;34704.132396690286;34706.82646586751;54976.450235497134;55861.72069139628;55891;55973.16040259318;55973.16040259481;535518;535540;537550;539454;540613;30262.84868575643;30666.693333067276;30914.845425772728;31071.533926991564;31103.68896311008;51436;51491.74254128705;52147.21779173239;52560;52851.73574132105;43434;43457.78271108624;44110;45878.770606146754;45902.08195836131;42525.78737106295;46765;46847.76576117097;47450.28824567703;47621;44901;45208.54791452044;46321.768391159174;46491.30263046124;46590.30114548352;36999.44500832436;40094.799526002185;40336.19327613372;40545;41045.38431923583;30009.549856751728;30085.398292034475;30416.239594009443;30574.929877454182;30629.387412252076 06:29:31 INFO - PROCESS | 8635 | |2;jquery.html;418.322317845091;424.27507648496294;432.60200615433797;433.56643356643355;436.23658597454454;19336.51658708533;20702.48243793904;20942.581148377023;21045.57908841826;22024.339269821932;19581.314653987112;20250.39248822534;20388.286409975615;20652.586948261025;20697.586048279027;5929.940700592982;6132;6134.693265336738;6140.171076904606;6141.692915354237;5993.640381577097;6002.909956350636;6014.969925150368;6029.005214139662;6053.697315134248;5962.105684147391;5998.100284957248;6007.849803754897;6016.127661489103;6038.5471089668235;5983.730732117044;6011.969940150315;6013.1882195903645;6025.0661147522205;6029.54778391618;5285.101532739443;5347.438518955531;5391.487808658171;5436.782528698847;5456.045192091407;24526;24538.877305613358;24553;24734.628980565307;24866.880990355476;2690.273626120956;2723.0741547873818;2736.2065001149645;3065.1877252528097;3192.4732419150814;15213.339628736838;15354.846451535454;15532.378704851792;15995.92002039994;16163.91918040414;2025.1494372363495;2025.2911480981538;2055.219016773631;2067.338451695458;2096.2663067926255;81301;82473.58763206206;82733.58633206795;82787.17212827916;83161.58419207926;10929.945350273198;11134.38551410041;11231.26996745209;11423.771524569462;11449.141314401453;16287.348506059861;16291.511254662379;16293.837061629232;16303.103329316764;16353.91823040901;8897.866532002025;9053.59258833354;9089.545522723838;9133.954330228305;9235.584398702074;8458.661653533913;8487.278581320534;8807;8937.134582674204;9074.183323500916;6877.862442751217;6945.131858517685;6988.301169883072;7052.541584796972;7121.184098055066;2010.3667344786345;2042.1831267493121;2042.7242322286597;2093.27781915239;2106.7050612914204;1022.5909636145601;1099.763550836558;1151.7063148897146;1154.463174623804;1167.6847251242286;20169.09239084245;21002.26492072801;21061.26285580028;21105.57788844245;21272.255471058437;1032.6230925712061;1061;1067.4502631144967;1078.126717358926;1104.1663544024211;11675.88324116748;11758.893280632356;11976.700582485508;11986.280823150464;12027.879721202851;543815;548817;549264;559266;561631;80087.59956200182;80858.59570702109;82926.58536707278;84234.15765842385;85092.57453712815;1051.4900273367564;1087.8477013218155;1113.2207454781685;1116.4919961417536;1121.7419993401563;17537.473875783748;18661.813381866552;18904.905475473086;19217.51956201106;19364.51588710237;44570.3314450277;45076.32385514286;45112.09775804531;45247.773761130986;45343.09313813639;58144;59806.10290845554;60004.09993850008;66165.66917165383;68138.3186168132;8627.827443451222;8907.599158037774;8917.375783695079;8968.596413161293;8995.415298005608;12259.570915018288;13654.385552650354;13769.449222031006;14268.500602478864;14331.211783352015;11272.887271127513;11558.364289964133;11756.000739936859;12805.295708736108;12858.67853303675;11382.373969431761;11923.940380298043;12137.21108127969;12252.448639811051;12382.257064576153;11351.37567433799;11676.241044332091;12233.816492752794;12311.261324320569;12321;7607.771766847003;8239.464434811718;8482.533460659723;8833.911660883567;8988.370814042953;12229.571964981184;12373;12443.564475243324;12491.37543122822;12676.366181691063 06:29:31 INFO - PROCESS | 8635 | |3;mootools.html;1549.86051255387;1566.6083479130218;1729.2650623485015;1832.4411054628333;1862.1620270878109;8249.381296402778;8798.912010879898;8938.553072346389;9547.188488978427;9562.187214086802;9000.324975626838;9318.487483188423;9359.812803743922;9401.200897923667;9453.952730236339;2419.5523828091773;2475.121331927158;2475.1460746042585;2477.4549599088264;2477.7274499805008;2380.3811009137576;2498.250524842549;2500.0499810072147;2507.034791605227;2509.335026218054;2437.1348171399163;2445.987770061156;2448.424620214248;2448.424620214248;2448.4490989527303;2448.436859522311;2449.2040086971806;2459.1515927005153;2482.4786794773117;2488.0669748844184;2362.3385452073276;2386.689730335045;2391.8445301055376;2393.1504315967927;2450.2894160693377;9283.442993420416;9345.252379809599;9368.110029547182;9368.625254989793;9371.390859594105;5241.266222728821;5317.734113294358;5385.838424847261;5393.217983392426;5398.082326004549;3434.796665131831;3544.680978711928;3552.626974167701;3563.6614521620404;3572.982135089334;1097.928634638746;1112.6161474291357;1115.827046807746;1117.4245263689206;1136.7442325476784;12972.80540791889;13064.673383165402;13076.934615326958;13085.86914130856;13119.147255428366;4582.885427864263;4705.4588722296685;4828.7102773833685;4862.80548778052;4884.413870335582;11151.498182581803;11158.832617510743;11166.05088567481;11173.553057877756;11200.10399168081;5343.332083489564;5408.8377348679605;5418.997485465202;5465.180222966586;5480.561555075585;4536.6143877770755;4908.558229759267;4992.650514463952;5011.373578302712;5038.874028149252;4260.318349064135;4302.290122129876;4341.196878577473;4344;4351.282038463618;1313.3761463304854;1323.4110820684896;1324.2253281830044;1325.7282257137456;1327.4557431453059;953.5280036382036;1060.957561697539;1062.527175406952;1082.3397727386289;1115.1524841120806;6153.84615384619;6256.624602523863;6321.810345689637;6439.774607888795;6657.434118099919;462.5212904643678;478.12741746312423;490.6075139888075;501.04800878331463;503.0919190860459;4605.562471565196;4606.032733126014;4659.767011649404;4661.230896901973;4667.369905062773;10609.89390106089;10991.560337586567;11442.14183936208;11503.942480287546;11522.539098436137;11068.335899846035;11394.601188958346;11412.201145919871;11423.828642570368;11440.542378304775;8336.291415229653;8488.066312705598;8536.530490823065;8546.871796923051;8547.444416113058;6446.5165112615805;6454.386833250834;6639.103720997797;6729.024291477806;6759.5606285591275;10332.586696532355;10340.586376545154;10415.583376664848;10635.627753028606;10733.516991735234;10569.788604227719;10623.150147988297;10819.080378167944;10962.451877406258;11014.229003969966;8028.397870159644;8109.959450202711;8319.043310019426;8361;8377.413581049512;9072.183503484717;9124;9124.133207345292;9124.817503649758;9124.908750912406;8218.260356567938;8223.383246256675;8250.711225107092;8376.87434688468;8395.454295470774;7909.3277071449575;7951.204879512234;7996.760097197093;8052.355811535181;8202.548859812767;6827;6834.829129271808;6897.620630865351;6922.550034247758;6966.860662786615;5715.228444159985;5721.342045664635;5772.855678608068;5775.249217601685;5851.824445266649;5608.943910560843;5628.718564071862;5673.8722978882915;5720.8283751487525;5817.970910145422 06:29:31 INFO - PROCESS | 8635 | |4;prototype.html;351.88563716792044;353.3410189995659;354.5603451719866;354.5852742821388;358.9766665166766;5786.929418057657;5787.276590426197;5798.710064496769;5824.44667756563;5850.414958504148;5703.372629010805;5710.314762228528;5710.543156547476;5723.599348045628;5732.197492351074;4244.660427165827;4459.264221403465;4461.308497182926;4479.977600112011;4482.686211965164;4471.910561788763;4479.3281007848755;4484.573965473275;4485;4497.3029180476915;4447.688661793676;4448.7553184575;4450.755208463534;4468.932966005513;4492.505824359318;4410.2943529035365;4461.754603496806;4462.085272519126;4467.3299005149165;4509.391232183646;3927.8625248116464;3933.6459718625174;3945.5462621798574;3962.722609417342;3999.6600288975474;5569.248151499536;5666.291713535808;5682.289713785777;5692.430756924316;5723.771049158028;4910.484399138075;5114;5145.30538377318;5159.406668233126;5189.481051894818;6038.879222415571;6083.422074902922;6085.908711369333;6098.2682078150465;6106.419890110433;4390.275604525282;4393.890152746207;4405.251107311765;4409.434650698988;4409.647228221735;6063.969680151615;6074.635521868658;6274.309825919191;6285.748570057238;6289.245290565162;4417.60241578253;4470.485894122217;4483.7533935633855;4493.078918821634;4493.573110554492;4509.481409637933;4520.141173177086;4554.407926969539;4556.794944227518;4565.931511027337;4922.72924989129;5159.845204643867;5169.922451163236;5185;5196.428392876781;6058.878822423527;6074.696265186812;6075.27096748393;6075.878482430327;6122.755089796358;1546.7757175209756;1556.6341909651223;1559.165846272239;1560.1029408090394;1568.5764843492193;954.7899462118323;975.6536429567543;982.8034393121261;1009.5658866687248;1028.0798685176874;5237.633365664443;5237.961982050401;5242.9213561796605;5243.060067774948;5253.373313343328;5446.1558458439;5459.317585301837;5481.671099734029;5492.901419715993;5517.586181036439;4896.53104068778;5198.558122559549;5242.68543887368;5262.8947421052135;5307.310049693592;2892.363679990399;2937.6474823021376;2941.191172427557;2943.440746258204;2966.569847372119;5624.353199382123;5655.971720141455;5693.348928810681;5696.829095127153;5698;5918.585699001114;6355.269144048401;6370.490360771128;6382.234131904108;6437.710303036374;6496.707648155844;6502.2118917297175;6504;6507.381798729113;6543.574667646588;6078.817635470943;6177.567570270038;6256.562040657111;6266.154069200599;6278.246610406781;6137.140800288053;6144.38556144382;6176.969115154396;6179.938200617937;6194.256689197326;6257.748450309865;6444.903326450013;6491.545591808528;6500.089987401862;6548.705308261235;4464.263396539534;4496.527864574304;4507.909841803211;4512.9774351128035;4531.685811114739;6143.730107575192;6239.661780947172;6316.7473301069285;6376.458001069961;6442.09810626522;6145.293291271382;6172.660503672341;6176.66028368444;6177;6184.5052395809125;5924.851878703067;6129.540284478593;6150.630962142286;6167.568270221221;6173.629582225081;6034.909476357946;6078.088286757022;6087.726052327745;6096;6109.228323786052;6194.318624951342;6194.81415557534;6226.315105338319;6240.968795155995;6251.343608920998;5824.650520968756;5890.440408161217;5981.756841184556;5982.760689572542;6097.878042439038 06:29:31 INFO - PROCESS | 8635 | |5;yui.html;851.5188918261182;864.226517267046;864.2610567964387;892.4288455388553;922.5802259971714;16202.351905923764;17367.565810854703;17508.82491175088;17572.73640895386;17640.911795441036;15651.295691693873;15998.200089995511;16028.118453485054;16191.757123643154;16297;876.2464280718577;892.9955350223272;898.5103118800237;898.6989358564889;901.8602116671926;848.1730312944891;889.1464194373377;889.3063410539789;889.7553172877479;893.9955300223489;929.0848514213494;934.7429456899339;935.050923312838;936.7845395559026;938.1181689212153;924.6578765856676;927.8561822917459;929.9256059515291;932.3753085432743;932.8460803967337;681.6455443169574;684.555039224503;685.9725610975555;687.7420967137324;688.703857341343;15475.922620386826;15494.457693980768;15536.844631553653;15561.066336019874;15572.532824015298;16236.350545978265;16341.509754707378;16617.750733739005;16681.24934377956;16699.91650041742;13677;13911.095778774346;13962.58112256634;14010.299485025707;14062.367193476319;4135.710500264982;4146.854860079913;4148.605882441163;4165;4247.19303332369;92034;92496.53751731265;92830;93995;94742.5262873688;11976.221545599508;11993.88006119945;11994.580189693494;11997.820032699516;12066.638000859988;23914.40213994629;23925.16261930824;23943.760562394153;23952.161674341663;24063.879680601836;8368.748937531884;8561.828763424697;8721.171488708562;8739.781505462413;8764.123587641312;4960.355153829979;5030.0694371541385;5041.0422019816115;5109.105906466353;5148.176291793295;3809.4285857121654;3880.20455806559;3911.413288006765;3918.2163567286657;3944.4674968878835;667.2893368562466;668.2682462703332;685.1880521581942;692.9480288978245;696.4254490045732;697.9720811167497;713.9357457828717;765.242410014082;775.5656832174001;804.818990155599;9777.706668799947;10129.442880641636;11333.94333028346;11715.882841171479;12265.386730663431;811.3225456743567;846.5640195299426;848.0798333807764;848.5460278750838;867.444835305405;5373.167159090347;5391.433899440581;5410.567154627621;5525.4474552545225;5562.972185139049;102520.48739756254;108089;112120;122087.38956305162;125651;91874.54062729643;99643.50178249062;100682.4965875166;101168;103530.48234758929;90557.54721226351;91225.99999999868;92243;94163.52918235365;94888;10692.46739313987;10744.30162039465;10916;10929.78140437171;11170.218084734315;53695.46304536905;54874.45125548853;55448.72275638596;55581.44418555763;58608.413915862;68875.65562172358;70396;73724;78587.60706196433;81192;14350.569482915529;14517.564473065824;14721.852781472477;14930.328135234158;15027.549173524812;16623.83376166223;16799.41202057922;16979.066151361792;17437.128143593025;17920.91039544846;14358.282085895455;14520;15287.464938727091;15496.147711875505;15962.920185399464;13409.865901341253;15210.619734506727;15351.462698805488;15755.44855930037;16156.838431615533;14702;14970;15054.172020538976;15251.847481525043;15412.152331621868;12108.21296615717;12649.304288264233;12852.614421567368;13057.08600397963;13401;12170.45232964501;12344.321062341658;12395.504179833066;12559.623211303675;12641.683957901127 06:29:31 INFO - PROCESS | 8635 | __end_tp_report 06:29:31 INFO - PROCESS | 8635 | __start_cc_report 06:29:31 INFO - PROCESS | 8635 | _x_x_mozilla_cycle_collect,338 06:29:31 INFO - PROCESS | 8635 | __end_cc_report 06:29:31 INFO - PROCESS | 8635 | __startTimestamp1476797371822__endTimestamp 06:29:31 INFO - PROCESS | 8635 | 06:29:31 INFO - PROCESS | 8635 | ------- Summary: start ------- 06:29:31 INFO - PROCESS | 8635 | Number of tests: 6 06:29:31 INFO - PROCESS | 8635 | 06:29:31 INFO - PROCESS | 8635 | [#0] dojo.html Cycles:165 Average:5767.54 Median:6024.04 stddev:666.41 (11.1%) stddev-sans-first:638.89 06:29:31 INFO - PROCESS | 8635 | Values: 3265.2 3286.6 3299.5 3301.9 3308.0 5729.4 5733.1 5742.4 5825.8 5827.1 5722.4 5738.3 5764.2 5774.9 5806.9 5192.5 5213.0 5246.4 5297.0 5315.1 5226.4 5268.6 5300.8 5301.8 5309.8 5192.8 5198.3 5275.1 5307.4 5315.8 5240.4 5283.2 5295.0 5334.8 5402.5 5242.5 5323.0 5327.4 5336.1 5347.5 5784.4 5803.7 5828.9 5843.1 5903.2 5915.6 6089.2 6114.8 6119.1 6226.3 6251.6 6253.8 6254.0 6255.6 6271.1 5785.8 5804.7 5812.0 5829.0 5830.9 6138.4 6256.6 6289.9 6316.2 6403.3 6108.7 6128.7 6149.6 6152.7 6164.0 6214.1 6225.8 6275.1 6285.6 6291.2 6031.0 6128.4 6138.4 6156.8 6236.4 6165.9 6168.7 6169.0 6169.6 6224.7 4740.5 4742.9 4753.4 4763.7 4765.7 4085.1 4156.9 4161.9 4194.8 4250.5 5855.8 6014.4 6023.2 6024.0 6026.1 6261.3 6266.6 6289.5 6295.6 6302.4 5724.7 5880.5 5947.5 5955.2 6028.0 5342.6 5360.9 5363.2 5365.3 5377.7 6255.6 6493.2 6499.3 6512.0 6517.4 6130.2 6135.6 6143.4 6235.1 6235.5 6369.0 6403.7 6409.2 6418.2 6426.1 5839.6 6105.5 6109.4 6109.5 6117.4 6085.5 6122.3 6183.9 6263.0 6277.0 6081.1 6094.4 6099.2 6099.8 6110.0 5989.0 6094.1 6106.5 6106.9 6137.7 5971.3 5988.7 6048.5 6093.3 6123.1 6119.4 6123.1 6146.1 6187.7 6208.4 5843.5 5927.7 6010.5 6011.6 6021.3 06:29:31 INFO - PROCESS | 8635 | 06:29:31 INFO - PROCESS | 8635 | [#1] ext.html Cycles:180 Average:67969.18 Median:45890.43 stddev:140246.03 (305.6%) stddev-sans-first:140548.22 06:29:31 INFO - PROCESS | 8635 | Values: 591.8 630.2 660.5 664.7 713.2 41263.4 46457.5 46464.1 46508.5 46529.1 46100.8 46594.5 46679.0 46684.5 46788.0 8996.9 9184.8 9190.7 9194.3 9208.4 9151.3 9157.1 9230.5 9241.5 9251.0 9213.3 9220.3 9236.6 9240.0 9282.3 9144.8 9181.5 9186.6 9191.3 9221.9 9156.8 9222.6 9251.3 9253.9 9279.6 43589.3 43830.8 43923.0 44073.3 44137.6 3791.3 3949.0 3985.9 4071.2 4234.0 34898.0 34917.1 35451.8 35634.1 36325.3 4626.8 4713.0 4715.9 4725.1 4761.9 380155.0 380501.0 381096.1 381571.0 381906.0 61199.7 61462.7 61569.7 61585.0 61716.1 40334.4 41159.4 41309.6 42505.4 64951.7 19124.0 19296.8 19364.5 19370.9 19390.4 14960.6 15034.3 15071.5 15073.2 15093.9 20238.2 20287.8 20415.0 20521.9 20533.2 7252.8 7392.5 7534.2 7610.2 7641.6 998.6 1095.1 1181.0 1186.9 1204.3 31431.8 32867.3 32892.8 33222.5 33587.2 1136.3 1171.7 1201.3 1245.0 1293.5 17119.0 17638.2 18408.2 18949.3 19131.6 629194.0 629844.0 631710.0 632548.0 634123.0 64937.0 65194.0 65228.3 65491.0 65717.7 1486.4 1490.3 1495.4 1500.1 1524.5 33262.5 34605.7 34626.0 34704.1 34706.8 54976.5 55861.7 55891.0 55973.2 55973.2 535518.0 535540.0 537550.0 539454.0 540613.0 30262.8 30666.7 30914.8 31071.5 31103.7 51436.0 51491.7 52147.2 52560.0 52851.7 43434.0 43457.8 44110.0 45878.8 45902.1 42525.8 46765.0 46847.8 47450.3 47621.0 44901.0 45208.5 46321.8 46491.3 46590.3 36999.4 40094.8 40336.2 40545.0 41045.4 30009.5 30085.4 30416.2 30574.9 30629.4 06:29:31 INFO - PROCESS | 8635 | 06:29:31 INFO - PROCESS | 8635 | [#2] jquery.html Cycles:180 Average:31395.28 Median:24532.44 stddev:90593.84 (369.3%) stddev-sans-first:90818.12 06:29:31 INFO - PROCESS | 8635 | Values: 418.3 424.3 432.6 433.6 436.2 19336.5 20702.5 20942.6 21045.6 22024.3 19581.3 20250.4 20388.3 20652.6 20697.6 5929.9 6132.0 6134.7 6140.2 6141.7 5993.6 6002.9 6015.0 6029.0 6053.7 5962.1 5998.1 6007.8 6016.1 6038.5 5983.7 6012.0 6013.2 6025.1 6029.5 5285.1 5347.4 5391.5 5436.8 5456.0 24526.0 24538.9 24553.0 24734.6 24866.9 2690.3 2723.1 2736.2 3065.2 3192.5 15213.3 15354.8 15532.4 15995.9 16163.9 2025.1 2025.3 2055.2 2067.3 2096.3 81301.0 82473.6 82733.6 82787.2 83161.6 10929.9 11134.4 11231.3 11423.8 11449.1 16287.3 16291.5 16293.8 16303.1 16353.9 8897.9 9053.6 9089.5 9134.0 9235.6 8458.7 8487.3 8807.0 8937.1 9074.2 6877.9 6945.1 6988.3 7052.5 7121.2 2010.4 2042.2 2042.7 2093.3 2106.7 1022.6 1099.8 1151.7 1154.5 1167.7 20169.1 21002.3 21061.3 21105.6 21272.3 1032.6 1061.0 1067.5 1078.1 1104.2 11675.9 11758.9 11976.7 11986.3 12027.9 543815.0 548817.0 549264.0 559266.0 561631.0 80087.6 80858.6 82926.6 84234.2 85092.6 1051.5 1087.8 1113.2 1116.5 1121.7 17537.5 18661.8 18904.9 19217.5 19364.5 44570.3 45076.3 45112.1 45247.8 45343.1 58144.0 59806.1 60004.1 66165.7 68138.3 8627.8 8907.6 8917.4 8968.6 8995.4 12259.6 13654.4 13769.4 14268.5 14331.2 11272.9 11558.4 11756.0 12805.3 12858.7 11382.4 11923.9 12137.2 12252.4 12382.3 11351.4 11676.2 12233.8 12311.3 12321.0 7607.8 8239.5 8482.5 8833.9 8988.4 12229.6 12373.0 12443.6 12491.4 12676.4 06:29:31 INFO - PROCESS | 8635 | 06:29:31 INFO - PROCESS | 8635 | [#3] mootools.html Cycles:180 Average:6114.24 Median:4664.30 stddev:3485.79 (74.7%) stddev-sans-first:3478.69 06:29:31 INFO - PROCESS | 8635 | Values: 1549.9 1566.6 1729.3 1832.4 1862.2 8249.4 8798.9 8938.6 9547.2 9562.2 9000.3 9318.5 9359.8 9401.2 9454.0 2419.6 2475.1 2475.1 2477.5 2477.7 2380.4 2498.3 2500.0 2507.0 2509.3 2437.1 2446.0 2448.4 2448.4 2448.4 2448.4 2449.2 2459.2 2482.5 2488.1 2362.3 2386.7 2391.8 2393.2 2450.3 9283.4 9345.3 9368.1 9368.6 9371.4 5241.3 5317.7 5385.8 5393.2 5398.1 3434.8 3544.7 3552.6 3563.7 3573.0 1097.9 1112.6 1115.8 1117.4 1136.7 12972.8 13064.7 13076.9 13085.9 13119.1 4582.9 4705.5 4828.7 4862.8 4884.4 11151.5 11158.8 11166.1 11173.6 11200.1 5343.3 5408.8 5419.0 5465.2 5480.6 4536.6 4908.6 4992.7 5011.4 5038.9 4260.3 4302.3 4341.2 4344.0 4351.3 1313.4 1323.4 1324.2 1325.7 1327.5 953.5 1061.0 1062.5 1082.3 1115.2 6153.8 6256.6 6321.8 6439.8 6657.4 462.5 478.1 490.6 501.0 503.1 4605.6 4606.0 4659.8 4661.2 4667.4 10609.9 10991.6 11442.1 11503.9 11522.5 11068.3 11394.6 11412.2 11423.8 11440.5 8336.3 8488.1 8536.5 8546.9 8547.4 6446.5 6454.4 6639.1 6729.0 6759.6 10332.6 10340.6 10415.6 10635.6 10733.5 10569.8 10623.2 10819.1 10962.5 11014.2 8028.4 8110.0 8319.0 8361.0 8377.4 9072.2 9124.0 9124.1 9124.8 9124.9 8218.3 8223.4 8250.7 8376.9 8395.5 7909.3 7951.2 7996.8 8052.4 8202.5 6827.0 6834.8 6897.6 6922.6 6966.9 5715.2 5721.3 5772.9 5775.2 5851.8 5608.9 5628.7 5673.9 5720.8 5818.0 06:29:31 INFO - PROCESS | 8635 | 06:29:31 INFO - PROCESS | 8635 | [#4] prototype.html Cycles:180 Average:5038.30 Median:5674.29 stddev:1496.52 (26.4%) stddev-sans-first:1458.80 06:29:31 INFO - PROCESS | 8635 | Values: 351.9 353.3 354.6 354.6 359.0 5786.9 5787.3 5798.7 5824.4 5850.4 5703.4 5710.3 5710.5 5723.6 5732.2 4244.7 4459.3 4461.3 4480.0 4482.7 4471.9 4479.3 4484.6 4485.0 4497.3 4447.7 4448.8 4450.8 4468.9 4492.5 4410.3 4461.8 4462.1 4467.3 4509.4 3927.9 3933.6 3945.5 3962.7 3999.7 5569.2 5666.3 5682.3 5692.4 5723.8 4910.5 5114.0 5145.3 5159.4 5189.5 6038.9 6083.4 6085.9 6098.3 6106.4 4390.3 4393.9 4405.3 4409.4 4409.6 6064.0 6074.6 6274.3 6285.7 6289.2 4417.6 4470.5 4483.8 4493.1 4493.6 4509.5 4520.1 4554.4 4556.8 4565.9 4922.7 5159.8 5169.9 5185.0 5196.4 6058.9 6074.7 6075.3 6075.9 6122.8 1546.8 1556.6 1559.2 1560.1 1568.6 954.8 975.7 982.8 1009.6 1028.1 5237.6 5238.0 5242.9 5243.1 5253.4 5446.2 5459.3 5481.7 5492.9 5517.6 4896.5 5198.6 5242.7 5262.9 5307.3 2892.4 2937.6 2941.2 2943.4 2966.6 5624.4 5656.0 5693.3 5696.8 5698.0 5918.6 6355.3 6370.5 6382.2 6437.7 6496.7 6502.2 6504.0 6507.4 6543.6 6078.8 6177.6 6256.6 6266.2 6278.2 6137.1 6144.4 6177.0 6179.9 6194.3 6257.7 6444.9 6491.5 6500.1 6548.7 4464.3 4496.5 4507.9 4513.0 4531.7 6143.7 6239.7 6316.7 6376.5 6442.1 6145.3 6172.7 6176.7 6177.0 6184.5 5924.9 6129.5 6150.6 6167.6 6173.6 6034.9 6078.1 6087.7 6096.0 6109.2 6194.3 6194.8 6226.3 6241.0 6251.3 5824.7 5890.4 5981.8 5982.8 6097.9 06:29:31 INFO - PROCESS | 8635 | 06:29:31 INFO - PROCESS | 8635 | [#5] yui.html Cycles:180 Average:22328.59 Median:3931.34 stddev:31220.36 (794.1%) stddev-sans-first:31266.29 06:29:31 INFO - PROCESS | 8635 | Values: 851.5 864.2 864.3 892.4 922.6 16202.4 17367.6 17508.8 17572.7 17640.9 15651.3 15998.2 16028.1 16191.8 16297.0 876.2 893.0 898.5 898.7 901.9 848.2 889.1 889.3 889.8 894.0 929.1 934.7 935.1 936.8 938.1 924.7 927.9 929.9 932.4 932.8 681.6 684.6 686.0 687.7 688.7 15475.9 15494.5 15536.8 15561.1 15572.5 16236.4 16341.5 16617.8 16681.2 16699.9 13677.0 13911.1 13962.6 14010.3 14062.4 4135.7 4146.9 4148.6 4165.0 4247.2 92034.0 92496.5 92830.0 93995.0 94742.5 11976.2 11993.9 11994.6 11997.8 12066.6 23914.4 23925.2 23943.8 23952.2 24063.9 8368.7 8561.8 8721.2 8739.8 8764.1 4960.4 5030.1 5041.0 5109.1 5148.2 3809.4 3880.2 3911.4 3918.2 3944.5 667.3 668.3 685.2 692.9 696.4 698.0 713.9 765.2 775.6 804.8 9777.7 10129.4 11333.9 11715.9 12265.4 811.3 846.6 848.1 848.5 867.4 5373.2 5391.4 5410.6 5525.4 5563.0 102520.5 108089.0 112120.0 122087.4 125651.0 91874.5 99643.5 100682.5 101168.0 103530.5 90557.5 91226.0 92243.0 94163.5 94888.0 10692.5 10744.3 10916.0 10929.8 11170.2 53695.5 54874.5 55448.7 55581.4 58608.4 68875.7 70396.0 73724.0 78587.6 81192.0 14350.6 14517.6 14721.9 14930.3 15027.5 16623.8 16799.4 16979.1 17437.1 17920.9 14358.3 14520.0 15287.5 15496.1 15962.9 13409.9 15210.6 15351.5 15755.4 16156.8 14702.0 14970.0 15054.2 15251.8 15412.2 12108.2 12649.3 12852.6 13057.1 13401.0 12170.5 12344.3 12395.5 12559.6 12641.7 06:29:31 INFO - PROCESS | 8635 | -------- Summary: end -------- 06:29:31 INFO - PROCESS | 8635 | 06:29:32 INFO - TEST-INFO | 8635: exit 0 06:29:32 INFO - TEST-OK | dromaeo_css | took 1110495ms 06:29:32 INFO - TEST-START | kraken 06:29:32 INFO - operating with platform_type : linux_ 06:29:32 INFO - Initialising browser for kraken test... 06:29:32 INFO - TEST-INFO | started process 8877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO0izj4/profile http://localhost:38705/getInfo.html) 06:29:37 INFO - PROCESS | 8877 | __metrics Screen width/height:1600/1200 06:29:37 INFO - PROCESS | 8877 | colorDepth:24 06:29:37 INFO - PROCESS | 8877 | Browser inner width/height: 1024/697 06:29:37 INFO - PROCESS | 8877 | __metrics 06:29:37 ERROR - PROCESS | 8877 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:29:38 INFO - TEST-INFO | 8877: exit 0 06:29:38 INFO - Browser initialized. 06:29:38 INFO - Running cycle 1/1 for kraken test... 06:29:38 INFO - TEST-INFO | started process 9005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO0izj4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:29:50 INFO - PROCESS | 9005 | RSS: Main: 149905408 06:29:50 INFO - PROCESS | 9005 | 06:29:52 INFO - PROCESS | 9005 | Cycle 1(1): loaded http://localhost:38705/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38705/tests/kraken/driver.html?testName=audio-beat-detection) 06:29:53 INFO - PROCESS | 9005 | RSS: Main: 157093888 06:29:53 INFO - PROCESS | 9005 | 06:29:56 INFO - PROCESS | 9005 | Cycle 1(1): loaded http://localhost:38705/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38705/tests/kraken/driver.html?testName=audio-dft) 06:29:56 INFO - PROCESS | 9005 | RSS: Main: 155459584 06:29:56 INFO - PROCESS | 9005 | 06:29:59 INFO - PROCESS | 9005 | Cycle 1(1): loaded http://localhost:38705/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38705/tests/kraken/driver.html?testName=audio-fft) 06:30:00 INFO - PROCESS | 9005 | RSS: Main: 156413952 06:30:00 INFO - PROCESS | 9005 | 06:30:02 INFO - PROCESS | 9005 | Cycle 1(1): loaded http://localhost:38705/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38705/tests/kraken/driver.html?testName=audio-oscillator) 06:30:03 INFO - PROCESS | 9005 | RSS: Main: 156086272 06:30:03 INFO - PROCESS | 9005 | 06:30:05 INFO - PROCESS | 9005 | Cycle 1(1): loaded http://localhost:38705/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38705/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:30:05 INFO - PROCESS | 9005 | RSS: Main: 156123136 06:30:05 INFO - PROCESS | 9005 | 06:30:08 INFO - PROCESS | 9005 | Cycle 1(1): loaded http://localhost:38705/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38705/tests/kraken/driver.html?testName=imaging-darkroom) 06:30:09 INFO - PROCESS | 9005 | RSS: Main: 155746304 06:30:09 INFO - PROCESS | 9005 | 06:30:12 INFO - PROCESS | 9005 | Cycle 1(1): loaded http://localhost:38705/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38705/tests/kraken/driver.html?testName=imaging-desaturate) 06:30:13 INFO - PROCESS | 9005 | RSS: Main: 156327936 06:30:13 INFO - PROCESS | 9005 | 06:30:16 INFO - PROCESS | 9005 | Cycle 1(1): loaded http://localhost:38705/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38705/tests/kraken/driver.html?testName=json-parse-financial) 06:30:16 INFO - PROCESS | 9005 | RSS: Main: 156516352 06:30:16 INFO - PROCESS | 9005 | 06:30:18 INFO - PROCESS | 9005 | Cycle 1(1): loaded http://localhost:38705/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38705/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:30:19 INFO - PROCESS | 9005 | RSS: Main: 155639808 06:30:19 INFO - PROCESS | 9005 | 06:30:20 INFO - PROCESS | 9005 | Cycle 1(1): loaded http://localhost:38705/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38705/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:30:21 INFO - PROCESS | 9005 | RSS: Main: 156073984 06:30:21 INFO - PROCESS | 9005 | 06:30:23 INFO - PROCESS | 9005 | Cycle 1(1): loaded http://localhost:38705/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38705/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:30:24 INFO - PROCESS | 9005 | RSS: Main: 156446720 06:30:24 INFO - PROCESS | 9005 | 06:30:26 INFO - PROCESS | 9005 | Cycle 1(1): loaded http://localhost:38705/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38705/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:30:27 INFO - PROCESS | 9005 | RSS: Main: 156336128 06:30:27 INFO - PROCESS | 9005 | 06:30:29 INFO - PROCESS | 9005 | Cycle 1(1): loaded http://localhost:38705/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38705/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:30:30 INFO - PROCESS | 9005 | RSS: Main: 156422144 06:30:30 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | Cycle 1(1): loaded http://localhost:38705/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38705/tests/kraken/driver.html?testName=ai-astar) 06:30:32 INFO - PROCESS | 9005 | RSS: Main: 158318592 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | __start_tp_report 06:30:32 INFO - PROCESS | 9005 | _x_x_mozilla_page_load 06:30:32 INFO - PROCESS | 9005 | _x_x_mozilla_page_load_details 06:30:32 INFO - PROCESS | 9005 | |i|pagename|runs| 06:30:32 INFO - PROCESS | 9005 | |0;ai-astar;101;115;106;111;113;112;113;111;113;111 06:30:32 INFO - PROCESS | 9005 | |1;audio-beat-detection;140;120;142;175;117;144;142;119;186;117 06:30:32 INFO - PROCESS | 9005 | |2;audio-dft;163;162;162;163;163;162;162;161;161;160 06:30:32 INFO - PROCESS | 9005 | |3;audio-fft;76;76;76;186;75;75;75;75;161;75 06:30:32 INFO - PROCESS | 9005 | |4;audio-oscillator;84;83;142;86;83;84;149;83;84;151 06:30:32 INFO - PROCESS | 9005 | |5;imaging-gaussian-blur;118;118;117;117;117;118;117;117;117;118 06:30:32 INFO - PROCESS | 9005 | |6;imaging-darkroom;148;148;147;148;148;147;147;148;147;147 06:30:32 INFO - PROCESS | 9005 | |7;imaging-desaturate;95;95;96;97;95;95;95;96;95;95 06:30:32 INFO - PROCESS | 9005 | |8;json-parse-financial;52;53;52;51;53;51;52;50;51;51 06:30:32 INFO - PROCESS | 9005 | |9;json-stringify-tinderbox;60;61;60;60;60;60;61;61;61;60 06:30:32 INFO - PROCESS | 9005 | |10;stanford-crypto-aes;74;73;76;79;73;82;73;72;74;75 06:30:32 INFO - PROCESS | 9005 | |11;stanford-crypto-ccm;128;122;129;121;139;121;125;118;155;125 06:30:32 INFO - PROCESS | 9005 | |12;stanford-crypto-pbkdf2;154;158;151;156;153;161;156;152;157;154 06:30:32 INFO - PROCESS | 9005 | |13;stanford-crypto-sha256-iterative;64;63;61;61;62;64;62;62;61;67 06:30:32 INFO - PROCESS | 9005 | __end_tp_report 06:30:32 INFO - PROCESS | 9005 | __start_cc_report 06:30:32 INFO - PROCESS | 9005 | _x_x_mozilla_cycle_collect,867 06:30:32 INFO - PROCESS | 9005 | __end_cc_report 06:30:32 INFO - PROCESS | 9005 | __startTimestamp1476797432448__endTimestamp 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | ------- Summary: start ------- 06:30:32 INFO - PROCESS | 9005 | Number of tests: 14 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.50 stddev:4.12 (3.7%) stddev-sans-first:2.50 06:30:32 INFO - PROCESS | 9005 | Values: 101.0 115.0 106.0 111.0 113.0 112.0 113.0 111.0 113.0 111.0 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:142.00 stddev:24.18 (17.0%) stddev-sans-first:25.65 06:30:32 INFO - PROCESS | 9005 | Values: 140.0 120.0 142.0 175.0 117.0 144.0 142.0 119.0 186.0 117.0 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 06:30:32 INFO - PROCESS | 9005 | Values: 163.0 162.0 162.0 163.0 163.0 162.0 162.0 161.0 161.0 160.0 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | [#3] audio-fft Cycles:10 Average:95.00 Median:75.00 stddev:41.79 (55.7%) stddev-sans-first:43.76 06:30:32 INFO - PROCESS | 9005 | Values: 76.0 76.0 76.0 186.0 75.0 75.0 75.0 75.0 161.0 75.0 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:83.50 stddev:30.76 (36.8%) stddev-sans-first:31.85 06:30:32 INFO - PROCESS | 9005 | Values: 84.0 83.0 142.0 86.0 83.0 84.0 149.0 83.0 84.0 151.0 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:30:32 INFO - PROCESS | 9005 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:30:32 INFO - PROCESS | 9005 | Values: 148.0 148.0 147.0 148.0 148.0 147.0 147.0 148.0 147.0 147.0 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 06:30:32 INFO - PROCESS | 9005 | Values: 95.0 95.0 96.0 97.0 95.0 95.0 95.0 96.0 95.0 95.0 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:0.97 (1.9%) stddev-sans-first:1.01 06:30:32 INFO - PROCESS | 9005 | Values: 52.0 53.0 52.0 51.0 53.0 51.0 52.0 50.0 51.0 51.0 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 06:30:32 INFO - PROCESS | 9005 | Values: 60.0 61.0 60.0 60.0 60.0 60.0 61.0 61.0 61.0 60.0 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:74.50 stddev:3.14 (4.2%) stddev-sans-first:3.31 06:30:32 INFO - PROCESS | 9005 | Values: 74.0 73.0 76.0 79.0 73.0 82.0 73.0 72.0 74.0 75.0 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:126.50 stddev:11.07 (8.7%) stddev-sans-first:11.74 06:30:32 INFO - PROCESS | 9005 | Values: 128.0 122.0 129.0 121.0 139.0 121.0 125.0 118.0 155.0 125.0 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:156.00 stddev:3.01 (1.9%) stddev-sans-first:3.16 06:30:32 INFO - PROCESS | 9005 | Values: 154.0 158.0 151.0 156.0 153.0 161.0 156.0 152.0 157.0 154.0 06:30:32 INFO - PROCESS | 9005 | 06:30:32 INFO - PROCESS | 9005 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:1.89 (3.0%) stddev-sans-first:1.94 06:30:32 INFO - PROCESS | 9005 | Values: 64.0 63.0 61.0 61.0 62.0 64.0 62.0 62.0 61.0 67.0 06:30:32 INFO - PROCESS | 9005 | -------- Summary: end -------- 06:30:32 INFO - PROCESS | 9005 | 06:30:33 INFO - TEST-INFO | 9005: exit 0 06:30:33 INFO - TEST-OK | kraken | took 60875ms 06:30:33 INFO - SUITE-END | took 1171s 06:30:33 INFO - Completed test suite (00:19:31) 06:30:33 INFO - javascript benchmark 06:30:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7802.63139734503, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3265.1837040739815, 3286.5891763529576, 3299.5215693724404, 3301.867925282989, 3307.9503807442893, 5729.369769325376, 5733.111367738002, 5742.39704830993, 5825.8252252432385, 5827.067669172928, 5722.399148089443, 5738.31140263169, 5764.164196191549, 5774.855628609287, 5806.912896306549, 5192.480751924796, 5213.0, 5246.37043554772, 5297.046531624306, 5315.123004704219, 5226.372835259775, 5268.604854635899, 5300.814471493499, 5301.787928482856, 5309.787608495655, 5192.818251361203, 5198.2982297389935, 5275.0768615492325, 5307.363116426034, 5315.760790764425, 5240.397354304266, 5283.233931079972, 5295.0, 5334.813281535127, 5402.51377376038, 5242.5281724644965, 5322.973385133049, 5327.440618735054, 5336.066188417011, 5347.54545863602, 5784.363719990798, 5803.680797556132, 5828.912566311508, 5843.123531470271, 5903.232579764646, 5915.556333275022, 6089.177960975256, 6114.814446323758, 6119.112728654365, 6226.25284965807, 6251.624902505819, 6253.78111766086, 6254.0, 6255.562110652256, 6271.059341098871, 5785.768569257225, 5804.738786754606, 5812.0, 5828.98514542504, 5830.883382332329, 6138.449706860497, 6256.624602523863, 6289.874202516015, 6316.242050953915, 6403.263624683128, 6108.725107370179, 6128.662923539159, 6149.600275982047, 6152.723127459275, 6164.044573091178, 6214.098955651405, 6225.8132256032395, 6275.090111933744, 6285.560010799291, 6291.182146320949, 6031.0, 6128.417800308964, 6138.419052470195, 6156.784512542129, 6236.438720515175, 6165.938340616536, 6168.660723660242, 6168.9691551541955, 6169.598976066542, 6224.657643829632, 4740.549647783455, 4742.928856067162, 4753.35829662998, 4763.666543341933, 4765.7140571565815, 4085.080856807254, 4156.854510092132, 4161.91676166475, 4194.8112334945, 4250.53244143144, 5855.824325270249, 6014.36849130835, 6023.247094113236, 6024.036154215304, 6026.0659597762415, 6261.311255761862, 6266.624002559861, 6289.496840252768, 6295.622262664255, 6302.432781049636, 5724.713764311768, 5880.500157486662, 5947.49446297061, 5955.196048533479, 6027.969860150672, 5342.6260161788305, 5360.892782144335, 5363.19552067193, 5365.3293338332705, 5377.650452720639, 6255.56211065221, 6493.188351456068, 6499.252585952581, 6512.0, 6517.3808488193545, 6130.214697154933, 6135.601185922901, 6143.416375444236, 6235.127082208403, 6235.501159907106, 6368.968155159195, 6403.655232401248, 6409.198850143732, 6418.1656384669695, 6426.068220108152, 5839.620424672383, 6105.511559075352, 6109.358517355614, 6109.48069414087, 6117.418845209698, 6085.513158947185, 6122.306673174842, 6183.907241391293, 6263.0, 6277.0, 6081.118237855575, 6094.421030002142, 6099.207103076749, 6099.75600975956, 6110.022396416552, 5989.041753319448, 6094.13321526467, 6106.542009349228, 6106.908396374147, 6137.723802428812, 5971.343152253162, 5988.730507127277, 6048.4858787003595, 6093.268807743099, 6123.14276001369, 6119.418655227746, 6123.050927106127, 6146.139540464428, 6187.690615469299, 6208.379162083756, 5843.532517398683, 5927.673977931255, 6010.519158467225, 6011.6393016417405, 6021.277446706424], "value": 5721.168177505327, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.801746414951, 630.2153818495972, 660.5211221864148, 664.7208172567524, 713.247523862325, 41263.381049284246, 46457.53542464574, 46464.07071858565, 46508.534914650845, 46529.06941861165, 46100.769496152556, 46594.534054659445, 46679.0, 46684.53315466845, 46788.0, 8996.865047024283, 9184.816303673922, 9190.72427827163, 9194.264458843276, 9208.355415120945, 9151.267898568132, 9157.130072643089, 9230.492322922237, 9241.537923103851, 9251.0, 9213.309001824857, 9220.262379009697, 9236.6305347786, 9240.0, 9282.257419406465, 9144.817103657922, 9181.495017774054, 9186.58660360282, 9191.264698824078, 9221.861672074925, 9156.816863662689, 9222.631094756201, 9251.306152038556, 9253.907460925371, 9279.628814847398, 43589.346159807625, 43830.780846095884, 43923.0, 44073.338899916525, 44137.558624413985, 3791.298609757176, 3948.9802550987347, 3985.860494882665, 4071.1654110907193, 4234.026173980002, 34898.0, 34917.12707182341, 35451.82274088639, 35634.10914727153, 36325.27349453023, 4626.768661566908, 4712.976435117836, 4715.858524244278, 4725.125851717409, 4761.904761904777, 380155.0, 380501.0, 381096.0945195284, 381571.0, 381906.0, 61199.69400152971, 61462.692686536284, 61569.692151538955, 61585.0, 61716.074258886154, 40334.39498407526, 41159.38260926089, 41309.586904131174, 42505.36241956311, 64951.675241624434, 19124.0, 19296.8070319295, 19364.515887102934, 19370.903145484463, 19390.4182874514, 14960.551183464513, 15034.323455444532, 15071.54785356441, 15073.246337683073, 15093.924530377497, 20238.190472381233, 20287.79712202859, 20415.0, 20521.897390512953, 20533.17867285292, 7252.818679533054, 7392.519486233377, 7534.246575342422, 7610.1628820829665, 7641.579713115832, 998.6305067125065, 1095.1129585036147, 1180.9940950295193, 1186.9169158159018, 1204.349651188366, 31431.842840785648, 32867.34265314681, 32892.83553582265, 33222.50166247508, 33587.16032099168, 1136.3466007045981, 1171.6602185366319, 1201.3152503073165, 1245.0350977991948, 1293.5407930184838, 17119.0, 17638.206280717397, 18408.17163227658, 18949.33677321287, 19131.61736765257, 629194.0, 629844.0, 631710.0, 632548.0, 634123.0, 64937.0, 65194.0, 65228.347716523174, 65491.0, 65717.67141164359, 1486.3905798622297, 1490.2921112471706, 1495.4093133212539, 1500.129924643704, 1524.542637208833, 33262.5010624836, 34605.653943460246, 34625.96122116341, 34704.132396690286, 34706.82646586751, 54976.450235497134, 55861.72069139628, 55891.0, 55973.16040259318, 55973.16040259481, 535518.0, 535540.0, 537550.0, 539454.0, 540613.0, 30262.84868575643, 30666.693333067276, 30914.845425772728, 31071.533926991564, 31103.68896311008, 51436.0, 51491.74254128705, 52147.21779173239, 52560.0, 52851.73574132105, 43434.0, 43457.78271108624, 44110.0, 45878.770606146754, 45902.08195836131, 42525.78737106295, 46765.0, 46847.76576117097, 47450.28824567703, 47621.0, 44901.0, 45208.54791452044, 46321.768391159174, 46491.30263046124, 46590.30114548352, 36999.44500832436, 40094.799526002185, 40336.19327613372, 40545.0, 41045.38431923583, 30009.549856751728, 30085.398292034475, 30416.239594009443, 30574.929877454182, 30629.387412252076], "value": 21670.033763633466, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.322317845091, 424.27507648496294, 432.60200615433797, 433.56643356643355, 436.23658597454454, 19336.51658708533, 20702.48243793904, 20942.581148377023, 21045.57908841826, 22024.339269821932, 19581.314653987112, 20250.39248822534, 20388.286409975615, 20652.586948261025, 20697.586048279027, 5929.940700592982, 6132.0, 6134.693265336738, 6140.171076904606, 6141.692915354237, 5993.640381577097, 6002.909956350636, 6014.969925150368, 6029.005214139662, 6053.697315134248, 5962.105684147391, 5998.100284957248, 6007.849803754897, 6016.127661489103, 6038.5471089668235, 5983.730732117044, 6011.969940150315, 6013.1882195903645, 6025.0661147522205, 6029.54778391618, 5285.101532739443, 5347.438518955531, 5391.487808658171, 5436.782528698847, 5456.045192091407, 24526.0, 24538.877305613358, 24553.0, 24734.628980565307, 24866.880990355476, 2690.273626120956, 2723.0741547873818, 2736.2065001149645, 3065.1877252528097, 3192.4732419150814, 15213.339628736838, 15354.846451535454, 15532.378704851792, 15995.92002039994, 16163.91918040414, 2025.1494372363495, 2025.2911480981538, 2055.219016773631, 2067.338451695458, 2096.2663067926255, 81301.0, 82473.58763206206, 82733.58633206795, 82787.17212827916, 83161.58419207926, 10929.945350273198, 11134.38551410041, 11231.26996745209, 11423.771524569462, 11449.141314401453, 16287.348506059861, 16291.511254662379, 16293.837061629232, 16303.103329316764, 16353.91823040901, 8897.866532002025, 9053.59258833354, 9089.545522723838, 9133.954330228305, 9235.584398702074, 8458.661653533913, 8487.278581320534, 8807.0, 8937.134582674204, 9074.183323500916, 6877.862442751217, 6945.131858517685, 6988.301169883072, 7052.541584796972, 7121.184098055066, 2010.3667344786345, 2042.1831267493121, 2042.7242322286597, 2093.27781915239, 2106.7050612914204, 1022.5909636145601, 1099.763550836558, 1151.7063148897146, 1154.463174623804, 1167.6847251242286, 20169.09239084245, 21002.26492072801, 21061.26285580028, 21105.57788844245, 21272.255471058437, 1032.6230925712061, 1061.0, 1067.4502631144967, 1078.126717358926, 1104.1663544024211, 11675.88324116748, 11758.893280632356, 11976.700582485508, 11986.280823150464, 12027.879721202851, 543815.0, 548817.0, 549264.0, 559266.0, 561631.0, 80087.59956200182, 80858.59570702109, 82926.58536707278, 84234.15765842385, 85092.57453712815, 1051.4900273367564, 1087.8477013218155, 1113.2207454781685, 1116.4919961417536, 1121.7419993401563, 17537.473875783748, 18661.813381866552, 18904.905475473086, 19217.51956201106, 19364.51588710237, 44570.3314450277, 45076.32385514286, 45112.09775804531, 45247.773761130986, 45343.09313813639, 58144.0, 59806.10290845554, 60004.09993850008, 66165.66917165383, 68138.3186168132, 8627.827443451222, 8907.599158037774, 8917.375783695079, 8968.596413161293, 8995.415298005608, 12259.570915018288, 13654.385552650354, 13769.449222031006, 14268.500602478864, 14331.211783352015, 11272.887271127513, 11558.364289964133, 11756.000739936859, 12805.295708736108, 12858.67853303675, 11382.373969431761, 11923.940380298043, 12137.21108127969, 12252.448639811051, 12382.257064576153, 11351.37567433799, 11676.241044332091, 12233.816492752794, 12311.261324320569, 12321.0, 7607.771766847003, 8239.464434811718, 8482.533460659723, 8833.911660883567, 8988.370814042953, 12229.571964981184, 12373.0, 12443.564475243324, 12491.37543122822, 12676.366181691063], "value": 9968.188553469849, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1549.86051255387, 1566.6083479130218, 1729.2650623485015, 1832.4411054628333, 1862.1620270878109, 8249.381296402778, 8798.912010879898, 8938.553072346389, 9547.188488978427, 9562.187214086802, 9000.324975626838, 9318.487483188423, 9359.812803743922, 9401.200897923667, 9453.952730236339, 2419.5523828091773, 2475.121331927158, 2475.1460746042585, 2477.4549599088264, 2477.7274499805008, 2380.3811009137576, 2498.250524842549, 2500.0499810072147, 2507.034791605227, 2509.335026218054, 2437.1348171399163, 2445.987770061156, 2448.424620214248, 2448.424620214248, 2448.4490989527303, 2448.436859522311, 2449.2040086971806, 2459.1515927005153, 2482.4786794773117, 2488.0669748844184, 2362.3385452073276, 2386.689730335045, 2391.8445301055376, 2393.1504315967927, 2450.2894160693377, 9283.442993420416, 9345.252379809599, 9368.110029547182, 9368.625254989793, 9371.390859594105, 5241.266222728821, 5317.734113294358, 5385.838424847261, 5393.217983392426, 5398.082326004549, 3434.796665131831, 3544.680978711928, 3552.626974167701, 3563.6614521620404, 3572.982135089334, 1097.928634638746, 1112.6161474291357, 1115.827046807746, 1117.4245263689206, 1136.7442325476784, 12972.80540791889, 13064.673383165402, 13076.934615326958, 13085.86914130856, 13119.147255428366, 4582.885427864263, 4705.4588722296685, 4828.7102773833685, 4862.80548778052, 4884.413870335582, 11151.498182581803, 11158.832617510743, 11166.05088567481, 11173.553057877756, 11200.10399168081, 5343.332083489564, 5408.8377348679605, 5418.997485465202, 5465.180222966586, 5480.561555075585, 4536.6143877770755, 4908.558229759267, 4992.650514463952, 5011.373578302712, 5038.874028149252, 4260.318349064135, 4302.290122129876, 4341.196878577473, 4344.0, 4351.282038463618, 1313.3761463304854, 1323.4110820684896, 1324.2253281830044, 1325.7282257137456, 1327.4557431453059, 953.5280036382036, 1060.957561697539, 1062.527175406952, 1082.3397727386289, 1115.1524841120806, 6153.84615384619, 6256.624602523863, 6321.810345689637, 6439.774607888795, 6657.434118099919, 462.5212904643678, 478.12741746312423, 490.6075139888075, 501.04800878331463, 503.0919190860459, 4605.562471565196, 4606.032733126014, 4659.767011649404, 4661.230896901973, 4667.369905062773, 10609.89390106089, 10991.560337586567, 11442.14183936208, 11503.942480287546, 11522.539098436137, 11068.335899846035, 11394.601188958346, 11412.201145919871, 11423.828642570368, 11440.542378304775, 8336.291415229653, 8488.066312705598, 8536.530490823065, 8546.871796923051, 8547.444416113058, 6446.5165112615805, 6454.386833250834, 6639.103720997797, 6729.024291477806, 6759.5606285591275, 10332.586696532355, 10340.586376545154, 10415.583376664848, 10635.627753028606, 10733.516991735234, 10569.788604227719, 10623.150147988297, 10819.080378167944, 10962.451877406258, 11014.229003969966, 8028.397870159644, 8109.959450202711, 8319.043310019426, 8361.0, 8377.413581049512, 9072.183503484717, 9124.0, 9124.133207345292, 9124.817503649758, 9124.908750912406, 8218.260356567938, 8223.383246256675, 8250.711225107092, 8376.87434688468, 8395.454295470774, 7909.3277071449575, 7951.204879512234, 7996.760097197093, 8052.355811535181, 8202.548859812767, 6827.0, 6834.829129271808, 6897.620630865351, 6922.550034247758, 6966.860662786615, 5715.228444159985, 5721.342045664635, 5772.855678608068, 5775.249217601685, 5851.824445266649, 5608.943910560843, 5628.718564071862, 5673.8722978882915, 5720.8283751487525, 5817.970910145422], "value": 4812.323185802974, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.88563716792044, 353.3410189995659, 354.5603451719866, 354.5852742821388, 358.9766665166766, 5786.929418057657, 5787.276590426197, 5798.710064496769, 5824.44667756563, 5850.414958504148, 5703.372629010805, 5710.314762228528, 5710.543156547476, 5723.599348045628, 5732.197492351074, 4244.660427165827, 4459.264221403465, 4461.308497182926, 4479.977600112011, 4482.686211965164, 4471.910561788763, 4479.3281007848755, 4484.573965473275, 4485.0, 4497.3029180476915, 4447.688661793676, 4448.7553184575, 4450.755208463534, 4468.932966005513, 4492.505824359318, 4410.2943529035365, 4461.754603496806, 4462.085272519126, 4467.3299005149165, 4509.391232183646, 3927.8625248116464, 3933.6459718625174, 3945.5462621798574, 3962.722609417342, 3999.6600288975474, 5569.248151499536, 5666.291713535808, 5682.289713785777, 5692.430756924316, 5723.771049158028, 4910.484399138075, 5114.0, 5145.30538377318, 5159.406668233126, 5189.481051894818, 6038.879222415571, 6083.422074902922, 6085.908711369333, 6098.2682078150465, 6106.419890110433, 4390.275604525282, 4393.890152746207, 4405.251107311765, 4409.434650698988, 4409.647228221735, 6063.969680151615, 6074.635521868658, 6274.309825919191, 6285.748570057238, 6289.245290565162, 4417.60241578253, 4470.485894122217, 4483.7533935633855, 4493.078918821634, 4493.573110554492, 4509.481409637933, 4520.141173177086, 4554.407926969539, 4556.794944227518, 4565.931511027337, 4922.72924989129, 5159.845204643867, 5169.922451163236, 5185.0, 5196.428392876781, 6058.878822423527, 6074.696265186812, 6075.27096748393, 6075.878482430327, 6122.755089796358, 1546.7757175209756, 1556.6341909651223, 1559.165846272239, 1560.1029408090394, 1568.5764843492193, 954.7899462118323, 975.6536429567543, 982.8034393121261, 1009.5658866687248, 1028.0798685176874, 5237.633365664443, 5237.961982050401, 5242.9213561796605, 5243.060067774948, 5253.373313343328, 5446.1558458439, 5459.317585301837, 5481.671099734029, 5492.901419715993, 5517.586181036439, 4896.53104068778, 5198.558122559549, 5242.68543887368, 5262.8947421052135, 5307.310049693592, 2892.363679990399, 2937.6474823021376, 2941.191172427557, 2943.440746258204, 2966.569847372119, 5624.353199382123, 5655.971720141455, 5693.348928810681, 5696.829095127153, 5698.0, 5918.585699001114, 6355.269144048401, 6370.490360771128, 6382.234131904108, 6437.710303036374, 6496.707648155844, 6502.2118917297175, 6504.0, 6507.381798729113, 6543.574667646588, 6078.817635470943, 6177.567570270038, 6256.562040657111, 6266.154069200599, 6278.246610406781, 6137.140800288053, 6144.38556144382, 6176.969115154396, 6179.938200617937, 6194.256689197326, 6257.748450309865, 6444.903326450013, 6491.545591808528, 6500.089987401862, 6548.705308261235, 4464.263396539534, 4496.527864574304, 4507.909841803211, 4512.9774351128035, 4531.685811114739, 6143.730107575192, 6239.661780947172, 6316.7473301069285, 6376.458001069961, 6442.09810626522, 6145.293291271382, 6172.660503672341, 6176.66028368444, 6177.0, 6184.5052395809125, 5924.851878703067, 6129.540284478593, 6150.630962142286, 6167.568270221221, 6173.629582225081, 6034.909476357946, 6078.088286757022, 6087.726052327745, 6096.0, 6109.228323786052, 6194.318624951342, 6194.81415557534, 6226.315105338319, 6240.968795155995, 6251.343608920998, 5824.650520968756, 5890.440408161217, 5981.756841184556, 5982.760689572542, 6097.878042439038], "value": 4558.869636649249, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [851.5188918261182, 864.226517267046, 864.2610567964387, 892.4288455388553, 922.5802259971714, 16202.351905923764, 17367.565810854703, 17508.82491175088, 17572.73640895386, 17640.911795441036, 15651.295691693873, 15998.200089995511, 16028.118453485054, 16191.757123643154, 16297.0, 876.2464280718577, 892.9955350223272, 898.5103118800237, 898.6989358564889, 901.8602116671926, 848.1730312944891, 889.1464194373377, 889.3063410539789, 889.7553172877479, 893.9955300223489, 929.0848514213494, 934.7429456899339, 935.050923312838, 936.7845395559026, 938.1181689212153, 924.6578765856676, 927.8561822917459, 929.9256059515291, 932.3753085432743, 932.8460803967337, 681.6455443169574, 684.555039224503, 685.9725610975555, 687.7420967137324, 688.703857341343, 15475.922620386826, 15494.457693980768, 15536.844631553653, 15561.066336019874, 15572.532824015298, 16236.350545978265, 16341.509754707378, 16617.750733739005, 16681.24934377956, 16699.91650041742, 13677.0, 13911.095778774346, 13962.58112256634, 14010.299485025707, 14062.367193476319, 4135.710500264982, 4146.854860079913, 4148.605882441163, 4165.0, 4247.19303332369, 92034.0, 92496.53751731265, 92830.0, 93995.0, 94742.5262873688, 11976.221545599508, 11993.88006119945, 11994.580189693494, 11997.820032699516, 12066.638000859988, 23914.40213994629, 23925.16261930824, 23943.760562394153, 23952.161674341663, 24063.879680601836, 8368.748937531884, 8561.828763424697, 8721.171488708562, 8739.781505462413, 8764.123587641312, 4960.355153829979, 5030.0694371541385, 5041.0422019816115, 5109.105906466353, 5148.176291793295, 3809.4285857121654, 3880.20455806559, 3911.413288006765, 3918.2163567286657, 3944.4674968878835, 667.2893368562466, 668.2682462703332, 685.1880521581942, 692.9480288978245, 696.4254490045732, 697.9720811167497, 713.9357457828717, 765.242410014082, 775.5656832174001, 804.818990155599, 9777.706668799947, 10129.442880641636, 11333.94333028346, 11715.882841171479, 12265.386730663431, 811.3225456743567, 846.5640195299426, 848.0798333807764, 848.5460278750838, 867.444835305405, 5373.167159090347, 5391.433899440581, 5410.567154627621, 5525.4474552545225, 5562.972185139049, 102520.48739756254, 108089.0, 112120.0, 122087.38956305162, 125651.0, 91874.54062729643, 99643.50178249062, 100682.4965875166, 101168.0, 103530.48234758929, 90557.54721226351, 91225.99999999868, 92243.0, 94163.52918235365, 94888.0, 10692.46739313987, 10744.30162039465, 10916.0, 10929.78140437171, 11170.218084734315, 53695.46304536905, 54874.45125548853, 55448.72275638596, 55581.44418555763, 58608.413915862, 68875.65562172358, 70396.0, 73724.0, 78587.60706196433, 81192.0, 14350.569482915529, 14517.564473065824, 14721.852781472477, 14930.328135234158, 15027.549173524812, 16623.83376166223, 16799.41202057922, 16979.066151361792, 17437.128143593025, 17920.91039544846, 14358.282085895455, 14520.0, 15287.464938727091, 15496.147711875505, 15962.920185399464, 13409.865901341253, 15210.619734506727, 15351.462698805488, 15755.44855930037, 16156.838431615533, 14702.0, 14970.0, 15054.172020538976, 15251.847481525043, 15412.152331621868, 12108.21296615717, 12649.304288264233, 12852.614421567368, 13057.08600397963, 13401.0, 12170.45232964501, 12344.321062341658, 12395.504179833066, 12559.623211303675, 12641.683957901127], "value": 8322.059093743776, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1504.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 115.0, 106.0, 111.0, 113.0, 112.0, 113.0, 111.0, 113.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 120.0, 142.0, 175.0, 117.0, 144.0, 142.0, 119.0, 186.0, 117.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 163.0, 162.0, 162.0, 161.0, 161.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 186.0, 75.0, 75.0, 75.0, 75.0, 161.0, 75.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 142.0, 86.0, 83.0, 84.0, 149.0, 83.0, 84.0, 151.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 97.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 51.0, 53.0, 51.0, 52.0, 50.0, 51.0, 51.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0, 61.0, 61.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 79.0, 73.0, 82.0, 73.0, 72.0, 74.0, 75.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 122.0, 129.0, 121.0, 139.0, 121.0, 125.0, 118.0, 155.0, 125.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 158.0, 151.0, 156.0, 153.0, 161.0, 156.0, 152.0, 157.0, 154.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 61.0, 61.0, 62.0, 64.0, 62.0, 62.0, 61.0, 67.0], "value": 62.7, "unit": "score"}]}]} 06:30:33 INFO - Return code: 0 06:30:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:30:33 ERROR - # TBPL SUCCESS # 06:30:33 INFO - Running post-action listener: _resource_record_post_action 06:30:33 INFO - [mozharness: 2016-10-18 13:30:33.734484Z] Finished run-tests step (success) 06:30:33 INFO - Running post-run listener: _resource_record_post_run 06:30:33 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288878592; Read time: 20; Write time: 168440 06:30:33 INFO - TinderboxPrint: CPU usage
13.2% 06:30:33 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 06:30:33 INFO - TinderboxPrint: I/O write bytes / time
288,878,592 / 168,440 06:30:33 INFO - TinderboxPrint: CPU idle
8,207.8 (86.8%) 06:30:33 INFO - TinderboxPrint: CPU user
1,194.2 (12.6%) 06:30:33 INFO - TinderboxPrint: Swap in / out
0 / 0 06:30:33 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 66375680; Read time: 0; Write time: 51700 06:30:33 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 222502912; Read time: 20; Write time: 116740 06:30:34 INFO - Running post-run listener: _upload_blobber_files 06:30:34 INFO - Blob upload gear active. 06:30:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:30:34 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 06:30:34 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'] 06:30:34 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 06:30:34 INFO - (blobuploader) - INFO - Open directory for files ... 06:30:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:30:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:30:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:30:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:30:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:30:37 INFO - (blobuploader) - INFO - Done attempting. 06:30:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:30:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:30:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:30:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:30:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:30:38 INFO - (blobuploader) - INFO - Done attempting. 06:30:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:30:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:30:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:30:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:30:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:30:39 INFO - (blobuploader) - INFO - Done attempting. 06:30:39 INFO - (blobuploader) - INFO - Iteration through files over. 06:30:39 INFO - Return code: 0 06:30:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:30:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:30:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cd1255be297d0a4acfd8430e1a72f667870f3361903514ecbf6e20b5eae64335de5b2c687b8c349dc090a205c26ba932e775adb507a5024c622ba5a95d417428", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4414b754751fc42ad99b17282aded7c3348fe7a7ca41f934b32913aa1a394b6a8b7484af31d4021326d9a2384dab79e12c2288fef1b7f8103981d8c3734b3a6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/507b506f584d0ff9fca6ae8de774f1210d79b2c19148ce7adc77f46835600c66f9820d2cb8d69370499f0f9f9f5c32f923354b944c942f9740fda944d980c64a"} 06:30:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:30:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:30:39 INFO - Contents: 06:30:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cd1255be297d0a4acfd8430e1a72f667870f3361903514ecbf6e20b5eae64335de5b2c687b8c349dc090a205c26ba932e775adb507a5024c622ba5a95d417428", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4414b754751fc42ad99b17282aded7c3348fe7a7ca41f934b32913aa1a394b6a8b7484af31d4021326d9a2384dab79e12c2288fef1b7f8103981d8c3734b3a6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/507b506f584d0ff9fca6ae8de774f1210d79b2c19148ce7adc77f46835600c66f9820d2cb8d69370499f0f9f9f5c32f923354b944c942f9740fda944d980c64a"} 06:30:39 INFO - Running post-run listener: copy_logs_to_upload_dir 06:30:39 INFO - Copying logs to upload dir... 06:30:39 INFO - mkdir: /builds/slave/test/build/upload/logs 06:30:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1673.357720 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-10-18 06:30:39.026766) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 06:30:39.030127) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787 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/cd1255be297d0a4acfd8430e1a72f667870f3361903514ecbf6e20b5eae64335de5b2c687b8c349dc090a205c26ba932e775adb507a5024c622ba5a95d417428", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4414b754751fc42ad99b17282aded7c3348fe7a7ca41f934b32913aa1a394b6a8b7484af31d4021326d9a2384dab79e12c2288fef1b7f8103981d8c3734b3a6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/507b506f584d0ff9fca6ae8de774f1210d79b2c19148ce7adc77f46835600c66f9820d2cb8d69370499f0f9f9f5c32f923354b944c942f9740fda944d980c64a"} build_url:https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/e4cQE6KmRKyf_4xDQq0HJg/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/cd1255be297d0a4acfd8430e1a72f667870f3361903514ecbf6e20b5eae64335de5b2c687b8c349dc090a205c26ba932e775adb507a5024c622ba5a95d417428", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4414b754751fc42ad99b17282aded7c3348fe7a7ca41f934b32913aa1a394b6a8b7484af31d4021326d9a2384dab79e12c2288fef1b7f8103981d8c3734b3a6d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/507b506f584d0ff9fca6ae8de774f1210d79b2c19148ce7adc77f46835600c66f9820d2cb8d69370499f0f9f9f5c32f923354b944c942f9740fda944d980c64a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 06:30:39.055328) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:30:39.055674) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1476792090.1144-333863787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:30:39.138563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 06:30:39.138890) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 06:30:39.139204) ========= ========= Total master_lag: 0.17 =========