builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1473094569.7 results: success (0) buildid: 20160905071419 builduid: ef232f6d88d74098976031283512d768 revision: efc8bd58d7c887c7c9c66931a5ae4a126405d0ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.701677) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.702551) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.702918) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.742434) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.742775) ========= 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=17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-05 09:56:10-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.4M=0s 2016-09-05 09:56:10 (42.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080777 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.842710) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.843037) ========= 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=17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015987 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.900551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.900955) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev efc8bd58d7c887c7c9c66931a5ae4a126405d0ac --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-aurora --rev efc8bd58d7c887c7c9c66931a5ae4a126405d0ac --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=17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-05 09:56:10,656 truncating revision to first 12 chars 2016-09-05 09:56:10,656 Setting DEBUG logging. 2016-09-05 09:56:10,656 attempt 1/10 2016-09-05 09:56:10,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/efc8bd58d7c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-05 09:56:10,984 unpacking tar archive at: mozilla-aurora-efc8bd58d7c8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.762795 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:10.679093) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:10.679464) ========= script_repo_revision: efc8bd58d7c887c7c9c66931a5ae4a126405d0ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:10.679956) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:10.680259) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:10.695368) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 0 secs) (at 2016-09-05 09:56:10.695808) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:56:11 INFO - MultiFileLogger online at 20160905 09:56:11 in /builds/slave/test 09:56:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:56:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:56:11 INFO - {'append_to_log': False, 09:56:11 INFO - 'base_work_dir': '/builds/slave/test', 09:56:11 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:56:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:56:11 INFO - 'branch': 'Mozilla-Aurora', 09:56:11 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:11 INFO - 'config_files': ('talos/linux_config.py',), 09:56:11 INFO - 'default_actions': ('clobber', 09:56:11 INFO - 'read-buildbot-config', 09:56:11 INFO - 'download-and-extract', 09:56:11 INFO - 'populate-webroot', 09:56:11 INFO - 'create-virtualenv', 09:56:11 INFO - 'install', 09:56:11 INFO - 'run-tests'), 09:56:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:11 INFO - 'download_minidump_stackwalk': True, 09:56:11 INFO - 'download_symbols': 'ondemand', 09:56:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:11 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:11 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:11 INFO - 'installer_path': 'installer.exe', 09:56:11 INFO - 'log_level': 'info', 09:56:11 INFO - 'log_name': 'talos', 09:56:11 INFO - 'log_to_console': True, 09:56:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:56:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:56:11 INFO - 'opt_config_files': (), 09:56:11 INFO - 'pip_index': False, 09:56:11 INFO - 'sps_profile': False, 09:56:11 INFO - 'sps_profile_interval': 0, 09:56:11 INFO - 'suite': 'dromaeojs', 09:56:11 INFO - 'system_bits': '32', 09:56:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:11 INFO - 'title': 'talos-linux64-ix-009', 09:56:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:11 INFO - 'use_talos_json': True, 09:56:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:56:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:11 INFO - 'work_dir': 'build'} 09:56:11 INFO - [mozharness: 2016-09-05 16:56:11.545579Z] Running clobber step. 09:56:11 INFO - Running pre-action listener: _resource_record_pre_action 09:56:11 INFO - Running main action method: clobber 09:56:11 INFO - rmtree: /builds/slave/test/build 09:56:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:56:12 INFO - Running post-action listener: _resource_record_post_action 09:56:12 INFO - [mozharness: 2016-09-05 16:56:12.513414Z] Finished clobber step (success) 09:56:12 INFO - [mozharness: 2016-09-05 16:56:12.513518Z] Running read-buildbot-config step. 09:56:12 INFO - Running pre-action listener: _resource_record_pre_action 09:56:12 INFO - Running main action method: read_buildbot_config 09:56:12 INFO - Using buildbot properties: 09:56:12 INFO - { 09:56:12 INFO - "project": "", 09:56:12 INFO - "product": "firefox", 09:56:12 INFO - "script_repo_revision": "production", 09:56:12 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:56:12 INFO - "repository": "", 09:56:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:56:12 INFO - "buildid": "20160905071419", 09:56:12 INFO - "pgo_build": "True", 09:56:12 INFO - "basedir": "/builds/slave/test", 09:56:12 INFO - "buildnumber": 736, 09:56:12 INFO - "slavename": "talos-linux64-ix-009", 09:56:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:56:12 INFO - "platform": "ubuntu64_hw", 09:56:12 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:56:12 INFO - "branch": "mozilla-aurora", 09:56:12 INFO - "repo_path": "releases/mozilla-aurora", 09:56:12 INFO - "revision": "efc8bd58d7c887c7c9c66931a5ae4a126405d0ac", 09:56:12 INFO - "stage_platform": "linux64-pgo", 09:56:12 INFO - "builduid": "ef232f6d88d74098976031283512d768", 09:56:12 INFO - "slavebuilddir": "test" 09:56:12 INFO - } 09:56:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 09:56:12 INFO - Running post-action listener: _resource_record_post_action 09:56:12 INFO - [mozharness: 2016-09-05 16:56:12.516029Z] Finished read-buildbot-config step (success) 09:56:12 INFO - [mozharness: 2016-09-05 16:56:12.516117Z] Running download-and-extract step. 09:56:12 INFO - Running pre-action listener: _resource_record_pre_action 09:56:12 INFO - Running main action method: download_and_extract 09:56:12 INFO - mkdir: /builds/slave/test/build/tests 09:56:12 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')]} 09:56:12 INFO - https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:56:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:56:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:56:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:56:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:56:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:56:12 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:56:12 INFO - retry: Failed, sleeping 30 seconds before retrying 09:56:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 09:56:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:56:42 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:56:42 INFO - retry: Failed, sleeping 60 seconds before retrying 09:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 09:57:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:57:42 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:57:42 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 09:57:42 INFO - Caught exception: HTTP Error 404: Not Found 09:57:42 INFO - Caught exception: HTTP Error 404: Not Found 09:57:42 INFO - Caught exception: HTTP Error 404: Not Found 09:57:42 INFO - trying https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:57:42 INFO - Downloading https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:57:43 INFO - Downloaded 1361 bytes. 09:57:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:57:43 INFO - Using the following test package requirements: 09:57:43 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 09:57:43 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:57:43 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:57:43 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:43 INFO - u'jsshell-linux-x86_64.zip'], 09:57:43 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:57:43 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 09:57:43 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:57:43 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:57:43 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:57:43 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:43 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:57:43 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:57: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')]} 09:57:43 INFO - https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:57:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:57:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:57:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:57:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:57:43 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:57:43 INFO - retry: Failed, sleeping 30 seconds before retrying 09:58:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 09:58:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:58:13 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:58:13 INFO - retry: Failed, sleeping 60 seconds before retrying 09:59:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 09:59:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:59:13 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:59:13 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 09:59:13 INFO - Caught exception: HTTP Error 404: Not Found 09:59:13 INFO - Caught exception: HTTP Error 404: Not Found 09:59:13 INFO - Caught exception: HTTP Error 404: Not Found 09:59:13 INFO - trying https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:59:13 INFO - Downloading https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:59:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:59:14 INFO - Downloaded 21771433 bytes. 09:59:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:59:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:59:15 INFO - Return code: 0 09:59:15 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:15 INFO - https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:59:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:59:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:59:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:59:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:59:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:59:15 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:59:15 INFO - retry: Failed, sleeping 30 seconds before retrying 09:59:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 09:59:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 09:59:45 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:59:45 INFO - retry: Failed, sleeping 60 seconds before retrying 10:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 10:00:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:00:45 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:00:45 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 10:00:45 INFO - Caught exception: HTTP Error 404: Not Found 10:00:45 INFO - Caught exception: HTTP Error 404: Not Found 10:00:45 INFO - Caught exception: HTTP Error 404: Not Found 10:00:45 INFO - trying https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:00:45 INFO - Downloading https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 10:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:00:46 INFO - Downloaded 21771433 bytes. 10:00:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:00:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:00:48 INFO - Return code: 0 10:00: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')]} 10:00:48 INFO - https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:00:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:00:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:00:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:00:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:00:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:00:48 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:00:48 INFO - retry: Failed, sleeping 30 seconds before retrying 10:01:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 10:01:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:01:18 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:01:18 INFO - retry: Failed, sleeping 60 seconds before retrying 10:02:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 10:02:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:02:18 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:02:18 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 10:02:18 INFO - Caught exception: HTTP Error 404: Not Found 10:02:18 INFO - Caught exception: HTTP Error 404: Not Found 10:02:18 INFO - Caught exception: HTTP Error 404: Not Found 10:02:18 INFO - trying https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:02:18 INFO - Downloading https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 10:02:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:02:19 INFO - Downloaded 14413740 bytes. 10:02:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:02:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:02:20 INFO - Return code: 0 10:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:02:20 INFO - https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:02:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:02:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:02:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:02:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:02:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:02:20 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:02:20 INFO - retry: Failed, sleeping 30 seconds before retrying 10:02:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 10:02:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:02:50 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:02:50 INFO - retry: Failed, sleeping 60 seconds before retrying 10:03:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 10:03:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:03:50 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:03:50 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 10:03:50 INFO - Caught exception: HTTP Error 404: Not Found 10:03:50 INFO - Caught exception: HTTP Error 404: Not Found 10:03:50 INFO - Caught exception: HTTP Error 404: Not Found 10:03:50 INFO - trying https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:03:50 INFO - Downloading https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:03:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:03:51 INFO - Downloaded 63922179 bytes. 10:03:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:03:51 INFO - mkdir: /builds/slave/test/properties 10:03:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:03:51 INFO - Writing to file /builds/slave/test/properties/build_url 10:03:51 INFO - Contents: 10:03:51 INFO - build_url:https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:03:52 INFO - Running post-action listener: _resource_record_post_action 10:03:52 INFO - Running post-action listener: set_extra_try_arguments 10:03:52 INFO - [mozharness: 2016-09-05 17:03:52.428430Z] Finished download-and-extract step (success) 10:03:52 INFO - [mozharness: 2016-09-05 17:03:52.428664Z] Running populate-webroot step. 10:03:52 INFO - Running pre-action listener: _resource_record_pre_action 10:03:52 INFO - Running main action method: populate_webroot 10:03:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:03:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:03:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:03:52 INFO - '--tppagecycles', 10:03:52 INFO - '7'], 10:03:52 INFO - 'tests': ['tsvgm']}}, 10:03:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:03:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:03:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:03:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:03:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:03:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:03:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:52 INFO - 'talos_options': ['--disable-e10s'], 10:03:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:52 INFO - 'talos_options': ['--disable-e10s'], 10:03:52 INFO - 'tests': ['damp', 'tps']}, 10:03:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:52 INFO - 'tests': ['damp', 'tps']}, 10:03:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:03:52 INFO - 'tests': ['dromaeo_dom']}, 10:03:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:03:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:03:52 INFO - 'tests': ['basic_compositor_video']}, 10:03:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:03:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:03:52 INFO - 'tests': ['a11yr', 10:03:52 INFO - 'ts_paint', 10:03:52 INFO - 'tpaint', 10:03:52 INFO - 'sessionrestore', 10:03:52 INFO - 'sessionrestore_no_auto_restore', 10:03:52 INFO - 'tabpaint']}, 10:03:52 INFO - 'other-e10s': {'tests': ['a11yr', 10:03:52 INFO - 'ts_paint', 10:03:52 INFO - 'tpaint', 10:03:52 INFO - 'sessionrestore', 10:03:52 INFO - 'sessionrestore_no_auto_restore', 10:03:52 INFO - 'tabpaint']}, 10:03:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:03:52 INFO - 'ts_paint', 10:03:52 INFO - 'tpaint', 10:03:52 INFO - 'sessionrestore', 10:03:52 INFO - 'sessionrestore_no_auto_restore', 10:03:52 INFO - 'tabpaint']}, 10:03:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:03:52 INFO - 'ts_paint', 10:03:52 INFO - 'tpaint', 10:03:52 INFO - 'sessionrestore', 10:03:52 INFO - 'sessionrestore_no_auto_restore', 10:03:52 INFO - 'tabpaint']}, 10:03:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:03:52 INFO - 'tests': ['a11yr', 10:03:52 INFO - 'ts_paint', 10:03:52 INFO - 'tpaint', 10:03:52 INFO - 'sessionrestore', 10:03:52 INFO - 'sessionrestore_no_auto_restore', 10:03:52 INFO - 'tabpaint']}, 10:03:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:03:52 INFO - 'tests': ['a11yr', 10:03:52 INFO - 'ts_paint', 10:03:52 INFO - 'tpaint', 10:03:52 INFO - 'sessionrestore', 10:03:52 INFO - 'sessionrestore_no_auto_restore', 10:03:52 INFO - 'tabpaint']}, 10:03:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:03:52 INFO - 'tests': ['tsvgx', 10:03:52 INFO - 'tsvgr_opacity', 10:03:52 INFO - 'tart', 10:03:52 INFO - 'tscrollx', 10:03:52 INFO - 'cart']}, 10:03:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:03:52 INFO - 'tsvgr_opacity', 10:03:52 INFO - 'tart', 10:03:52 INFO - 'tscrollx', 10:03:52 INFO - 'cart']}, 10:03:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:52 INFO - 'talos_options': ['--disable-e10s'], 10:03:52 INFO - 'tests': ['tp5o']}, 10:03:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:52 INFO - 'tests': ['tp5o']}, 10:03:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:52 INFO - 'talos_options': ['--disable-e10s', 10:03:52 INFO - '--xperf_path', 10:03:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:52 INFO - 'tests': ['tp5n']}, 10:03:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:52 INFO - 'talos_options': ['--xperf_path', 10:03:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:52 INFO - 'tests': ['tp5n']}}, 10:03:52 INFO - 'talos.zip': {'path': '', 10:03:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:03:52 INFO - Running post-action listener: _resource_record_post_action 10:03:52 INFO - [mozharness: 2016-09-05 17:03:52.450138Z] Finished populate-webroot step (success) 10:03:52 INFO - [mozharness: 2016-09-05 17:03:52.450227Z] Running create-virtualenv step. 10:03:52 INFO - Running pre-action listener: _resource_record_pre_action 10:03:52 INFO - Running main action method: create_virtualenv 10:03:52 INFO - Creating virtualenv /builds/slave/test/build/venv 10:03:52 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 10:03:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:03:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:03:52 INFO - Using real prefix '/usr' 10:03:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:03:53 INFO - Installing distribute.............................................................................................................................................................................................done. 10:03:54 INFO - Installing pip.................done. 10:03:55 INFO - Return code: 0 10:03:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:03:55 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')]} 10:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:55 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')]} 10:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:55 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 0x1f82030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22413b0>, '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 0x22422b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242740>, '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': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', '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 10:03:55 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 10:03:55 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 10:03:55 INFO - Using env: {'DISPLAY': ':0', 10:03:55 INFO - 'HOME': '/home/cltbld', 10:03:55 INFO - 'LANG': 'en_US.UTF-8', 10:03:55 INFO - 'LANGUAGE': 'en_US:en', 10:03:55 INFO - 'LOGNAME': 'cltbld', 10:03:55 INFO - 'MAIL': '/var/mail/cltbld', 10:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:55 INFO - 'MOZ_NO_REMOTE': '1', 10:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:55 INFO - 'NO_EM_RESTART': '1', 10:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:55 INFO - 'PWD': '/builds/slave/test', 10:03:55 INFO - 'SHELL': '/bin/bash', 10:03:55 INFO - 'SHLVL': '1', 10:03:55 INFO - 'TERM': 'linux', 10:03:55 INFO - 'TMOUT': '86400', 10:03:55 INFO - 'USER': 'cltbld', 10:03:55 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', 10:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:55 INFO - '_': '/tools/buildbot/bin/python'} 10:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:55 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 10:03:55 INFO - Cleaning up... 10:03:55 INFO - Return code: 0 10:03:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:03:55 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')]} 10:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:55 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')]} 10:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:55 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 0x1f82030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22413b0>, '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 0x22422b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242740>, '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': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', '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 10:03:55 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 10:03:55 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 10:03:55 INFO - Using env: {'DISPLAY': ':0', 10:03:55 INFO - 'HOME': '/home/cltbld', 10:03:55 INFO - 'LANG': 'en_US.UTF-8', 10:03:55 INFO - 'LANGUAGE': 'en_US:en', 10:03:55 INFO - 'LOGNAME': 'cltbld', 10:03:55 INFO - 'MAIL': '/var/mail/cltbld', 10:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:55 INFO - 'MOZ_NO_REMOTE': '1', 10:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:55 INFO - 'NO_EM_RESTART': '1', 10:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:55 INFO - 'PWD': '/builds/slave/test', 10:03:55 INFO - 'SHELL': '/bin/bash', 10:03:55 INFO - 'SHLVL': '1', 10:03:55 INFO - 'TERM': 'linux', 10:03:55 INFO - 'TMOUT': '86400', 10:03:55 INFO - 'USER': 'cltbld', 10:03:55 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', 10:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:55 INFO - '_': '/tools/buildbot/bin/python'} 10:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:55 INFO - Downloading/unpacking psutil>=3.1.1 10:03:55 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 10:03:55 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 10:03:55 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 10:03:55 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 10:03:55 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 10:03:55 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 10:03:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:03:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:03:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:03:57 INFO - Installing collected packages: psutil 10:03:57 INFO - Running setup.py install for psutil 10:03:57 INFO - building 'psutil._psutil_linux' extension 10:03:57 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 10:03:57 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 10:03:57 INFO - building 'psutil._psutil_posix' extension 10:03:57 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 10:03:57 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 10:03:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:03:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:03:57 INFO - Successfully installed psutil 10:03:57 INFO - Cleaning up... 10:03:57 INFO - Return code: 0 10:03:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:03:57 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')]} 10:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:57 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')]} 10:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:57 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 0x1f82030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22413b0>, '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 0x22422b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242740>, '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': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', '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 10:03:57 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 10:03:57 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 10:03:57 INFO - Using env: {'DISPLAY': ':0', 10:03:57 INFO - 'HOME': '/home/cltbld', 10:03:57 INFO - 'LANG': 'en_US.UTF-8', 10:03:57 INFO - 'LANGUAGE': 'en_US:en', 10:03:57 INFO - 'LOGNAME': 'cltbld', 10:03:57 INFO - 'MAIL': '/var/mail/cltbld', 10:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:57 INFO - 'MOZ_NO_REMOTE': '1', 10:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:57 INFO - 'NO_EM_RESTART': '1', 10:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:57 INFO - 'PWD': '/builds/slave/test', 10:03:57 INFO - 'SHELL': '/bin/bash', 10:03:57 INFO - 'SHLVL': '1', 10:03:57 INFO - 'TERM': 'linux', 10:03:57 INFO - 'TMOUT': '86400', 10:03:57 INFO - 'USER': 'cltbld', 10:03:57 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', 10:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:57 INFO - '_': '/tools/buildbot/bin/python'} 10:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:04:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:04:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:04:00 INFO - Installing collected packages: mozsystemmonitor 10:04:00 INFO - Running setup.py install for mozsystemmonitor 10:04:00 INFO - Successfully installed mozsystemmonitor 10:04:00 INFO - Cleaning up... 10:04:00 INFO - Return code: 0 10:04:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f82030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22413b0>, '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 0x22422b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242740>, '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': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', '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 10:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:04:00 INFO - Using env: {'DISPLAY': ':0', 10:04:00 INFO - 'HOME': '/home/cltbld', 10:04:00 INFO - 'LANG': 'en_US.UTF-8', 10:04:00 INFO - 'LANGUAGE': 'en_US:en', 10:04:00 INFO - 'LOGNAME': 'cltbld', 10:04:00 INFO - 'MAIL': '/var/mail/cltbld', 10:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:00 INFO - 'MOZ_NO_REMOTE': '1', 10:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:00 INFO - 'NO_EM_RESTART': '1', 10:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:00 INFO - 'PWD': '/builds/slave/test', 10:04:00 INFO - 'SHELL': '/bin/bash', 10:04:00 INFO - 'SHLVL': '1', 10:04:00 INFO - 'TERM': 'linux', 10:04:00 INFO - 'TMOUT': '86400', 10:04:00 INFO - 'USER': 'cltbld', 10:04:00 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', 10:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:00 INFO - '_': '/tools/buildbot/bin/python'} 10:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:00 INFO - Downloading/unpacking jsonschema==2.5.1 10:04:00 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 10:04:00 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 10:04:00 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 10:04:00 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 10:04:00 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 10:04:00 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 10:04:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:04:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:04:02 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 10:04:02 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 10:04:02 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 10:04:02 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 10:04:02 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 10:04:02 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 10:04:02 INFO - Downloading functools32-3.2.3-2.tar.gz 10:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:04:02 INFO - warning: no files found matching '*.txt' 10:04:02 INFO - no previously-included directories found matching 'build' 10:04:02 INFO - no previously-included directories found matching 'dist' 10:04:02 INFO - no previously-included directories found matching '.git*' 10:04:02 INFO - Installing collected packages: jsonschema, functools32 10:04:02 INFO - Running setup.py install for functools32 10:04:02 INFO - warning: no files found matching '*.txt' 10:04:02 INFO - no previously-included directories found matching 'build' 10:04:02 INFO - no previously-included directories found matching 'dist' 10:04:02 INFO - no previously-included directories found matching '.git*' 10:04:02 INFO - Successfully installed jsonschema functools32 10:04:02 INFO - Cleaning up... 10:04:02 INFO - Return code: 0 10:04:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:04:02 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')]} 10:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:02 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')]} 10:04:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:02 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 0x1f82030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22413b0>, '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 0x22422b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242740>, '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': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', '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 10:04:02 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 10:04:02 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 10:04:02 INFO - Using env: {'DISPLAY': ':0', 10:04:02 INFO - 'HOME': '/home/cltbld', 10:04:02 INFO - 'LANG': 'en_US.UTF-8', 10:04:02 INFO - 'LANGUAGE': 'en_US:en', 10:04:02 INFO - 'LOGNAME': 'cltbld', 10:04:02 INFO - 'MAIL': '/var/mail/cltbld', 10:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:02 INFO - 'MOZ_NO_REMOTE': '1', 10:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:02 INFO - 'NO_EM_RESTART': '1', 10:04:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:02 INFO - 'PWD': '/builds/slave/test', 10:04:02 INFO - 'SHELL': '/bin/bash', 10:04:02 INFO - 'SHLVL': '1', 10:04:02 INFO - 'TERM': 'linux', 10:04:02 INFO - 'TMOUT': '86400', 10:04:02 INFO - 'USER': 'cltbld', 10:04:02 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', 10:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:02 INFO - '_': '/tools/buildbot/bin/python'} 10:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:04:03 INFO - Cleaning up... 10:04:03 INFO - Return code: 0 10:04:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:04: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')]} 10:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04: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')]} 10:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:03 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 0x1f82030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22413b0>, '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 0x22422b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242740>, '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': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', '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 10:04:03 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 10:04:03 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 10:04:03 INFO - Using env: {'DISPLAY': ':0', 10:04:03 INFO - 'HOME': '/home/cltbld', 10:04:03 INFO - 'LANG': 'en_US.UTF-8', 10:04:03 INFO - 'LANGUAGE': 'en_US:en', 10:04:03 INFO - 'LOGNAME': 'cltbld', 10:04:03 INFO - 'MAIL': '/var/mail/cltbld', 10:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:03 INFO - 'MOZ_NO_REMOTE': '1', 10:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:03 INFO - 'NO_EM_RESTART': '1', 10:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:03 INFO - 'PWD': '/builds/slave/test', 10:04:03 INFO - 'SHELL': '/bin/bash', 10:04:03 INFO - 'SHLVL': '1', 10:04:03 INFO - 'TERM': 'linux', 10:04:03 INFO - 'TMOUT': '86400', 10:04:03 INFO - 'USER': 'cltbld', 10:04:03 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', 10:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:03 INFO - '_': '/tools/buildbot/bin/python'} 10:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:03 INFO - Downloading/unpacking blobuploader==1.2.4 10:04:03 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 10:04:03 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 10:04:03 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 10:04:03 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 10:04:03 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 10:04:03 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 10:04:05 INFO - Downloading blobuploader-1.2.4.tar.gz 10:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:04:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:04:05 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 10:04:05 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 10:04:05 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 10:04:05 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 10:04:05 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 10:04:05 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 10:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:04:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:04:05 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 10:04:05 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 10:04:05 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 10:04:05 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 10:04:05 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 10:04:05 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 10:04:05 INFO - Downloading docopt-0.6.1.tar.gz 10:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:04:05 INFO - Installing collected packages: blobuploader, requests, docopt 10:04:05 INFO - Running setup.py install for blobuploader 10:04:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:04:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:04:05 INFO - Running setup.py install for requests 10:04:06 INFO - Running setup.py install for docopt 10:04:06 INFO - Successfully installed blobuploader requests docopt 10:04:06 INFO - Cleaning up... 10:04:06 INFO - Return code: 0 10:04:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:06 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 0x1f82030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22413b0>, '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 0x22422b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242740>, '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': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', '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 10:04:06 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 10:04:06 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 10:04:06 INFO - Using env: {'DISPLAY': ':0', 10:04:06 INFO - 'HOME': '/home/cltbld', 10:04:06 INFO - 'LANG': 'en_US.UTF-8', 10:04:06 INFO - 'LANGUAGE': 'en_US:en', 10:04:06 INFO - 'LOGNAME': 'cltbld', 10:04:06 INFO - 'MAIL': '/var/mail/cltbld', 10:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:06 INFO - 'MOZ_NO_REMOTE': '1', 10:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:06 INFO - 'NO_EM_RESTART': '1', 10:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:06 INFO - 'PWD': '/builds/slave/test', 10:04:06 INFO - 'SHELL': '/bin/bash', 10:04:06 INFO - 'SHLVL': '1', 10:04:06 INFO - 'TERM': 'linux', 10:04:06 INFO - 'TMOUT': '86400', 10:04:06 INFO - 'USER': 'cltbld', 10:04:06 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', 10:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:06 INFO - '_': '/tools/buildbot/bin/python'} 10:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:06 INFO - Running setup.py (path:/tmp/pip-RUx2i6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:06 INFO - Running setup.py (path:/tmp/pip-2rT06p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:06 INFO - Running setup.py (path:/tmp/pip-XcSNZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:06 INFO - Running setup.py (path:/tmp/pip-J9OVVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:06 INFO - Running setup.py (path:/tmp/pip-QSzNzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:07 INFO - Running setup.py (path:/tmp/pip-Hg3yf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:07 INFO - Running setup.py (path:/tmp/pip-V54jLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:07 INFO - Running setup.py (path:/tmp/pip-GX5v5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:07 INFO - Running setup.py (path:/tmp/pip-K5YOqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:07 INFO - Running setup.py (path:/tmp/pip-XKg5XS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:07 INFO - Running setup.py (path:/tmp/pip-5ym431-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:07 INFO - Running setup.py (path:/tmp/pip-lSqllt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:04:07 INFO - Running setup.py (path:/tmp/pip-a9HrBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:04:07 INFO - Running setup.py (path:/tmp/pip-4I2zvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:07 INFO - Running setup.py (path:/tmp/pip-ewSDu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:07 INFO - Running setup.py (path:/tmp/pip-CuFYxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:07 INFO - Running setup.py (path:/tmp/pip-AYFOLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:04:07 INFO - Running setup.py install for manifestparser 10:04:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:04:08 INFO - Running setup.py install for mozcrash 10:04:08 INFO - Running setup.py install for mozdebug 10:04:08 INFO - Running setup.py install for mozdevice 10:04:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:04:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:04:08 INFO - Running setup.py install for mozfile 10:04:08 INFO - Running setup.py install for mozhttpd 10:04:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:04:08 INFO - Running setup.py install for mozinfo 10:04:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:04:08 INFO - Running setup.py install for mozInstall 10:04:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:04:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:04:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:04:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:04:08 INFO - Running setup.py install for mozleak 10:04:08 INFO - Running setup.py install for mozlog 10:04:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:04:08 INFO - Running setup.py install for moznetwork 10:04:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:04:09 INFO - Running setup.py install for mozprocess 10:04:09 INFO - Running setup.py install for mozprofile 10:04:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:04:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:04:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:04:09 INFO - Running setup.py install for mozrunner 10:04:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:04:09 INFO - Running setup.py install for mozscreenshot 10:04:09 INFO - Running setup.py install for moztest 10:04:09 INFO - Running setup.py install for mozversion 10:04:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:04:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:04:09 INFO - Cleaning up... 10:04:09 INFO - Return code: 0 10:04:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:09 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')]} 10:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:09 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')]} 10:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:09 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 0x1f82030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22413b0>, '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 0x22422b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242740>, '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': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', '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 10:04:09 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 10:04:09 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 10:04:09 INFO - Using env: {'DISPLAY': ':0', 10:04:09 INFO - 'HOME': '/home/cltbld', 10:04:09 INFO - 'LANG': 'en_US.UTF-8', 10:04:09 INFO - 'LANGUAGE': 'en_US:en', 10:04:09 INFO - 'LOGNAME': 'cltbld', 10:04:09 INFO - 'MAIL': '/var/mail/cltbld', 10:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:09 INFO - 'MOZ_NO_REMOTE': '1', 10:04:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:09 INFO - 'NO_EM_RESTART': '1', 10:04:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:09 INFO - 'PWD': '/builds/slave/test', 10:04:09 INFO - 'SHELL': '/bin/bash', 10:04:09 INFO - 'SHLVL': '1', 10:04:09 INFO - 'TERM': 'linux', 10:04:09 INFO - 'TMOUT': '86400', 10:04:09 INFO - 'USER': 'cltbld', 10:04:09 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', 10:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:09 INFO - '_': '/tools/buildbot/bin/python'} 10:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:04:09 INFO - Running setup.py (path:/tmp/pip-CYfRds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:10 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)) 10:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:10 INFO - Running setup.py (path:/tmp/pip-NYDp7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:10 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)) 10:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:10 INFO - Running setup.py (path:/tmp/pip-YIaxOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:10 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)) 10:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:10 INFO - Running setup.py (path:/tmp/pip-z2hsEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:10 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)) 10:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:10 INFO - Running setup.py (path:/tmp/pip-q1IY_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:10 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)) 10:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:10 INFO - Running setup.py (path:/tmp/pip-SaDhT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:10 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)) 10:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:10 INFO - Running setup.py (path:/tmp/pip-not9lP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:10 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)) 10:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:10 INFO - Running setup.py (path:/tmp/pip-xCPWyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:10 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)) 10:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:10 INFO - Running setup.py (path:/tmp/pip-WKDs4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:10 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)) 10:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:10 INFO - Running setup.py (path:/tmp/pip-E0TvzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:10 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)) 10:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:10 INFO - Running setup.py (path:/tmp/pip-Kza4nN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:10 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)) 10:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:10 INFO - Running setup.py (path:/tmp/pip-KoQC9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:04:10 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)) 10:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:04:10 INFO - Running setup.py (path:/tmp/pip-k93yBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:04:10 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)) 10:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:04:10 INFO - Running setup.py (path:/tmp/pip-jDDu0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:04:10 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)) 10:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:10 INFO - Running setup.py (path:/tmp/pip-IHoXxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:11 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)) 10:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:11 INFO - Running setup.py (path:/tmp/pip-_15iWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:11 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)) 10:04:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:11 INFO - Running setup.py (path:/tmp/pip-ti41vL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:11 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)) 10:04:11 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)) 10:04:11 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)) 10:04:11 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)) 10:04:11 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)) 10:04:11 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)) 10:04:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:04:11 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 10:04:11 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 10:04:11 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 10:04:11 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 10:04:11 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 10:04:11 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 10:04:13 INFO - Downloading blessings-1.6.tar.gz 10:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:04:13 INFO - Installing collected packages: blessings 10:04:13 INFO - Running setup.py install for blessings 10:04:13 INFO - Successfully installed blessings 10:04:13 INFO - Cleaning up... 10:04:13 INFO - Return code: 0 10:04:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:04:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:04:13 INFO - Reading from file tmpfile_stdout 10:04:13 INFO - Current package versions: 10:04:13 INFO - argparse == 1.2.1 10:04:13 INFO - blessings == 1.6 10:04:13 INFO - blobuploader == 1.2.4 10:04:13 INFO - docopt == 0.6.1 10:04:13 INFO - functools32 == 3.2.3-2 10:04:13 INFO - jsonschema == 2.5.1 10:04:13 INFO - manifestparser == 1.1 10:04:13 INFO - mozInstall == 1.12 10:04:13 INFO - mozcrash == 0.17 10:04:13 INFO - mozdebug == 0.1 10:04:13 INFO - mozdevice == 0.48 10:04:13 INFO - mozfile == 1.2 10:04:13 INFO - mozhttpd == 0.7 10:04:13 INFO - mozinfo == 0.9 10:04:13 INFO - mozleak == 0.1 10:04:13 INFO - mozlog == 3.3 10:04:13 INFO - moznetwork == 0.27 10:04:13 INFO - mozprocess == 0.23 10:04:13 INFO - mozprofile == 0.28 10:04:13 INFO - mozrunner == 6.12 10:04:13 INFO - mozscreenshot == 0.1 10:04:13 INFO - mozsystemmonitor == 0.3 10:04:13 INFO - moztest == 0.7 10:04:13 INFO - mozversion == 1.4 10:04:13 INFO - psutil == 3.1.1 10:04:13 INFO - requests == 1.2.3 10:04:13 INFO - wsgiref == 0.1.2 10:04:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:13 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')]} 10:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:13 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')]} 10:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:13 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 0x1f82030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22413b0>, '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 0x22422b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242740>, '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': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', '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 10:04:13 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 10:04:13 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 10:04:13 INFO - Using env: {'DISPLAY': ':0', 10:04:13 INFO - 'HOME': '/home/cltbld', 10:04:13 INFO - 'LANG': 'en_US.UTF-8', 10:04:13 INFO - 'LANGUAGE': 'en_US:en', 10:04:13 INFO - 'LOGNAME': 'cltbld', 10:04:13 INFO - 'MAIL': '/var/mail/cltbld', 10:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:13 INFO - 'MOZ_NO_REMOTE': '1', 10:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:13 INFO - 'NO_EM_RESTART': '1', 10:04:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:13 INFO - 'PWD': '/builds/slave/test', 10:04:13 INFO - 'SHELL': '/bin/bash', 10:04:13 INFO - 'SHLVL': '1', 10:04:13 INFO - 'TERM': 'linux', 10:04:13 INFO - 'TMOUT': '86400', 10:04:13 INFO - 'USER': 'cltbld', 10:04:13 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', 10:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:13 INFO - '_': '/tools/buildbot/bin/python'} 10:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:13 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)) 10:04:13 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)) 10:04:13 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)) 10:04:13 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)) 10:04:13 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)) 10:04:13 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)) 10:04:13 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)) 10:04:13 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)) 10:04:13 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)) 10:04:13 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)) 10:04:13 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)) 10:04:13 INFO - Cleaning up... 10:04:13 INFO - Return code: 0 10:04:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:04:13 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')]} 10:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:13 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')]} 10:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:13 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 0x1f82030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2243180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22413b0>, '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 0x22422b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242740>, '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': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', '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 10:04:13 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 10:04:13 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 10:04:13 INFO - Using env: {'DISPLAY': ':0', 10:04:13 INFO - 'HOME': '/home/cltbld', 10:04:13 INFO - 'LANG': 'en_US.UTF-8', 10:04:13 INFO - 'LANGUAGE': 'en_US:en', 10:04:13 INFO - 'LOGNAME': 'cltbld', 10:04:13 INFO - 'MAIL': '/var/mail/cltbld', 10:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:13 INFO - 'MOZ_NO_REMOTE': '1', 10:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:13 INFO - 'NO_EM_RESTART': '1', 10:04:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:13 INFO - 'PWD': '/builds/slave/test', 10:04:13 INFO - 'SHELL': '/bin/bash', 10:04:13 INFO - 'SHLVL': '1', 10:04:13 INFO - 'TERM': 'linux', 10:04:13 INFO - 'TMOUT': '86400', 10:04:13 INFO - 'USER': 'cltbld', 10:04:13 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', 10:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:13 INFO - '_': '/tools/buildbot/bin/python'} 10:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:04:13 INFO - Cleaning up... 10:04:13 INFO - Return code: 0 10:04:13 INFO - Running post-action listener: _resource_record_post_action 10:04:13 INFO - Running post-action listener: _start_resource_monitoring 10:04:13 INFO - Starting resource monitoring. 10:04:13 INFO - [mozharness: 2016-09-05 17:04:13.986266Z] Finished create-virtualenv step (success) 10:04:13 INFO - [mozharness: 2016-09-05 17:04:13.986737Z] Running install step. 10:04:13 INFO - Running pre-action listener: _resource_record_pre_action 10:04:13 INFO - Running main action method: install 10:04:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:04:14 INFO - Reading from file tmpfile_stdout 10:04:14 INFO - Detecting whether we're running mozinstall >=1.0... 10:04:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:04:14 INFO - Reading from file tmpfile_stdout 10:04:14 INFO - Output received: 10:04:14 INFO - Usage: mozinstall [options] installer 10:04:14 INFO - Options: 10:04:14 INFO - -h, --help show this help message and exit 10:04:14 INFO - -d DEST, --destination=DEST 10:04:14 INFO - Directory to install application into. [default: 10:04:14 INFO - "/builds/slave/test"] 10:04:14 INFO - --app=APP Application being installed. [default: firefox] 10:04:14 INFO - mkdir: /builds/slave/test/build/application 10:04:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:04:31 INFO - Reading from file tmpfile_stdout 10:04:31 INFO - Output received: 10:04:31 INFO - /builds/slave/test/build/application/firefox/firefox 10:04:31 INFO - Running post-action listener: _resource_record_post_action 10:04:31 INFO - [mozharness: 2016-09-05 17:04:31.163939Z] Finished install step (success) 10:04:31 INFO - [mozharness: 2016-09-05 17:04:31.164217Z] Running run-tests step. 10:04:31 INFO - Running pre-action listener: _resource_record_pre_action 10:04:31 INFO - Running main action method: run_tests 10:04:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:04:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:04:31 INFO - Python 2.7.3 10:04:31 INFO - Return code: 0 10:04:31 INFO - grabbing minidump binary from tooltool 10:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:04:31 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 0x22413b0>, '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 0x22422b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2242740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:04:31 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 10:04:31 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 10:04:31 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 10:04:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:04:31 INFO - Return code: 0 10:04:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:04:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:04:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:04:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:04:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:04:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:04:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:04:31 INFO - Using env: {'DISPLAY': ':0', 10:04:31 INFO - 'HOME': '/home/cltbld', 10:04:31 INFO - 'LANG': 'en_US.UTF-8', 10:04:31 INFO - 'LANGUAGE': 'en_US:en', 10:04:31 INFO - 'LOGNAME': 'cltbld', 10:04:31 INFO - 'MAIL': '/var/mail/cltbld', 10:04:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:04:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:31 INFO - 'MOZ_NO_REMOTE': '1', 10:04:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:04:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:31 INFO - 'NO_EM_RESTART': '1', 10:04:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:31 INFO - 'PWD': '/builds/slave/test', 10:04:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:04:31 INFO - 'SHELL': '/bin/bash', 10:04:31 INFO - 'SHLVL': '1', 10:04:31 INFO - 'TERM': 'linux', 10:04:31 INFO - 'TMOUT': '86400', 10:04:31 INFO - 'USER': 'cltbld', 10:04:31 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352', 10:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:31 INFO - '_': '/tools/buildbot/bin/python'} 10:04:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:04:31 INFO - mozversion application_buildid: 20160905071419 10:04:31 INFO - mozversion application_changeset: efc8bd58d7c887c7c9c66931a5ae4a126405d0ac 10:04:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:04:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:04:31 INFO - mozversion application_name: Firefox 10:04:31 INFO - mozversion application_remotingname: firefox-dev 10:04:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:04:31 INFO - mozversion application_vendor: Mozilla 10:04:31 INFO - mozversion application_version: 50.0a2 10:04:31 INFO - mozversion platform_buildid: 20160905071419 10:04:31 INFO - mozversion platform_changeset: efc8bd58d7c887c7c9c66931a5ae4a126405d0ac 10:04:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:04:31 INFO - mozversion platform_version: 50.0a2 10:04:31 INFO - using testdate: 1473095071 10:04:31 INFO - actual date: 1473095071 10:04:31 INFO - starting webserver on 'localhost:51163' 10:04:31 INFO - SUITE-START | Running 2 tests 10:04:31 INFO - TEST-START | dromaeo_css 10:04:31 INFO - operating with platform_type : linux_ 10:04:31 INFO - Initialising browser for dromaeo_css test... 10:04:31 INFO - TEST-INFO | started process 324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplG2JC3/profile http://localhost:51163/getInfo.html) 10:04:35 INFO - PROCESS | 324 | __metrics Screen width/height:1600/1200 10:04:35 INFO - PROCESS | 324 | colorDepth:24 10:04:35 INFO - PROCESS | 324 | Browser inner width/height: 1024/697 10:04:35 INFO - PROCESS | 324 | __metrics 10:04:36 INFO - PROCESS | 324 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:04:36 INFO - PROCESS | 324 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:04:37 INFO - TEST-INFO | 324: exit 0 10:04:37 INFO - Browser initialized. 10:04:37 INFO - Running cycle 1/1 for dromaeo_css test... 10:04:37 INFO - TEST-INFO | started process 413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplG2JC3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:04:49 INFO - PROCESS | 413 | RSS: Main: 144855040 10:04:49 INFO - PROCESS | 413 | 10:05:40 INFO - PROCESS | 413 | 1473095140134 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] 10:07:49 INFO - PROCESS | 413 | Cycle 1(1): loaded http://localhost:51163/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51163/tests/dromaeo/cssquery-ext.html) 10:07:50 INFO - PROCESS | 413 | RSS: Main: 276377600 10:07:50 INFO - PROCESS | 413 | 10:10:52 INFO - PROCESS | 413 | Cycle 1(1): loaded http://localhost:51163/tests/dromaeo/cssquery-ext.html (next: http://localhost:51163/tests/dromaeo/cssquery-jquery.html) 10:10:53 INFO - PROCESS | 413 | RSS: Main: 232927232 10:10:53 INFO - PROCESS | 413 | 10:13:55 INFO - PROCESS | 413 | Cycle 1(1): loaded http://localhost:51163/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51163/tests/dromaeo/cssquery-mootools.html) 10:13:56 INFO - PROCESS | 413 | RSS: Main: 226897920 10:13:56 INFO - PROCESS | 413 | 10:16:58 INFO - PROCESS | 413 | Cycle 1(1): loaded http://localhost:51163/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51163/tests/dromaeo/cssquery-prototype.html) 10:16:58 INFO - PROCESS | 413 | RSS: Main: 224382976 10:16:58 INFO - PROCESS | 413 | 10:20:01 INFO - PROCESS | 413 | Cycle 1(1): loaded http://localhost:51163/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51163/tests/dromaeo/cssquery-yui.html) 10:20:01 INFO - PROCESS | 413 | RSS: Main: 179363840 10:20:01 INFO - PROCESS | 413 | 10:23:04 INFO - PROCESS | 413 | Cycle 1(1): loaded http://localhost:51163/tests/dromaeo/cssquery-yui.html (next: http://localhost:51163/tests/dromaeo/cssquery-dojo.html) 10:23:04 INFO - PROCESS | 413 | RSS: Main: 261394432 10:23:04 INFO - PROCESS | 413 | 10:23:04 INFO - PROCESS | 413 | __start_tp_report 10:23:04 INFO - PROCESS | 413 | _x_x_mozilla_page_load 10:23:04 INFO - PROCESS | 413 | _x_x_mozilla_page_load_details 10:23:04 INFO - PROCESS | 413 | |i|pagename|runs| 10:23:04 INFO - PROCESS | 413 | |0;dojo.html;3228.3866065447564;3248.8375581220935;3255.088575198945;3269.7057264846167;3269.7711160218796;5628.127640215768;5745.540356771458;5785.768569257235;5793.6234144780665;5801.303843538776;5712.742926568304;5780.450857168573;5791.942080579193;5793.4785869271755;5805.3323867755225;5085.364329458817;5169.508896654812;5229.79080836767;5247.239150323201;5300.0459917214885;5248.107821670306;5293.867653308679;5298.841034768963;5305.7877684892555;5311.203319502067;5110.156824124015;5162.328897243353;5192;5211.973940130313;5216.921746173811;5306.177542480922;5307.071262529081;5312.362516498007;5312.893742125175;5340.813071542516;5068.974655126738;5131.281620573122;5192.714400707997;5202.583793296565;5202.661826981234;5630.746616402272;5640.661560306354;5679.602427830054;5680.801171958961;5683.062294721366;6119.571629985903;6125.908111378333;6126.387361263883;6127;6130.203073600448;5940.61386009908;6078.574499785017;6097;6142.447179753844;6149.938500614981;5790.942090579082;5802.564807639402;5809.24479817621;5814.30228372598;5822.0684690449325;6308.3060863305;6308.369163083655;6319.652419116901;6322.462590679844;6322.9051564226575;5793.304803423532;5865.2961644602065;5944.286685597669;5958.136070269787;6036.879262414727;6075.665838378932;6076.574639775262;6086.839306843172;6092.868393245213;6136;5983;6028.819135425944;6036.637801731822;6037.18498002764;6046.637201767908;5930.991731405671;5981.102834574762;5989.8203053908455;6021.307549631849;6034.034554471264;4604.102200070954;4637.768111594407;4665.393498845128;4676.8129274828625;4680.134175177603;4141.627253547195;4141.91716165675;4156.168766246763;4165.479315085614;4177.519585247735;5651.067573850269;5737.110747834093;5759.395263497272;5852.882942341129;5853.502452291517;6124.533510047256;6135.32453530862;6135.349157687728;6137.009281402767;6147.200863887755;5788.102844059177;5847.912281315784;5848.707564621752;5853.09277062056;5871.853203669943;4871.196252618278;4966.279889416014;4994.675346102492;5115.360579927509;5121.001404726043;6294.685265736694;6316.62100273985;6317.052442133717;6317.399847014526;6319.55763096588;6012;6054.757809687563;6058.909116363347;6065;6066.302375226729;6121.2700689216845;6186.072089186478;6255.530835187288;6295.307516173126;6306.054091886253;5989.610675306091;5997.760089596367;6017.879642407215;6022.8255490180745;6027.60820546663;6074.787382441594;6076.756929722762;6080.969595151996;6085.300190478151;6088.4215999479975;5774.105013722879;5867.237259156454;5889.146073819186;5911.733971971357;5993.520518358434;5889.528837692888;5945.048792193401;5947.256592925884;5980.5514586405325;5984.491318237999;5937.406259374028;5946.0189068803165;5946.643201407929;5947.643141411356;5948.702564871825;5826.912596311144;5932.406759324033;5950.3454619992635;5988.790392336247;6035.155078289131;5865.090910908816;5888.087346461305;5890.293164820249;5902.557308201816;5919.289685237627 10:23:04 INFO - PROCESS | 413 | |1;ext.html;603.7192705391992;627.1063734178795;644.687326646576;663.1577896071989;666.450178602653;35690.8215458923;47071.764641176786;47951.760241198834;47967.760161199236;48004.51995480048;48901.75549122258;48941.51058489414;49315.75342123285;49367.50632493683;49377.259341109915;8530.23227909488;9132.041135680758;9266.768330791716;9276.907230927673;9277.443353398783;10864.61973830916;11143.777124457505;11154.609588664398;11397.601083962063;11420.428978551081;11278.887211127907;11382.146339024606;11388.145889058313;11390.088792896548;11392.487338069765;10863.076638485738;10982.615608453745;11018.559257629686;11031.338119712762;11040.503177356957;10918.07196388308;10952.178586605956;10955.890441095646;11037;11051.226414151013;45856.7707161462;46331.768341158415;46544.30183547249;46640;46762.298565521545;3755.962440375589;3832.827522761482;3833.7891415972113;3838.4434257032854;3885.358915778893;36132.45801312956;36380.81809590961;36644.63355366439;38230.42654360187;38299.425508617394;4716.95283047172;4814.6870453420415;4834.468208497097;4846.418429788413;4906.950930490685;375073;376480;378351.108244457;379335;382629.0868545667;38860.2227955445;40183;67042.66478667673;67525;67692.3230767686;41670.37494437586;41857.581424185366;41874.37188442176;41964.37053444201;41968.580314197075;17645.647087058445;17889.28442862297;17893.821061789477;17898;17915.37296194627;11892.04863610909;13722.45110195601;13807;14715.92642036783;14967.326470308863;9414.858777118348;9435.103665151799;9472.384295020802;9494.240460763122;9507.57215925285;3471.2363280078343;3519.4896739973074;3524.559430071241;3535.356044534759;3537.752357335013;1082.8429877667852;1119.6361182615683;1144.187626784992;1158.9652310430702;1188.4711303469874;35784.46323305152;36471.81764091163;36637.267254654755;36670;36720;1165.7085728567858;1169.5088063013554;1273.1088238233274;1296.8119622654663;1307.60118163959;18827.623447530972;18837.717434238497;18845.528861778566;19004.80995190058;19127.33054343091;587170;587571;592256;593820;595144;44021.33967990483;44063.11873762571;44257.778711106235;44399.55600443954;44488.3326750099;1349;1416.3697154766237;1443.8737784528084;1449.8405175430694;1479.977800332996;34892;37604.81197593995;38171.23657526779;38208.23583528258;38390.808045959595;57586.424135758105;58105;58122.12816807836;58224.4177558236;58296;328579;328837;328886;329882;330625;31251.218719532193;32042.359152816345;32322.191945201557;33595;33602.49596256107;54379;54804;55089;55111.173332399245;55149;44093.559064408946;45415.318770219135;45918;47168.528314716415;47399.52600473951;42151.7892410536;45335;46851.765741171075;47710.522894770605;47906;46782.298265526726;46895;47074.29388559243;47306;47783.28325075196;38830.80584597172;40682.1863562733;40800.89694107394;41250.58749412467;41944.370834438116;30116;30210.54684179695;30601.540976885808;30909.227269318446;31033.069007929796 10:23:04 INFO - PROCESS | 413 | |2;jquery.html;384.68455866189737;406.5629448343032;409.96310332070107;410.55249777742256;424.71119638645706;16619.750703739453;20343.59312813743;20789.896050519765;21012.159513619456;22027.449313767163;21581.136754529838;21664.2417515387;21714;21739.565208695854;21786.673199902016;5684.289463817013;6042.999999999978;6064.4541991220785;6080.2399700037495;6086.117512960618;4323;5963.761449542035;5993.1909192259145;5997.130416089664;6452.7418903243815;6663;6799.320067993211;6811.897821532681;6813.591184528919;6815.48883833712;6638.767643132467;6650.401463868275;6651.2018557773135;6667.033280174372;6769.729210831585;5719.28508936383;5851.678157701324;5882;5893.911591326134;5931.228940237785;20287.492812679655;20296.289629863033;20301.796982030286;22684.65973010406;23281.534369312518;2435.0503303711566;2452.497238066192;2464.9014039438403;2700.933131413081;2827.971720282812;10600.840987385196;10713.625023124154;10717.9464102679;10851.67444976652;10915.072218861405;1965.8132477414765;1972.5364539333245;2020.8484363672783;2037.8675386100003;2092.717483139772;68562.65718671425;78313.60843195747;78855.60572197102;86709.56645216733;90993.54503227508;11144.108471322275;11231.382273974847;11432.828507572392;11440.713982150513;11483.770324593628;15917.52247432579;15941.282642281125;15957.920210398874;15969.041857488355;15971.680566388608;8031.7992050198045;8688.261497772633;9089;9159.90840091604;9190.356675032817;8517.701880434155;8728.476291422536;8770.780730481662;8854.38019338653;9180.311476639145;4770.570648641639;4845;4863.732494712754;4946.35697359341;4965.975170124127;1964.6856502959458;1984.3154111831395;2027.4120505053663;2040.9795902041087;2046.2326627514683;959.8320293948531;1009.3086235928413;1013.200498132005;1067.140951534007;1075.5590208014676;20239.595208095754;20689.89655051715;20971.685424718642;21020.894895525424;21409.78590214109;1055.0346433013706;1080.3140006096028;1106.9944650276698;1108.2020944919645;1125.6172901213627;11236.381998990135;11547.133964952494;11771.23486973344;11797.115216358636;11889.940550297366;579976;582145;582349;595033;599562;86298;90792;98472.50763746136;100543;100615;1042.760165162017;1045.5765415006933;1086.41333679812;1088.4013792414141;1089.4389389464432;18657.346992855186;18683.906580467556;18890.905545472186;18973.810261897757;19226.654591955852;42961.78519107385;43234.56765432305;43823.780881095394;44361.77819111013;44643.33035004543;64140;64305.356946431806;64582;65364;65486;8819.206271435602;8882.15619516145;9136.95431522838;9201.079892010745;9290.210332121846;13516.93241533786;14085.647858803202;14241.715165696834;14471.131732096108;14655;12290.446929887998;12438.564650237198;12459.626211213677;12615.810762838748;12916.160449570747;12134.33261170644;12210.694732631755;12518.812217816558;12584.30786306762;12681.175723577939;12076.577319793765;12445.25328480294;12597.433115510008;12789;12792.74414511723;8848.778780530538;9014.32392570573;9020.188183063556;9140.954295228481;9231.261499079923;9290.489023103793;12090.697732556757;12790.872091278969;12821.871781282067;13313 10:23:04 INFO - PROCESS | 413 | |3;mootools.html;1428.5500067478738;1487.9107253564787;1559.5009596928983;1683.3098429643849;1829.6706592813289;8366.874496882545;9068.455892646438;9510.619575217;9556.474393908333;9811.754706132333;9523.761905952355;9552.996935321795;9623;9657.903420965788;9677.370970886905;2472.666190064336;2492.1402116269946;2503.4242124311418;2513.5098655762135;2513.8240323177383;2404.63930410439;2496.301035709995;2499.2252401755422;2500.4749002709455;2507.6865391826022;2460.3972026853444;2470.4564995701007;2474.7401522840114;2493.775560199582;2495.962560561593;2403.3991502124554;2425.417899704076;2440.414300567869;2466.519028789387;2470.0737223541173;2374.643803429482;2406.554787364343;2426.8786560671897;2427.199024321987;2427.405285704996;9341.439513629137;9372.109649583279;9521.428714277166;9524.809503809885;9538.52307384628;5369.087255166631;5578.609497335188;5656.632318899258;5659.26429564154;5676.545876329884;3666.6883314918264;3742.7192960527796;3751.362268414349;3813.4470501777364;3825.6556909878245;1275.4005617359826;1277.929713865737;1282.070483921692;1291.541502766523;1333.5799223244744;13382.330883455885;13468.461261549526;13480.797788033187;13482.52811151605;13492.055556111174;4794.520547945247;4810.062037902645;4837.4920633332995;4945.9258111128365;4977.253411988231;10637.468126593794;10639.095676867399;10648.946755266174;10657.680269591925;10661.147108231324;5612.102063669793;5629.605927585029;5636.126400407943;5646.153077038477;5647.29408823897;4571.817127314936;5099.515546023122;5198.506141916512;5232.424433312332;5268.367795864444;3992.061865461614;4012.7792971386853;4093.795310234536;4100.261952848516;4152.1072969311135;1161.4192903548226;1171.8828117188214;1177.1348059176498;1185.0697202695842;1195.6831439668495;739.7004213293625;937.3672770879629;997.5211898288862;1009.6062535611118;1023.1610079734546;6106.877862442726;6416.422521973045;6473.482121430275;6585.6707164641575;6687.966560167265;526.3893883095667;680.8867501634763;1080.2978064258295;1117.4915413486844;1132.8527291452058;4170.4995400552125;4379.4525684289465;4397.340398940185;4437.955620443819;4518.344839998182;11889.524419023315;12314.322712250912;12332.691682708004;12338.753224935452;12339.07456940733;12068.818967715491;12155.149139560146;12307.6923076922;12334.259944403364;12336;8951.910480895238;9030.27757779376;9147.679831205876;9150.633974641072;9166.312526560534;6347.174867267226;6355.618662880242;6409.7436102555375;6432.614043157426;6594.505412094208;10813.783724325627;10904.563817447213;11118.833217501906;11393.259438136494;11442.542298308308;10537.315074520131;10752.946235269086;10798.67603971882;11125.554977800797;11305.660830175108;8183.222593853575;8638.222559969632;8779.078196789245;8831.425957312755;8860.29117670572;9353.438793672402;9377.249820014518;9447.480388578695;9456.574454149717;9467.810643787223;8292.12932642064;8330.166983301622;8341.66633334684;8450.408471407189;8457.87313190315;8222.17778222197;8252.711155109542;8319.084900661044;8348.123447037973;8357.164283571594;7239.167495738057;7409.703611855465;7470.775876723707;7680.731174408869;7688.423368247516;5353.223782551586;5504.394516603251;5724.656520608777;5869.911951320819;5902.940970590239;5612.102063669793;5648.915266271091;5775.537956963517;5875.20684707559;5909 10:23:04 INFO - PROCESS | 413 | |4;prototype.html;331.36543519160807;340.9948850767238;348.58344278587083;349.16026955172816;351.76080265419523;5498.2027605997155;5508.7521061552225;5553.222548843165;5575;5586.832395028146;5471.042567550682;5484.287042684456;5493.983613031592;5498.147787093007;5522.22688823565;4395.813130454775;4400.44994375703;4410.9779451102695;4438.4451943507065;4450.8858292311215;3970.5235371755284;4030.032792129882;4329.242382583051;4352.7823608819435;4367.384067894867;4321.222180007598;4322.178786030644;4327.372530983005;4333.458317710286;4337.7397356158735;4308.138372325532;4315.741055536678;4328.420126653765;4345.50026746925;4354.8911277218;3587.336342776595;3688.61269566697;3824.7322687411893;3828.8659896903473;3839.138018061238;5304.6286759926825;5318.9202161967605;5326.174442961347;5328.946710532922;5337.891532844544;4841.273808928654;4937.506249375069;4940.8764780880765;4942.752862356903;4946.72792996385;5669.177969194485;5680.750234948305;5689.943100568983;5723.799667011676;5740.167675687002;4243.27864263076;4246.490421149451;4250.4899412070445;4256.5953235432235;4274.829006839723;5808.535317174616;5954.672493012926;6046.909296360558;6063.666498342589;6072.392760723937;4303.935440968388;4309.719868208619;4330.2638551446325;4345.717528360709;4368.934465983013;4414.713043652152;4418.756968366771;4419.9779001105435;4427.690061695715;4453.19842428366;4748.382710247645;4951.851444456672;4954.3063971044085;4972.57733092684;4982.9252561211615;5748.19525266463;5765.1928729977835;5770.740316685759;5771.59598828078;5774.740136693859;1508.2232650184944;1525.2678714217016;1529.4341093795367;1547.674988252457;1548.4735190035217;932.3520153493257;949.4445749236774;973.3478569358547;979.8530220466987;985.9211263098935;5020.59835213182;5028.245763135559;5029.220470827027;5398.94959347975;5590.413006634326;5910.379410161871;5933.406659334032;5935.40645935403;5936.28764548257;5961.850953726105;5618.803341883015;5646.520045796154;5651.802186923438;5657.858553536194;5682.204491371129;3050.054483110243;3117.8752849886205;3132.592762940803;3140.8378899807217;3169.4453470642547;6128.3258841527395;6151.323354431009;6166.136740856284;6169.619570105186;6172.475339596184;5705.657660540381;5949.018411962064;5976.282846058501;6041.667708276087;6085.087236914498;6054.395585170021;6097.2683278006925;6126.172966649446;6130.141780150782;6134.662593557308;5760.366359700513;5893.057110862242;5944.910826337522;5958.851028724316;6028.819135425944;5827.649101766586;5845.269341332333;5848.64908105515;5854.824355269348;5889;6076.240469941257;6163.767246550618;6170.568060235741;6170.6914654268;6197.17183430898;4051.230266249403;4266.765327906995;4272.978635106804;4368.148211098805;4373.8846594118295;5961.642301461753;5965.343812180743;5975;5989.580729349078;5993.130996005642;5834.095715164156;5866.735996880066;5876.823695289148;5886;5907.670774075798;5581.74882130297;5816.127580862904;5821.679807610622;5842.364138041356;5865.885481758452;5796.739146738491;5802.390748971297;5810.448007439287;5822.126680997715;5837.562182836389;5659.207710920557;5835.066389377679;5871.706414679335;5883.676397798162;5923.259592550931;5686.004949133968;5706.630408701964;5710.314762228559;5729.197912292366;5734.340550836707 10:23:04 INFO - PROCESS | 413 | |5;yui.html;724.2689379529767;760.5322726523189;763.1033535595674;767.2749251956901;813.0852790610563;16394.18029098545;17329.566760830985;17367.565810854736;17511.562210944718;17533.649327013467;16171;16457.012579245253;16469.505914822545;16480.42318518852;16486.01083934965;728.2608152724988;845.9154084591553;854.5043874552775;863.404251066765;870.6822009966348;895.771578247546;895.8566629339307;899.5232526760827;899.7390756680587;899.8875140607424;957.3920560444134;958.5542722633974;959.596969272907;959.8848138223423;960.0831206198098;765.4565258666354;791.4894892794144;794.7496538590383;898.7438580004667;949.4255975135047;693.5665209244222;697.1111832413662;697.7209116353448;697.8081027717368;698.1935864077;15148.924255378763;15228.390864365412;15241.16173610451;15297.311620977083;15341.386344546205;15811.525654230392;15854.524364269091;15854.762178567331;16032.278547465392;16307.83692163087;14293.714125717532;14325.161905518664;14424.423023079064;14546.854531454655;14747.115173089649;4829.855104346875;4856.465788763233;4873.80504779812;4956.231784073474;5013.899722005576;85928;86199.56900215521;87123;93052;93163.53418232933;12122.878771212352;12408.069394795426;12430.813537796941;12506.437210325557;12697.746045079231;20264.898675506527;20405.693914591295;20430.284940027326;20543.38369848907;20714.067866946025;8520.829583408296;9162.450252984841;9185.219256363283;9219.953900230455;9523.190528804991;5094.61790365724;5248.1340578804065;5316.521513063843;5333.2266821310695;5343.011542864582;3535.9469607955903;3647.6534729200685;3647.8176091195332;3648.635136486383;3655.5065066216252;645.3062957320805;645.5223134880155;652.709544252803;652.8216569092833;672.4821887146869;724.8332883436839;738.2138023005482;760.7413479417024;762.2758379539459;765.2691679446116;10064.496775161213;10099.242556808269;10553.419561924014;10668.62659806903;10762.838557421645;623.5759683415231;688.1363888320126;739.807650011001;749.7151082588581;753.9623018849036;4643.210654188796;4818.542238487338;5074.619403544749;5091.287219789232;5113.565346945551;79893;80282.5985870067;136313;140927;142798;116605;119096;121268;123097.38451307686;125418;67777.3222267771;79407.20592794113;80495;100982.49508752409;103391;9489.66786162481;10135.746606334606;10318.690439286833;10473.162147028372;10869.076128529163;39057.414138787375;51403;52806;54087.45912540824;54460.45539544713;72784;81303;81684.59157704173;86067;86624.13375866161;13955.58133256004;14196.895335006047;14223.502177423741;14419.134851908919;14508.564743057725;15831.208439577744;15958.361665533248;15961.8403815965;16043.679126417639;16100.355985760907;14867.479638212611;15088.698226035198;15117.1685557291;15381.615459613151;15838.52484425469;14020.228887410882;14190.219537925514;14218.431262749375;14520.782188267396;14656.853431465976;14199.148051116967;14944.92527537399;14978.700425991638;15427;15675.608109797346;11418.257813242444;11627.418629068681;11668.649940501798;11967.401629918644;12337.629871103882;11763.705907352043;11801;11823.290602563873;12002.279863208236;12094.213876098025 10:23:04 INFO - PROCESS | 413 | __end_tp_report 10:23:04 INFO - PROCESS | 413 | __start_cc_report 10:23:04 INFO - PROCESS | 413 | _x_x_mozilla_cycle_collect,1112 10:23:04 INFO - PROCESS | 413 | __end_cc_report 10:23:04 INFO - PROCESS | 413 | __startTimestamp1473096184369__endTimestamp 10:23:04 INFO - PROCESS | 413 | 10:23:04 INFO - PROCESS | 413 | ------- Summary: start ------- 10:23:04 INFO - PROCESS | 413 | Number of tests: 6 10:23:04 INFO - PROCESS | 413 | 10:23:04 INFO - PROCESS | 413 | [#0] dojo.html Cycles:165 Average:5661.91 Median:5889.15 stddev:646.03 (11.0%) stddev-sans-first:619.16 10:23:04 INFO - PROCESS | 413 | Values: 3228.4 3248.8 3255.1 3269.7 3269.8 5628.1 5745.5 5785.8 5793.6 5801.3 5712.7 5780.5 5791.9 5793.5 5805.3 5085.4 5169.5 5229.8 5247.2 5300.0 5248.1 5293.9 5298.8 5305.8 5311.2 5110.2 5162.3 5192.0 5212.0 5216.9 5306.2 5307.1 5312.4 5312.9 5340.8 5069.0 5131.3 5192.7 5202.6 5202.7 5630.7 5640.7 5679.6 5680.8 5683.1 6119.6 6125.9 6126.4 6127.0 6130.2 5940.6 6078.6 6097.0 6142.4 6149.9 5790.9 5802.6 5809.2 5814.3 5822.1 6308.3 6308.4 6319.7 6322.5 6322.9 5793.3 5865.3 5944.3 5958.1 6036.9 6075.7 6076.6 6086.8 6092.9 6136.0 5983.0 6028.8 6036.6 6037.2 6046.6 5931.0 5981.1 5989.8 6021.3 6034.0 4604.1 4637.8 4665.4 4676.8 4680.1 4141.6 4141.9 4156.2 4165.5 4177.5 5651.1 5737.1 5759.4 5852.9 5853.5 6124.5 6135.3 6135.3 6137.0 6147.2 5788.1 5847.9 5848.7 5853.1 5871.9 4871.2 4966.3 4994.7 5115.4 5121.0 6294.7 6316.6 6317.1 6317.4 6319.6 6012.0 6054.8 6058.9 6065.0 6066.3 6121.3 6186.1 6255.5 6295.3 6306.1 5989.6 5997.8 6017.9 6022.8 6027.6 6074.8 6076.8 6081.0 6085.3 6088.4 5774.1 5867.2 5889.1 5911.7 5993.5 5889.5 5945.0 5947.3 5980.6 5984.5 5937.4 5946.0 5946.6 5947.6 5948.7 5826.9 5932.4 5950.3 5988.8 6035.2 5865.1 5888.1 5890.3 5902.6 5919.3 10:23:04 INFO - PROCESS | 413 | 10:23:04 INFO - PROCESS | 413 | [#1] ext.html Cycles:180 Average:60543.81 Median:21066.13 stddev:118785.44 (563.9%) stddev-sans-first:119033.41 10:23:04 INFO - PROCESS | 413 | Values: 603.7 627.1 644.7 663.2 666.5 35690.8 47071.8 47951.8 47967.8 48004.5 48901.8 48941.5 49315.8 49367.5 49377.3 8530.2 9132.0 9266.8 9276.9 9277.4 10864.6 11143.8 11154.6 11397.6 11420.4 11278.9 11382.1 11388.1 11390.1 11392.5 10863.1 10982.6 11018.6 11031.3 11040.5 10918.1 10952.2 10955.9 11037.0 11051.2 45856.8 46331.8 46544.3 46640.0 46762.3 3756.0 3832.8 3833.8 3838.4 3885.4 36132.5 36380.8 36644.6 38230.4 38299.4 4717.0 4814.7 4834.5 4846.4 4907.0 375073.0 376480.0 378351.1 379335.0 382629.1 38860.2 40183.0 67042.7 67525.0 67692.3 41670.4 41857.6 41874.4 41964.4 41968.6 17645.6 17889.3 17893.8 17898.0 17915.4 11892.0 13722.5 13807.0 14715.9 14967.3 9414.9 9435.1 9472.4 9494.2 9507.6 3471.2 3519.5 3524.6 3535.4 3537.8 1082.8 1119.6 1144.2 1159.0 1188.5 35784.5 36471.8 36637.3 36670.0 36720.0 1165.7 1169.5 1273.1 1296.8 1307.6 18827.6 18837.7 18845.5 19004.8 19127.3 587170.0 587571.0 592256.0 593820.0 595144.0 44021.3 44063.1 44257.8 44399.6 44488.3 1349.0 1416.4 1443.9 1449.8 1480.0 34892.0 37604.8 38171.2 38208.2 38390.8 57586.4 58105.0 58122.1 58224.4 58296.0 328579.0 328837.0 328886.0 329882.0 330625.0 31251.2 32042.4 32322.2 33595.0 33602.5 54379.0 54804.0 55089.0 55111.2 55149.0 44093.6 45415.3 45918.0 47168.5 47399.5 42151.8 45335.0 46851.8 47710.5 47906.0 46782.3 46895.0 47074.3 47306.0 47783.3 38830.8 40682.2 40800.9 41250.6 41944.4 30116.0 30210.5 30601.5 30909.2 31033.1 10:23:04 INFO - PROCESS | 413 | 10:23:04 INFO - PROCESS | 413 | [#2] jquery.html Cycles:180 Average:32521.31 Median:21763.12 stddev:96512.13 (443.5%) stddev-sans-first:96752.70 10:23:04 INFO - PROCESS | 413 | Values: 384.7 406.6 410.0 410.6 424.7 16619.8 20343.6 20789.9 21012.2 22027.4 21581.1 21664.2 21714.0 21739.6 21786.7 5684.3 6043.0 6064.5 6080.2 6086.1 4323.0 5963.8 5993.2 5997.1 6452.7 6663.0 6799.3 6811.9 6813.6 6815.5 6638.8 6650.4 6651.2 6667.0 6769.7 5719.3 5851.7 5882.0 5893.9 5931.2 20287.5 20296.3 20301.8 22684.7 23281.5 2435.1 2452.5 2464.9 2700.9 2828.0 10600.8 10713.6 10717.9 10851.7 10915.1 1965.8 1972.5 2020.8 2037.9 2092.7 68562.7 78313.6 78855.6 86709.6 90993.5 11144.1 11231.4 11432.8 11440.7 11483.8 15917.5 15941.3 15957.9 15969.0 15971.7 8031.8 8688.3 9089.0 9159.9 9190.4 8517.7 8728.5 8770.8 8854.4 9180.3 4770.6 4845.0 4863.7 4946.4 4966.0 1964.7 1984.3 2027.4 2041.0 2046.2 959.8 1009.3 1013.2 1067.1 1075.6 20239.6 20689.9 20971.7 21020.9 21409.8 1055.0 1080.3 1107.0 1108.2 1125.6 11236.4 11547.1 11771.2 11797.1 11889.9 579976.0 582145.0 582349.0 595033.0 599562.0 86298.0 90792.0 98472.5 100543.0 100615.0 1042.8 1045.6 1086.4 1088.4 1089.4 18657.3 18683.9 18890.9 18973.8 19226.7 42961.8 43234.6 43823.8 44361.8 44643.3 64140.0 64305.4 64582.0 65364.0 65486.0 8819.2 8882.2 9137.0 9201.1 9290.2 13516.9 14085.6 14241.7 14471.1 14655.0 12290.4 12438.6 12459.6 12615.8 12916.2 12134.3 12210.7 12518.8 12584.3 12681.2 12076.6 12445.3 12597.4 12789.0 12792.7 8848.8 9014.3 9020.2 9141.0 9231.3 9290.5 12090.7 12790.9 12821.9 13313.0 10:23:04 INFO - PROCESS | 413 | 10:23:04 INFO - PROCESS | 413 | [#3] mootools.html Cycles:180 Average:6284.17 Median:4683.17 stddev:3638.38 (77.7%) stddev-sans-first:3630.28 10:23:04 INFO - PROCESS | 413 | Values: 1428.6 1487.9 1559.5 1683.3 1829.7 8366.9 9068.5 9510.6 9556.5 9811.8 9523.8 9553.0 9623.0 9657.9 9677.4 2472.7 2492.1 2503.4 2513.5 2513.8 2404.6 2496.3 2499.2 2500.5 2507.7 2460.4 2470.5 2474.7 2493.8 2496.0 2403.4 2425.4 2440.4 2466.5 2470.1 2374.6 2406.6 2426.9 2427.2 2427.4 9341.4 9372.1 9521.4 9524.8 9538.5 5369.1 5578.6 5656.6 5659.3 5676.5 3666.7 3742.7 3751.4 3813.4 3825.7 1275.4 1277.9 1282.1 1291.5 1333.6 13382.3 13468.5 13480.8 13482.5 13492.1 4794.5 4810.1 4837.5 4945.9 4977.3 10637.5 10639.1 10648.9 10657.7 10661.1 5612.1 5629.6 5636.1 5646.2 5647.3 4571.8 5099.5 5198.5 5232.4 5268.4 3992.1 4012.8 4093.8 4100.3 4152.1 1161.4 1171.9 1177.1 1185.1 1195.7 739.7 937.4 997.5 1009.6 1023.2 6106.9 6416.4 6473.5 6585.7 6688.0 526.4 680.9 1080.3 1117.5 1132.9 4170.5 4379.5 4397.3 4438.0 4518.3 11889.5 12314.3 12332.7 12338.8 12339.1 12068.8 12155.1 12307.7 12334.3 12336.0 8951.9 9030.3 9147.7 9150.6 9166.3 6347.2 6355.6 6409.7 6432.6 6594.5 10813.8 10904.6 11118.8 11393.3 11442.5 10537.3 10752.9 10798.7 11125.6 11305.7 8183.2 8638.2 8779.1 8831.4 8860.3 9353.4 9377.2 9447.5 9456.6 9467.8 8292.1 8330.2 8341.7 8450.4 8457.9 8222.2 8252.7 8319.1 8348.1 8357.2 7239.2 7409.7 7470.8 7680.7 7688.4 5353.2 5504.4 5724.7 5869.9 5902.9 5612.1 5648.9 5775.5 5875.2 5909.0 10:23:04 INFO - PROCESS | 413 | 10:23:04 INFO - PROCESS | 413 | [#4] prototype.html Cycles:180 Average:4885.78 Median:5604.61 stddev:1429.50 (25.5%) stddev-sans-first:1392.04 10:23:04 INFO - PROCESS | 413 | Values: 331.4 341.0 348.6 349.2 351.8 5498.2 5508.8 5553.2 5575.0 5586.8 5471.0 5484.3 5494.0 5498.1 5522.2 4395.8 4400.4 4411.0 4438.4 4450.9 3970.5 4030.0 4329.2 4352.8 4367.4 4321.2 4322.2 4327.4 4333.5 4337.7 4308.1 4315.7 4328.4 4345.5 4354.9 3587.3 3688.6 3824.7 3828.9 3839.1 5304.6 5318.9 5326.2 5328.9 5337.9 4841.3 4937.5 4940.9 4942.8 4946.7 5669.2 5680.8 5689.9 5723.8 5740.2 4243.3 4246.5 4250.5 4256.6 4274.8 5808.5 5954.7 6046.9 6063.7 6072.4 4303.9 4309.7 4330.3 4345.7 4368.9 4414.7 4418.8 4420.0 4427.7 4453.2 4748.4 4951.9 4954.3 4972.6 4982.9 5748.2 5765.2 5770.7 5771.6 5774.7 1508.2 1525.3 1529.4 1547.7 1548.5 932.4 949.4 973.3 979.9 985.9 5020.6 5028.2 5029.2 5398.9 5590.4 5910.4 5933.4 5935.4 5936.3 5961.9 5618.8 5646.5 5651.8 5657.9 5682.2 3050.1 3117.9 3132.6 3140.8 3169.4 6128.3 6151.3 6166.1 6169.6 6172.5 5705.7 5949.0 5976.3 6041.7 6085.1 6054.4 6097.3 6126.2 6130.1 6134.7 5760.4 5893.1 5944.9 5958.9 6028.8 5827.6 5845.3 5848.6 5854.8 5889.0 6076.2 6163.8 6170.6 6170.7 6197.2 4051.2 4266.8 4273.0 4368.1 4373.9 5961.6 5965.3 5975.0 5989.6 5993.1 5834.1 5866.7 5876.8 5886.0 5907.7 5581.7 5816.1 5821.7 5842.4 5865.9 5796.7 5802.4 5810.4 5822.1 5837.6 5659.2 5835.1 5871.7 5883.7 5923.3 5686.0 5706.6 5710.3 5729.2 5734.3 10:23:04 INFO - PROCESS | 413 | 10:23:04 INFO - PROCESS | 413 | [#5] yui.html Cycles:180 Average:22532.38 Median:3647.74 stddev:33104.05 (907.5%) stddev-sans-first:33156.42 10:23:04 INFO - PROCESS | 413 | Values: 724.3 760.5 763.1 767.3 813.1 16394.2 17329.6 17367.6 17511.6 17533.6 16171.0 16457.0 16469.5 16480.4 16486.0 728.3 845.9 854.5 863.4 870.7 895.8 895.9 899.5 899.7 899.9 957.4 958.6 959.6 959.9 960.1 765.5 791.5 794.7 898.7 949.4 693.6 697.1 697.7 697.8 698.2 15148.9 15228.4 15241.2 15297.3 15341.4 15811.5 15854.5 15854.8 16032.3 16307.8 14293.7 14325.2 14424.4 14546.9 14747.1 4829.9 4856.5 4873.8 4956.2 5013.9 85928.0 86199.6 87123.0 93052.0 93163.5 12122.9 12408.1 12430.8 12506.4 12697.7 20264.9 20405.7 20430.3 20543.4 20714.1 8520.8 9162.5 9185.2 9220.0 9523.2 5094.6 5248.1 5316.5 5333.2 5343.0 3535.9 3647.7 3647.8 3648.6 3655.5 645.3 645.5 652.7 652.8 672.5 724.8 738.2 760.7 762.3 765.3 10064.5 10099.2 10553.4 10668.6 10762.8 623.6 688.1 739.8 749.7 754.0 4643.2 4818.5 5074.6 5091.3 5113.6 79893.0 80282.6 136313.0 140927.0 142798.0 116605.0 119096.0 121268.0 123097.4 125418.0 67777.3 79407.2 80495.0 100982.5 103391.0 9489.7 10135.7 10318.7 10473.2 10869.1 39057.4 51403.0 52806.0 54087.5 54460.5 72784.0 81303.0 81684.6 86067.0 86624.1 13955.6 14196.9 14223.5 14419.1 14508.6 15831.2 15958.4 15961.8 16043.7 16100.4 14867.5 15088.7 15117.2 15381.6 15838.5 14020.2 14190.2 14218.4 14520.8 14656.9 14199.1 14944.9 14978.7 15427.0 15675.6 11418.3 11627.4 11668.6 11967.4 12337.6 11763.7 11801.0 11823.3 12002.3 12094.2 10:23:04 INFO - PROCESS | 413 | -------- Summary: end -------- 10:23:04 INFO - PROCESS | 413 | 10:23:05 INFO - TEST-INFO | 413: exit 0 10:23:05 INFO - TEST-OK | dromaeo_css | took 1113683ms 10:23:05 INFO - TEST-START | kraken 10:23:05 INFO - operating with platform_type : linux_ 10:23:05 INFO - Initialising browser for kraken test... 10:23:05 INFO - TEST-INFO | started process 623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9a0FRT/profile http://localhost:51163/getInfo.html) 10:23:08 INFO - PROCESS | 623 | __metrics Screen width/height:1600/1200 10:23:08 INFO - PROCESS | 623 | colorDepth:24 10:23:08 INFO - PROCESS | 623 | Browser inner width/height: 1024/697 10:23:08 INFO - PROCESS | 623 | __metrics 10:23:09 INFO - PROCESS | 623 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:23:09 INFO - PROCESS | 623 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:23:10 INFO - TEST-INFO | 623: exit 0 10:23:10 INFO - Browser initialized. 10:23:10 INFO - Running cycle 1/1 for kraken test... 10:23:10 INFO - TEST-INFO | started process 714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9a0FRT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:23:22 INFO - PROCESS | 714 | RSS: Main: 144236544 10:23:22 INFO - PROCESS | 714 | 10:23:25 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:51163/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51163/tests/kraken/driver.html?testName=audio-beat-detection) 10:23:25 INFO - PROCESS | 714 | RSS: Main: 191463424 10:23:25 INFO - PROCESS | 714 | 10:23:28 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:51163/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51163/tests/kraken/driver.html?testName=audio-dft) 10:23:29 INFO - PROCESS | 714 | RSS: Main: 181219328 10:23:29 INFO - PROCESS | 714 | 10:23:31 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:51163/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51163/tests/kraken/driver.html?testName=audio-fft) 10:23:32 INFO - PROCESS | 714 | RSS: Main: 269828096 10:23:32 INFO - PROCESS | 714 | 10:23:34 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:51163/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51163/tests/kraken/driver.html?testName=audio-oscillator) 10:23:35 INFO - PROCESS | 714 | RSS: Main: 175489024 10:23:35 INFO - PROCESS | 714 | 10:23:37 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:51163/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51163/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:23:37 INFO - PROCESS | 714 | RSS: Main: 177094656 10:23:37 INFO - PROCESS | 714 | 10:23:40 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:51163/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51163/tests/kraken/driver.html?testName=imaging-darkroom) 10:23:41 INFO - PROCESS | 714 | RSS: Main: 212627456 10:23:41 INFO - PROCESS | 714 | 10:23:44 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:51163/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51163/tests/kraken/driver.html?testName=imaging-desaturate) 10:23:45 INFO - PROCESS | 714 | RSS: Main: 211795968 10:23:45 INFO - PROCESS | 714 | 10:23:48 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:51163/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51163/tests/kraken/driver.html?testName=json-parse-financial) 10:23:48 INFO - PROCESS | 714 | RSS: Main: 211369984 10:23:48 INFO - PROCESS | 714 | 10:23:50 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:51163/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51163/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:23:50 INFO - PROCESS | 714 | RSS: Main: 175665152 10:23:50 INFO - PROCESS | 714 | 10:23:52 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:51163/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51163/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:23:53 INFO - PROCESS | 714 | RSS: Main: 182456320 10:23:53 INFO - PROCESS | 714 | 10:23:55 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:51163/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51163/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:23:55 INFO - PROCESS | 714 | RSS: Main: 185888768 10:23:55 INFO - PROCESS | 714 | 10:23:58 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:51163/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:23:58 INFO - PROCESS | 714 | RSS: Main: 179527680 10:23:58 INFO - PROCESS | 714 | 10:24:01 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:51163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:24:02 INFO - PROCESS | 714 | RSS: Main: 184606720 10:24:02 INFO - PROCESS | 714 | 10:24:03 INFO - PROCESS | 714 | Cycle 1(1): loaded http://localhost:51163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51163/tests/kraken/driver.html?testName=ai-astar) 10:24:04 INFO - PROCESS | 714 | RSS: Main: 234827776 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | __start_tp_report 10:24:04 INFO - PROCESS | 714 | _x_x_mozilla_page_load 10:24:04 INFO - PROCESS | 714 | _x_x_mozilla_page_load_details 10:24:04 INFO - PROCESS | 714 | |i|pagename|runs| 10:24:04 INFO - PROCESS | 714 | |0;ai-astar;102;113;111;112;113;110;110;111;112;111 10:24:04 INFO - PROCESS | 714 | |1;audio-beat-detection;146;114;115;169;122;124;137;115;162;117 10:24:04 INFO - PROCESS | 714 | |2;audio-dft;160;161;161;162;160;161;163;162;160;161 10:24:04 INFO - PROCESS | 714 | |3;audio-fft;74;76;76;109;76;75;75;76;107;74 10:24:04 INFO - PROCESS | 714 | |4;audio-oscillator;83;83;138;84;84;84;129;82;83;126 10:24:04 INFO - PROCESS | 714 | |5;imaging-gaussian-blur;116;118;116;117;116;117;117;117;117;117 10:24:04 INFO - PROCESS | 714 | |6;imaging-darkroom;146;145;147;146;146;145;146;146;146;145 10:24:04 INFO - PROCESS | 714 | |7;imaging-desaturate;95;95;98;96;96;95;96;96;96;96 10:24:04 INFO - PROCESS | 714 | |8;json-parse-financial;50;50;50;49;49;50;51;50;50;49 10:24:04 INFO - PROCESS | 714 | |9;json-stringify-tinderbox;61;63;61;61;61;61;61;61;61;62 10:24:04 INFO - PROCESS | 714 | |10;stanford-crypto-aes;73;72;71;71;80;74;72;77;71;76 10:24:04 INFO - PROCESS | 714 | |11;stanford-crypto-ccm;121;117;125;127;114;115;117;119;188;118 10:24:04 INFO - PROCESS | 714 | |12;stanford-crypto-pbkdf2;148;155;151;154;151;150;151;152;152;152 10:24:04 INFO - PROCESS | 714 | |13;stanford-crypto-sha256-iterative;62;68;63;62;62;63;61;61;61;64 10:24:04 INFO - PROCESS | 714 | __end_tp_report 10:24:04 INFO - PROCESS | 714 | __start_cc_report 10:24:04 INFO - PROCESS | 714 | _x_x_mozilla_cycle_collect,1618 10:24:04 INFO - PROCESS | 714 | __end_cc_report 10:24:04 INFO - PROCESS | 714 | __startTimestamp1473096244024__endTimestamp 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | ------- Summary: start ------- 10:24:04 INFO - PROCESS | 714 | Number of tests: 14 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.50 stddev:3.17 (2.8%) stddev-sans-first:1.13 10:24:04 INFO - PROCESS | 714 | Values: 102.0 113.0 111.0 112.0 113.0 110.0 110.0 111.0 112.0 111.0 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | [#1] audio-beat-detection Cycles:10 Average:132.10 Median:130.50 stddev:20.50 (15.7%) stddev-sans-first:21.11 10:24:04 INFO - PROCESS | 714 | Values: 146.0 114.0 115.0 169.0 122.0 124.0 137.0 115.0 162.0 117.0 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 10:24:04 INFO - PROCESS | 714 | Values: 160.0 161.0 161.0 162.0 160.0 161.0 163.0 162.0 160.0 161.0 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.50 stddev:13.84 (18.3%) stddev-sans-first:14.39 10:24:04 INFO - PROCESS | 714 | Values: 74.0 76.0 76.0 109.0 76.0 75.0 75.0 76.0 107.0 74.0 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:83.00 stddev:23.24 (28.0%) stddev-sans-first:24.05 10:24:04 INFO - PROCESS | 714 | Values: 83.0 83.0 138.0 84.0 84.0 84.0 129.0 82.0 83.0 126.0 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 10:24:04 INFO - PROCESS | 714 | Values: 116.0 118.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 10:24:04 INFO - PROCESS | 714 | Values: 146.0 145.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.87 10:24:04 INFO - PROCESS | 714 | Values: 95.0 95.0 98.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:50.00 stddev:0.63 (1.3%) stddev-sans-first:0.67 10:24:04 INFO - PROCESS | 714 | Values: 50.0 50.0 50.0 49.0 49.0 50.0 51.0 50.0 50.0 49.0 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 10:24:04 INFO - PROCESS | 714 | Values: 61.0 63.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | [#10] stanford-crypto-aes Cycles:10 Average:73.70 Median:73.50 stddev:3.06 (4.2%) stddev-sans-first:3.23 10:24:04 INFO - PROCESS | 714 | Values: 73.0 72.0 71.0 71.0 80.0 74.0 72.0 77.0 71.0 76.0 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:120.00 stddev:22.14 (18.4%) stddev-sans-first:23.40 10:24:04 INFO - PROCESS | 714 | Values: 121.0 117.0 125.0 127.0 114.0 115.0 117.0 119.0 188.0 118.0 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:152.00 stddev:1.96 (1.3%) stddev-sans-first:1.58 10:24:04 INFO - PROCESS | 714 | Values: 148.0 155.0 151.0 154.0 151.0 150.0 151.0 152.0 152.0 152.0 10:24:04 INFO - PROCESS | 714 | 10:24:04 INFO - PROCESS | 714 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:2.11 (3.4%) stddev-sans-first:2.22 10:24:04 INFO - PROCESS | 714 | Values: 62.0 68.0 63.0 62.0 62.0 63.0 61.0 61.0 61.0 64.0 10:24:04 INFO - PROCESS | 714 | -------- Summary: end -------- 10:24:04 INFO - PROCESS | 714 | 10:24:05 INFO - TEST-INFO | 714: exit 0 10:24:05 INFO - TEST-OK | kraken | took 59965ms 10:24:05 INFO - SUITE-END | took 1173s 10:24:05 INFO - Completed test suite (00:19:33) 10:24:05 INFO - javascript benchmark 10:24:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3228.3866065447564, 3248.8375581220935, 3255.088575198945, 3269.7057264846167, 3269.7711160218796, 5628.127640215768, 5745.540356771458, 5785.768569257235, 5793.6234144780665, 5801.303843538776, 5712.742926568304, 5780.450857168573, 5791.942080579193, 5793.4785869271755, 5805.3323867755225, 5085.364329458817, 5169.508896654812, 5229.79080836767, 5247.239150323201, 5300.0459917214885, 5248.107821670306, 5293.867653308679, 5298.841034768963, 5305.7877684892555, 5311.203319502067, 5110.156824124015, 5162.328897243353, 5192.0, 5211.973940130313, 5216.921746173811, 5306.177542480922, 5307.071262529081, 5312.362516498007, 5312.893742125175, 5340.813071542516, 5068.974655126738, 5131.281620573122, 5192.714400707997, 5202.583793296565, 5202.661826981234, 5630.746616402272, 5640.661560306354, 5679.602427830054, 5680.801171958961, 5683.062294721366, 6119.571629985903, 6125.908111378333, 6126.387361263883, 6127.0, 6130.203073600448, 5940.61386009908, 6078.574499785017, 6097.0, 6142.447179753844, 6149.938500614981, 5790.942090579082, 5802.564807639402, 5809.24479817621, 5814.30228372598, 5822.0684690449325, 6308.3060863305, 6308.369163083655, 6319.652419116901, 6322.462590679844, 6322.9051564226575, 5793.304803423532, 5865.2961644602065, 5944.286685597669, 5958.136070269787, 6036.879262414727, 6075.665838378932, 6076.574639775262, 6086.839306843172, 6092.868393245213, 6136.0, 5983.0, 6028.819135425944, 6036.637801731822, 6037.18498002764, 6046.637201767908, 5930.991731405671, 5981.102834574762, 5989.8203053908455, 6021.307549631849, 6034.034554471264, 4604.102200070954, 4637.768111594407, 4665.393498845128, 4676.8129274828625, 4680.134175177603, 4141.627253547195, 4141.91716165675, 4156.168766246763, 4165.479315085614, 4177.519585247735, 5651.067573850269, 5737.110747834093, 5759.395263497272, 5852.882942341129, 5853.502452291517, 6124.533510047256, 6135.32453530862, 6135.349157687728, 6137.009281402767, 6147.200863887755, 5788.102844059177, 5847.912281315784, 5848.707564621752, 5853.09277062056, 5871.853203669943, 4871.196252618278, 4966.279889416014, 4994.675346102492, 5115.360579927509, 5121.001404726043, 6294.685265736694, 6316.62100273985, 6317.052442133717, 6317.399847014526, 6319.55763096588, 6012.0, 6054.757809687563, 6058.909116363347, 6065.0, 6066.302375226729, 6121.2700689216845, 6186.072089186478, 6255.530835187288, 6295.307516173126, 6306.054091886253, 5989.610675306091, 5997.760089596367, 6017.879642407215, 6022.8255490180745, 6027.60820546663, 6074.787382441594, 6076.756929722762, 6080.969595151996, 6085.300190478151, 6088.4215999479975, 5774.105013722879, 5867.237259156454, 5889.146073819186, 5911.733971971357, 5993.520518358434, 5889.528837692888, 5945.048792193401, 5947.256592925884, 5980.5514586405325, 5984.491318237999, 5937.406259374028, 5946.0189068803165, 5946.643201407929, 5947.643141411356, 5948.702564871825, 5826.912596311144, 5932.406759324033, 5950.3454619992635, 5988.790392336247, 6035.155078289131, 5865.090910908816, 5888.087346461305, 5890.293164820249, 5902.557308201816, 5919.289685237627], "value": 5617.566876175461, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.7192705391992, 627.1063734178795, 644.687326646576, 663.1577896071989, 666.450178602653, 35690.8215458923, 47071.764641176786, 47951.760241198834, 47967.760161199236, 48004.51995480048, 48901.75549122258, 48941.51058489414, 49315.75342123285, 49367.50632493683, 49377.259341109915, 8530.23227909488, 9132.041135680758, 9266.768330791716, 9276.907230927673, 9277.443353398783, 10864.61973830916, 11143.777124457505, 11154.609588664398, 11397.601083962063, 11420.428978551081, 11278.887211127907, 11382.146339024606, 11388.145889058313, 11390.088792896548, 11392.487338069765, 10863.076638485738, 10982.615608453745, 11018.559257629686, 11031.338119712762, 11040.503177356957, 10918.07196388308, 10952.178586605956, 10955.890441095646, 11037.0, 11051.226414151013, 45856.7707161462, 46331.768341158415, 46544.30183547249, 46640.0, 46762.298565521545, 3755.962440375589, 3832.827522761482, 3833.7891415972113, 3838.4434257032854, 3885.358915778893, 36132.45801312956, 36380.81809590961, 36644.63355366439, 38230.42654360187, 38299.425508617394, 4716.95283047172, 4814.6870453420415, 4834.468208497097, 4846.418429788413, 4906.950930490685, 375073.0, 376480.0, 378351.108244457, 379335.0, 382629.0868545667, 38860.2227955445, 40183.0, 67042.66478667673, 67525.0, 67692.3230767686, 41670.37494437586, 41857.581424185366, 41874.37188442176, 41964.37053444201, 41968.580314197075, 17645.647087058445, 17889.28442862297, 17893.821061789477, 17898.0, 17915.37296194627, 11892.04863610909, 13722.45110195601, 13807.0, 14715.92642036783, 14967.326470308863, 9414.858777118348, 9435.103665151799, 9472.384295020802, 9494.240460763122, 9507.57215925285, 3471.2363280078343, 3519.4896739973074, 3524.559430071241, 3535.356044534759, 3537.752357335013, 1082.8429877667852, 1119.6361182615683, 1144.187626784992, 1158.9652310430702, 1188.4711303469874, 35784.46323305152, 36471.81764091163, 36637.267254654755, 36670.0, 36720.0, 1165.7085728567858, 1169.5088063013554, 1273.1088238233274, 1296.8119622654663, 1307.60118163959, 18827.623447530972, 18837.717434238497, 18845.528861778566, 19004.80995190058, 19127.33054343091, 587170.0, 587571.0, 592256.0, 593820.0, 595144.0, 44021.33967990483, 44063.11873762571, 44257.778711106235, 44399.55600443954, 44488.3326750099, 1349.0, 1416.3697154766237, 1443.8737784528084, 1449.8405175430694, 1479.977800332996, 34892.0, 37604.81197593995, 38171.23657526779, 38208.23583528258, 38390.808045959595, 57586.424135758105, 58105.0, 58122.12816807836, 58224.4177558236, 58296.0, 328579.0, 328837.0, 328886.0, 329882.0, 330625.0, 31251.218719532193, 32042.359152816345, 32322.191945201557, 33595.0, 33602.49596256107, 54379.0, 54804.0, 55089.0, 55111.173332399245, 55149.0, 44093.559064408946, 45415.318770219135, 45918.0, 47168.528314716415, 47399.52600473951, 42151.7892410536, 45335.0, 46851.765741171075, 47710.522894770605, 47906.0, 46782.298265526726, 46895.0, 47074.29388559243, 47306.0, 47783.28325075196, 38830.80584597172, 40682.1863562733, 40800.89694107394, 41250.58749412467, 41944.370834438116, 30116.0, 30210.54684179695, 30601.540976885808, 30909.227269318446, 31033.069007929796], "value": 20777.168427883313, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.68455866189737, 406.5629448343032, 409.96310332070107, 410.55249777742256, 424.71119638645706, 16619.750703739453, 20343.59312813743, 20789.896050519765, 21012.159513619456, 22027.449313767163, 21581.136754529838, 21664.2417515387, 21714.0, 21739.565208695854, 21786.673199902016, 5684.289463817013, 6042.999999999978, 6064.4541991220785, 6080.2399700037495, 6086.117512960618, 4323.0, 5963.761449542035, 5993.1909192259145, 5997.130416089664, 6452.7418903243815, 6663.0, 6799.320067993211, 6811.897821532681, 6813.591184528919, 6815.48883833712, 6638.767643132467, 6650.401463868275, 6651.2018557773135, 6667.033280174372, 6769.729210831585, 5719.28508936383, 5851.678157701324, 5882.0, 5893.911591326134, 5931.228940237785, 20287.492812679655, 20296.289629863033, 20301.796982030286, 22684.65973010406, 23281.534369312518, 2435.0503303711566, 2452.497238066192, 2464.9014039438403, 2700.933131413081, 2827.971720282812, 10600.840987385196, 10713.625023124154, 10717.9464102679, 10851.67444976652, 10915.072218861405, 1965.8132477414765, 1972.5364539333245, 2020.8484363672783, 2037.8675386100003, 2092.717483139772, 68562.65718671425, 78313.60843195747, 78855.60572197102, 86709.56645216733, 90993.54503227508, 11144.108471322275, 11231.382273974847, 11432.828507572392, 11440.713982150513, 11483.770324593628, 15917.52247432579, 15941.282642281125, 15957.920210398874, 15969.041857488355, 15971.680566388608, 8031.7992050198045, 8688.261497772633, 9089.0, 9159.90840091604, 9190.356675032817, 8517.701880434155, 8728.476291422536, 8770.780730481662, 8854.38019338653, 9180.311476639145, 4770.570648641639, 4845.0, 4863.732494712754, 4946.35697359341, 4965.975170124127, 1964.6856502959458, 1984.3154111831395, 2027.4120505053663, 2040.9795902041087, 2046.2326627514683, 959.8320293948531, 1009.3086235928413, 1013.200498132005, 1067.140951534007, 1075.5590208014676, 20239.595208095754, 20689.89655051715, 20971.685424718642, 21020.894895525424, 21409.78590214109, 1055.0346433013706, 1080.3140006096028, 1106.9944650276698, 1108.2020944919645, 1125.6172901213627, 11236.381998990135, 11547.133964952494, 11771.23486973344, 11797.115216358636, 11889.940550297366, 579976.0, 582145.0, 582349.0, 595033.0, 599562.0, 86298.0, 90792.0, 98472.50763746136, 100543.0, 100615.0, 1042.760165162017, 1045.5765415006933, 1086.41333679812, 1088.4013792414141, 1089.4389389464432, 18657.346992855186, 18683.906580467556, 18890.905545472186, 18973.810261897757, 19226.654591955852, 42961.78519107385, 43234.56765432305, 43823.780881095394, 44361.77819111013, 44643.33035004543, 64140.0, 64305.356946431806, 64582.0, 65364.0, 65486.0, 8819.206271435602, 8882.15619516145, 9136.95431522838, 9201.079892010745, 9290.210332121846, 13516.93241533786, 14085.647858803202, 14241.715165696834, 14471.131732096108, 14655.0, 12290.446929887998, 12438.564650237198, 12459.626211213677, 12615.810762838748, 12916.160449570747, 12134.33261170644, 12210.694732631755, 12518.812217816558, 12584.30786306762, 12681.175723577939, 12076.577319793765, 12445.25328480294, 12597.433115510008, 12789.0, 12792.74414511723, 8848.778780530538, 9014.32392570573, 9020.188183063556, 9140.954295228481, 9231.261499079923, 9290.489023103793, 12090.697732556757, 12790.872091278969, 12821.871781282067, 13313.0], "value": 9822.705191333462, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.5500067478738, 1487.9107253564787, 1559.5009596928983, 1683.3098429643849, 1829.6706592813289, 8366.874496882545, 9068.455892646438, 9510.619575217, 9556.474393908333, 9811.754706132333, 9523.761905952355, 9552.996935321795, 9623.0, 9657.903420965788, 9677.370970886905, 2472.666190064336, 2492.1402116269946, 2503.4242124311418, 2513.5098655762135, 2513.8240323177383, 2404.63930410439, 2496.301035709995, 2499.2252401755422, 2500.4749002709455, 2507.6865391826022, 2460.3972026853444, 2470.4564995701007, 2474.7401522840114, 2493.775560199582, 2495.962560561593, 2403.3991502124554, 2425.417899704076, 2440.414300567869, 2466.519028789387, 2470.0737223541173, 2374.643803429482, 2406.554787364343, 2426.8786560671897, 2427.199024321987, 2427.405285704996, 9341.439513629137, 9372.109649583279, 9521.428714277166, 9524.809503809885, 9538.52307384628, 5369.087255166631, 5578.609497335188, 5656.632318899258, 5659.26429564154, 5676.545876329884, 3666.6883314918264, 3742.7192960527796, 3751.362268414349, 3813.4470501777364, 3825.6556909878245, 1275.4005617359826, 1277.929713865737, 1282.070483921692, 1291.541502766523, 1333.5799223244744, 13382.330883455885, 13468.461261549526, 13480.797788033187, 13482.52811151605, 13492.055556111174, 4794.520547945247, 4810.062037902645, 4837.4920633332995, 4945.9258111128365, 4977.253411988231, 10637.468126593794, 10639.095676867399, 10648.946755266174, 10657.680269591925, 10661.147108231324, 5612.102063669793, 5629.605927585029, 5636.126400407943, 5646.153077038477, 5647.29408823897, 4571.817127314936, 5099.515546023122, 5198.506141916512, 5232.424433312332, 5268.367795864444, 3992.061865461614, 4012.7792971386853, 4093.795310234536, 4100.261952848516, 4152.1072969311135, 1161.4192903548226, 1171.8828117188214, 1177.1348059176498, 1185.0697202695842, 1195.6831439668495, 739.7004213293625, 937.3672770879629, 997.5211898288862, 1009.6062535611118, 1023.1610079734546, 6106.877862442726, 6416.422521973045, 6473.482121430275, 6585.6707164641575, 6687.966560167265, 526.3893883095667, 680.8867501634763, 1080.2978064258295, 1117.4915413486844, 1132.8527291452058, 4170.4995400552125, 4379.4525684289465, 4397.340398940185, 4437.955620443819, 4518.344839998182, 11889.524419023315, 12314.322712250912, 12332.691682708004, 12338.753224935452, 12339.07456940733, 12068.818967715491, 12155.149139560146, 12307.6923076922, 12334.259944403364, 12336.0, 8951.910480895238, 9030.27757779376, 9147.679831205876, 9150.633974641072, 9166.312526560534, 6347.174867267226, 6355.618662880242, 6409.7436102555375, 6432.614043157426, 6594.505412094208, 10813.783724325627, 10904.563817447213, 11118.833217501906, 11393.259438136494, 11442.542298308308, 10537.315074520131, 10752.946235269086, 10798.67603971882, 11125.554977800797, 11305.660830175108, 8183.222593853575, 8638.222559969632, 8779.078196789245, 8831.425957312755, 8860.29117670572, 9353.438793672402, 9377.249820014518, 9447.480388578695, 9456.574454149717, 9467.810643787223, 8292.12932642064, 8330.166983301622, 8341.66633334684, 8450.408471407189, 8457.87313190315, 8222.17778222197, 8252.711155109542, 8319.084900661044, 8348.123447037973, 8357.164283571594, 7239.167495738057, 7409.703611855465, 7470.775876723707, 7680.731174408869, 7688.423368247516, 5353.223782551586, 5504.394516603251, 5724.656520608777, 5869.911951320819, 5902.940970590239, 5612.102063669793, 5648.915266271091, 5775.537956963517, 5875.20684707559, 5909.0], "value": 4965.393933287784, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.36543519160807, 340.9948850767238, 348.58344278587083, 349.16026955172816, 351.76080265419523, 5498.2027605997155, 5508.7521061552225, 5553.222548843165, 5575.0, 5586.832395028146, 5471.042567550682, 5484.287042684456, 5493.983613031592, 5498.147787093007, 5522.22688823565, 4395.813130454775, 4400.44994375703, 4410.9779451102695, 4438.4451943507065, 4450.8858292311215, 3970.5235371755284, 4030.032792129882, 4329.242382583051, 4352.7823608819435, 4367.384067894867, 4321.222180007598, 4322.178786030644, 4327.372530983005, 4333.458317710286, 4337.7397356158735, 4308.138372325532, 4315.741055536678, 4328.420126653765, 4345.50026746925, 4354.8911277218, 3587.336342776595, 3688.61269566697, 3824.7322687411893, 3828.8659896903473, 3839.138018061238, 5304.6286759926825, 5318.9202161967605, 5326.174442961347, 5328.946710532922, 5337.891532844544, 4841.273808928654, 4937.506249375069, 4940.8764780880765, 4942.752862356903, 4946.72792996385, 5669.177969194485, 5680.750234948305, 5689.943100568983, 5723.799667011676, 5740.167675687002, 4243.27864263076, 4246.490421149451, 4250.4899412070445, 4256.5953235432235, 4274.829006839723, 5808.535317174616, 5954.672493012926, 6046.909296360558, 6063.666498342589, 6072.392760723937, 4303.935440968388, 4309.719868208619, 4330.2638551446325, 4345.717528360709, 4368.934465983013, 4414.713043652152, 4418.756968366771, 4419.9779001105435, 4427.690061695715, 4453.19842428366, 4748.382710247645, 4951.851444456672, 4954.3063971044085, 4972.57733092684, 4982.9252561211615, 5748.19525266463, 5765.1928729977835, 5770.740316685759, 5771.59598828078, 5774.740136693859, 1508.2232650184944, 1525.2678714217016, 1529.4341093795367, 1547.674988252457, 1548.4735190035217, 932.3520153493257, 949.4445749236774, 973.3478569358547, 979.8530220466987, 985.9211263098935, 5020.59835213182, 5028.245763135559, 5029.220470827027, 5398.94959347975, 5590.413006634326, 5910.379410161871, 5933.406659334032, 5935.40645935403, 5936.28764548257, 5961.850953726105, 5618.803341883015, 5646.520045796154, 5651.802186923438, 5657.858553536194, 5682.204491371129, 3050.054483110243, 3117.8752849886205, 3132.592762940803, 3140.8378899807217, 3169.4453470642547, 6128.3258841527395, 6151.323354431009, 6166.136740856284, 6169.619570105186, 6172.475339596184, 5705.657660540381, 5949.018411962064, 5976.282846058501, 6041.667708276087, 6085.087236914498, 6054.395585170021, 6097.2683278006925, 6126.172966649446, 6130.141780150782, 6134.662593557308, 5760.366359700513, 5893.057110862242, 5944.910826337522, 5958.851028724316, 6028.819135425944, 5827.649101766586, 5845.269341332333, 5848.64908105515, 5854.824355269348, 5889.0, 6076.240469941257, 6163.767246550618, 6170.568060235741, 6170.6914654268, 6197.17183430898, 4051.230266249403, 4266.765327906995, 4272.978635106804, 4368.148211098805, 4373.8846594118295, 5961.642301461753, 5965.343812180743, 5975.0, 5989.580729349078, 5993.130996005642, 5834.095715164156, 5866.735996880066, 5876.823695289148, 5886.0, 5907.670774075798, 5581.74882130297, 5816.127580862904, 5821.679807610622, 5842.364138041356, 5865.885481758452, 5796.739146738491, 5802.390748971297, 5810.448007439287, 5822.126680997715, 5837.562182836389, 5659.207710920557, 5835.066389377679, 5871.706414679335, 5883.676397798162, 5923.259592550931, 5686.004949133968, 5706.630408701964, 5710.314762228559, 5729.197912292366, 5734.340550836707], "value": 4428.651111079872, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.2689379529767, 760.5322726523189, 763.1033535595674, 767.2749251956901, 813.0852790610563, 16394.18029098545, 17329.566760830985, 17367.565810854736, 17511.562210944718, 17533.649327013467, 16171.0, 16457.012579245253, 16469.505914822545, 16480.42318518852, 16486.01083934965, 728.2608152724988, 845.9154084591553, 854.5043874552775, 863.404251066765, 870.6822009966348, 895.771578247546, 895.8566629339307, 899.5232526760827, 899.7390756680587, 899.8875140607424, 957.3920560444134, 958.5542722633974, 959.596969272907, 959.8848138223423, 960.0831206198098, 765.4565258666354, 791.4894892794144, 794.7496538590383, 898.7438580004667, 949.4255975135047, 693.5665209244222, 697.1111832413662, 697.7209116353448, 697.8081027717368, 698.1935864077, 15148.924255378763, 15228.390864365412, 15241.16173610451, 15297.311620977083, 15341.386344546205, 15811.525654230392, 15854.524364269091, 15854.762178567331, 16032.278547465392, 16307.83692163087, 14293.714125717532, 14325.161905518664, 14424.423023079064, 14546.854531454655, 14747.115173089649, 4829.855104346875, 4856.465788763233, 4873.80504779812, 4956.231784073474, 5013.899722005576, 85928.0, 86199.56900215521, 87123.0, 93052.0, 93163.53418232933, 12122.878771212352, 12408.069394795426, 12430.813537796941, 12506.437210325557, 12697.746045079231, 20264.898675506527, 20405.693914591295, 20430.284940027326, 20543.38369848907, 20714.067866946025, 8520.829583408296, 9162.450252984841, 9185.219256363283, 9219.953900230455, 9523.190528804991, 5094.61790365724, 5248.1340578804065, 5316.521513063843, 5333.2266821310695, 5343.011542864582, 3535.9469607955903, 3647.6534729200685, 3647.8176091195332, 3648.635136486383, 3655.5065066216252, 645.3062957320805, 645.5223134880155, 652.709544252803, 652.8216569092833, 672.4821887146869, 724.8332883436839, 738.2138023005482, 760.7413479417024, 762.2758379539459, 765.2691679446116, 10064.496775161213, 10099.242556808269, 10553.419561924014, 10668.62659806903, 10762.838557421645, 623.5759683415231, 688.1363888320126, 739.807650011001, 749.7151082588581, 753.9623018849036, 4643.210654188796, 4818.542238487338, 5074.619403544749, 5091.287219789232, 5113.565346945551, 79893.0, 80282.5985870067, 136313.0, 140927.0, 142798.0, 116605.0, 119096.0, 121268.0, 123097.38451307686, 125418.0, 67777.3222267771, 79407.20592794113, 80495.0, 100982.49508752409, 103391.0, 9489.66786162481, 10135.746606334606, 10318.690439286833, 10473.162147028372, 10869.076128529163, 39057.414138787375, 51403.0, 52806.0, 54087.45912540824, 54460.45539544713, 72784.0, 81303.0, 81684.59157704173, 86067.0, 86624.13375866161, 13955.58133256004, 14196.895335006047, 14223.502177423741, 14419.134851908919, 14508.564743057725, 15831.208439577744, 15958.361665533248, 15961.8403815965, 16043.679126417639, 16100.355985760907, 14867.479638212611, 15088.698226035198, 15117.1685557291, 15381.615459613151, 15838.52484425469, 14020.228887410882, 14190.219537925514, 14218.431262749375, 14520.782188267396, 14656.853431465976, 14199.148051116967, 14944.92527537399, 14978.700425991638, 15427.0, 15675.608109797346, 11418.257813242444, 11627.418629068681, 11668.649940501798, 11967.401629918644, 12337.629871103882, 11763.705907352043, 11801.0, 11823.290602563873, 12002.279863208236, 12094.213876098025], "value": 8140.842732638263, "unit": "score"}], "name": "dromaeo_css", "value": 7680.39777983606, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 111.0, 112.0, 113.0, 110.0, 110.0, 111.0, 112.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 114.0, 115.0, 169.0, 122.0, 124.0, 137.0, 115.0, 162.0, 117.0], "value": 132.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 162.0, 160.0, 161.0, 163.0, 162.0, 160.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 109.0, 76.0, 75.0, 75.0, 76.0, 107.0, 74.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 138.0, 84.0, 84.0, 84.0, 129.0, 82.0, 83.0, 126.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 98.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 49.0, 49.0, 50.0, 51.0, 50.0, 50.0, 49.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 71.0, 71.0, 80.0, 74.0, 72.0, 77.0, 71.0, 76.0], "value": 73.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 117.0, 125.0, 127.0, 114.0, 115.0, 117.0, 119.0, 188.0, 118.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 155.0, 151.0, 154.0, 151.0, 150.0, 151.0, 152.0, 152.0, 152.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 68.0, 63.0, 62.0, 62.0, 63.0, 61.0, 61.0, 61.0, 64.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1466.8, "alertThreshold": 2.0}]} 10:24:05 INFO - Return code: 0 10:24:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:24:05 INFO - # TBPL SUCCESS # 10:24:05 INFO - Running post-action listener: _resource_record_post_action 10:24:05 INFO - [mozharness: 2016-09-05 17:24:05.351859Z] Finished run-tests step (success) 10:24:05 INFO - Running post-run listener: _resource_record_post_run 10:24:05 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 329420800; Read time: 32; Write time: 313084 10:24:05 INFO - TinderboxPrint: CPU usage
12.9% 10:24:05 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 10:24:05 INFO - TinderboxPrint: I/O write bytes / time
329,420,800 / 313,084 10:24:05 INFO - TinderboxPrint: CPU idle
8,276.5 (87.1%) 10:24:05 INFO - TinderboxPrint: CPU user
1,183.6 (12.5%) 10:24:05 INFO - TinderboxPrint: Swap in / out
0 / 0 10:24:05 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 79343616; Read time: 0; Write time: 110736 10:24:05 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 249708544; Read time: 24; Write time: 202268 10:24:05 INFO - Running post-run listener: _upload_blobber_files 10:24:05 INFO - Blob upload gear active. 10:24:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:24:05 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 10:24:05 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:24:05 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:24:06 INFO - (blobuploader) - INFO - Open directory for files ... 10:24:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:24:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:24:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:07 INFO - (blobuploader) - INFO - Done attempting. 10:24:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:24:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:24:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:07 INFO - (blobuploader) - INFO - Done attempting. 10:24:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:24:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:24:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:12 INFO - (blobuploader) - INFO - Done attempting. 10:24:12 INFO - (blobuploader) - INFO - Iteration through files over. 10:24:12 INFO - Return code: 0 10:24:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:24:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:24:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f4063c1542bee6b58ce447c96f9074f5009156600619bcc4f9b506263271d39faf9ac701db689e7061623e856b0d2ac060253c9f9578c0253a4fee026228d2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c497efe4387576046833fda87250b6008d8e50b6045ac43d97d420e211b522c829ce1810c6b117a7930cf4d7a4f667f8a13fb66b23376b15c2892d9f20e39870", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b54bd22944e4502a0ed71d650d1adcde4a1619ff2d734bdb11402c9f5d81af71fe2895d86bf3e4a1090c99295ab377e32cba4613b5e0538de8e0719617b3c24"} 10:24:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:24:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:24:12 INFO - Contents: 10:24:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f4063c1542bee6b58ce447c96f9074f5009156600619bcc4f9b506263271d39faf9ac701db689e7061623e856b0d2ac060253c9f9578c0253a4fee026228d2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c497efe4387576046833fda87250b6008d8e50b6045ac43d97d420e211b522c829ce1810c6b117a7930cf4d7a4f667f8a13fb66b23376b15c2892d9f20e39870", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b54bd22944e4502a0ed71d650d1adcde4a1619ff2d734bdb11402c9f5d81af71fe2895d86bf3e4a1090c99295ab377e32cba4613b5e0538de8e0719617b3c24"} 10:24:12 INFO - Running post-run listener: copy_logs_to_upload_dir 10:24:12 INFO - Copying logs to upload dir... 10:24:12 INFO - mkdir: /builds/slave/test/build/upload/logs 10:24:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1680.655637 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 28 mins, 0 secs) (at 2016-09-05 10:24:11.376305) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-05 10:24:11.380108) ========= 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=17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f4063c1542bee6b58ce447c96f9074f5009156600619bcc4f9b506263271d39faf9ac701db689e7061623e856b0d2ac060253c9f9578c0253a4fee026228d2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c497efe4387576046833fda87250b6008d8e50b6045ac43d97d420e211b522c829ce1810c6b117a7930cf4d7a4f667f8a13fb66b23376b15c2892d9f20e39870", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b54bd22944e4502a0ed71d650d1adcde4a1619ff2d734bdb11402c9f5d81af71fe2895d86bf3e4a1090c99295ab377e32cba4613b5e0538de8e0719617b3c24"} build_url:https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6f4063c1542bee6b58ce447c96f9074f5009156600619bcc4f9b506263271d39faf9ac701db689e7061623e856b0d2ac060253c9f9578c0253a4fee026228d2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c497efe4387576046833fda87250b6008d8e50b6045ac43d97d420e211b522c829ce1810c6b117a7930cf4d7a4f667f8a13fb66b23376b15c2892d9f20e39870", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b54bd22944e4502a0ed71d650d1adcde4a1619ff2d734bdb11402c9f5d81af71fe2895d86bf3e4a1090c99295ab377e32cba4613b5e0538de8e0719617b3c24"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-05 10:24:11.409101) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 10:24:11.409424) ========= 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=17051fcd5208b27b50bedfeb000001dd-1473093262.114352-872108352 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 10:24:11.494100) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-05 10:24:11.494451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-05 10:24:11.494791) ========= ========= Total master_lag: 0.20 =========