builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1476805063.89 results: success (0) buildid: 20161018055521 builduid: 11864edd8d4f4aa7b058218d3a521130 revision: 42362b3185baaa3c0d82c481f5facd031c7ee993 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 08:37:43.888864) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 08:37:43.889341) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 08:37:43.889750) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 08:37:43.957349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 08:37:43.957794) ========= 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=745a4373a2a16df560f216e000000264-1476799428.752022-703643501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-18 08:37:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-10-18 08:37:44 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145670 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 08:37:44.127258) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 08:37:44.127579) ========= 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=745a4373a2a16df560f216e000000264-1476799428.752022-703643501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017032 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 08:37:44.177608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 08:37:44.177968) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 42362b3185baaa3c0d82c481f5facd031c7ee993 --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 42362b3185baaa3c0d82c481f5facd031c7ee993 --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=745a4373a2a16df560f216e000000264-1476799428.752022-703643501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-18 08:37:44,786 truncating revision to first 12 chars 2016-10-18 08:37:44,786 Setting DEBUG logging. 2016-10-18 08:37:44,786 attempt 1/10 2016-10-18 08:37:44,786 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/42362b3185ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 08:37:45,109 unpacking tar archive at: mozilla-beta-42362b3185ba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684664 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 08:37:44.877960) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 08:37:44.878264) ========= script_repo_revision: 42362b3185baaa3c0d82c481f5facd031c7ee993 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 08:37:44.878659) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 08:37:44.878919) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 08:37:44.889155) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-10-18 08:37:44.889554) ========= /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=745a4373a2a16df560f216e000000264-1476799428.752022-703643501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:37:45 INFO - MultiFileLogger online at 20161018 08:37:45 in /builds/slave/test 08:37:45 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 08:37:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:37:45 INFO - {'append_to_log': False, 08:37:45 INFO - 'base_work_dir': '/builds/slave/test', 08:37:45 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:37:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:37:45 INFO - 'branch': 'Mozilla-Beta', 08:37:45 INFO - 'buildbot_json_path': 'buildprops.json', 08:37:45 INFO - 'config_files': ('talos/linux_config.py',), 08:37:45 INFO - 'default_actions': ('clobber', 08:37:45 INFO - 'read-buildbot-config', 08:37:45 INFO - 'download-and-extract', 08:37:45 INFO - 'populate-webroot', 08:37:45 INFO - 'create-virtualenv', 08:37:45 INFO - 'install', 08:37:45 INFO - 'run-tests'), 08:37:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:37:45 INFO - 'download_minidump_stackwalk': True, 08:37:45 INFO - 'download_symbols': 'ondemand', 08:37:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:37:45 INFO - 'tooltool.py': '/tools/tooltool.py', 08:37:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:37:45 INFO - '/tools/misc-python/virtualenv.py')}, 08:37:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:37:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:37:45 INFO - 'installer_path': 'installer.exe', 08:37:45 INFO - 'log_level': 'info', 08:37:45 INFO - 'log_name': 'talos', 08:37:45 INFO - 'log_to_console': True, 08:37:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:37:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:37:45 INFO - 'opt_config_files': (), 08:37:45 INFO - 'pip_index': False, 08:37:45 INFO - 'sps_profile': False, 08:37:45 INFO - 'sps_profile_interval': 0, 08:37:45 INFO - 'suite': 'dromaeojs-e10s', 08:37:45 INFO - 'system_bits': '32', 08:37:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:37:45 INFO - 'title': 'talos-linux64-ix-032', 08:37:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:37:45 INFO - 'use_talos_json': True, 08:37:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:37:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:37:45 INFO - 'work_dir': 'build'} 08:37:45 INFO - [mozharness: 2016-10-18 15:37:45.588817Z] Running clobber step. 08:37:45 INFO - Running pre-action listener: _resource_record_pre_action 08:37:45 INFO - Running main action method: clobber 08:37:45 INFO - rmtree: /builds/slave/test/build 08:37:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:37:46 INFO - Running post-action listener: _resource_record_post_action 08:37:46 INFO - [mozharness: 2016-10-18 15:37:46.056683Z] Finished clobber step (success) 08:37:46 INFO - [mozharness: 2016-10-18 15:37:46.056784Z] Running read-buildbot-config step. 08:37:46 INFO - Running pre-action listener: _resource_record_pre_action 08:37:46 INFO - Running main action method: read_buildbot_config 08:37:46 INFO - Using buildbot properties: 08:37:46 INFO - { 08:37:46 INFO - "project": "", 08:37:46 INFO - "product": "firefox", 08:37:46 INFO - "script_repo_revision": "production", 08:37:46 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:37:46 INFO - "repository": "", 08:37:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 08:37:46 INFO - "buildid": "20161018055521", 08:37:46 INFO - "pgo_build": "True", 08:37:46 INFO - "basedir": "/builds/slave/test", 08:37:46 INFO - "buildnumber": 287, 08:37:46 INFO - "slavename": "talos-linux64-ix-032", 08:37:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:37:46 INFO - "platform": "ubuntu64_hw", 08:37:46 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:37:46 INFO - "branch": "mozilla-beta", 08:37:46 INFO - "repo_path": "releases/mozilla-beta", 08:37:46 INFO - "revision": "42362b3185baaa3c0d82c481f5facd031c7ee993", 08:37:46 INFO - "stage_platform": "linux64-pgo", 08:37:46 INFO - "builduid": "11864edd8d4f4aa7b058218d3a521130", 08:37:46 INFO - "slavebuilddir": "test" 08:37:46 INFO - } 08:37:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 08:37:46 INFO - Running post-action listener: _resource_record_post_action 08:37:46 INFO - [mozharness: 2016-10-18 15:37:46.059232Z] Finished read-buildbot-config step (success) 08:37:46 INFO - [mozharness: 2016-10-18 15:37:46.059322Z] Running download-and-extract step. 08:37:46 INFO - Running pre-action listener: _resource_record_pre_action 08:37:46 INFO - Running main action method: download_and_extract 08:37:46 INFO - mkdir: /builds/slave/test/build/tests 08:37: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')]} 08:37:46 INFO - https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:37:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 08:37:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 08:37:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:37:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:37:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 08:37:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:37:46 INFO - retry: Failed, sleeping 30 seconds before retrying 08:38:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:38:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 08:38:16 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:38:16 INFO - retry: Failed, sleeping 60 seconds before retrying 08:39:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:39:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 08:39:16 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:39:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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! 08:39:16 INFO - Caught exception: HTTP Error 404: Not Found 08:39:16 INFO - Caught exception: HTTP Error 404: Not Found 08:39:16 INFO - Caught exception: HTTP Error 404: Not Found 08:39:16 INFO - trying https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 08:39:16 INFO - Downloading https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:39:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:39:16 INFO - Downloaded 1327 bytes. 08:39:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 08:39:16 INFO - Using the following test package requirements: 08:39:16 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 08:39:16 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:39:16 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:39:16 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:39:16 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 08:39:16 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:39:16 INFO - u'jsshell-linux-x86_64.zip'], 08:39:16 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:39:16 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:39:16 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 08:39:16 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:39:16 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 08:39:16 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:39:16 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 08:39:16 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:39:16 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:39:16 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 08:39:16 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:39:16 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:39:16 INFO - https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:39:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:39:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:39:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:39:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:39:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:39:16 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:39:16 INFO - retry: Failed, sleeping 30 seconds before retrying 08:39:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:39:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:39:46 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:39:46 INFO - retry: Failed, sleeping 60 seconds before retrying 08:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:40:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:40:46 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:40:46 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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! 08:40:46 INFO - Caught exception: HTTP Error 404: Not Found 08:40:46 INFO - Caught exception: HTTP Error 404: Not Found 08:40:46 INFO - Caught exception: HTTP Error 404: Not Found 08:40:46 INFO - trying https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:40:46 INFO - Downloading https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:40:48 INFO - Downloaded 21774013 bytes. 08:40: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'] 08:40: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 08:40:49 INFO - Return code: 0 08:40: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 08:40: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')]} 08:40:49 INFO - https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:40:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:40:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:40:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:40:49 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:40:49 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:40:49 INFO - retry: Failed, sleeping 30 seconds before retrying 08:41:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:41:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:41:19 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:41:19 INFO - retry: Failed, sleeping 60 seconds before retrying 08:42:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:42:19 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:42:19 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:42:19 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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! 08:42:19 INFO - Caught exception: HTTP Error 404: Not Found 08:42:19 INFO - Caught exception: HTTP Error 404: Not Found 08:42:19 INFO - Caught exception: HTTP Error 404: Not Found 08:42:19 INFO - trying https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 08:42:19 INFO - Downloading https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:42:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:42:20 INFO - Downloaded 21774013 bytes. 08:42: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'] 08:42: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 08:42:22 INFO - Return code: 0 08:42: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')]} 08:42:22 INFO - https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:42:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 08:42:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 08:42:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:42:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:42:22 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 08:42:22 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:42:22 INFO - retry: Failed, sleeping 30 seconds before retrying 08:42:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:42:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 08:42:52 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:42:52 INFO - retry: Failed, sleeping 60 seconds before retrying 08:43:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:43:52 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 08:43:52 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:43:52 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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! 08:43:52 INFO - Caught exception: HTTP Error 404: Not Found 08:43:52 INFO - Caught exception: HTTP Error 404: Not Found 08:43:52 INFO - Caught exception: HTTP Error 404: Not Found 08:43:52 INFO - trying https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 08:43:52 INFO - Downloading https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:43:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:43:53 INFO - Downloaded 14413762 bytes. 08:43: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'] 08:43: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 08:43:53 INFO - Return code: 0 08:43:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:53 INFO - https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:43:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:43:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:43:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:43:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:43:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:43:53 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:43:53 INFO - retry: Failed, sleeping 30 seconds before retrying 08:44:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:44:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:44:24 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:44:24 INFO - retry: Failed, sleeping 60 seconds before retrying 08:45:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:45:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:45:24 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:45:24 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PpEETHCzRcmnOPT-6eoOaA/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! 08:45:24 INFO - Caught exception: HTTP Error 404: Not Found 08:45:24 INFO - Caught exception: HTTP Error 404: Not Found 08:45:24 INFO - Caught exception: HTTP Error 404: Not Found 08:45:24 INFO - trying https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:45:24 INFO - Downloading https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:45:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/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 08:45:25 INFO - Downloaded 56780509 bytes. 08:45:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:45:25 INFO - mkdir: /builds/slave/test/properties 08:45:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:45:25 INFO - Writing to file /builds/slave/test/properties/build_url 08:45:25 INFO - Contents: 08:45:25 INFO - build_url:https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 08:45:26 INFO - Running post-action listener: _resource_record_post_action 08:45:26 INFO - Running post-action listener: set_extra_try_arguments 08:45:26 INFO - [mozharness: 2016-10-18 15:45:26.552677Z] Finished download-and-extract step (success) 08:45:26 INFO - [mozharness: 2016-10-18 15:45:26.552909Z] Running populate-webroot step. 08:45:26 INFO - Running pre-action listener: _resource_record_pre_action 08:45:26 INFO - Running main action method: populate_webroot 08:45:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:26 INFO - '--tppagecycles', 08:45:26 INFO - '7'], 08:45:26 INFO - 'tests': ['tsvgm']}}, 08:45:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:45:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:45:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:45:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:45:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:45:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:26 INFO - 'talos_options': ['--disable-e10s'], 08:45:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:26 INFO - 'talos_options': ['--disable-e10s'], 08:45:26 INFO - 'tests': ['damp', 'tps']}, 08:45:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:26 INFO - 'tests': ['damp', 'tps']}, 08:45:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:45:26 INFO - 'tests': ['dromaeo_dom']}, 08:45:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:45:26 INFO - 'tests': ['basic_compositor_video']}, 08:45:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:45:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:45:26 INFO - 'tests': ['a11yr', 08:45:26 INFO - 'ts_paint', 08:45:26 INFO - 'tpaint', 08:45:26 INFO - 'sessionrestore', 08:45:26 INFO - 'sessionrestore_no_auto_restore', 08:45:26 INFO - 'tabpaint']}, 08:45:26 INFO - 'other-e10s': {'tests': ['a11yr', 08:45:26 INFO - 'ts_paint', 08:45:26 INFO - 'tpaint', 08:45:26 INFO - 'sessionrestore', 08:45:26 INFO - 'sessionrestore_no_auto_restore', 08:45:26 INFO - 'tabpaint']}, 08:45:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:45:26 INFO - 'ts_paint', 08:45:26 INFO - 'tpaint', 08:45:26 INFO - 'sessionrestore', 08:45:26 INFO - 'sessionrestore_no_auto_restore', 08:45:26 INFO - 'tabpaint']}, 08:45:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:45:26 INFO - 'ts_paint', 08:45:26 INFO - 'tpaint', 08:45:26 INFO - 'sessionrestore', 08:45:26 INFO - 'sessionrestore_no_auto_restore', 08:45:26 INFO - 'tabpaint']}, 08:45:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:45:26 INFO - 'tests': ['a11yr', 08:45:26 INFO - 'ts_paint', 08:45:26 INFO - 'tpaint', 08:45:26 INFO - 'sessionrestore', 08:45:26 INFO - 'sessionrestore_no_auto_restore', 08:45:26 INFO - 'tabpaint']}, 08:45:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:45:26 INFO - 'tests': ['a11yr', 08:45:26 INFO - 'ts_paint', 08:45:26 INFO - 'tpaint', 08:45:26 INFO - 'sessionrestore', 08:45:26 INFO - 'sessionrestore_no_auto_restore', 08:45:26 INFO - 'tabpaint']}, 08:45:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:45:26 INFO - 'tests': ['tsvgx', 08:45:26 INFO - 'tsvgr_opacity', 08:45:26 INFO - 'tart', 08:45:26 INFO - 'tscrollx', 08:45:26 INFO - 'cart']}, 08:45:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:45:26 INFO - 'tsvgr_opacity', 08:45:26 INFO - 'tart', 08:45:26 INFO - 'tscrollx', 08:45:26 INFO - 'cart']}, 08:45:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:26 INFO - 'talos_options': ['--disable-e10s'], 08:45:26 INFO - 'tests': ['tp5o']}, 08:45:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:26 INFO - 'tests': ['tp5o']}, 08:45:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:26 INFO - 'talos_options': ['--disable-e10s', 08:45:26 INFO - '--xperf_path', 08:45:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:26 INFO - 'tests': ['tp5n']}, 08:45:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:26 INFO - 'talos_options': ['--xperf_path', 08:45:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:26 INFO - 'tests': ['tp5n']}}, 08:45:26 INFO - 'talos.zip': {'path': '', 08:45:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:26 INFO - Running post-action listener: _resource_record_post_action 08:45:26 INFO - [mozharness: 2016-10-18 15:45:26.573411Z] Finished populate-webroot step (success) 08:45:26 INFO - [mozharness: 2016-10-18 15:45:26.573502Z] Running create-virtualenv step. 08:45:26 INFO - Running pre-action listener: _resource_record_pre_action 08:45:26 INFO - Running main action method: create_virtualenv 08:45:26 INFO - Creating virtualenv /builds/slave/test/build/venv 08:45: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 08:45:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:45:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:26 INFO - Using real prefix '/usr' 08:45:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:45:27 INFO - Installing distribute.............................................................................................................................................................................................done. 08:45:29 INFO - Installing pip.................done. 08:45:29 INFO - Return code: 0 08:45:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:29 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 0x244d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b570>, '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 0x270c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270c900>, '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': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', '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 08:45:29 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 08:45:29 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 08:45:29 INFO - Using env: {'DISPLAY': ':0', 08:45:29 INFO - 'HOME': '/home/cltbld', 08:45:29 INFO - 'LANG': 'en_US.UTF-8', 08:45:29 INFO - 'LANGUAGE': 'en_US:en', 08:45:29 INFO - 'LOGNAME': 'cltbld', 08:45:29 INFO - 'MAIL': '/var/mail/cltbld', 08:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:29 INFO - 'MOZ_NO_REMOTE': '1', 08:45:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:29 INFO - 'NO_EM_RESTART': '1', 08:45:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:29 INFO - 'PWD': '/builds/slave/test', 08:45:29 INFO - 'SHELL': '/bin/bash', 08:45:29 INFO - 'SHLVL': '1', 08:45:29 INFO - 'TERM': 'linux', 08:45:29 INFO - 'TMOUT': '86400', 08:45:29 INFO - 'USER': 'cltbld', 08:45:29 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', 08:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:29 INFO - '_': '/tools/buildbot/bin/python'} 08:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:29 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 08:45:29 INFO - Cleaning up... 08:45:29 INFO - Return code: 0 08:45:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:29 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 0x244d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b570>, '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 0x270c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270c900>, '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': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', '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 08:45:29 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 08:45:29 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 08:45:29 INFO - Using env: {'DISPLAY': ':0', 08:45:29 INFO - 'HOME': '/home/cltbld', 08:45:29 INFO - 'LANG': 'en_US.UTF-8', 08:45:29 INFO - 'LANGUAGE': 'en_US:en', 08:45:29 INFO - 'LOGNAME': 'cltbld', 08:45:29 INFO - 'MAIL': '/var/mail/cltbld', 08:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:29 INFO - 'MOZ_NO_REMOTE': '1', 08:45:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:29 INFO - 'NO_EM_RESTART': '1', 08:45:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:29 INFO - 'PWD': '/builds/slave/test', 08:45:29 INFO - 'SHELL': '/bin/bash', 08:45:29 INFO - 'SHLVL': '1', 08:45:29 INFO - 'TERM': 'linux', 08:45:29 INFO - 'TMOUT': '86400', 08:45:29 INFO - 'USER': 'cltbld', 08:45:29 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', 08:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:29 INFO - '_': '/tools/buildbot/bin/python'} 08:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:29 INFO - Downloading/unpacking psutil>=3.1.1 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:45:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:31 INFO - Installing collected packages: psutil 08:45:31 INFO - Running setup.py install for psutil 08:45:31 INFO - building 'psutil._psutil_linux' extension 08:45: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 08:45: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 08:45:31 INFO - building 'psutil._psutil_posix' extension 08:45: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 08:45: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 08:45:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:32 INFO - Successfully installed psutil 08:45:32 INFO - Cleaning up... 08:45:32 INFO - Return code: 0 08:45:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:32 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 0x244d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b570>, '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 0x270c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270c900>, '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': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', '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 08:45:32 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 08:45:32 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 08:45:32 INFO - Using env: {'DISPLAY': ':0', 08:45:32 INFO - 'HOME': '/home/cltbld', 08:45:32 INFO - 'LANG': 'en_US.UTF-8', 08:45:32 INFO - 'LANGUAGE': 'en_US:en', 08:45:32 INFO - 'LOGNAME': 'cltbld', 08:45:32 INFO - 'MAIL': '/var/mail/cltbld', 08:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:32 INFO - 'MOZ_NO_REMOTE': '1', 08:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:32 INFO - 'NO_EM_RESTART': '1', 08:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:32 INFO - 'PWD': '/builds/slave/test', 08:45:32 INFO - 'SHELL': '/bin/bash', 08:45:32 INFO - 'SHLVL': '1', 08:45:32 INFO - 'TERM': 'linux', 08:45:32 INFO - 'TMOUT': '86400', 08:45:32 INFO - 'USER': 'cltbld', 08:45:32 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', 08:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:32 INFO - '_': '/tools/buildbot/bin/python'} 08:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:45:32 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 08:45:32 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 08:45:32 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 08:45:32 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 08:45:32 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 08:45:32 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 08:45:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:45:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:45:34 INFO - Installing collected packages: mozsystemmonitor 08:45:34 INFO - Running setup.py install for mozsystemmonitor 08:45:34 INFO - Successfully installed mozsystemmonitor 08:45:34 INFO - Cleaning up... 08:45:34 INFO - Return code: 0 08:45:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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')]} 08:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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 0x244d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b570>, '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 0x270c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270c900>, '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': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', '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 08:45: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 08:45: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 08:45:34 INFO - Using env: {'DISPLAY': ':0', 08:45:34 INFO - 'HOME': '/home/cltbld', 08:45:34 INFO - 'LANG': 'en_US.UTF-8', 08:45:34 INFO - 'LANGUAGE': 'en_US:en', 08:45:34 INFO - 'LOGNAME': 'cltbld', 08:45:34 INFO - 'MAIL': '/var/mail/cltbld', 08:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:34 INFO - 'MOZ_NO_REMOTE': '1', 08:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:34 INFO - 'NO_EM_RESTART': '1', 08:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:34 INFO - 'PWD': '/builds/slave/test', 08:45:34 INFO - 'SHELL': '/bin/bash', 08:45:34 INFO - 'SHLVL': '1', 08:45:34 INFO - 'TERM': 'linux', 08:45:34 INFO - 'TMOUT': '86400', 08:45:34 INFO - 'USER': 'cltbld', 08:45:34 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', 08:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:34 INFO - '_': '/tools/buildbot/bin/python'} 08:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:34 INFO - Downloading/unpacking jsonschema==2.5.1 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:45:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:36 INFO - Downloading functools32-3.2.3-2.tar.gz 08:45:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:45:36 INFO - warning: no files found matching '*.txt' 08:45:36 INFO - no previously-included directories found matching 'build' 08:45:36 INFO - no previously-included directories found matching 'dist' 08:45:36 INFO - no previously-included directories found matching '.git*' 08:45:36 INFO - Installing collected packages: jsonschema, functools32 08:45:36 INFO - Running setup.py install for functools32 08:45:36 INFO - warning: no files found matching '*.txt' 08:45:36 INFO - no previously-included directories found matching 'build' 08:45:36 INFO - no previously-included directories found matching 'dist' 08:45:36 INFO - no previously-included directories found matching '.git*' 08:45:37 INFO - Successfully installed jsonschema functools32 08:45:37 INFO - Cleaning up... 08:45:37 INFO - Return code: 0 08:45:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:45:37 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')]} 08:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:37 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')]} 08:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:37 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 0x244d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b570>, '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 0x270c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270c900>, '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': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', '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 08:45:37 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 08:45:37 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 08:45:37 INFO - Using env: {'DISPLAY': ':0', 08:45:37 INFO - 'HOME': '/home/cltbld', 08:45:37 INFO - 'LANG': 'en_US.UTF-8', 08:45:37 INFO - 'LANGUAGE': 'en_US:en', 08:45:37 INFO - 'LOGNAME': 'cltbld', 08:45:37 INFO - 'MAIL': '/var/mail/cltbld', 08:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:37 INFO - 'MOZ_NO_REMOTE': '1', 08:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:37 INFO - 'NO_EM_RESTART': '1', 08:45:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:37 INFO - 'PWD': '/builds/slave/test', 08:45:37 INFO - 'SHELL': '/bin/bash', 08:45:37 INFO - 'SHLVL': '1', 08:45:37 INFO - 'TERM': 'linux', 08:45:37 INFO - 'TMOUT': '86400', 08:45:37 INFO - 'USER': 'cltbld', 08:45:37 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', 08:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:37 INFO - '_': '/tools/buildbot/bin/python'} 08:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:45:37 INFO - Cleaning up... 08:45:37 INFO - Return code: 0 08:45:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:45:37 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')]} 08:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:37 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')]} 08:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:37 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 0x244d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b570>, '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 0x270c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270c900>, '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': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', '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 08:45:37 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 08:45:37 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 08:45:37 INFO - Using env: {'DISPLAY': ':0', 08:45:37 INFO - 'HOME': '/home/cltbld', 08:45:37 INFO - 'LANG': 'en_US.UTF-8', 08:45:37 INFO - 'LANGUAGE': 'en_US:en', 08:45:37 INFO - 'LOGNAME': 'cltbld', 08:45:37 INFO - 'MAIL': '/var/mail/cltbld', 08:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:37 INFO - 'MOZ_NO_REMOTE': '1', 08:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:37 INFO - 'NO_EM_RESTART': '1', 08:45:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:37 INFO - 'PWD': '/builds/slave/test', 08:45:37 INFO - 'SHELL': '/bin/bash', 08:45:37 INFO - 'SHLVL': '1', 08:45:37 INFO - 'TERM': 'linux', 08:45:37 INFO - 'TMOUT': '86400', 08:45:37 INFO - 'USER': 'cltbld', 08:45:37 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', 08:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:37 INFO - '_': '/tools/buildbot/bin/python'} 08:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:37 INFO - Downloading/unpacking blobuploader==1.2.4 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:39 INFO - Downloading blobuploader-1.2.4.tar.gz 08:45:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:45:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:45:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:40 INFO - Downloading docopt-0.6.1.tar.gz 08:45:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:45:40 INFO - Installing collected packages: blobuploader, requests, docopt 08:45:40 INFO - Running setup.py install for blobuploader 08:45:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:45:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:45:40 INFO - Running setup.py install for requests 08:45:40 INFO - Running setup.py install for docopt 08:45:40 INFO - Successfully installed blobuploader requests docopt 08:45:40 INFO - Cleaning up... 08:45:40 INFO - Return code: 0 08:45:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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')]} 08:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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 0x244d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b570>, '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 0x270c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270c900>, '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': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', '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 08:45: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 08:45: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 08:45:40 INFO - Using env: {'DISPLAY': ':0', 08:45:40 INFO - 'HOME': '/home/cltbld', 08:45:40 INFO - 'LANG': 'en_US.UTF-8', 08:45:40 INFO - 'LANGUAGE': 'en_US:en', 08:45:40 INFO - 'LOGNAME': 'cltbld', 08:45:40 INFO - 'MAIL': '/var/mail/cltbld', 08:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:40 INFO - 'MOZ_NO_REMOTE': '1', 08:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:40 INFO - 'NO_EM_RESTART': '1', 08:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:40 INFO - 'PWD': '/builds/slave/test', 08:45:40 INFO - 'SHELL': '/bin/bash', 08:45:40 INFO - 'SHLVL': '1', 08:45:40 INFO - 'TERM': 'linux', 08:45:40 INFO - 'TMOUT': '86400', 08:45:40 INFO - 'USER': 'cltbld', 08:45:40 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', 08:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:40 INFO - '_': '/tools/buildbot/bin/python'} 08:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:41 INFO - Running setup.py (path:/tmp/pip-O8N1rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:41 INFO - Running setup.py (path:/tmp/pip-zFkTPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:41 INFO - Running setup.py (path:/tmp/pip-GcIvPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:41 INFO - Running setup.py (path:/tmp/pip-mUqQTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:41 INFO - Running setup.py (path:/tmp/pip-BEDWD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:41 INFO - Running setup.py (path:/tmp/pip-rYba7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:41 INFO - Running setup.py (path:/tmp/pip-bymXrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:41 INFO - Running setup.py (path:/tmp/pip-eb6EhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:41 INFO - Running setup.py (path:/tmp/pip-Bg0ZMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:41 INFO - Running setup.py (path:/tmp/pip-3HMXv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:41 INFO - Running setup.py (path:/tmp/pip-XE0uSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:41 INFO - Running setup.py (path:/tmp/pip-i_C9bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:41 INFO - Running setup.py (path:/tmp/pip-20irgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:41 INFO - Running setup.py (path:/tmp/pip-gtS82x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:42 INFO - Running setup.py (path:/tmp/pip-bEmKmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:42 INFO - Running setup.py (path:/tmp/pip-yWyzJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:42 INFO - Running setup.py (path:/tmp/pip-W3trMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:45:42 INFO - Running setup.py install for manifestparser 08:45:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:45:42 INFO - Running setup.py install for mozcrash 08:45:42 INFO - Running setup.py install for mozdebug 08:45:42 INFO - Running setup.py install for mozdevice 08:45:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:45:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:45:42 INFO - Running setup.py install for mozfile 08:45:42 INFO - Running setup.py install for mozhttpd 08:45:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:45:42 INFO - Running setup.py install for mozinfo 08:45:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:45:42 INFO - Running setup.py install for mozInstall 08:45:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:45:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:45:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:45:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:45:43 INFO - Running setup.py install for mozleak 08:45:43 INFO - Running setup.py install for mozlog 08:45:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:45:43 INFO - Running setup.py install for moznetwork 08:45:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:45:43 INFO - Running setup.py install for mozprocess 08:45:43 INFO - Running setup.py install for mozprofile 08:45:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:45:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:45:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:45:43 INFO - Running setup.py install for mozrunner 08:45:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:45:43 INFO - Running setup.py install for mozscreenshot 08:45:43 INFO - Running setup.py install for moztest 08:45:43 INFO - Running setup.py install for mozversion 08:45:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:45:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:43 INFO - Cleaning up... 08:45:43 INFO - Return code: 0 08:45:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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')]} 08:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:44 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 0x244d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b570>, '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 0x270c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270c900>, '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': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', '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 08:45:44 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 08:45:44 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 08:45:44 INFO - Using env: {'DISPLAY': ':0', 08:45:44 INFO - 'HOME': '/home/cltbld', 08:45:44 INFO - 'LANG': 'en_US.UTF-8', 08:45:44 INFO - 'LANGUAGE': 'en_US:en', 08:45:44 INFO - 'LOGNAME': 'cltbld', 08:45:44 INFO - 'MAIL': '/var/mail/cltbld', 08:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:44 INFO - 'MOZ_NO_REMOTE': '1', 08:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:44 INFO - 'NO_EM_RESTART': '1', 08:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:44 INFO - 'PWD': '/builds/slave/test', 08:45:44 INFO - 'SHELL': '/bin/bash', 08:45:44 INFO - 'SHLVL': '1', 08:45:44 INFO - 'TERM': 'linux', 08:45:44 INFO - 'TMOUT': '86400', 08:45:44 INFO - 'USER': 'cltbld', 08:45:44 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', 08:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:44 INFO - '_': '/tools/buildbot/bin/python'} 08:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:44 INFO - Running setup.py (path:/tmp/pip-M7hMRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:44 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)) 08:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:44 INFO - Running setup.py (path:/tmp/pip-XOg0ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45: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)) 08:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:44 INFO - Running setup.py (path:/tmp/pip-YqNAJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45: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)) 08:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:44 INFO - Running setup.py (path:/tmp/pip-QsYCOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45: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)) 08:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:44 INFO - Running setup.py (path:/tmp/pip-dt1sTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45: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)) 08:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:44 INFO - Running setup.py (path:/tmp/pip-sgX5nz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45: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)) 08:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:44 INFO - Running setup.py (path:/tmp/pip-xgajDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45: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)) 08:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:44 INFO - Running setup.py (path:/tmp/pip-3aaHGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45: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)) 08:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:44 INFO - Running setup.py (path:/tmp/pip-cWWCaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45: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)) 08:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:44 INFO - Running setup.py (path:/tmp/pip-_0Yd2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45: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)) 08:45:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:44 INFO - Running setup.py (path:/tmp/pip-kwmOvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:45 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)) 08:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:45 INFO - Running setup.py (path:/tmp/pip-682yIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:45 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)) 08:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:45 INFO - Running setup.py (path:/tmp/pip-pi1ZJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:45 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)) 08:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:45 INFO - Running setup.py (path:/tmp/pip-NtFgcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:45 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)) 08:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:45 INFO - Running setup.py (path:/tmp/pip-aowZWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:45 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)) 08:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:45 INFO - Running setup.py (path:/tmp/pip-XwP1Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45: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)) 08:45:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:45 INFO - Running setup.py (path:/tmp/pip-ApMEg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45: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)) 08:45: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)) 08:45: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)) 08:45: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)) 08:45: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)) 08:45: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)) 08:45:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:47 INFO - Downloading blessings-1.6.tar.gz 08:45:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:45:47 INFO - Installing collected packages: blessings 08:45:47 INFO - Running setup.py install for blessings 08:45:47 INFO - Successfully installed blessings 08:45:47 INFO - Cleaning up... 08:45:47 INFO - Return code: 0 08:45:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:45:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:47 INFO - Reading from file tmpfile_stdout 08:45:47 INFO - Current package versions: 08:45:47 INFO - argparse == 1.2.1 08:45:47 INFO - blessings == 1.6 08:45:47 INFO - blobuploader == 1.2.4 08:45:47 INFO - docopt == 0.6.1 08:45:47 INFO - functools32 == 3.2.3-2 08:45:47 INFO - jsonschema == 2.5.1 08:45:47 INFO - manifestparser == 1.1 08:45:47 INFO - mozInstall == 1.12 08:45:47 INFO - mozcrash == 0.17 08:45:47 INFO - mozdebug == 0.1 08:45:47 INFO - mozdevice == 0.48 08:45:47 INFO - mozfile == 1.2 08:45:47 INFO - mozhttpd == 0.7 08:45:47 INFO - mozinfo == 0.9 08:45:47 INFO - mozleak == 0.1 08:45:47 INFO - mozlog == 3.3 08:45:47 INFO - moznetwork == 0.27 08:45:47 INFO - mozprocess == 0.23 08:45:47 INFO - mozprofile == 0.28 08:45:47 INFO - mozrunner == 6.12 08:45:47 INFO - mozscreenshot == 0.1 08:45:47 INFO - mozsystemmonitor == 0.3 08:45:47 INFO - moztest == 0.7 08:45:47 INFO - mozversion == 1.4 08:45:47 INFO - psutil == 3.1.1 08:45:47 INFO - requests == 1.2.3 08:45:47 INFO - wsgiref == 0.1.2 08:45:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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')]} 08:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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 0x244d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b570>, '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 0x270c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270c900>, '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': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', '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 08:45: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 08:45: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 08:45:47 INFO - Using env: {'DISPLAY': ':0', 08:45:47 INFO - 'HOME': '/home/cltbld', 08:45:47 INFO - 'LANG': 'en_US.UTF-8', 08:45:47 INFO - 'LANGUAGE': 'en_US:en', 08:45:47 INFO - 'LOGNAME': 'cltbld', 08:45:47 INFO - 'MAIL': '/var/mail/cltbld', 08:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:47 INFO - 'MOZ_NO_REMOTE': '1', 08:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:47 INFO - 'NO_EM_RESTART': '1', 08:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:47 INFO - 'PWD': '/builds/slave/test', 08:45:47 INFO - 'SHELL': '/bin/bash', 08:45:47 INFO - 'SHLVL': '1', 08:45:47 INFO - 'TERM': 'linux', 08:45:47 INFO - 'TMOUT': '86400', 08:45:47 INFO - 'USER': 'cltbld', 08:45:47 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', 08:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:47 INFO - '_': '/tools/buildbot/bin/python'} 08:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:48 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)) 08:45:48 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)) 08:45:48 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)) 08:45:48 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)) 08:45:48 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)) 08:45:48 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)) 08:45:48 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)) 08:45:48 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)) 08:45:48 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)) 08:45:48 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)) 08:45:48 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)) 08:45:48 INFO - Cleaning up... 08:45:48 INFO - Return code: 0 08:45:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:45:48 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')]} 08:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:48 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')]} 08:45:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:48 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 0x244d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x267c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b570>, '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 0x270c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270c900>, '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': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', '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 08:45:48 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 08:45:48 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 08:45:48 INFO - Using env: {'DISPLAY': ':0', 08:45:48 INFO - 'HOME': '/home/cltbld', 08:45:48 INFO - 'LANG': 'en_US.UTF-8', 08:45:48 INFO - 'LANGUAGE': 'en_US:en', 08:45:48 INFO - 'LOGNAME': 'cltbld', 08:45:48 INFO - 'MAIL': '/var/mail/cltbld', 08:45:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:48 INFO - 'MOZ_NO_REMOTE': '1', 08:45:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:48 INFO - 'NO_EM_RESTART': '1', 08:45:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:48 INFO - 'PWD': '/builds/slave/test', 08:45:48 INFO - 'SHELL': '/bin/bash', 08:45:48 INFO - 'SHLVL': '1', 08:45:48 INFO - 'TERM': 'linux', 08:45:48 INFO - 'TMOUT': '86400', 08:45:48 INFO - 'USER': 'cltbld', 08:45:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', 08:45:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:48 INFO - '_': '/tools/buildbot/bin/python'} 08:45:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:45:48 INFO - Cleaning up... 08:45:48 INFO - Return code: 0 08:45:48 INFO - Running post-action listener: _resource_record_post_action 08:45:48 INFO - Running post-action listener: _start_resource_monitoring 08:45:48 INFO - Starting resource monitoring. 08:45:48 INFO - [mozharness: 2016-10-18 15:45:48.300451Z] Finished create-virtualenv step (success) 08:45:48 INFO - [mozharness: 2016-10-18 15:45:48.300918Z] Running install step. 08:45:48 INFO - Running pre-action listener: _resource_record_pre_action 08:45:48 INFO - Running main action method: install 08:45:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:48 INFO - Reading from file tmpfile_stdout 08:45:48 INFO - Detecting whether we're running mozinstall >=1.0... 08:45:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:45:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:45:48 INFO - Reading from file tmpfile_stdout 08:45:48 INFO - Output received: 08:45:48 INFO - Usage: mozinstall [options] installer 08:45:48 INFO - Options: 08:45:48 INFO - -h, --help show this help message and exit 08:45:48 INFO - -d DEST, --destination=DEST 08:45:48 INFO - Directory to install application into. [default: 08:45:48 INFO - "/builds/slave/test"] 08:45:48 INFO - --app=APP Application being installed. [default: firefox] 08:45:48 INFO - mkdir: /builds/slave/test/build/application 08:45: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'] 08:45: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 08:46:03 INFO - Reading from file tmpfile_stdout 08:46:03 INFO - Output received: 08:46:03 INFO - /builds/slave/test/build/application/firefox/firefox 08:46:03 INFO - Running post-action listener: _resource_record_post_action 08:46:03 INFO - [mozharness: 2016-10-18 15:46:03.558057Z] Finished install step (success) 08:46:03 INFO - [mozharness: 2016-10-18 15:46:03.558336Z] Running run-tests step. 08:46:03 INFO - Running pre-action listener: _resource_record_pre_action 08:46:03 INFO - Running main action method: run_tests 08:46:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:46:03 INFO - Python 2.7.3 08:46:03 INFO - Return code: 0 08:46:03 INFO - grabbing minidump binary from tooltool 08:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:03 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 0x270b570>, '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 0x270c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x270c900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:46:03 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 08:46:03 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 08:46:03 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 08:46:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:46:03 INFO - Return code: 0 08:46:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:46:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:46:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:46:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:46:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:46:03 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/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 08:46:03 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/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 08:46:03 INFO - Using env: {'DISPLAY': ':0', 08:46:03 INFO - 'HOME': '/home/cltbld', 08:46:03 INFO - 'LANG': 'en_US.UTF-8', 08:46:03 INFO - 'LANGUAGE': 'en_US:en', 08:46:03 INFO - 'LOGNAME': 'cltbld', 08:46:03 INFO - 'MAIL': '/var/mail/cltbld', 08:46:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:46:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:03 INFO - 'MOZ_NO_REMOTE': '1', 08:46:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:03 INFO - 'NO_EM_RESTART': '1', 08:46:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:03 INFO - 'PWD': '/builds/slave/test', 08:46:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:46:03 INFO - 'SHELL': '/bin/bash', 08:46:03 INFO - 'SHLVL': '1', 08:46:03 INFO - 'TERM': 'linux', 08:46:03 INFO - 'TMOUT': '86400', 08:46:03 INFO - 'USER': 'cltbld', 08:46:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1476799428.752022-703643501', 08:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:03 INFO - '_': '/tools/buildbot/bin/python'} 08:46:03 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/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 08:46:03 INFO - mozversion application_buildid: 20161018055521 08:46:03 INFO - mozversion application_changeset: 42362b3185baaa3c0d82c481f5facd031c7ee993 08:46:03 INFO - mozversion application_display_name: Firefox 08:46:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:46:03 INFO - mozversion application_name: Firefox 08:46:03 INFO - mozversion application_remotingname: firefox 08:46:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:46:03 INFO - mozversion application_vendor: Mozilla 08:46:03 INFO - mozversion application_version: 50.0 08:46:03 INFO - mozversion platform_buildid: 20161018055521 08:46:03 INFO - mozversion platform_changeset: 42362b3185baaa3c0d82c481f5facd031c7ee993 08:46:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:46:03 INFO - mozversion platform_version: 50.0 08:46:03 INFO - using testdate: 1476805563 08:46:03 INFO - actual date: 1476805563 08:46:03 INFO - starting webserver on 'localhost:59065' 08:46:03 INFO - SUITE-START | Running 2 tests 08:46:03 INFO - TEST-START | dromaeo_css 08:46:03 INFO - operating with platform_type : linux_ 08:46:03 INFO - Initialising browser for dromaeo_css test... 08:46:03 INFO - TEST-INFO | started process 6154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5O5R4E/profile http://localhost:59065/getInfo.html) 08:46:08 INFO - PROCESS | 6154 | __metrics Screen width/height:1600/1200 08:46:08 INFO - PROCESS | 6154 | colorDepth:24 08:46:08 INFO - PROCESS | 6154 | Browser inner width/height: 1024/697 08:46:08 INFO - PROCESS | 6154 | __metrics 08:46:09 ERROR - PROCESS | 6154 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:46:10 INFO - TEST-INFO | 6154: exit 0 08:46:10 INFO - Browser initialized. 08:46:10 INFO - Running cycle 1/1 for dromaeo_css test... 08:46:10 INFO - TEST-INFO | started process 6281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5O5R4E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:22 INFO - PROCESS | 6281 | RSS: Main: 150687744 08:46:22 INFO - PROCESS | 6281 | 08:47:12 INFO - PROCESS | 6281 | 1476805632260 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] 08:49:20 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:59065/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59065/tests/dromaeo/cssquery-ext.html) 08:49:21 INFO - PROCESS | 6281 | RSS: Main: 158310400 08:49:21 INFO - PROCESS | 6281 | 08:52:23 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:59065/tests/dromaeo/cssquery-ext.html (next: http://localhost:59065/tests/dromaeo/cssquery-jquery.html) 08:52:24 INFO - PROCESS | 6281 | RSS: Main: 155353088 08:52:24 INFO - PROCESS | 6281 | 08:55:26 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:59065/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59065/tests/dromaeo/cssquery-mootools.html) 08:55:26 INFO - PROCESS | 6281 | RSS: Main: 155222016 08:55:26 INFO - PROCESS | 6281 | 08:58:28 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:59065/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59065/tests/dromaeo/cssquery-prototype.html) 08:58:29 INFO - PROCESS | 6281 | RSS: Main: 156897280 08:58:29 INFO - PROCESS | 6281 | 09:01:31 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:59065/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59065/tests/dromaeo/cssquery-yui.html) 09:01:32 INFO - PROCESS | 6281 | RSS: Main: 157765632 09:01:32 INFO - PROCESS | 6281 | 09:04:34 INFO - PROCESS | 6281 | Cycle 1(1): loaded http://localhost:59065/tests/dromaeo/cssquery-yui.html (next: http://localhost:59065/tests/dromaeo/cssquery-dojo.html) 09:04:34 INFO - PROCESS | 6281 | RSS: Main: 157790208 09:04:34 INFO - PROCESS | 6281 | 09:04:34 INFO - PROCESS | 6281 | __start_tp_report 09:04:34 INFO - PROCESS | 6281 | _x_x_mozilla_page_load 09:04:34 INFO - PROCESS | 6281 | _x_x_mozilla_page_load_details 09:04:34 INFO - PROCESS | 6281 | |i|pagename|runs| 09:04:34 INFO - PROCESS | 6281 | |0;dojo.html;3321.086701157182;3341.6157141928684;3345.581802274715;3356.7482438817096;3374.156460884779;5876.265466816642;5958.523318134549;5973.283206015279;5979.850503737409;5992.370801065886;5885.823425297237;5905.084711869667;5909.881802363951;5952.345242023374;5958.49352805011;5342.519173274414;5387.218853266274;5413.729313534327;5447.591430642698;5485.862853428656;5447.727613619303;5454.427285135043;5455.454454554552;5456.563474921997;5462.399136095027;5206.193040078775;5285.233641122035;5446.2647542581835;5448.42791506892;5483.588730845183;5357.08929481989;5458.781648734026;5464.6994415307145;5467.890642187173;5486.972565137189;5316.38861530925;5395.082835917903;5405.783768649249;5407.080796264605;5418.485243901823;5673.149027645845;5710.229119068914;5903.557233207526;5931.187436312395;5995.580309378345;6194.690265486708;6307;6316.1788967434395;6323.841903952392;6323.9051414228825;6362.363763623647;6372.3946225109;6384.233891932998;6388.2653494847755;6403.039544068381;5714.114312281603;5742.598018138774;5905.557083218733;5919.378465261172;5924.822255332347;6266.68666566679;6316.968415157895;6324.114623952651;6330.905036424458;6357.1735674362035;6053.576249662569;6113.449789518964;6128.203333566607;6142.201513803177;6144.9246381882995;6031.849203769941;6156.630602163795;6160.9383906161265;6235.095911092957;6252.187215661935;6154.169187159676;6289.24529056507;6311.368863113652;6312.715927783261;6315.715792789336;6224.719887605069;6293.276273228637;6304.716287767062;6318;6327.050942358591;4645.953540464619;4744.881377965578;4769.904601907942;4812.590929770939;4827.782749776268;4210.5578914214175;4264.978675106605;4278.5293617702655;4296.570342965679;4328.220920234325;6124.328549168396;6169;6173.629582225081;6176.135341052256;6179.227596550431;6088.269407671108;6196.10156527301;6416.839579010469;6471.0940468334475;6478.740850365933;6064.545159113084;6109.556495504338;6117.895491762441;6120.232734228663;6123.953766440866;5469.945300547023;5470.753816078286;5475.616706830563;5482.314710661168;5483.122700367922;6270.059491076375;6373.5857169283845;6420.839479012969;6588.143541339595;6594.274629790719;6283.151774510566;6320.304766475776;6335.778247761306;6344.968275158594;6345.904811427925;6503.674816259074;6506.3493650634555;6527.706253218712;6547.181602299713;6552.082708420729;5950.285965684146;6083.878322433615;6127.448529632355;6217.285012223652;6237.12680224778;6310.84222894413;6319.58922670025;6324;6329.398707122816;6329.46199573023;6148.3236843948025;6161.229846269216;6169.413905678954;6170.784022559189;6181.227346581677;5933.1396947443245;6175.660338681416;6177.7837775677635;6185.474234690102;6278.811635650938;6207.348228435949;6217.502599792097;6235.407636274546;6249.687515624291;6253.468455181361;6246.968765156145;6293.716782744696;6324.778632747832;6347.619142851444;6357.078223657636;5918.73365698536;5921.3782552831335;6027.457528822427;6035.155078288955;6054.8183554493435 09:04:34 INFO - PROCESS | 6281 | |1;ext.html;587.6004317064397;627.6924307089525;651.7588492257864;671.251554516714;676.1446769836158;41663.58336416635;46246.537534624644;46446.535534644645;46527;46541.767291163495;46740.53259467404;47281.763591181996;47344.52655473444;47355.289670654965;47373.289400659014;8897.199252067296;9066.863997040049;9067.501287429188;9069.956954950167;9089.363744537884;8999.730008099768;9080.091990800933;9089.318301127409;9094.681686140986;9105;9097.863532047024;9110.681126160585;9128;9151.130642588976;9172.403793753418;9075.636974521045;9090.50002249876;9148.222401095914;9153.405028673149;9162.267018638493;8931.866022009675;8988.46069235848;8999.865002024975;9016.8647470288;9029.548522573845;44123.77938110321;44856.102877942256;44888.10223795538;44940.3258951116;44985.325220121726;3788.109794198361;3933.5083114610675;3945.230680017398;3959.1289916218384;4055.837766489337;34795;35273.82363088194;35580;35776.642233577855;37472.81263593692;4746.4541577718655;4761.47623761386;4785.928211076836;4819.180739274332;4849.442314133849;275845;276116;277336;277413;278163.99999999796;38724.41913371302;39915.40126898099;62805.68597156985;63375.049374259426;63504;40782.184356312704;41002.38496422556;41010;41068.58931410647;41186.58813411887;16183.595410114605;16190.352385904667;16198;16200.675986480204;16322.67354652924;13455;13491.865081349257;13559.186448813103;13569.118007329493;13601.04792664504;9133.725988220363;9270.30472714549;9331.393459425251;9379.671711490066;9381.812363752686;3512.9824350878084;3572.8928132156075;3623.3296840084668;3646.9817650911577;3656.780593164419;1131.332513816852;1135.6649788312468;1160.5067846165346;1169.3334799164566;1191.434068817305;34669.30661386758;34739.30521389558;34941;35254.82372588121;35391.16019892532;1109.7059279290995;1168.8305195746568;1173.0849937049115;1175.5709166154463;1235.975280494403;18000.549986250186;18160.273589056553;18256.452306430827;18301.267949282144;18339.899606023682;618365;618730;620528;623326;624372;64672;64931.350686493475;65174.34825651778;65247.67376163089;65256.347436525975;1404.473322504061;1415.2852809331223;1425.7433661940743;1444.5738507140209;1451.8620731030535;33152.66847331592;33556.328873422884;34095.65904340925;34271;34415;55234.447655522934;55556.72221638866;55779.721101394236;55813.72093139508;55838.441615583324;456377;459169;459314;459522;463737;31253.531197032517;31518.369632606762;31681;31999.36001279915;32153.03540893777;52204;52215.995160557024;52370.476295236556;52787.472125278255;53225;44197.13672868733;45214.54785452235;45594;46375.53624463712;47414;45189.32216016828;45504;45615.54384456113;45827.3125903105;47068.29397559108;43561.34657980196;44854.10291794081;45303.54696452993;45945.31082033839;47763.76118119526;39136.80431597824;39953;40134.598654014255;40293.98530073543;40340.193196135326;30986.535201972438;31085.844570777;31206;31461.685383145876;31644 09:04:34 INFO - PROCESS | 6281 | |2;jquery.html;407.9265732168208;418.305612682946;423.54892039977415;427.72198071253683;445.71251542754925;19013.904930475346;19838.50403739907;20630.89684551577;20969.16123355064;21084.57830843382;20244.493887652818;20549.178032878666;20663.27678531252;21066.683999740017;21269.36191914241;5783.2481777368885;5989.6406215626985;5991.400859913995;5993.550483713717;5996.700164991733;5817.7091145442555;5867.76528938842;5871.266091738533;5898.1447690084915;5943.673097979609;5697.515711164535;5842.094475356305;5863.648181109147;5875.148103524986;5893.057110862263;5699;5801.767929282823;5847.44449277318;5848.824535263906;5861.824145275648;5250.212468129811;5277.340332458442;5280.762365693515;5290.1800220965815;5290.444503327134;24598;24928.875355623288;24945;25035;25124.371890702878;2592.520383729016;2613.9346516337055;2629.9868500657567;2706.580480025599;2925.356421587269;15007.399704011827;15205.695886082216;15557.844421555752;15815.288312025987;15895.92052039744;2110.6939493773316;2123.4266747978113;2133.869049403803;2153.418576984221;2169.9566008679894;79477.60261198657;83436;83665;84180.15819841785;85554.14445855524;11145.888541114648;11363.318200907972;11550.94224528872;11560;11566.42167891602;16171.43399980995;16214.837851621569;16237.269322880498;16307.103109328864;16319.83680163207;8042.235987581171;8231.382646301432;8389.370797190235;8444.704435344856;8611.13888611134;7795.766127016199;7826.608669566499;7906.407019473562;8003;8218.096009438957;6973.163220413583;7009.4392448603985;7025.051618031501;7074.929250707427;7144.8928266076055;2065.1223230127134;2130.765615782294;2144.1637761273114;2157.5253444242244;2207.5915955548276;995.7560397702609;1045.9633912813015;1108.1578000719512;1118.182180904117;1172.513406936129;20915;20966.266180683604;21257.362279131652;21323.827189504726;21452.141914323565;955.8375076237056;1028.2545154762738;1028.8148133335922;1073.7100982734619;1104.1773878460438;11142.665720028412;11623.12826537996;11629.651110466699;11690.766184676258;11790.410479475991;544119;556127;566341;573253;581515;100161;105496;108563;109988.4500577492;110097.44951275192;1088.7822435512928;1109.7614012987246;1118.5022664914197;1126.8704099028716;1145.1754736589642;17949.192286346886;18365;18506.537336566693;18580.907095464976;18686.81313186851;37577.81211093927;40752.79623601863;44315.33526997162;47087.76456117698;47462;55686;57339.13991290051;59296;66112;67179.66410167918;8825.558722063999;9081.591328390106;9299;9384.108509691569;9472.810543789223;12844.743105137659;14287.357068932131;14753.778693319824;14907.180105094323;14947.701045978802;12749.617511474671;12769.74460510766;12774.425150868048;12849.907757840314;12885.033622478164;12488.625341239778;12504.124711270488;12611.30637814929;12785.36073196355;13001.869981300066;12463.5014599415;12716.109872308849;12804.743905121659;12834.010728337124;12890.29103399322;8938.195562399154;9132.863007054766;9272.211861991536;9409.623615055321;9474;12412.131150819718;12633.557825476064;12781.297028663514;12819.551315704279;12883.677908052374 09:04:34 INFO - PROCESS | 6281 | |3;mootools.html;1566.6553358261178;1577.0852905314914;1765.9823401765977;1848.9537761555969;1850.8519318454526;9438.575264113115;9661.130498255156;10016.24878134141;10127.24045696573;10171.593136274558;10090.798184036315;10258.07677309042;10258.948705256464;10258.948705256482;10278.434686092261;2571.0872640212688;2621.934451638705;2635.934101647455;2650.257927780215;2652.681678198619;2625.0418597211974;2636.578147496401;2654.0710751237107;2661.627372167898;2669.3326668332916;2617.031698271642;2640.749128832758;2641.1020253114034;2642.3394151462135;2643.8810253538636;2485.565026120431;2491.7632824881607;2534.733852945451;2541.7966562675033;2542.275451496315;2522.117258959368;2523.735007824189;2556.2459074573044;2560.974390256092;2562.2569454858067;9961.501924903725;10016.54925528353;10044.246681498844;10121.392716437038;10127.392356458637;5581.469760372799;5702.885942281131;5716.114002329646;5723.713814309268;5726.055200891848;3453.067671728644;3502.124468882779;3562.412201986669;3628.618995005539;3722.571904230994;1141.7545227776068;1153.6769704482758;1198.6404078776332;1212.060652993928;1213.9757204855941;14160.433582656682;14306.570802875825;14360.066595671247;14388.712225755531;14430.278486075655;4767.380240568773;5042.546170844568;5047.293378926953;5062;5075.56857667095;11153.721156970978;11183.44082795857;11185.94407027976;11193.94403027996;11232.943835280772;5497.642653227527;5520.006398848246;5529.30883639545;5533.667979921218;5536.695481748462;4561.178987782231;5110.514501122388;5119.974400127976;5133.050385678662;5169.276301317818;4178.143480586473;4238.385434112098;4328.653707703376;4336.176126536011;4403.3174857897075;1264.4120483974996;1278.6100239427064;1288.671388795851;1289.4455384184891;1291.754566632337;839.7900524868783;966.2849491376471;971.9939862242545;977.8875429325576;994.796066806303;6150.846228844314;6272.874542509125;6478.708458119396;6499.155109835691;6508.056331831858;488.1774210455394;497.2441888329791;497.47516370229033;512.8282025521493;522.9462632794921;4165.000399904001;4244.511881133647;4279.101388708406;4302.634276086567;4308.202982448257;11959.282443053444;12280.07899407548;12284.631461056182;12321.445534950948;12361.505539778487;12267.325297108744;12267.754644907052;12299;12309.630711078682;12326.383680815923;8644.740657780276;9061.456312621263;9066;9074.364794464323;9195.63217471307;6752.797416077526;6823.658817059227;6853.211880633591;6968.477364197604;7059.223485416703;11130.499127539118;11475.196736228383;11554.76890462203;11564.537418503165;11618.6514404568;11552.42237888119;11572;11672.649820505398;11679.824802628138;11743.354115523729;8769.605367758593;8808.251298639687;8842.425242359483;8924.732258032269;8947.105289471001;9517.333786634868;9597.184239339455;9619.615215391306;9622.51887405613;9657.3239873211;8301.626426810688;8345.33237340999;8453.830923381622;8477.194666506672;8746.956265218887;8149.79625509367;8256.669733210605;8355.665773368997;8444.746657600283;8542.487450752975;7428.145763237297;7599.240075992357;7630.236976302325;7633.809154771176;7640.388768898586;5562.16567514876;5660.51885589713;5667;5667.4332566743;5780.450857168562;5614.410486898817;5678.261825962599;5710.200571919851;5743.052396354722;5801.071828507418 09:04:34 INFO - PROCESS | 6281 | |4;prototype.html;336.60448972457357;338.59876046884443;342.42643572016874;344.98965031049045;348.242572405019;5759.4816466518005;5801.303843538771;5832.6792026438525;5847.766089356426;5859.355470898203;5678.744456499458;5680.403557626451;5683.777987732647;5703.429657034295;5746.367899531048;4289.142171565692;4364.607185353318;4437.689361744679;4481.260592002316;4486;4454.443194600675;4460.620847227973;4482.350059241408;4486.528914463983;4508.797104130305;4452.1986042512335;4470.508244093147;4478.731276123427;4487.509432265091;4491.887702807423;4312.805923733439;4458.598726114666;4461.687681862287;4483.618892394151;4485.3944717463055;3896.4544963705102;3935.2719746846924;3942.881713548569;3945.467361906163;3948.8420463181437;5561.666300021971;5583.4974852263085;5605;5613.522850557708;5644.153376993443;5012.949870501285;5059.569936555397;5091.770870310845;5094.5160209780015;5111.974440127813;5937.495312898365;5958.463738263577;5960.334394347488;5996.820095397145;6004.369541198155;4297.828086876521;4331.198728235287;4332.003639162978;4337.457817772778;4343.565643435662;5956.344802071769;6243.65659888706;6274.905876411812;6283.937160628381;6284.465820405271;4345.217860785026;4353.238183317907;4358.8910277242685;4359.346098085249;4368.344748287782;4318.913621727548;4413.977930110394;4414.911701765946;4416.80124394403;4422.159789639958;5000.549950504472;5024.497550244946;5046.470120637354;5055.823046193439;5080.466551012164;6027.57806953509;6037.366076561985;6061.212042434456;6080.7567697291615;6094.2077529920825;1493.9691612787142;1521.239380309845;1532.6934613077428;1541.2370876416246;1545.1424459424902;951.9666811661558;972.2902281334524;1023.1123577000423;1060.522764755863;1063.8297872340388;5900.232969713996;5915.763369465173;5919.763209471573;5937.495312898365;5949.553783466171;6196.287426945959;6229.345918678564;6236.407541283571;6241.906371404432;6260.968695156495;5726.255586773693;5907.32065812437;5909.8227053188475;5947.940520594825;5949.345571987078;3307.998660810223;3312.685294896981;3323.019709185796;3324.6675332467044;3328.6671332866517;6167.6694584924535;6368.363163683594;6386.521010924106;6460.483161347081;6480.2547707013355;6338.968305158444;6342.587731797418;6343.27052388972;6390.488760899117;6396.2964073951825;6279.434850863444;6437.871242575216;6486.902696459557;6491.091247225392;6519.359659337976;6207.193064901715;6254.9687251563455;6262;6273.466755325849;6278.6546739929745;6146.354632763496;6186.834607887204;6199.597026193283;6200.162977997912;6226.505638646783;6185;6468.838279043061;6476.514261430318;6482.70827812759;6536.869262614816;4464.888377790451;4495.640348772155;4498.482674492475;4501.954980450285;4510.1656193604285;6172.808652928145;6258.780942666985;6300.59046161998;6322.209723784527;6334.054664580992;5970.194023806905;6009.399060093956;6097.939020609737;6116.633002019893;6129.724162412613;5936.851578710567;6110.236220472441;6131.417515336036;6161.907571386522;6163.876722465615;5857.4435428634215;6016.7292471838;6056.36408177135;6090.725917333642;6096.664683442454;6145.463634091477;6161.44546990773;6163.753449862134;6173.9073913892225;6176.320604733565;5869.236999190078;6001.609895356788;6005.39946005396;6050.394960503914;6077.270727512727 09:04:34 INFO - PROCESS | 6281 | |5;yui.html;740.6926125657851;794.249434284601;798.2336956521739;800.8718605023194;838.1409055717888;15860.762088568681;17511.474655760314;17603.82396176038;17642.38251661192;17693.64612707745;16130.758038629401;16273.104979226138;16357.91821040893;16380.262888170031;16400.097994610293;861.7156338408341;866.3762091294258;889.6530353162271;889.6752685269862;893.8212357528488;873.0309356614154;874.2830878679486;874.4185116897256;875.5403413208053;878.3105262369041;918.2699753695795;920.3557509743173;921.1111277617098;921.4793641592512;932.1238036245907;921.940073895198;923.8891333040011;923.9630414783401;925.6112432778249;925.8472352061901;679.9456043516507;682.0451368084672;682.6484360554318;683.8392977650249;685.3968507713181;16316.184190790531;16329.673406531803;16337.346506139858;16410.015399075975;16412;13836.30818459073;14822.703545929022;14853.702925941529;15284.617884552865;15308.846911530853;13068.54260100892;13261.27063011534;13425.865741342657;13562.254076025814;13652.726945461036;4109.835606575763;4142.440770495975;4199.370094485821;4200.810963506649;4233.703640745149;90049.09950900472;91897.54051229701;92592;94927.52536237343;95079.9999999993;12669.746605067847;12748.872511274954;12868.356582170854;12905.677358065936;12964.027697922693;23807.523849522913;23819.642705359434;23850.403739906295;23878.164264250667;23979;8537;8555.871661925075;8631.913680863237;8810.955945220361;8819.470831750115;4938.9012219755405;4941.65408421407;5019.29729837823;5086.491350864884;5090.949090509122;3888.105735680753;4003.819828107742;4032.072623296658;4037.515498140242;4044.272031034442;669.7019826177304;674.2818897873749;703.9824004399828;729.9343059124704;736.9152547457004;727.3817255333031;728.1735230513406;740.2893222506347;764.0792844622217;768.8654485465021;10669.27433645886;10698.465076746132;10737.677869663923;10997.725056873482;11004.39475828837;596.2695697770283;701.6912558474255;707.8831992721143;721.8123287945172;820.7578764264556;5004.0578792137385;5015.533293108017;5019.437970665887;5025.23107669248;5036.093503169464;79475.60262198652;105463;117887;118060;143861;119813;121399;121562;121933;124333.37833310956;102501.48749256205;103471;103817;105565.47217263865;106335.93664063416;9217.493037882981;9305.022972587782;9372.95313523428;9481.952590237004;9798.412095274307;48381.5161848377;49878.501214988835;60481.69759151176;61779;62260.377396225456;76489.61755191188;76499;78465.21534784579;79472.20527794649;79891.60054199692;13335.533256335983;13470.595882123553;13530.864691352961;13570.796438053634;14019.649508761955;16037.278322475284;16049.919750401174;16327.183640817673;16531.421400250932;17365.913170434065;15345.733522466222;15405.76891346653;15487.922560387125;16166.757498637295;16622.916885415496;14643.707125857636;14649.26753662334;15339.846601533842;15341.232938353261;15622;14309.427622894967;14961;15468.613284667974;15617.609559761097;16318.18409079565;12727.23636581808;12950.158239714388;13036.804447933479;13089.738205236032;13590.86409135896;12461.127721059438;12570.622881313575;12841.743165136832;13096.541621043218;13217.933910330386 09:04:34 INFO - PROCESS | 6281 | __end_tp_report 09:04:34 INFO - PROCESS | 6281 | __start_cc_report 09:04:34 INFO - PROCESS | 6281 | _x_x_mozilla_cycle_collect,344 09:04:34 INFO - PROCESS | 6281 | __end_cc_report 09:04:34 INFO - PROCESS | 6281 | __startTimestamp1476806674593__endTimestamp 09:04:34 INFO - PROCESS | 6281 | 09:04:34 INFO - PROCESS | 6281 | ------- Summary: start ------- 09:04:34 INFO - PROCESS | 6281 | Number of tests: 6 09:04:34 INFO - PROCESS | 6281 | 09:04:34 INFO - PROCESS | 6281 | [#0] dojo.html Cycles:165 Average:5865.35 Median:6124.33 stddev:669.94 (10.9%) stddev-sans-first:641.57 09:04:34 INFO - PROCESS | 6281 | Values: 3321.1 3341.6 3345.6 3356.7 3374.2 5876.3 5958.5 5973.3 5979.9 5992.4 5885.8 5905.1 5909.9 5952.3 5958.5 5342.5 5387.2 5413.7 5447.6 5485.9 5447.7 5454.4 5455.5 5456.6 5462.4 5206.2 5285.2 5446.3 5448.4 5483.6 5357.1 5458.8 5464.7 5467.9 5487.0 5316.4 5395.1 5405.8 5407.1 5418.5 5673.1 5710.2 5903.6 5931.2 5995.6 6194.7 6307.0 6316.2 6323.8 6323.9 6362.4 6372.4 6384.2 6388.3 6403.0 5714.1 5742.6 5905.6 5919.4 5924.8 6266.7 6317.0 6324.1 6330.9 6357.2 6053.6 6113.4 6128.2 6142.2 6144.9 6031.8 6156.6 6160.9 6235.1 6252.2 6154.2 6289.2 6311.4 6312.7 6315.7 6224.7 6293.3 6304.7 6318.0 6327.1 4646.0 4744.9 4769.9 4812.6 4827.8 4210.6 4265.0 4278.5 4296.6 4328.2 6124.3 6169.0 6173.6 6176.1 6179.2 6088.3 6196.1 6416.8 6471.1 6478.7 6064.5 6109.6 6117.9 6120.2 6124.0 5469.9 5470.8 5475.6 5482.3 5483.1 6270.1 6373.6 6420.8 6588.1 6594.3 6283.2 6320.3 6335.8 6345.0 6345.9 6503.7 6506.3 6527.7 6547.2 6552.1 5950.3 6083.9 6127.4 6217.3 6237.1 6310.8 6319.6 6324.0 6329.4 6329.5 6148.3 6161.2 6169.4 6170.8 6181.2 5933.1 6175.7 6177.8 6185.5 6278.8 6207.3 6217.5 6235.4 6249.7 6253.5 6247.0 6293.7 6324.8 6347.6 6357.1 5918.7 5921.4 6027.5 6035.2 6054.8 09:04:34 INFO - PROCESS | 6281 | 09:04:34 INFO - PROCESS | 6281 | [#1] ext.html Cycles:180 Average:61865.44 Median:45087.32 stddev:126386.46 (280.3%) stddev-sans-first:126657.26 09:04:34 INFO - PROCESS | 6281 | Values: 587.6 627.7 651.8 671.3 676.1 41663.6 46246.5 46446.5 46527.0 46541.8 46740.5 47281.8 47344.5 47355.3 47373.3 8897.2 9066.9 9067.5 9070.0 9089.4 8999.7 9080.1 9089.3 9094.7 9105.0 9097.9 9110.7 9128.0 9151.1 9172.4 9075.6 9090.5 9148.2 9153.4 9162.3 8931.9 8988.5 8999.9 9016.9 9029.5 44123.8 44856.1 44888.1 44940.3 44985.3 3788.1 3933.5 3945.2 3959.1 4055.8 34795.0 35273.8 35580.0 35776.6 37472.8 4746.5 4761.5 4785.9 4819.2 4849.4 275845.0 276116.0 277336.0 277413.0 278164.0 38724.4 39915.4 62805.7 63375.0 63504.0 40782.2 41002.4 41010.0 41068.6 41186.6 16183.6 16190.4 16198.0 16200.7 16322.7 13455.0 13491.9 13559.2 13569.1 13601.0 9133.7 9270.3 9331.4 9379.7 9381.8 3513.0 3572.9 3623.3 3647.0 3656.8 1131.3 1135.7 1160.5 1169.3 1191.4 34669.3 34739.3 34941.0 35254.8 35391.2 1109.7 1168.8 1173.1 1175.6 1236.0 18000.5 18160.3 18256.5 18301.3 18339.9 618365.0 618730.0 620528.0 623326.0 624372.0 64672.0 64931.4 65174.3 65247.7 65256.3 1404.5 1415.3 1425.7 1444.6 1451.9 33152.7 33556.3 34095.7 34271.0 34415.0 55234.4 55556.7 55779.7 55813.7 55838.4 456377.0 459169.0 459314.0 459522.0 463737.0 31253.5 31518.4 31681.0 31999.4 32153.0 52204.0 52216.0 52370.5 52787.5 53225.0 44197.1 45214.5 45594.0 46375.5 47414.0 45189.3 45504.0 45615.5 45827.3 47068.3 43561.3 44854.1 45303.5 45945.3 47763.8 39136.8 39953.0 40134.6 40294.0 40340.2 30986.5 31085.8 31206.0 31461.7 31644.0 09:04:34 INFO - PROCESS | 6281 | 09:04:34 INFO - PROCESS | 6281 | [#2] jquery.html Cycles:180 Average:32382.83 Median:2163.74 stddev:92944.84 (4295.6%) stddev-sans-first:93174.57 09:04:34 INFO - PROCESS | 6281 | Values: 407.9 418.3 423.5 427.7 445.7 19013.9 19838.5 20630.9 20969.2 21084.6 20244.5 20549.2 20663.3 21066.7 21269.4 5783.2 5989.6 5991.4 5993.6 5996.7 5817.7 5867.8 5871.3 5898.1 5943.7 5697.5 5842.1 5863.6 5875.1 5893.1 5699.0 5801.8 5847.4 5848.8 5861.8 5250.2 5277.3 5280.8 5290.2 5290.4 24598.0 24928.9 24945.0 25035.0 25124.4 2592.5 2613.9 2630.0 2706.6 2925.4 15007.4 15205.7 15557.8 15815.3 15895.9 2110.7 2123.4 2133.9 2153.4 2170.0 79477.6 83436.0 83665.0 84180.2 85554.1 11145.9 11363.3 11550.9 11560.0 11566.4 16171.4 16214.8 16237.3 16307.1 16319.8 8042.2 8231.4 8389.4 8444.7 8611.1 7795.8 7826.6 7906.4 8003.0 8218.1 6973.2 7009.4 7025.1 7074.9 7144.9 2065.1 2130.8 2144.2 2157.5 2207.6 995.8 1046.0 1108.2 1118.2 1172.5 20915.0 20966.3 21257.4 21323.8 21452.1 955.8 1028.3 1028.8 1073.7 1104.2 11142.7 11623.1 11629.7 11690.8 11790.4 544119.0 556127.0 566341.0 573253.0 581515.0 100161.0 105496.0 108563.0 109988.5 110097.4 1088.8 1109.8 1118.5 1126.9 1145.2 17949.2 18365.0 18506.5 18580.9 18686.8 37577.8 40752.8 44315.3 47087.8 47462.0 55686.0 57339.1 59296.0 66112.0 67179.7 8825.6 9081.6 9299.0 9384.1 9472.8 12844.7 14287.4 14753.8 14907.2 14947.7 12749.6 12769.7 12774.4 12849.9 12885.0 12488.6 12504.1 12611.3 12785.4 13001.9 12463.5 12716.1 12804.7 12834.0 12890.3 8938.2 9132.9 9272.2 9409.6 9474.0 12412.1 12633.6 12781.3 12819.6 12883.7 09:04:34 INFO - PROCESS | 6281 | 09:04:34 INFO - PROCESS | 6281 | [#3] mootools.html Cycles:180 Average:6439.89 Median:4261.81 stddev:3798.20 (89.1%) stddev-sans-first:3791.20 09:04:34 INFO - PROCESS | 6281 | Values: 1566.7 1577.1 1766.0 1849.0 1850.9 9438.6 9661.1 10016.2 10127.2 10171.6 10090.8 10258.1 10258.9 10258.9 10278.4 2571.1 2621.9 2635.9 2650.3 2652.7 2625.0 2636.6 2654.1 2661.6 2669.3 2617.0 2640.7 2641.1 2642.3 2643.9 2485.6 2491.8 2534.7 2541.8 2542.3 2522.1 2523.7 2556.2 2561.0 2562.3 9961.5 10016.5 10044.2 10121.4 10127.4 5581.5 5702.9 5716.1 5723.7 5726.1 3453.1 3502.1 3562.4 3628.6 3722.6 1141.8 1153.7 1198.6 1212.1 1214.0 14160.4 14306.6 14360.1 14388.7 14430.3 4767.4 5042.5 5047.3 5062.0 5075.6 11153.7 11183.4 11185.9 11193.9 11232.9 5497.6 5520.0 5529.3 5533.7 5536.7 4561.2 5110.5 5120.0 5133.1 5169.3 4178.1 4238.4 4328.7 4336.2 4403.3 1264.4 1278.6 1288.7 1289.4 1291.8 839.8 966.3 972.0 977.9 994.8 6150.8 6272.9 6478.7 6499.2 6508.1 488.2 497.2 497.5 512.8 522.9 4165.0 4244.5 4279.1 4302.6 4308.2 11959.3 12280.1 12284.6 12321.4 12361.5 12267.3 12267.8 12299.0 12309.6 12326.4 8644.7 9061.5 9066.0 9074.4 9195.6 6752.8 6823.7 6853.2 6968.5 7059.2 11130.5 11475.2 11554.8 11564.5 11618.7 11552.4 11572.0 11672.6 11679.8 11743.4 8769.6 8808.3 8842.4 8924.7 8947.1 9517.3 9597.2 9619.6 9622.5 9657.3 8301.6 8345.3 8453.8 8477.2 8747.0 8149.8 8256.7 8355.7 8444.7 8542.5 7428.1 7599.2 7630.2 7633.8 7640.4 5562.2 5660.5 5667.0 5667.4 5780.5 5614.4 5678.3 5710.2 5743.1 5801.1 09:04:34 INFO - PROCESS | 6281 | 09:04:34 INFO - PROCESS | 6281 | [#4] prototype.html Cycles:180 Average:5103.59 Median:5884.73 stddev:1517.91 (25.8%) stddev-sans-first:1479.40 09:04:34 INFO - PROCESS | 6281 | Values: 336.6 338.6 342.4 345.0 348.2 5759.5 5801.3 5832.7 5847.8 5859.4 5678.7 5680.4 5683.8 5703.4 5746.4 4289.1 4364.6 4437.7 4481.3 4486.0 4454.4 4460.6 4482.4 4486.5 4508.8 4452.2 4470.5 4478.7 4487.5 4491.9 4312.8 4458.6 4461.7 4483.6 4485.4 3896.5 3935.3 3942.9 3945.5 3948.8 5561.7 5583.5 5605.0 5613.5 5644.2 5012.9 5059.6 5091.8 5094.5 5112.0 5937.5 5958.5 5960.3 5996.8 6004.4 4297.8 4331.2 4332.0 4337.5 4343.6 5956.3 6243.7 6274.9 6283.9 6284.5 4345.2 4353.2 4358.9 4359.3 4368.3 4318.9 4414.0 4414.9 4416.8 4422.2 5000.5 5024.5 5046.5 5055.8 5080.5 6027.6 6037.4 6061.2 6080.8 6094.2 1494.0 1521.2 1532.7 1541.2 1545.1 952.0 972.3 1023.1 1060.5 1063.8 5900.2 5915.8 5919.8 5937.5 5949.6 6196.3 6229.3 6236.4 6241.9 6261.0 5726.3 5907.3 5909.8 5947.9 5949.3 3308.0 3312.7 3323.0 3324.7 3328.7 6167.7 6368.4 6386.5 6460.5 6480.3 6339.0 6342.6 6343.3 6390.5 6396.3 6279.4 6437.9 6486.9 6491.1 6519.4 6207.2 6255.0 6262.0 6273.5 6278.7 6146.4 6186.8 6199.6 6200.2 6226.5 6185.0 6468.8 6476.5 6482.7 6536.9 4464.9 4495.6 4498.5 4502.0 4510.2 6172.8 6258.8 6300.6 6322.2 6334.1 5970.2 6009.4 6097.9 6116.6 6129.7 5936.9 6110.2 6131.4 6161.9 6163.9 5857.4 6016.7 6056.4 6090.7 6096.7 6145.5 6161.4 6163.8 6173.9 6176.3 5869.2 6001.6 6005.4 6050.4 6077.3 09:04:34 INFO - PROCESS | 6281 | 09:04:34 INFO - PROCESS | 6281 | [#5] yui.html Cycles:180 Average:23282.61 Median:4017.95 stddev:33937.80 (844.7%) stddev-sans-first:33990.80 09:04:34 INFO - PROCESS | 6281 | Values: 740.7 794.2 798.2 800.9 838.1 15860.8 17511.5 17603.8 17642.4 17693.6 16130.8 16273.1 16357.9 16380.3 16400.1 861.7 866.4 889.7 889.7 893.8 873.0 874.3 874.4 875.5 878.3 918.3 920.4 921.1 921.5 932.1 921.9 923.9 924.0 925.6 925.8 679.9 682.0 682.6 683.8 685.4 16316.2 16329.7 16337.3 16410.0 16412.0 13836.3 14822.7 14853.7 15284.6 15308.8 13068.5 13261.3 13425.9 13562.3 13652.7 4109.8 4142.4 4199.4 4200.8 4233.7 90049.1 91897.5 92592.0 94927.5 95080.0 12669.7 12748.9 12868.4 12905.7 12964.0 23807.5 23819.6 23850.4 23878.2 23979.0 8537.0 8555.9 8631.9 8811.0 8819.5 4938.9 4941.7 5019.3 5086.5 5090.9 3888.1 4003.8 4032.1 4037.5 4044.3 669.7 674.3 704.0 729.9 736.9 727.4 728.2 740.3 764.1 768.9 10669.3 10698.5 10737.7 10997.7 11004.4 596.3 701.7 707.9 721.8 820.8 5004.1 5015.5 5019.4 5025.2 5036.1 79475.6 105463.0 117887.0 118060.0 143861.0 119813.0 121399.0 121562.0 121933.0 124333.4 102501.5 103471.0 103817.0 105565.5 106335.9 9217.5 9305.0 9373.0 9482.0 9798.4 48381.5 49878.5 60481.7 61779.0 62260.4 76489.6 76499.0 78465.2 79472.2 79891.6 13335.5 13470.6 13530.9 13570.8 14019.6 16037.3 16049.9 16327.2 16531.4 17365.9 15345.7 15405.8 15487.9 16166.8 16622.9 14643.7 14649.3 15339.8 15341.2 15622.0 14309.4 14961.0 15468.6 15617.6 16318.2 12727.2 12950.2 13036.8 13089.7 13590.9 12461.1 12570.6 12841.7 13096.5 13217.9 09:04:34 INFO - PROCESS | 6281 | -------- Summary: end -------- 09:04:34 INFO - PROCESS | 6281 | 09:04:35 INFO - TEST-INFO | 6281: exit 0 09:04:35 INFO - TEST-OK | dromaeo_css | took 1111435ms 09:04:35 INFO - TEST-START | kraken 09:04:35 INFO - operating with platform_type : linux_ 09:04:35 INFO - Initialising browser for kraken test... 09:04:35 INFO - TEST-INFO | started process 6526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6BKR5o/profile http://localhost:59065/getInfo.html) 09:04:40 INFO - PROCESS | 6526 | __metrics Screen width/height:1600/1200 09:04:40 INFO - PROCESS | 6526 | colorDepth:24 09:04:40 INFO - PROCESS | 6526 | Browser inner width/height: 1024/697 09:04:40 INFO - PROCESS | 6526 | __metrics 09:04:41 ERROR - PROCESS | 6526 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:04:41 INFO - TEST-INFO | 6526: exit 0 09:04:41 INFO - Browser initialized. 09:04:41 INFO - Running cycle 1/1 for kraken test... 09:04:41 INFO - TEST-INFO | started process 6653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6BKR5o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:53 INFO - PROCESS | 6653 | RSS: Main: 150331392 09:04:53 INFO - PROCESS | 6653 | 09:04:56 INFO - PROCESS | 6653 | Cycle 1(1): loaded http://localhost:59065/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59065/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:56 INFO - PROCESS | 6653 | RSS: Main: 156377088 09:04:56 INFO - PROCESS | 6653 | 09:04:59 INFO - PROCESS | 6653 | Cycle 1(1): loaded http://localhost:59065/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59065/tests/kraken/driver.html?testName=audio-dft) 09:05:00 INFO - PROCESS | 6653 | RSS: Main: 155078656 09:05:00 INFO - PROCESS | 6653 | 09:05:03 INFO - PROCESS | 6653 | Cycle 1(1): loaded http://localhost:59065/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59065/tests/kraken/driver.html?testName=audio-fft) 09:05:03 INFO - PROCESS | 6653 | RSS: Main: 155566080 09:05:03 INFO - PROCESS | 6653 | 09:05:05 INFO - PROCESS | 6653 | Cycle 1(1): loaded http://localhost:59065/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59065/tests/kraken/driver.html?testName=audio-oscillator) 09:05:06 INFO - PROCESS | 6653 | RSS: Main: 155709440 09:05:06 INFO - PROCESS | 6653 | 09:05:08 INFO - PROCESS | 6653 | Cycle 1(1): loaded http://localhost:59065/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59065/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:05:09 INFO - PROCESS | 6653 | RSS: Main: 156155904 09:05:09 INFO - PROCESS | 6653 | 09:05:12 INFO - PROCESS | 6653 | Cycle 1(1): loaded http://localhost:59065/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59065/tests/kraken/driver.html?testName=imaging-darkroom) 09:05:12 INFO - PROCESS | 6653 | RSS: Main: 156266496 09:05:12 INFO - PROCESS | 6653 | 09:05:16 INFO - PROCESS | 6653 | Cycle 1(1): loaded http://localhost:59065/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59065/tests/kraken/driver.html?testName=imaging-desaturate) 09:05:16 INFO - PROCESS | 6653 | RSS: Main: 156966912 09:05:16 INFO - PROCESS | 6653 | 09:05:19 INFO - PROCESS | 6653 | Cycle 1(1): loaded http://localhost:59065/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59065/tests/kraken/driver.html?testName=json-parse-financial) 09:05:20 INFO - PROCESS | 6653 | RSS: Main: 156553216 09:05:20 INFO - PROCESS | 6653 | 09:05:21 INFO - PROCESS | 6653 | Cycle 1(1): loaded http://localhost:59065/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59065/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:05:22 INFO - PROCESS | 6653 | RSS: Main: 155803648 09:05:22 INFO - PROCESS | 6653 | 09:05:24 INFO - PROCESS | 6653 | Cycle 1(1): loaded http://localhost:59065/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59065/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:05:24 INFO - PROCESS | 6653 | RSS: Main: 155951104 09:05:24 INFO - PROCESS | 6653 | 09:05:26 INFO - PROCESS | 6653 | Cycle 1(1): loaded http://localhost:59065/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59065/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:05:27 INFO - PROCESS | 6653 | RSS: Main: 156835840 09:05:27 INFO - PROCESS | 6653 | 09:05:29 INFO - PROCESS | 6653 | Cycle 1(1): loaded http://localhost:59065/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:05:30 INFO - PROCESS | 6653 | RSS: Main: 156422144 09:05:30 INFO - PROCESS | 6653 | 09:05:33 INFO - PROCESS | 6653 | Cycle 1(1): loaded http://localhost:59065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:05:33 INFO - PROCESS | 6653 | RSS: Main: 156930048 09:05:33 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | Cycle 1(1): loaded http://localhost:59065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59065/tests/kraken/driver.html?testName=ai-astar) 09:05:35 INFO - PROCESS | 6653 | RSS: Main: 158568448 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | __start_tp_report 09:05:35 INFO - PROCESS | 6653 | _x_x_mozilla_page_load 09:05:35 INFO - PROCESS | 6653 | _x_x_mozilla_page_load_details 09:05:35 INFO - PROCESS | 6653 | |i|pagename|runs| 09:05:35 INFO - PROCESS | 6653 | |0;ai-astar;101;111;107;110;111;110;111;112;111;111 09:05:35 INFO - PROCESS | 6653 | |1;audio-beat-detection;144;122;158;173;120;145;146;118;169;117 09:05:35 INFO - PROCESS | 6653 | |2;audio-dft;163;164;164;163;162;162;172;164;164;161 09:05:35 INFO - PROCESS | 6653 | |3;audio-fft;76;76;75;171;76;75;76;76;171;76 09:05:35 INFO - PROCESS | 6653 | |4;audio-oscillator;83;84;143;83;82;83;131;83;84;147 09:05:35 INFO - PROCESS | 6653 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;121;118 09:05:35 INFO - PROCESS | 6653 | |6;imaging-darkroom;147;146;147;147;147;147;150;146;147;148 09:05:35 INFO - PROCESS | 6653 | |7;imaging-desaturate;97;95;95;95;96;95;95;96;96;95 09:05:35 INFO - PROCESS | 6653 | |8;json-parse-financial;50;56;51;56;52;53;52;52;51;51 09:05:35 INFO - PROCESS | 6653 | |9;json-stringify-tinderbox;62;61;62;62;62;62;62;63;66;62 09:05:35 INFO - PROCESS | 6653 | |10;stanford-crypto-aes;74;78;73;74;74;73;74;72;79;73 09:05:35 INFO - PROCESS | 6653 | |11;stanford-crypto-ccm;133;125;128;122;130;128;127;131;155;119 09:05:35 INFO - PROCESS | 6653 | |12;stanford-crypto-pbkdf2;152;151;154;153;150;155;157;149;157;152 09:05:35 INFO - PROCESS | 6653 | |13;stanford-crypto-sha256-iterative;65;63;65;62;70;62;63;61;63;61 09:05:35 INFO - PROCESS | 6653 | __end_tp_report 09:05:35 INFO - PROCESS | 6653 | __start_cc_report 09:05:35 INFO - PROCESS | 6653 | _x_x_mozilla_cycle_collect,882 09:05:35 INFO - PROCESS | 6653 | __end_cc_report 09:05:35 INFO - PROCESS | 6653 | __startTimestamp1476806735864__endTimestamp 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | ------- Summary: start ------- 09:05:35 INFO - PROCESS | 6653 | Number of tests: 14 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.27 (2.9%) stddev-sans-first:1.42 09:05:35 INFO - PROCESS | 6653 | Values: 101.0 111.0 107.0 110.0 111.0 110.0 111.0 112.0 111.0 111.0 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:145.50 stddev:21.22 (14.6%) stddev-sans-first:22.49 09:05:35 INFO - PROCESS | 6653 | Values: 144.0 122.0 158.0 173.0 120.0 145.0 146.0 118.0 169.0 117.0 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:3.03 (1.9%) stddev-sans-first:3.20 09:05:35 INFO - PROCESS | 6653 | Values: 163.0 164.0 164.0 163.0 162.0 162.0 172.0 164.0 164.0 161.0 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:40.16 (52.8%) stddev-sans-first:42.02 09:05:35 INFO - PROCESS | 6653 | Values: 76.0 76.0 75.0 171.0 76.0 75.0 76.0 76.0 171.0 76.0 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | [#4] audio-oscillator Cycles:10 Average:100.30 Median:83.00 stddev:27.91 (33.6%) stddev-sans-first:28.89 09:05:35 INFO - PROCESS | 6653 | Values: 83.0 84.0 143.0 83.0 82.0 83.0 131.0 83.0 84.0 147.0 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:1.26 (1.1%) stddev-sans-first:1.33 09:05:35 INFO - PROCESS | 6653 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 121.0 118.0 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 09:05:35 INFO - PROCESS | 6653 | Values: 147.0 146.0 147.0 147.0 147.0 147.0 150.0 146.0 147.0 148.0 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.50 09:05:35 INFO - PROCESS | 6653 | Values: 97.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.00 stddev:2.07 (4.0%) stddev-sans-first:2.00 09:05:35 INFO - PROCESS | 6653 | Values: 50.0 56.0 51.0 56.0 52.0 53.0 52.0 52.0 51.0 51.0 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.00 stddev:1.35 (2.2%) stddev-sans-first:1.42 09:05:35 INFO - PROCESS | 6653 | Values: 62.0 61.0 62.0 62.0 62.0 62.0 62.0 63.0 66.0 62.0 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:74.00 stddev:2.27 (3.1%) stddev-sans-first:2.40 09:05:35 INFO - PROCESS | 6653 | Values: 74.0 78.0 73.0 74.0 74.0 73.0 74.0 72.0 79.0 73.0 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:129.00 stddev:9.78 (7.6%) stddev-sans-first:10.31 09:05:35 INFO - PROCESS | 6653 | Values: 133.0 125.0 128.0 122.0 130.0 128.0 127.0 131.0 155.0 119.0 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.00 Median:153.50 stddev:2.75 (1.8%) stddev-sans-first:2.89 09:05:35 INFO - PROCESS | 6653 | Values: 152.0 151.0 154.0 153.0 150.0 155.0 157.0 149.0 157.0 152.0 09:05:35 INFO - PROCESS | 6653 | 09:05:35 INFO - PROCESS | 6653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:2.68 (4.2%) stddev-sans-first:2.78 09:05:35 INFO - PROCESS | 6653 | Values: 65.0 63.0 65.0 62.0 70.0 62.0 63.0 61.0 63.0 61.0 09:05:35 INFO - PROCESS | 6653 | -------- Summary: end -------- 09:05:35 INFO - PROCESS | 6653 | 09:05:36 INFO - TEST-INFO | 6653: exit 0 09:05:36 INFO - TEST-OK | kraken | took 61614ms 09:05:36 INFO - SUITE-END | took 1173s 09:05:37 INFO - Completed test suite (00:19:33) 09:05:37 INFO - javascript benchmark 09:05:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7801.3223880118685, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3321.086701157182, 3341.6157141928684, 3345.581802274715, 3356.7482438817096, 3374.156460884779, 5876.265466816642, 5958.523318134549, 5973.283206015279, 5979.850503737409, 5992.370801065886, 5885.823425297237, 5905.084711869667, 5909.881802363951, 5952.345242023374, 5958.49352805011, 5342.519173274414, 5387.218853266274, 5413.729313534327, 5447.591430642698, 5485.862853428656, 5447.727613619303, 5454.427285135043, 5455.454454554552, 5456.563474921997, 5462.399136095027, 5206.193040078775, 5285.233641122035, 5446.2647542581835, 5448.42791506892, 5483.588730845183, 5357.08929481989, 5458.781648734026, 5464.6994415307145, 5467.890642187173, 5486.972565137189, 5316.38861530925, 5395.082835917903, 5405.783768649249, 5407.080796264605, 5418.485243901823, 5673.149027645845, 5710.229119068914, 5903.557233207526, 5931.187436312395, 5995.580309378345, 6194.690265486708, 6307.0, 6316.1788967434395, 6323.841903952392, 6323.9051414228825, 6362.363763623647, 6372.3946225109, 6384.233891932998, 6388.2653494847755, 6403.039544068381, 5714.114312281603, 5742.598018138774, 5905.557083218733, 5919.378465261172, 5924.822255332347, 6266.68666566679, 6316.968415157895, 6324.114623952651, 6330.905036424458, 6357.1735674362035, 6053.576249662569, 6113.449789518964, 6128.203333566607, 6142.201513803177, 6144.9246381882995, 6031.849203769941, 6156.630602163795, 6160.9383906161265, 6235.095911092957, 6252.187215661935, 6154.169187159676, 6289.24529056507, 6311.368863113652, 6312.715927783261, 6315.715792789336, 6224.719887605069, 6293.276273228637, 6304.716287767062, 6318.0, 6327.050942358591, 4645.953540464619, 4744.881377965578, 4769.904601907942, 4812.590929770939, 4827.782749776268, 4210.5578914214175, 4264.978675106605, 4278.5293617702655, 4296.570342965679, 4328.220920234325, 6124.328549168396, 6169.0, 6173.629582225081, 6176.135341052256, 6179.227596550431, 6088.269407671108, 6196.10156527301, 6416.839579010469, 6471.0940468334475, 6478.740850365933, 6064.545159113084, 6109.556495504338, 6117.895491762441, 6120.232734228663, 6123.953766440866, 5469.945300547023, 5470.753816078286, 5475.616706830563, 5482.314710661168, 5483.122700367922, 6270.059491076375, 6373.5857169283845, 6420.839479012969, 6588.143541339595, 6594.274629790719, 6283.151774510566, 6320.304766475776, 6335.778247761306, 6344.968275158594, 6345.904811427925, 6503.674816259074, 6506.3493650634555, 6527.706253218712, 6547.181602299713, 6552.082708420729, 5950.285965684146, 6083.878322433615, 6127.448529632355, 6217.285012223652, 6237.12680224778, 6310.84222894413, 6319.58922670025, 6324.0, 6329.398707122816, 6329.46199573023, 6148.3236843948025, 6161.229846269216, 6169.413905678954, 6170.784022559189, 6181.227346581677, 5933.1396947443245, 6175.660338681416, 6177.7837775677635, 6185.474234690102, 6278.811635650938, 6207.348228435949, 6217.502599792097, 6235.407636274546, 6249.687515624291, 6253.468455181361, 6246.968765156145, 6293.716782744696, 6324.778632747832, 6347.619142851444, 6357.078223657636, 5918.73365698536, 5921.3782552831335, 6027.457528822427, 6035.155078288955, 6054.8183554493435], "value": 5819.178623609565, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.6004317064397, 627.6924307089525, 651.7588492257864, 671.251554516714, 676.1446769836158, 41663.58336416635, 46246.537534624644, 46446.535534644645, 46527.0, 46541.767291163495, 46740.53259467404, 47281.763591181996, 47344.52655473444, 47355.289670654965, 47373.289400659014, 8897.199252067296, 9066.863997040049, 9067.501287429188, 9069.956954950167, 9089.363744537884, 8999.730008099768, 9080.091990800933, 9089.318301127409, 9094.681686140986, 9105.0, 9097.863532047024, 9110.681126160585, 9128.0, 9151.130642588976, 9172.403793753418, 9075.636974521045, 9090.50002249876, 9148.222401095914, 9153.405028673149, 9162.267018638493, 8931.866022009675, 8988.46069235848, 8999.865002024975, 9016.8647470288, 9029.548522573845, 44123.77938110321, 44856.102877942256, 44888.10223795538, 44940.3258951116, 44985.325220121726, 3788.109794198361, 3933.5083114610675, 3945.230680017398, 3959.1289916218384, 4055.837766489337, 34795.0, 35273.82363088194, 35580.0, 35776.642233577855, 37472.81263593692, 4746.4541577718655, 4761.47623761386, 4785.928211076836, 4819.180739274332, 4849.442314133849, 275845.0, 276116.0, 277336.0, 277413.0, 278163.99999999796, 38724.41913371302, 39915.40126898099, 62805.68597156985, 63375.049374259426, 63504.0, 40782.184356312704, 41002.38496422556, 41010.0, 41068.58931410647, 41186.58813411887, 16183.595410114605, 16190.352385904667, 16198.0, 16200.675986480204, 16322.67354652924, 13455.0, 13491.865081349257, 13559.186448813103, 13569.118007329493, 13601.04792664504, 9133.725988220363, 9270.30472714549, 9331.393459425251, 9379.671711490066, 9381.812363752686, 3512.9824350878084, 3572.8928132156075, 3623.3296840084668, 3646.9817650911577, 3656.780593164419, 1131.332513816852, 1135.6649788312468, 1160.5067846165346, 1169.3334799164566, 1191.434068817305, 34669.30661386758, 34739.30521389558, 34941.0, 35254.82372588121, 35391.16019892532, 1109.7059279290995, 1168.8305195746568, 1173.0849937049115, 1175.5709166154463, 1235.975280494403, 18000.549986250186, 18160.273589056553, 18256.452306430827, 18301.267949282144, 18339.899606023682, 618365.0, 618730.0, 620528.0, 623326.0, 624372.0, 64672.0, 64931.350686493475, 65174.34825651778, 65247.67376163089, 65256.347436525975, 1404.473322504061, 1415.2852809331223, 1425.7433661940743, 1444.5738507140209, 1451.8620731030535, 33152.66847331592, 33556.328873422884, 34095.65904340925, 34271.0, 34415.0, 55234.447655522934, 55556.72221638866, 55779.721101394236, 55813.72093139508, 55838.441615583324, 456377.0, 459169.0, 459314.0, 459522.0, 463737.0, 31253.531197032517, 31518.369632606762, 31681.0, 31999.36001279915, 32153.03540893777, 52204.0, 52215.995160557024, 52370.476295236556, 52787.472125278255, 53225.0, 44197.13672868733, 45214.54785452235, 45594.0, 46375.53624463712, 47414.0, 45189.32216016828, 45504.0, 45615.54384456113, 45827.3125903105, 47068.29397559108, 43561.34657980196, 44854.10291794081, 45303.54696452993, 45945.31082033839, 47763.76118119526, 39136.80431597824, 39953.0, 40134.598654014255, 40293.98530073543, 40340.193196135326, 30986.535201972438, 31085.844570777, 31206.0, 31461.685383145876, 31644.0], "value": 20206.05873733417, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.9265732168208, 418.305612682946, 423.54892039977415, 427.72198071253683, 445.71251542754925, 19013.904930475346, 19838.50403739907, 20630.89684551577, 20969.16123355064, 21084.57830843382, 20244.493887652818, 20549.178032878666, 20663.27678531252, 21066.683999740017, 21269.36191914241, 5783.2481777368885, 5989.6406215626985, 5991.400859913995, 5993.550483713717, 5996.700164991733, 5817.7091145442555, 5867.76528938842, 5871.266091738533, 5898.1447690084915, 5943.673097979609, 5697.515711164535, 5842.094475356305, 5863.648181109147, 5875.148103524986, 5893.057110862263, 5699.0, 5801.767929282823, 5847.44449277318, 5848.824535263906, 5861.824145275648, 5250.212468129811, 5277.340332458442, 5280.762365693515, 5290.1800220965815, 5290.444503327134, 24598.0, 24928.875355623288, 24945.0, 25035.0, 25124.371890702878, 2592.520383729016, 2613.9346516337055, 2629.9868500657567, 2706.580480025599, 2925.356421587269, 15007.399704011827, 15205.695886082216, 15557.844421555752, 15815.288312025987, 15895.92052039744, 2110.6939493773316, 2123.4266747978113, 2133.869049403803, 2153.418576984221, 2169.9566008679894, 79477.60261198657, 83436.0, 83665.0, 84180.15819841785, 85554.14445855524, 11145.888541114648, 11363.318200907972, 11550.94224528872, 11560.0, 11566.42167891602, 16171.43399980995, 16214.837851621569, 16237.269322880498, 16307.103109328864, 16319.83680163207, 8042.235987581171, 8231.382646301432, 8389.370797190235, 8444.704435344856, 8611.13888611134, 7795.766127016199, 7826.608669566499, 7906.407019473562, 8003.0, 8218.096009438957, 6973.163220413583, 7009.4392448603985, 7025.051618031501, 7074.929250707427, 7144.8928266076055, 2065.1223230127134, 2130.765615782294, 2144.1637761273114, 2157.5253444242244, 2207.5915955548276, 995.7560397702609, 1045.9633912813015, 1108.1578000719512, 1118.182180904117, 1172.513406936129, 20915.0, 20966.266180683604, 21257.362279131652, 21323.827189504726, 21452.141914323565, 955.8375076237056, 1028.2545154762738, 1028.8148133335922, 1073.7100982734619, 1104.1773878460438, 11142.665720028412, 11623.12826537996, 11629.651110466699, 11690.766184676258, 11790.410479475991, 544119.0, 556127.0, 566341.0, 573253.0, 581515.0, 100161.0, 105496.0, 108563.0, 109988.4500577492, 110097.44951275192, 1088.7822435512928, 1109.7614012987246, 1118.5022664914197, 1126.8704099028716, 1145.1754736589642, 17949.192286346886, 18365.0, 18506.537336566693, 18580.907095464976, 18686.81313186851, 37577.81211093927, 40752.79623601863, 44315.33526997162, 47087.76456117698, 47462.0, 55686.0, 57339.13991290051, 59296.0, 66112.0, 67179.66410167918, 8825.558722063999, 9081.591328390106, 9299.0, 9384.108509691569, 9472.810543789223, 12844.743105137659, 14287.357068932131, 14753.778693319824, 14907.180105094323, 14947.701045978802, 12749.617511474671, 12769.74460510766, 12774.425150868048, 12849.907757840314, 12885.033622478164, 12488.625341239778, 12504.124711270488, 12611.30637814929, 12785.36073196355, 13001.869981300066, 12463.5014599415, 12716.109872308849, 12804.743905121659, 12834.010728337124, 12890.29103399322, 8938.195562399154, 9132.863007054766, 9272.211861991536, 9409.623615055321, 9474.0, 12412.131150819718, 12633.557825476064, 12781.297028663514, 12819.551315704279, 12883.677908052374], "value": 10036.08787756849, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1566.6553358261178, 1577.0852905314914, 1765.9823401765977, 1848.9537761555969, 1850.8519318454526, 9438.575264113115, 9661.130498255156, 10016.24878134141, 10127.24045696573, 10171.593136274558, 10090.798184036315, 10258.07677309042, 10258.948705256464, 10258.948705256482, 10278.434686092261, 2571.0872640212688, 2621.934451638705, 2635.934101647455, 2650.257927780215, 2652.681678198619, 2625.0418597211974, 2636.578147496401, 2654.0710751237107, 2661.627372167898, 2669.3326668332916, 2617.031698271642, 2640.749128832758, 2641.1020253114034, 2642.3394151462135, 2643.8810253538636, 2485.565026120431, 2491.7632824881607, 2534.733852945451, 2541.7966562675033, 2542.275451496315, 2522.117258959368, 2523.735007824189, 2556.2459074573044, 2560.974390256092, 2562.2569454858067, 9961.501924903725, 10016.54925528353, 10044.246681498844, 10121.392716437038, 10127.392356458637, 5581.469760372799, 5702.885942281131, 5716.114002329646, 5723.713814309268, 5726.055200891848, 3453.067671728644, 3502.124468882779, 3562.412201986669, 3628.618995005539, 3722.571904230994, 1141.7545227776068, 1153.6769704482758, 1198.6404078776332, 1212.060652993928, 1213.9757204855941, 14160.433582656682, 14306.570802875825, 14360.066595671247, 14388.712225755531, 14430.278486075655, 4767.380240568773, 5042.546170844568, 5047.293378926953, 5062.0, 5075.56857667095, 11153.721156970978, 11183.44082795857, 11185.94407027976, 11193.94403027996, 11232.943835280772, 5497.642653227527, 5520.006398848246, 5529.30883639545, 5533.667979921218, 5536.695481748462, 4561.178987782231, 5110.514501122388, 5119.974400127976, 5133.050385678662, 5169.276301317818, 4178.143480586473, 4238.385434112098, 4328.653707703376, 4336.176126536011, 4403.3174857897075, 1264.4120483974996, 1278.6100239427064, 1288.671388795851, 1289.4455384184891, 1291.754566632337, 839.7900524868783, 966.2849491376471, 971.9939862242545, 977.8875429325576, 994.796066806303, 6150.846228844314, 6272.874542509125, 6478.708458119396, 6499.155109835691, 6508.056331831858, 488.1774210455394, 497.2441888329791, 497.47516370229033, 512.8282025521493, 522.9462632794921, 4165.000399904001, 4244.511881133647, 4279.101388708406, 4302.634276086567, 4308.202982448257, 11959.282443053444, 12280.07899407548, 12284.631461056182, 12321.445534950948, 12361.505539778487, 12267.325297108744, 12267.754644907052, 12299.0, 12309.630711078682, 12326.383680815923, 8644.740657780276, 9061.456312621263, 9066.0, 9074.364794464323, 9195.63217471307, 6752.797416077526, 6823.658817059227, 6853.211880633591, 6968.477364197604, 7059.223485416703, 11130.499127539118, 11475.196736228383, 11554.76890462203, 11564.537418503165, 11618.6514404568, 11552.42237888119, 11572.0, 11672.649820505398, 11679.824802628138, 11743.354115523729, 8769.605367758593, 8808.251298639687, 8842.425242359483, 8924.732258032269, 8947.105289471001, 9517.333786634868, 9597.184239339455, 9619.615215391306, 9622.51887405613, 9657.3239873211, 8301.626426810688, 8345.33237340999, 8453.830923381622, 8477.194666506672, 8746.956265218887, 8149.79625509367, 8256.669733210605, 8355.665773368997, 8444.746657600283, 8542.487450752975, 7428.145763237297, 7599.240075992357, 7630.236976302325, 7633.809154771176, 7640.388768898586, 5562.16567514876, 5660.51885589713, 5667.0, 5667.4332566743, 5780.450857168562, 5614.410486898817, 5678.261825962599, 5710.200571919851, 5743.052396354722, 5801.071828507418], "value": 5000.453039512337, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.60448972457357, 338.59876046884443, 342.42643572016874, 344.98965031049045, 348.242572405019, 5759.4816466518005, 5801.303843538771, 5832.6792026438525, 5847.766089356426, 5859.355470898203, 5678.744456499458, 5680.403557626451, 5683.777987732647, 5703.429657034295, 5746.367899531048, 4289.142171565692, 4364.607185353318, 4437.689361744679, 4481.260592002316, 4486.0, 4454.443194600675, 4460.620847227973, 4482.350059241408, 4486.528914463983, 4508.797104130305, 4452.1986042512335, 4470.508244093147, 4478.731276123427, 4487.509432265091, 4491.887702807423, 4312.805923733439, 4458.598726114666, 4461.687681862287, 4483.618892394151, 4485.3944717463055, 3896.4544963705102, 3935.2719746846924, 3942.881713548569, 3945.467361906163, 3948.8420463181437, 5561.666300021971, 5583.4974852263085, 5605.0, 5613.522850557708, 5644.153376993443, 5012.949870501285, 5059.569936555397, 5091.770870310845, 5094.5160209780015, 5111.974440127813, 5937.495312898365, 5958.463738263577, 5960.334394347488, 5996.820095397145, 6004.369541198155, 4297.828086876521, 4331.198728235287, 4332.003639162978, 4337.457817772778, 4343.565643435662, 5956.344802071769, 6243.65659888706, 6274.905876411812, 6283.937160628381, 6284.465820405271, 4345.217860785026, 4353.238183317907, 4358.8910277242685, 4359.346098085249, 4368.344748287782, 4318.913621727548, 4413.977930110394, 4414.911701765946, 4416.80124394403, 4422.159789639958, 5000.549950504472, 5024.497550244946, 5046.470120637354, 5055.823046193439, 5080.466551012164, 6027.57806953509, 6037.366076561985, 6061.212042434456, 6080.7567697291615, 6094.2077529920825, 1493.9691612787142, 1521.239380309845, 1532.6934613077428, 1541.2370876416246, 1545.1424459424902, 951.9666811661558, 972.2902281334524, 1023.1123577000423, 1060.522764755863, 1063.8297872340388, 5900.232969713996, 5915.763369465173, 5919.763209471573, 5937.495312898365, 5949.553783466171, 6196.287426945959, 6229.345918678564, 6236.407541283571, 6241.906371404432, 6260.968695156495, 5726.255586773693, 5907.32065812437, 5909.8227053188475, 5947.940520594825, 5949.345571987078, 3307.998660810223, 3312.685294896981, 3323.019709185796, 3324.6675332467044, 3328.6671332866517, 6167.6694584924535, 6368.363163683594, 6386.521010924106, 6460.483161347081, 6480.2547707013355, 6338.968305158444, 6342.587731797418, 6343.27052388972, 6390.488760899117, 6396.2964073951825, 6279.434850863444, 6437.871242575216, 6486.902696459557, 6491.091247225392, 6519.359659337976, 6207.193064901715, 6254.9687251563455, 6262.0, 6273.466755325849, 6278.6546739929745, 6146.354632763496, 6186.834607887204, 6199.597026193283, 6200.162977997912, 6226.505638646783, 6185.0, 6468.838279043061, 6476.514261430318, 6482.70827812759, 6536.869262614816, 4464.888377790451, 4495.640348772155, 4498.482674492475, 4501.954980450285, 4510.1656193604285, 6172.808652928145, 6258.780942666985, 6300.59046161998, 6322.209723784527, 6334.054664580992, 5970.194023806905, 6009.399060093956, 6097.939020609737, 6116.633002019893, 6129.724162412613, 5936.851578710567, 6110.236220472441, 6131.417515336036, 6161.907571386522, 6163.876722465615, 5857.4435428634215, 6016.7292471838, 6056.36408177135, 6090.725917333642, 6096.664683442454, 6145.463634091477, 6161.44546990773, 6163.753449862134, 6173.9073913892225, 6176.320604733565, 5869.236999190078, 6001.609895356788, 6005.39946005396, 6050.394960503914, 6077.270727512727], "value": 4611.966771428531, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.6926125657851, 794.249434284601, 798.2336956521739, 800.8718605023194, 838.1409055717888, 15860.762088568681, 17511.474655760314, 17603.82396176038, 17642.38251661192, 17693.64612707745, 16130.758038629401, 16273.104979226138, 16357.91821040893, 16380.262888170031, 16400.097994610293, 861.7156338408341, 866.3762091294258, 889.6530353162271, 889.6752685269862, 893.8212357528488, 873.0309356614154, 874.2830878679486, 874.4185116897256, 875.5403413208053, 878.3105262369041, 918.2699753695795, 920.3557509743173, 921.1111277617098, 921.4793641592512, 932.1238036245907, 921.940073895198, 923.8891333040011, 923.9630414783401, 925.6112432778249, 925.8472352061901, 679.9456043516507, 682.0451368084672, 682.6484360554318, 683.8392977650249, 685.3968507713181, 16316.184190790531, 16329.673406531803, 16337.346506139858, 16410.015399075975, 16412.0, 13836.30818459073, 14822.703545929022, 14853.702925941529, 15284.617884552865, 15308.846911530853, 13068.54260100892, 13261.27063011534, 13425.865741342657, 13562.254076025814, 13652.726945461036, 4109.835606575763, 4142.440770495975, 4199.370094485821, 4200.810963506649, 4233.703640745149, 90049.09950900472, 91897.54051229701, 92592.0, 94927.52536237343, 95079.9999999993, 12669.746605067847, 12748.872511274954, 12868.356582170854, 12905.677358065936, 12964.027697922693, 23807.523849522913, 23819.642705359434, 23850.403739906295, 23878.164264250667, 23979.0, 8537.0, 8555.871661925075, 8631.913680863237, 8810.955945220361, 8819.470831750115, 4938.9012219755405, 4941.65408421407, 5019.29729837823, 5086.491350864884, 5090.949090509122, 3888.105735680753, 4003.819828107742, 4032.072623296658, 4037.515498140242, 4044.272031034442, 669.7019826177304, 674.2818897873749, 703.9824004399828, 729.9343059124704, 736.9152547457004, 727.3817255333031, 728.1735230513406, 740.2893222506347, 764.0792844622217, 768.8654485465021, 10669.27433645886, 10698.465076746132, 10737.677869663923, 10997.725056873482, 11004.39475828837, 596.2695697770283, 701.6912558474255, 707.8831992721143, 721.8123287945172, 820.7578764264556, 5004.0578792137385, 5015.533293108017, 5019.437970665887, 5025.23107669248, 5036.093503169464, 79475.60262198652, 105463.0, 117887.0, 118060.0, 143861.0, 119813.0, 121399.0, 121562.0, 121933.0, 124333.37833310956, 102501.48749256205, 103471.0, 103817.0, 105565.47217263865, 106335.93664063416, 9217.493037882981, 9305.022972587782, 9372.95313523428, 9481.952590237004, 9798.412095274307, 48381.5161848377, 49878.501214988835, 60481.69759151176, 61779.0, 62260.377396225456, 76489.61755191188, 76499.0, 78465.21534784579, 79472.20527794649, 79891.60054199692, 13335.533256335983, 13470.595882123553, 13530.864691352961, 13570.796438053634, 14019.649508761955, 16037.278322475284, 16049.919750401174, 16327.183640817673, 16531.421400250932, 17365.913170434065, 15345.733522466222, 15405.76891346653, 15487.922560387125, 16166.757498637295, 16622.916885415496, 14643.707125857636, 14649.26753662334, 15339.846601533842, 15341.232938353261, 15622.0, 14309.427622894967, 14961.0, 15468.613284667974, 15617.609559761097, 16318.18409079565, 12727.23636581808, 12950.158239714388, 13036.804447933479, 13089.738205236032, 13590.86409135896, 12461.127721059438, 12570.622881313575, 12841.743165136832, 13096.541621043218, 13217.933910330386], "value": 8282.610719613698, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1505.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 107.0, 110.0, 111.0, 110.0, 111.0, 112.0, 111.0, 111.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 122.0, 158.0, 173.0, 120.0, 145.0, 146.0, 118.0, 169.0, 117.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 163.0, 162.0, 162.0, 172.0, 164.0, 164.0, 161.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 171.0, 76.0, 75.0, 76.0, 76.0, 171.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 143.0, 83.0, 82.0, 83.0, 131.0, 83.0, 84.0, 147.0], "value": 100.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 121.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 150.0, 146.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 56.0, 51.0, 56.0, 52.0, 53.0, 52.0, 52.0, 51.0, 51.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 66.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 73.0, 74.0, 74.0, 73.0, 74.0, 72.0, 79.0, 73.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 125.0, 128.0, 122.0, 130.0, 128.0, 127.0, 131.0, 155.0, 119.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 154.0, 153.0, 150.0, 155.0, 157.0, 149.0, 157.0, 152.0], "value": 153.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 62.0, 70.0, 62.0, 63.0, 61.0, 63.0, 61.0], "value": 63.5, "unit": "score"}]}]} 09:05:37 INFO - Return code: 0 09:05:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:05:37 ERROR - # TBPL SUCCESS # 09:05:37 INFO - Running post-action listener: _resource_record_post_action 09:05:37 INFO - [mozharness: 2016-10-18 16:05:37.190204Z] Finished run-tests step (success) 09:05:37 INFO - Running post-run listener: _resource_record_post_run 09:05:37 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285601792; Read time: 16; Write time: 618456 09:05:37 INFO - TinderboxPrint: CPU usage
13.2% 09:05:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:05:37 INFO - TinderboxPrint: I/O write bytes / time
285,601,792 / 618,456 09:05:37 INFO - TinderboxPrint: CPU idle
8,228.7 (86.8%) 09:05:37 INFO - TinderboxPrint: CPU user
1,191.6 (12.6%) 09:05:37 INFO - TinderboxPrint: Swap in / out
0 / 0 09:05:37 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 71315456; Read time: 0; Write time: 224928 09:05:37 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 213659648; Read time: 0; Write time: 393460 09:05:37 INFO - Running post-run listener: _upload_blobber_files 09:05:37 INFO - Blob upload gear active. 09:05:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:05:37 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 09:05:37 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'] 09:05:37 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 09:05:38 INFO - (blobuploader) - INFO - Open directory for files ... 09:05:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:05:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:05:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:41 INFO - (blobuploader) - INFO - Done attempting. 09:05:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:05:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:05:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:42 INFO - (blobuploader) - INFO - Done attempting. 09:05:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:05:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:05:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:43 INFO - (blobuploader) - INFO - Done attempting. 09:05:43 INFO - (blobuploader) - INFO - Iteration through files over. 09:05:43 INFO - Return code: 0 09:05:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:05:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:05:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f550e133fec81dc790e167a2068b00138d6aec842c18e8e6f1650212ed7545139487771416466eb637052ea10cdbd5763007c938084856f5ed6b076008583653", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e35ea335ef936fc12f6b6487f1d0280968a6c8fc57e942b7737676461209dc252e109a006e7c86d67c6a0515a78bb883e0308025762deded5a883a781320245d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d269dfcbb62027c81f8abaa3e4e1be8373cef63d0d90b7cf8a58edc193247d79e5e9a6730649c4292cd2891ea3d35df53a5fb6475a81174bb3e9a88b8819bdb"} 09:05:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:05:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:05:43 INFO - Contents: 09:05:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f550e133fec81dc790e167a2068b00138d6aec842c18e8e6f1650212ed7545139487771416466eb637052ea10cdbd5763007c938084856f5ed6b076008583653", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e35ea335ef936fc12f6b6487f1d0280968a6c8fc57e942b7737676461209dc252e109a006e7c86d67c6a0515a78bb883e0308025762deded5a883a781320245d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d269dfcbb62027c81f8abaa3e4e1be8373cef63d0d90b7cf8a58edc193247d79e5e9a6730649c4292cd2891ea3d35df53a5fb6475a81174bb3e9a88b8819bdb"} 09:05:43 INFO - Running post-run listener: copy_logs_to_upload_dir 09:05:43 INFO - Copying logs to upload dir... 09:05:43 INFO - mkdir: /builds/slave/test/build/upload/logs 09:05:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.884208 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-10-18 09:05:42.841882) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 09:05:42.848465) ========= 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=745a4373a2a16df560f216e000000264-1476799428.752022-703643501 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/f550e133fec81dc790e167a2068b00138d6aec842c18e8e6f1650212ed7545139487771416466eb637052ea10cdbd5763007c938084856f5ed6b076008583653", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e35ea335ef936fc12f6b6487f1d0280968a6c8fc57e942b7737676461209dc252e109a006e7c86d67c6a0515a78bb883e0308025762deded5a883a781320245d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d269dfcbb62027c81f8abaa3e4e1be8373cef63d0d90b7cf8a58edc193247d79e5e9a6730649c4292cd2891ea3d35df53a5fb6475a81174bb3e9a88b8819bdb"} build_url:https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/PpEETHCzRcmnOPT-6eoOaA/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/f550e133fec81dc790e167a2068b00138d6aec842c18e8e6f1650212ed7545139487771416466eb637052ea10cdbd5763007c938084856f5ed6b076008583653", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e35ea335ef936fc12f6b6487f1d0280968a6c8fc57e942b7737676461209dc252e109a006e7c86d67c6a0515a78bb883e0308025762deded5a883a781320245d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8d269dfcbb62027c81f8abaa3e4e1be8373cef63d0d90b7cf8a58edc193247d79e5e9a6730649c4292cd2891ea3d35df53a5fb6475a81174bb3e9a88b8819bdb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 09:05:42.879799) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 09:05:42.880178) ========= 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=745a4373a2a16df560f216e000000264-1476799428.752022-703643501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 09:05:42.962668) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 09:05:42.963026) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 09:05:42.963384) ========= ========= Total master_lag: 0.24 =========