builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-034 starttime: 1473094569.67 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.667348) ========= 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.667791) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.668103) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.717895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.718224) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-05 09:56:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.6M=0s 2016-09-05 09:56:09 (50.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088466 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.829190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.829505) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014818 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.880351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:09.880717) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-05 09:56:10,004 truncating revision to first 12 chars 2016-09-05 09:56:10,004 Setting DEBUG logging. 2016-09-05 09:56:10,004 attempt 1/10 2016-09-05 09:56:10,004 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,320 unpacking tar archive at: mozilla-aurora-efc8bd58d7c8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655926 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:10.552556) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:10.552904) ========= script_repo_revision: efc8bd58d7c887c7c9c66931a5ae4a126405d0ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:10.553336) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:10.553707) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-05 09:56:10.573814) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-09-05 09:56:10.574135) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=d6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:56:10 INFO - MultiFileLogger online at 20160905 09:56:10 in /builds/slave/test 09:56:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:56:10 INFO - {'append_to_log': False, 09:56:10 INFO - 'base_work_dir': '/builds/slave/test', 09:56:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:56:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:56:10 INFO - 'branch': 'Mozilla-Aurora', 09:56:10 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:10 INFO - 'config_files': ('talos/linux_config.py',), 09:56:10 INFO - 'default_actions': ('clobber', 09:56:10 INFO - 'read-buildbot-config', 09:56:10 INFO - 'download-and-extract', 09:56:10 INFO - 'populate-webroot', 09:56:10 INFO - 'create-virtualenv', 09:56:10 INFO - 'install', 09:56:10 INFO - 'run-tests'), 09:56:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:10 INFO - 'download_minidump_stackwalk': True, 09:56:10 INFO - 'download_symbols': 'ondemand', 09:56:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:10 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:10 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:10 INFO - 'installer_path': 'installer.exe', 09:56:10 INFO - 'log_level': 'info', 09:56:10 INFO - 'log_name': 'talos', 09:56:10 INFO - 'log_to_console': True, 09:56:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:56:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:56:10 INFO - 'opt_config_files': (), 09:56:10 INFO - 'pip_index': False, 09:56:10 INFO - 'sps_profile': False, 09:56:10 INFO - 'sps_profile_interval': 0, 09:56:10 INFO - 'suite': 'dromaeojs-e10s', 09:56:10 INFO - 'system_bits': '32', 09:56:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:10 INFO - 'title': 'talos-linux64-ix-034', 09:56:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:10 INFO - 'use_talos_json': True, 09:56:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:56:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:10 INFO - 'work_dir': 'build'} 09:56:10 INFO - [mozharness: 2016-09-05 16:56:10.787405Z] Running clobber step. 09:56:10 INFO - Running pre-action listener: _resource_record_pre_action 09:56:10 INFO - Running main action method: clobber 09:56:10 INFO - rmtree: /builds/slave/test/build 09:56:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:56:11 INFO - Running post-action listener: _resource_record_post_action 09:56:11 INFO - [mozharness: 2016-09-05 16:56:11.246736Z] Finished clobber step (success) 09:56:11 INFO - [mozharness: 2016-09-05 16:56:11.246837Z] Running read-buildbot-config step. 09:56:11 INFO - Running pre-action listener: _resource_record_pre_action 09:56:11 INFO - Running main action method: read_buildbot_config 09:56:11 INFO - Using buildbot properties: 09:56:11 INFO - { 09:56:11 INFO - "project": "", 09:56:11 INFO - "product": "firefox", 09:56:11 INFO - "script_repo_revision": "production", 09:56:11 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:56:11 INFO - "repository": "", 09:56:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:56:11 INFO - "buildid": "20160905071419", 09:56:11 INFO - "pgo_build": "True", 09:56:11 INFO - "basedir": "/builds/slave/test", 09:56:11 INFO - "buildnumber": 536, 09:56:11 INFO - "slavename": "talos-linux64-ix-034", 09:56:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:56:11 INFO - "platform": "ubuntu64_hw", 09:56:11 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:56:11 INFO - "branch": "mozilla-aurora", 09:56:11 INFO - "repo_path": "releases/mozilla-aurora", 09:56:11 INFO - "revision": "efc8bd58d7c887c7c9c66931a5ae4a126405d0ac", 09:56:11 INFO - "stage_platform": "linux64-pgo", 09:56:11 INFO - "builduid": "ef232f6d88d74098976031283512d768", 09:56:11 INFO - "slavebuilddir": "test" 09:56:11 INFO - } 09:56:11 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:11 INFO - Running post-action listener: _resource_record_post_action 09:56:11 INFO - [mozharness: 2016-09-05 16:56:11.249274Z] Finished read-buildbot-config step (success) 09:56:11 INFO - [mozharness: 2016-09-05 16:56:11.249365Z] Running download-and-extract step. 09:56:11 INFO - Running pre-action listener: _resource_record_pre_action 09:56:11 INFO - Running main action method: download_and_extract 09:56:11 INFO - mkdir: /builds/slave/test/build/tests 09:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:11 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:11 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:11 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:11 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:11 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:11 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:11 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:56:11 INFO - retry: Failed, sleeping 30 seconds before retrying 09:56:41 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:41 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:41 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:56:41 INFO - retry: Failed, sleeping 60 seconds before retrying 09:57:41 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:41 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:41 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:57:41 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:41 INFO - Caught exception: HTTP Error 404: Not Found 09:57:41 INFO - Caught exception: HTTP Error 404: Not Found 09:57:41 INFO - Caught exception: HTTP Error 404: Not Found 09:57:41 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:41 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:41 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:41 INFO - Downloaded 1361 bytes. 09:57:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 09:57:41 INFO - Using the following test package requirements: 09:57:41 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 09:57:41 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:41 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:57:41 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:41 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:57:41 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:41 INFO - u'jsshell-linux-x86_64.zip'], 09:57:41 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:41 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:57:41 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 09:57:41 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:41 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:57:41 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:41 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:57:41 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:41 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:57:41 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:41 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:57:41 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:41 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:41 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:41 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:41 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:41 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:41 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:41 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 09:57:41 INFO - retry: Failed, sleeping 30 seconds before retrying 09:58:12 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: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.common.tests.zip 09:58:12 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 09:58:12 INFO - retry: Failed, sleeping 60 seconds before retrying 09:59:12 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: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.common.tests.zip 09:59:12 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 09:59:12 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:12 INFO - Caught exception: HTTP Error 404: Not Found 09:59:12 INFO - Caught exception: HTTP Error 404: Not Found 09:59:12 INFO - Caught exception: HTTP Error 404: Not Found 09:59:12 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:12 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:12 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:13 INFO - Downloaded 21771433 bytes. 09:59:13 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:13 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:47 INFO - Return code: 0 10:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:47 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:47 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:47 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:47 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:47 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:47 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:47 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:00:47 INFO - retry: Failed, sleeping 30 seconds before retrying 10:01:17 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:17 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:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:01:17 INFO - retry: Failed, sleeping 60 seconds before retrying 10:02:17 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:17 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:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:02:17 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:17 INFO - Caught exception: HTTP Error 404: Not Found 10:02:17 INFO - Caught exception: HTTP Error 404: Not Found 10:02:17 INFO - Caught exception: HTTP Error 404: Not Found 10:02:17 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:17 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:17 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:19 INFO - Return code: 0 10:02:19 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:19 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:19 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:19 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:19 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:19 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:19 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:19 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 10:02:19 INFO - retry: Failed, sleeping 30 seconds before retrying 10:02:49 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:49 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:49 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 10:02:49 INFO - retry: Failed, sleeping 60 seconds before retrying 10:03:49 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:49 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:49 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 10:03:49 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:49 INFO - Caught exception: HTTP Error 404: Not Found 10:03:49 INFO - Caught exception: HTTP Error 404: Not Found 10:03:49 INFO - Caught exception: HTTP Error 404: Not Found 10:03:49 INFO - trying https://queue.taskcluster.net/v1/task/UyVGqMttRlmjVMq5NQbflQ/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 10:03:49 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:49 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:51 INFO - Running post-action listener: _resource_record_post_action 10:03:51 INFO - Running post-action listener: set_extra_try_arguments 10:03:51 INFO - [mozharness: 2016-09-05 17:03:51.916194Z] Finished download-and-extract step (success) 10:03:51 INFO - [mozharness: 2016-09-05 17:03:51.916427Z] Running populate-webroot step. 10:03:51 INFO - Running pre-action listener: _resource_record_pre_action 10:03:51 INFO - Running main action method: populate_webroot 10:03:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:03:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:03:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:03:51 INFO - '--tppagecycles', 10:03:51 INFO - '7'], 10:03:51 INFO - 'tests': ['tsvgm']}}, 10:03:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:03:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:03:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:03:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:03:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:03:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:03:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:51 INFO - 'talos_options': ['--disable-e10s'], 10:03:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:03:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:51 INFO - 'talos_options': ['--disable-e10s'], 10:03:51 INFO - 'tests': ['damp', 'tps']}, 10:03:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:51 INFO - 'tests': ['damp', 'tps']}, 10:03:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:03:51 INFO - 'tests': ['dromaeo_dom']}, 10:03:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:03:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:03:51 INFO - 'tests': ['basic_compositor_video']}, 10:03:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:03:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:03:51 INFO - 'tests': ['a11yr', 10:03:51 INFO - 'ts_paint', 10:03:51 INFO - 'tpaint', 10:03:51 INFO - 'sessionrestore', 10:03:51 INFO - 'sessionrestore_no_auto_restore', 10:03:51 INFO - 'tabpaint']}, 10:03:51 INFO - 'other-e10s': {'tests': ['a11yr', 10:03:51 INFO - 'ts_paint', 10:03:51 INFO - 'tpaint', 10:03:51 INFO - 'sessionrestore', 10:03:51 INFO - 'sessionrestore_no_auto_restore', 10:03:51 INFO - 'tabpaint']}, 10:03:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:03:51 INFO - 'ts_paint', 10:03:51 INFO - 'tpaint', 10:03:51 INFO - 'sessionrestore', 10:03:51 INFO - 'sessionrestore_no_auto_restore', 10:03:51 INFO - 'tabpaint']}, 10:03:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:03:51 INFO - 'ts_paint', 10:03:51 INFO - 'tpaint', 10:03:51 INFO - 'sessionrestore', 10:03:51 INFO - 'sessionrestore_no_auto_restore', 10:03:51 INFO - 'tabpaint']}, 10:03:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:03:51 INFO - 'tests': ['a11yr', 10:03:51 INFO - 'ts_paint', 10:03:51 INFO - 'tpaint', 10:03:51 INFO - 'sessionrestore', 10:03:51 INFO - 'sessionrestore_no_auto_restore', 10:03:51 INFO - 'tabpaint']}, 10:03:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:03:51 INFO - 'tests': ['a11yr', 10:03:51 INFO - 'ts_paint', 10:03:51 INFO - 'tpaint', 10:03:51 INFO - 'sessionrestore', 10:03:51 INFO - 'sessionrestore_no_auto_restore', 10:03:51 INFO - 'tabpaint']}, 10:03:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:03:51 INFO - 'tests': ['tsvgx', 10:03:51 INFO - 'tsvgr_opacity', 10:03:51 INFO - 'tart', 10:03:51 INFO - 'tscrollx', 10:03:51 INFO - 'cart']}, 10:03:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:03:51 INFO - 'tsvgr_opacity', 10:03:51 INFO - 'tart', 10:03:51 INFO - 'tscrollx', 10:03:51 INFO - 'cart']}, 10:03:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:51 INFO - 'talos_options': ['--disable-e10s'], 10:03:51 INFO - 'tests': ['tp5o']}, 10:03:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:51 INFO - 'tests': ['tp5o']}, 10:03:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:51 INFO - 'talos_options': ['--disable-e10s', 10:03:51 INFO - '--xperf_path', 10:03:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:51 INFO - 'tests': ['tp5n']}, 10:03:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:03:51 INFO - 'talos_options': ['--xperf_path', 10:03:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:03:51 INFO - 'tests': ['tp5n']}}, 10:03:51 INFO - 'talos.zip': {'path': '', 10:03:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:03:51 INFO - Running post-action listener: _resource_record_post_action 10:03:51 INFO - [mozharness: 2016-09-05 17:03:51.933699Z] Finished populate-webroot step (success) 10:03:51 INFO - [mozharness: 2016-09-05 17:03:51.933789Z] Running create-virtualenv step. 10:03:51 INFO - Running pre-action listener: _resource_record_pre_action 10:03:51 INFO - Running main action method: create_virtualenv 10:03:51 INFO - Creating virtualenv /builds/slave/test/build/venv 10:03:51 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:51 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:52 INFO - Installing distribute.............................................................................................................................................................................................done. 10:03:54 INFO - Installing pip.................done. 10:03:54 INFO - Return code: 0 10:03:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:54 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 0x1bee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac570>, '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 0x1ead470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ead900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', '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:54 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:54 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:54 INFO - Using env: {'DISPLAY': ':0', 10:03:54 INFO - 'HOME': '/home/cltbld', 10:03:54 INFO - 'LANG': 'en_US.UTF-8', 10:03:54 INFO - 'LANGUAGE': 'en_US:en', 10:03:54 INFO - 'LOGNAME': 'cltbld', 10:03:54 INFO - 'MAIL': '/var/mail/cltbld', 10:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:54 INFO - 'MOZ_NO_REMOTE': '1', 10:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:54 INFO - 'NO_EM_RESTART': '1', 10:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:54 INFO - 'PWD': '/builds/slave/test', 10:03:54 INFO - 'SHELL': '/bin/bash', 10:03:54 INFO - 'SHLVL': '1', 10:03:54 INFO - 'TERM': 'linux', 10:03:54 INFO - 'TMOUT': '86400', 10:03:54 INFO - 'USER': 'cltbld', 10:03:54 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', 10:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:54 INFO - '_': '/tools/buildbot/bin/python'} 10:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:54 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:54 INFO - Cleaning up... 10:03:54 INFO - Return code: 0 10:03:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:54 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 0x1bee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac570>, '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 0x1ead470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ead900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', '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:54 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:54 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:54 INFO - Using env: {'DISPLAY': ':0', 10:03:54 INFO - 'HOME': '/home/cltbld', 10:03:54 INFO - 'LANG': 'en_US.UTF-8', 10:03:54 INFO - 'LANGUAGE': 'en_US:en', 10:03:54 INFO - 'LOGNAME': 'cltbld', 10:03:54 INFO - 'MAIL': '/var/mail/cltbld', 10:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:54 INFO - 'MOZ_NO_REMOTE': '1', 10:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:54 INFO - 'NO_EM_RESTART': '1', 10:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:54 INFO - 'PWD': '/builds/slave/test', 10:03:54 INFO - 'SHELL': '/bin/bash', 10:03:54 INFO - 'SHLVL': '1', 10:03:54 INFO - 'TERM': 'linux', 10:03:54 INFO - 'TMOUT': '86400', 10:03:54 INFO - 'USER': 'cltbld', 10:03:54 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', 10:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:54 INFO - '_': '/tools/buildbot/bin/python'} 10:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:54 INFO - Downloading/unpacking psutil>=3.1.1 10:03:54 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:54 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:54 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:54 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:54 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:54 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:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:03:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:03:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:03:56 INFO - Installing collected packages: psutil 10:03:56 INFO - Running setup.py install for psutil 10:03:56 INFO - building 'psutil._psutil_linux' extension 10:03:56 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 0x1bee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac570>, '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 0x1ead470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ead900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', '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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', 10:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:57 INFO - '_': '/tools/buildbot/bin/python'} 10:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:03:57 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:57 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 - 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:57 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:57 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:57 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:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:03:59 INFO - Installing collected packages: mozsystemmonitor 10:03:59 INFO - Running setup.py install for mozsystemmonitor 10:03:59 INFO - Successfully installed mozsystemmonitor 10:03:59 INFO - Cleaning up... 10:03:59 INFO - Return code: 0 10:03:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:03:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:03:59 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 0x1bee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac570>, '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 0x1ead470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ead900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', '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:59 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:03:59 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:03:59 INFO - Using env: {'DISPLAY': ':0', 10:03:59 INFO - 'HOME': '/home/cltbld', 10:03:59 INFO - 'LANG': 'en_US.UTF-8', 10:03:59 INFO - 'LANGUAGE': 'en_US:en', 10:03:59 INFO - 'LOGNAME': 'cltbld', 10:03:59 INFO - 'MAIL': '/var/mail/cltbld', 10:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:59 INFO - 'MOZ_NO_REMOTE': '1', 10:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:59 INFO - 'NO_EM_RESTART': '1', 10:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:59 INFO - 'PWD': '/builds/slave/test', 10:03:59 INFO - 'SHELL': '/bin/bash', 10:03:59 INFO - 'SHLVL': '1', 10:03:59 INFO - 'TERM': 'linux', 10:03:59 INFO - 'TMOUT': '86400', 10:03:59 INFO - 'USER': 'cltbld', 10:03:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', 10:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:59 INFO - '_': '/tools/buildbot/bin/python'} 10:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:59 INFO - Downloading/unpacking jsonschema==2.5.1 10:03:59 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:59 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:59 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:59 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:59 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:59 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:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:04:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:04:01 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:01 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:01 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:01 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:01 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:01 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 0x1bee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac570>, '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 0x1ead470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ead900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', '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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', 10:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:02 INFO - '_': '/tools/buildbot/bin/python'} 10:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:04:02 INFO - Cleaning up... 10:04:02 INFO - Return code: 0 10:04:02 INFO - Installing blobuploader==1.2.4 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', '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 0x1bee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac570>, '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 0x1ead470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ead900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', '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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', 10:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:02 INFO - '_': '/tools/buildbot/bin/python'} 10:04:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:04:02 INFO - Downloading/unpacking blobuploader==1.2.4 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:04 INFO - Downloading blobuploader-1.2.4.tar.gz 10:04:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:04:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:04:04 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:04 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:04 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:04 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:04 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:04 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:04 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:05 INFO - Running setup.py install for docopt 10:04:05 INFO - Successfully installed blobuploader requests docopt 10:04:05 INFO - Cleaning up... 10:04:05 INFO - Return code: 0 10:04:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:04:05 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:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:04:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:05 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:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:04:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:04:05 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 0x1bee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac570>, '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 0x1ead470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ead900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', '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:05 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:05 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:05 INFO - Using env: {'DISPLAY': ':0', 10:04:05 INFO - 'HOME': '/home/cltbld', 10:04:05 INFO - 'LANG': 'en_US.UTF-8', 10:04:05 INFO - 'LANGUAGE': 'en_US:en', 10:04:05 INFO - 'LOGNAME': 'cltbld', 10:04:05 INFO - 'MAIL': '/var/mail/cltbld', 10:04:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:05 INFO - 'MOZ_NO_REMOTE': '1', 10:04:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:05 INFO - 'NO_EM_RESTART': '1', 10:04:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:05 INFO - 'PWD': '/builds/slave/test', 10:04:05 INFO - 'SHELL': '/bin/bash', 10:04:05 INFO - 'SHLVL': '1', 10:04:05 INFO - 'TERM': 'linux', 10:04:05 INFO - 'TMOUT': '86400', 10:04:05 INFO - 'USER': 'cltbld', 10:04:05 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', 10:04:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:05 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-Lx45Ze-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-GJWSWK-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-ZHSH21-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-VNbThL-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-SyrrzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:06 INFO - Running setup.py (path:/tmp/pip-K46c9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:06 INFO - Running setup.py (path:/tmp/pip-sKzvmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:06 INFO - Running setup.py (path:/tmp/pip-eYI681-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:04:06 INFO - Running setup.py (path:/tmp/pip-jpzAKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:04:06 INFO - Running setup.py (path:/tmp/pip-uOoLHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:04:06 INFO - Running setup.py (path:/tmp/pip-Ah_kTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:04:06 INFO - Running setup.py (path:/tmp/pip-F1aU1I-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-ZACN72-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-ljyRoj-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-9EQnPZ-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-hhjb5W-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-LnxIje-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:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:04:07 INFO - Running setup.py install for mozcrash 10:04:07 INFO - Running setup.py install for mozdebug 10:04:07 INFO - Running setup.py install for mozdevice 10:04:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:04:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:04:07 INFO - Running setup.py install for mozfile 10:04:07 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:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:04:08 INFO - Running setup.py install for mozprocess 10:04:08 INFO - Running setup.py install for mozprofile 10:04:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:04:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:04:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:04:08 INFO - Running setup.py install for mozrunner 10:04:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:04:08 INFO - Running setup.py install for mozscreenshot 10:04:08 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 0x1bee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac570>, '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 0x1ead470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ead900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', '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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', 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-F0NhuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:04:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:04:09 INFO - Running setup.py (path:/tmp/pip-gOT9fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:04:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:04:09 INFO - Running setup.py (path:/tmp/pip-bLJLw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:04:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:04:09 INFO - Running setup.py (path:/tmp/pip-QtcPW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:04:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:04:09 INFO - Running setup.py (path:/tmp/pip-oWrV_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:04:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:04:09 INFO - Running setup.py (path:/tmp/pip-mUx4lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:04:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:04:09 INFO - Running setup.py (path:/tmp/pip-QvfPkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:04:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:04:09 INFO - Running setup.py (path:/tmp/pip-aaw7C8-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-kYFZvJ-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-9a7HJk-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-WUebYg-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-SgEqOp-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-6Ok26q-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-NnQYIe-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-RnzZpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:04:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:04:10 INFO - Running setup.py (path:/tmp/pip-AH1L6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:04:10 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:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:04:10 INFO - Running setup.py (path:/tmp/pip-JlRWkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:04:10 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:10 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:10 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:10 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:10 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:10 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:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:04:10 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:10 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:10 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:10 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:10 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:10 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:12 INFO - Downloading blessings-1.6.tar.gz 10:04:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:04:12 INFO - Installing collected packages: blessings 10:04:12 INFO - Running setup.py install for blessings 10:04:12 INFO - Successfully installed blessings 10:04:12 INFO - Cleaning up... 10:04:12 INFO - Return code: 0 10:04:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:04:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:04:12 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 0x1bee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac570>, '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 0x1ead470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ead900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', '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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', 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 0x1bee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e1d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eac570>, '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 0x1ead470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ead900>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', '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': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', 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.475648Z] Finished create-virtualenv step (success) 10:04:13 INFO - [mozharness: 2016-09-05 17:04:13.476078Z] 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:13 INFO - Reading from file tmpfile_stdout 10:04:13 INFO - Detecting whether we're running mozinstall >=1.0... 10:04:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:04:13 INFO - Reading from file tmpfile_stdout 10:04:13 INFO - Output received: 10:04:13 INFO - Usage: mozinstall [options] installer 10:04:13 INFO - Options: 10:04:13 INFO - -h, --help show this help message and exit 10:04:13 INFO - -d DEST, --destination=DEST 10:04:13 INFO - Directory to install application into. [default: 10:04:13 INFO - "/builds/slave/test"] 10:04:13 INFO - --app=APP Application being installed. [default: firefox] 10:04:13 INFO - mkdir: /builds/slave/test/build/application 10:04:13 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:13 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:30 INFO - Reading from file tmpfile_stdout 10:04:30 INFO - Output received: 10:04:30 INFO - /builds/slave/test/build/application/firefox/firefox 10:04:30 INFO - Running post-action listener: _resource_record_post_action 10:04:30 INFO - [mozharness: 2016-09-05 17:04:30.511052Z] Finished install step (success) 10:04:30 INFO - [mozharness: 2016-09-05 17:04:30.511328Z] Running run-tests step. 10:04:30 INFO - Running pre-action listener: _resource_record_pre_action 10:04:30 INFO - Running main action method: run_tests 10:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:04:30 INFO - Python 2.7.3 10:04:30 INFO - Return code: 0 10:04:30 INFO - grabbing minidump binary from tooltool 10:04:30 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:30 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 0x1eac570>, '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 0x1ead470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ead900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:04:30 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:30 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:30 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:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:04:30 INFO - Return code: 0 10:04:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:04:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:04:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:04:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:04:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:04:30 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-e10s', '--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-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:04:30 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-e10s --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-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:04:30 INFO - Using env: {'DISPLAY': ':0', 10:04:30 INFO - 'HOME': '/home/cltbld', 10:04:30 INFO - 'LANG': 'en_US.UTF-8', 10:04:30 INFO - 'LANGUAGE': 'en_US:en', 10:04:30 INFO - 'LOGNAME': 'cltbld', 10:04:30 INFO - 'MAIL': '/var/mail/cltbld', 10:04:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:04:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:04:30 INFO - 'MOZ_NO_REMOTE': '1', 10:04:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:04:30 INFO - 'NO_EM_RESTART': '1', 10:04:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:04:30 INFO - 'PWD': '/builds/slave/test', 10:04:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:04:30 INFO - 'SHELL': '/bin/bash', 10:04:30 INFO - 'SHLVL': '1', 10:04:30 INFO - 'TERM': 'linux', 10:04:30 INFO - 'TMOUT': '86400', 10:04:30 INFO - 'USER': 'cltbld', 10:04:30 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199', 10:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:04:30 INFO - '_': '/tools/buildbot/bin/python'} 10:04:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--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-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:04:30 INFO - mozversion application_buildid: 20160905071419 10:04:30 INFO - mozversion application_changeset: efc8bd58d7c887c7c9c66931a5ae4a126405d0ac 10:04:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:04:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:04:30 INFO - mozversion application_name: Firefox 10:04:30 INFO - mozversion application_remotingname: firefox-dev 10:04:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:04:30 INFO - mozversion application_vendor: Mozilla 10:04:30 INFO - mozversion application_version: 50.0a2 10:04:30 INFO - mozversion platform_buildid: 20160905071419 10:04:30 INFO - mozversion platform_changeset: efc8bd58d7c887c7c9c66931a5ae4a126405d0ac 10:04:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:04:30 INFO - mozversion platform_version: 50.0a2 10:04:30 INFO - using testdate: 1473095070 10:04:30 INFO - actual date: 1473095070 10:04:30 INFO - starting webserver on 'localhost:34111' 10:04:30 INFO - SUITE-START | Running 2 tests 10:04:30 INFO - TEST-START | dromaeo_css 10:04:30 INFO - operating with platform_type : linux_ 10:04:30 INFO - Initialising browser for dromaeo_css test... 10:04:30 INFO - TEST-INFO | started process 3940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTN8JyB/profile http://localhost:34111/getInfo.html) 10:04:35 INFO - PROCESS | 3940 | __metrics Screen width/height:1600/1200 10:04:35 INFO - PROCESS | 3940 | colorDepth:24 10:04:35 INFO - PROCESS | 3940 | Browser inner width/height: 1024/697 10:04:35 INFO - PROCESS | 3940 | __metrics 10:04:36 ERROR - PROCESS | 3940 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:04:36 INFO - TEST-INFO | 3940: exit 0 10:04:36 INFO - Browser initialized. 10:04:36 INFO - Running cycle 1/1 for dromaeo_css test... 10:04:36 INFO - TEST-INFO | started process 4064 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTN8JyB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:04:48 INFO - PROCESS | 4064 | RSS: Main: 152891392 10:04:48 INFO - PROCESS | 4064 | 10:05:38 INFO - PROCESS | 4064 | 1473095138229 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:46 INFO - PROCESS | 4064 | Cycle 1(1): loaded http://localhost:34111/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34111/tests/dromaeo/cssquery-ext.html) 10:07:47 INFO - PROCESS | 4064 | RSS: Main: 157896704 10:07:47 INFO - PROCESS | 4064 | 10:10:49 INFO - PROCESS | 4064 | Cycle 1(1): loaded http://localhost:34111/tests/dromaeo/cssquery-ext.html (next: http://localhost:34111/tests/dromaeo/cssquery-jquery.html) 10:10:50 INFO - PROCESS | 4064 | RSS: Main: 154202112 10:10:50 INFO - PROCESS | 4064 | 10:13:52 INFO - PROCESS | 4064 | Cycle 1(1): loaded http://localhost:34111/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34111/tests/dromaeo/cssquery-mootools.html) 10:13:53 INFO - PROCESS | 4064 | RSS: Main: 154742784 10:13:53 INFO - PROCESS | 4064 | 10:16:54 INFO - PROCESS | 4064 | Cycle 1(1): loaded http://localhost:34111/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34111/tests/dromaeo/cssquery-prototype.html) 10:16:55 INFO - PROCESS | 4064 | RSS: Main: 153387008 10:16:55 INFO - PROCESS | 4064 | 10:19:57 INFO - PROCESS | 4064 | Cycle 1(1): loaded http://localhost:34111/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34111/tests/dromaeo/cssquery-yui.html) 10:19:58 INFO - PROCESS | 4064 | RSS: Main: 155873280 10:19:58 INFO - PROCESS | 4064 | 10:23:00 INFO - PROCESS | 4064 | Cycle 1(1): loaded http://localhost:34111/tests/dromaeo/cssquery-yui.html (next: http://localhost:34111/tests/dromaeo/cssquery-dojo.html) 10:23:01 INFO - PROCESS | 4064 | RSS: Main: 155897856 10:23:01 INFO - PROCESS | 4064 | 10:23:01 INFO - PROCESS | 4064 | __start_tp_report 10:23:01 INFO - PROCESS | 4064 | _x_x_mozilla_page_load 10:23:01 INFO - PROCESS | 4064 | _x_x_mozilla_page_load_details 10:23:01 INFO - PROCESS | 4064 | |i|pagename|runs| 10:23:01 INFO - PROCESS | 4064 | |0;dojo.html;3291.111399922021;3292.259241670623;3304.9504257436142;3318.70131688148;3327.2680010397703;5755.712214389285;5781.537477001835;5787.21872547206;5845.3570107288215;5857.794977175799;5765.250517432728;5775.249217601706;5792.073268277077;5832.591718579701;5852.180694702734;5287.021900948327;5303.549198318147;5311.654742441749;5340.54605358545;5382.1926710993275;5155.7164355960595;5179.948200518003;5185.222216667492;5222.973885130588;5254.81608143715;5208.140656791625;5218.191180367049;5222.086134926391;5264.552513036378;5268.420473747885;5216.165413533854;5264.368275806889;5265.447128051576;5276.604254680895;5287.576993840503;5098.082345177866;5130.4356520782685;5133.486651334874;5172.069027575035;5173.224016397533;5652.576056795757;5696.601237913348;5716;5733.082706766897;5750;6098.756049758004;6144.139820425144;6148.784792532285;6151.261848578154;6154.876902461926;6083.513318934474;6133.202683651097;6177.752889884399;6181.474574661114;6187.226596675416;5766.596338256324;5824.621399609012;5863.384344643836;5884.735186916599;5912.763489460416;6332.651704156316;6364.109024736541;6395.20059992501;6432.099506069154;6442;5837.562182836219;5949.494292985059;6117.694115294217;6120.418560236771;6134.263888333428;6107.236595425572;6127.172831667668;6138.817583427401;6202.503799696014;6205.255369355616;6176.69116544171;6179.876402472015;6185.628862268279;6193.659348735772;6201.534884883652;5952.434518720715;6098.054801505774;6130.816075517741;6182.28903676074;6192.783252586138;4716.882077948078;4721.126591580569;4724.527547245248;4743.66794324394;4749.430068391746;4215.072684009513;4215.873523794291;4215.936760948588;4231.2806822839575;4235.618794308527;5842.328132264759;5863.149843272701;5969.283685957713;6022.09668549721;6024.457798798129;6167.321594624587;6183.721732522047;6224.315325314212;6249.281332646804;6250.593711408744;5969.641821490724;5982.880342393128;6013.218281623361;6015.939840601538;6019.789307374221;5019.924701129413;5110.310108135429;5125.461826508237;5131.947950670104;5143.588512918957;6437.871242575216;6499.772507962199;6534.967325163344;6551.1155993941165;6551.21385433751;6259.906101408392;6266.530010249158;6284.497240220863;6294.213223347082;6318.526110541636;6120;6131.529590167291;6482.481401487964;6509.804705858832;6590.044443555562;5855.765769369177;5932.406759324033;5963.612365196248;5965.254343207099;5985;5976.521878249642;6051.909221361771;6053.061775424816;6053.4551890330085;6092.116643086639;5820.097884827858;5946.524278057832;5947.851303717442;5956.5532585055425;5966.164736936746;5974.850628734316;6001.639901605918;6054.848628784315;6102.755889764359;6109.11417844419;5997.700114994145;6054.485368743706;6056.06131049688;6059.575829691879;6068.878622427438;5995.250593675791;6016.699165041643;6033.668148251888;6053.969730151321;6077.4834139098675;5931.288245410578;6000.09998500211;6023.849403764941;6032.75868965254;6041.78853740117 10:23:01 INFO - PROCESS | 4064 | |1;ext.html;589.7464090441111;626.4549841637775;654.7970129259929;672.959622422655;693.3932808792307;42652.72041838746;47761.522384776144;47916.52083479164;47932.76033619831;47953.76023119884;46886.76556617221;47807;47908.28137577939;47917.28124078133;48280.03439931199;9202.35583509153;9256.72229833106;9296.20982216509;9298.953505232499;9308.581113849894;9135.954320228422;9195.08049195082;9204.40171388861;9209.861852072225;9211.355205135644;9303.906960930371;9417.858732119024;9418.387804792701;9439.575219115157;9445.29160312976;9354;9364.204042656382;9364.672236471759;9375.249980001618;9385.57764900581;9118.452892826452;9231.492267925261;9231.630734770668;9237.399569027992;9238.937522184968;44536.55463445389;44649.776751116035;44916.77541612304;45222;45330.77334613306;3910.4720862683457;4041.353383458662;4703.341532185496;4767.213409787381;4812.879678008043;35939.4609080864;36359.63640363589;36395.81802090999;36511.63488365136;38508.42237366442;4658.394408726844;4700.835470758507;4703.247480403119;4748.6438517111355;4832.057748738997;394811;395808;396072.01963990286;396980;399365;61839.6908015457;61906.38093619096;61919;62033;62501.68749156316;40522.39216411756;41133.38299925504;41143.58856411457;43721.78139109284;72758;20001.099950502263;20010;20068.799312006984;20158.39524814258;20192.495187620134;15279.92360038215;15414.075155490706;15414.46049388266;15415.152166630944;15464.768028479582;21654.242101526685;21806;21965.67051494229;22034.33896983093;22119.115235390727;7442.255774422514;7590.3927685785;7652.540847549165;7702.382499675131;7790.259925307087;1093.3057508482011;1100.2243418390017;1141.5776162819643;1198.7662405830954;1208.9214201076902;35670.464943025356;35910.46134307988;36042.918712438666;36136.457953130724;36322.81838590843;1190.9285442873456;1220.2190598017276;1260.9093134438644;1262.5896583610363;1287.6265882893856;18565.25738970426;18624.813751862308;18680.25278988825;18684.719729204073;18971;668248;668623;669171;669172;673132;68472.97290540645;68902.65548672224;69491;69491;69615.65192174108;1407.7325308191412;1419.936102875373;1431.7637589797775;1453.157168842069;1469.7427950108688;33860;34493.31013379668;34762.65237347695;34950;35505;59880.70059649848;59936.40063599308;60092.69953650379;60139.39860601338;60242.69878650579;505433;505700;505756;507597;510151;32847.67152328446;32868.34263314673;33034;33163.17092072718;33227.16932076718;54056;54173;54955.45044549663;55304.72347638236;55441.722791385786;45265.87619478804;47125;47555.52444475649;48483;48712.75643621759;46710;47048;47795;47881.281780774014;48205.276920845514;39292.410613841384;44130.55869441265;45094.32358514691;45551;47764.5223547774;39746.00634984148;40469.39295910505;41369.586304136574;41512;41554.79222603868;30860;31191.532127018567;31363.529547056354;31604.209894751897;31695.207619809687 10:23:01 INFO - PROCESS | 4064 | |2;jquery.html;401.6726368010072;402.41448692152926;417.3239352249356;420.9747415155091;435.9128174365128;19984.70022949655;20752.27367042152;21774.237901673445;21782.673259901094;21890.23384181554;20099.29652462164;20514.692279615818;20532.28137015201;20720.792792072076;20929.58140837186;5175.482451754832;5384.865378365553;5407.080796264625;5415.323084614423;5433.293671822657;5185.55922746567;5284.101702710529;5344.625876188668;5377.300950876381;5390;5310.522053015228;5363.6245462817615;5367.838964831061;5377.6824677953955;5401;5373.919391209135;5376.704281264529;5801.535877129841;6056.666883321415;6123.050927106306;5938.257717785277;5971;5971.343152253248;5986.97006514969;6014.8496287592725;14541.491047813275;14609.48866789668;14768.187749673763;15098.622534436618;15165.469208577646;2373.3829204406807;2708.8103832731717;2771.8614069296655;2967.2581854536365;2981.7465515431213;13726.382312795848;15295;15374.385024599003;16066.196690165445;16394.754078688828;1959.823615874578;1972.8816271023784;2014.1540552967788;2100.19142630087;2134.2956824247963;84303.15696843015;89564;91337;91438.54280728554;94236.05763942341;9821.705348839547;10308;10346.32748871321;10356.067953884187;11551.711207219887;13936.442542298195;14007.789883151761;14051.78922316166;14103.294835258195;14124.081934674214;8411.98742854322;8508.74473765788;8593.95703021481;8627.48235105883;8729.519876406732;8631.352648551383;8817.250533704708;8853.822923541622;8971;8997.865032024525;4339.284018136972;4341.261985462479;4346.434963454731;4353.73877567347;4354;2005.7836091119395;2026.1996511377922;2040.5918816236813;2085.3118470904565;2086.1863873089505;1008.0625018732502;1021.6219998600417;1054.7046826888484;1084.1326938449367;1152.6772503698978;20892.37322880316;21091;21156.576868462544;21438;21730;1049.8372752223418;1057.2916146182076;1066.8453074304182;1134.6199023327279;1138.612871623652;11043.337399756041;11735.119866010084;11840.526378944918;11916.285022898654;12021.75956480883;514468;531039;532361;536998;539313;90169;91723;97205.51397242969;100573;102089.48955255325;1050.6427814543092;1086.750047489082;1090.2913106480692;1092.224520590374;1097.9945100274447;18985.43043708691;19084;19146.904265478584;19207.847529148297;19250.80749192546;32732.672673272962;41560.376594350506;44186.55813441824;44792.328115077646;44835.77582112199;60896.69551652214;60978.39021609727;63378.68310658417;63805.36194637994;64818.67590662016;8968.327375446997;9036.683716069905;9184.12750788674;9225.538723063686;9250.676226332045;13950.79073813914;14159.43362265539;14216.50242241558;14275.571732848031;14609.342579584158;5907.91138132937;11033.558657653604;12590.181638193855;12716.109872308849;12806.935965320114;12409.751804964031;12670.049746268882;12788.616341509769;12942.676433089247;13081.803772943224;12155.209911355734;12850.67873303175;12976.480940762263;12991.350432478528;12993.675158121123;8976.147266009719;9015.459072455673;9064.093590640883;9177.174054335143;9321;11699.766004680028;11928.105392095455;11941.283522988648;12137.939310303393;12145.757084858076 10:23:01 INFO - PROCESS | 4064 | |3;mootools.html;1569.4036266218839;1588.586967388479;1774.1572752942354;1880.3418803418797;1911.6941289393699;8475.83048339033;9041.547922603877;9102.499362535058;9842.065003824635;9849.162821160193;9216.815663686722;9491.19324857388;9504.904950950488;9520.143187113159;9551.283653725963;2461.2985299189736;2492.0530198524534;2508.598624220125;2508.8745562721792;2512.899484020646;2433.4889673168655;2561.9871900640564;2575.793936485086;2579.57437022891;2582.702989156243;2467.7532246775268;2483.615039668854;2499.600063989762;2509.648649189115;2510.8493490390542;2363.243761996162;2378.3816207786012;2380.9999999999914;2462.298245000184;2474.072222916406;2443.2670198940245;2447.7919376852988;2457.7665121813397;2488.664030355897;2490.464550121714;9744.853827192597;9879.308448408614;9888.505574721235;9889.901100989042;9910.950445247727;5571.275734154575;5680.857978550528;5713.714314284311;5718.313802343704;5737.856553586152;3566.5898421681577;3571.4107172316535;3601.5137956375816;3602.3342726382552;3699.2601479704167;1239;1323.6955500234903;1329.0829327763813;2272.9545409091893;2357.7642235776457;13581.253031083286;13592.320383980861;13729.244891530961;13730.51943181984;13747.656308592364;4574.199515084847;4697;4812.302216178635;4827.589654879374;4866.7079975200895;10512.42181680015;10583.682489525327;10586.788264234672;10617.946910265398;10623.893761062445;5598;5636.4927156556105;5659.405762394971;5659.971700141473;5675.2054712340305;4688.8124475021295;5165.638405311592;5249.448807875195;5262.368515778131;5277.868053298622;3966;4025.9798701006307;4031.294523458383;4097.528784189797;4111.075008123148;1136.8635763708407;1147.0880649883363;1147.4951021550492;1148.8626260002538;1178.092868491257;1017.730301470111;1018.6383833739064;1079.4063265204106;1086.4567716141928;1089.05796486039;6298.401651843067;6350.0792385103905;6484.351564843478;6607.141071660653;6703.162104736908;950.2872845365976;963.3112324687742;1005.2561104782409;1023.7542989682571;1037.6316407675317;4393.692441529062;4395.912081758347;4498.865034048984;4503.459584849839;4531.43357080365;11728.179027467995;11986.880131198577;12048.759024819454;12059.336736479403;12089.879101209051;11169.38568378747;11470.082393408507;11933.343666098448;11959.103067269816;11989.580364687194;8850.601722922484;9083.545822708838;9095.636174552943;9103.81792364149;9110.225630821322;6374.649394283359;6586;6594.505412094016;6623.138991931018;6656.900146497709;10888.074513666426;11016.834747478633;11194.944025279821;11340.09279257674;11397.601083962354;11202.887971120184;11242.66272011841;11370.94314528422;11379.658610241706;11515.193936424705;8176;8335.374846886387;8542.359323050672;8599.312055035458;8861.689840855539;9474.099960503741;9475.384100033476;9490.240780737386;9530.189933855423;9574.760630984281;8208.958955205186;8265.504069755834;8303.294219991369;8405.285550728257;8413.621387037476;8219.219174178443;8237;8302.501849889026;8364.372672049742;8501.617427215913;7898.486598371088;7902.525848449111;7932.405069619686;7950.602469876599;7956.84086318282;5474.09677403224;5708.686022268649;5797.565182611237;5811.94188058114;5812.408197524078;5524.889502209853;5595.356533998643;5635.859103522281;5670.546356291405;5710.086386178192 10:23:01 INFO - PROCESS | 4064 | |4;prototype.html;349.26305495404694;349.44089456869006;352.3059572641896;354.6719284661687;356.274980414856;5844.678542680156;5845.7953971611005;5858.88282234355;5867.55993300502;5893.116032595102;5684.4315568443135;5788.176724331833;5804.622699524528;5824.126381042835;5842;4462.263726485126;4482.1259854328255;4491.752953587551;4520.254158063915;4526.298423744309;4482.377808981733;4497.595216430521;4499.302608095734;4505.954940450586;4524.796384162721;4477.507474177838;4482.97758511207;4512.481064677555;4539.523350048247;4548.499665036843;4361.781910904458;4460.66545009124;4480.484744254387;4492.820287188509;4506.1663592235545;3911.4523966644692;3926.2147570486018;3952.960470395317;3953.327934251184;3970.801459927021;5677.545796336283;5681.630694004918;5699.857503562444;5708;5737.885242295172;5089;5107.106256405114;5162.561182299509;5175.146100893348;5187.922181167285;6034.125051867454;6035;6069.484093852028;6089.421504957067;6109.84725381869;4294.7974567121255;4355.150745604608;4357.542458041891;4362.1275744851155;4403.911921761547;5927.940720592782;6124.488959526618;6261.46777523911;6353.555251132422;6365.612895164313;4348.695591308578;4384.254676704968;4393;4396.856817227544;4402.141582391403;4428.4685837699035;4458.197524445631;4459.843905463294;4468.240399132155;4473.418455600751;4972.378452693413;5052.696838189647;5157.432682404932;5165.173572228426;5188.662736922088;5984.640921544721;6029.246344206974;6033.366496517802;6049.1833602463985;6090.725917333731;1520.817501899757;1529.9311530981133;1540.4069433268048;1540.8151021877447;1544.7605621128744;944.4805357053593;982.5873133284038;984.9359791613665;989.7773001074845;991.6727479931606;5262.71055091966;5296.814611488579;5299.721119918395;5332.040232758063;5340.786368545215;5458.344998600193;5553.972230138824;5555.916661250085;5592;5599.664020158803;4894.975525122423;5212.009718153538;5235.947640523546;5239.947600523946;5243.947560524422;2914.810537315068;2917.0665387076356;2930.1063175731606;2931.9267018324713;2936.471435141695;5629.971850140805;5655.9253741788925;5692.260006199251;5731.656100633975;5732.656040637575;5190.870228244324;5493.807716729895;5534.363548191929;5573.1855413016165;5590.8043218487155;5591.8602034948635;5600.719964001783;5683.488486036276;5728.341240757283;5728.455796699307;5154.433012368711;5464;5518.696471694096;5522.641028333306;5539.587405211645;5378.489043540857;5427.294451721251;5431.582945589175;5454.727263636882;5491.32514583056;6303.149074875017;6427.228732552124;6444.8388790280615;6526.24948130971;6609.636469994197;4458.777061146865;4492.685512014258;4508.729476231437;4514.029483661028;4516.322551617283;6196.442320191204;6299.11812346281;6372.426481616677;6385.233771947396;6428.935710642833;6120.724567394389;6137.478314343152;6162.969185154046;6173.197484327009;6176.845578860564;5883.794067207627;6054.182685337423;6117.3576774439825;6120.663363515049;6137.294211165595;5990.251218597676;6057;6098.908516372347;6108.6945652716295;6117.541184411098;6106.389361063858;6157.753689852535;6163.9383606163365;6165.72254248551;6165.907511387422;5859.2382990211;6013.135927862377;6039.124326972652;6043.612772954746;6059.878802424015 10:23:01 INFO - PROCESS | 4064 | |5;yui.html;807.140395478815;820.331429884644;833.1793183714044;857.8241460500598;931.9813603727921;16899.070551119683;17338.82661173388;17483.475495735118;17542.298308067693;17593.82406175938;16631.168441577935;16892.83107168928;16910.915445422786;16973.660526789456;17008.4047058353;868.3400615532178;890.243293200779;910.6266430763388;911.8723378726984;912.2473958983865;903.7785742493065;905.551751882819;906.4425378392274;906.9410488318238;907.120093509295;951.6050838901847;955.6320816485668;955.8375076237022;958.6213445688949;960.4957397366404;947.8720372749694;950.9381890177116;952.5903861339622;953.0231512699469;953.2088366655694;703.6657587645878;703.8451540661098;705.0517054561658;705.3933617089299;707.091387566979;16829.49511514644;16852.831471685247;16878.240479178465;16883.40908068224;16936.407225747163;15429.768553471707;15600.622473686552;15603.687926241526;15701.528954131394;15960.680786384208;13508.459661613524;13573.242718640306;13623.455061797516;13632.795508067387;13852.961027922946;4194.328907374806;4211.144453899847;4214.726042807208;4232.365145228209;4326.242907491176;97249.51375243149;97451.45812469177;97877;97960;98231;12350.44423000967;12526.248425094524;12570.622881313575;12773.361331933365;12897.935510322575;21927.451813704785;22996.65505017426;23669.171578994654;23687.644685329735;23754.406139846644;9011.188992990663;9068.591913363915;9072.649145598109;9098.590563424661;9142.862857057149;5159.716215608102;5163.690178589221;5226.555742761831;5244.423113457517;5343.118385466432;3894.1432884765304;4040.1919616076902;4059.6143366380147;4062.370332598452;4081.77550234734;689.2659317826599;690.6305126757161;702.3117345001824;709.5848928376957;714.5498336048256;684.7911387027004;807.3823525003377;822.7038266224155;824.2664029014182;824.8350329934037;10394.22043346752;10520.526576304084;11224.551017959353;11536.538538458368;11612.825807612893;677.8745932002595;735.3014636095623;740.9666565004587;796.303234669664;815.3558688635911;5140.357455318085;5357.7053262070185;5364.409914909357;5457.781688732406;5530.834074977757;137316;138708;139667;140565;141855;83940.58029709812;87522.56238718766;121127;122592;122651.38674306571;63186.0522092169;90559.54720226357;99898.50050749845;101045;103091.48454257831;9452.669156579761;10263.23025773085;10361.896381036093;10394.792104157723;10406.635767748092;59082;59133.40866591279;59867;61381;62407.37592624016;49326;70427.64786176241;87621;88003;89722.55138724265;12684.682882928;12971.675708107372;13175.934120329337;13383.263920484467;13438.865611344152;15240.314185861442;15356.462523811613;15527.37890484368;15854.132804164417;15975.520734377988;14236;14550.781738273723;14718.484853030093;15560.92219538895;15644.217789110271;13275.66810829737;13799.379027943565;13971.09187902783;14472.421103155755;14772.33524491379;14183.858161418253;14229.573112806633;14390.208538530482;14399.856001439852;14512.927435362755;11377.374244416636;11723.120765942758;11927.701807454883;12084.818727719266;12542.1847579907;11354.26197297173;11819.527218911147;12034.458449369975;12102;12178.756424871275 10:23:01 INFO - PROCESS | 4064 | __end_tp_report 10:23:01 INFO - PROCESS | 4064 | __start_cc_report 10:23:01 INFO - PROCESS | 4064 | _x_x_mozilla_cycle_collect,331 10:23:01 INFO - PROCESS | 4064 | __end_cc_report 10:23:01 INFO - PROCESS | 4064 | __startTimestamp1473096181065__endTimestamp 10:23:01 INFO - PROCESS | 4064 | 10:23:01 INFO - PROCESS | 4064 | ------- Summary: start ------- 10:23:01 INFO - PROCESS | 4064 | Number of tests: 6 10:23:01 INFO - PROCESS | 4064 | 10:23:01 INFO - PROCESS | 4064 | [#0] dojo.html Cycles:165 Average:5734.83 Median:5974.85 stddev:666.35 (11.2%) stddev-sans-first:640.22 10:23:01 INFO - PROCESS | 4064 | Values: 3291.1 3292.3 3305.0 3318.7 3327.3 5755.7 5781.5 5787.2 5845.4 5857.8 5765.3 5775.2 5792.1 5832.6 5852.2 5287.0 5303.5 5311.7 5340.5 5382.2 5155.7 5179.9 5185.2 5223.0 5254.8 5208.1 5218.2 5222.1 5264.6 5268.4 5216.2 5264.4 5265.4 5276.6 5287.6 5098.1 5130.4 5133.5 5172.1 5173.2 5652.6 5696.6 5716.0 5733.1 5750.0 6098.8 6144.1 6148.8 6151.3 6154.9 6083.5 6133.2 6177.8 6181.5 6187.2 5766.6 5824.6 5863.4 5884.7 5912.8 6332.7 6364.1 6395.2 6432.1 6442.0 5837.6 5949.5 6117.7 6120.4 6134.3 6107.2 6127.2 6138.8 6202.5 6205.3 6176.7 6179.9 6185.6 6193.7 6201.5 5952.4 6098.1 6130.8 6182.3 6192.8 4716.9 4721.1 4724.5 4743.7 4749.4 4215.1 4215.9 4215.9 4231.3 4235.6 5842.3 5863.1 5969.3 6022.1 6024.5 6167.3 6183.7 6224.3 6249.3 6250.6 5969.6 5982.9 6013.2 6015.9 6019.8 5019.9 5110.3 5125.5 5131.9 5143.6 6437.9 6499.8 6535.0 6551.1 6551.2 6259.9 6266.5 6284.5 6294.2 6318.5 6120.0 6131.5 6482.5 6509.8 6590.0 5855.8 5932.4 5963.6 5965.3 5985.0 5976.5 6051.9 6053.1 6053.5 6092.1 5820.1 5946.5 5947.9 5956.6 5966.2 5974.9 6001.6 6054.8 6102.8 6109.1 5997.7 6054.5 6056.1 6059.6 6068.9 5995.3 6016.7 6033.7 6054.0 6077.5 5931.3 6000.1 6023.8 6032.8 6041.8 10:23:01 INFO - PROCESS | 4064 | 10:23:01 INFO - PROCESS | 4064 | [#1] ext.html Cycles:180 Average:69517.05 Median:4702.04 stddev:142704.57 (3034.9%) stddev-sans-first:143011.06 10:23:01 INFO - PROCESS | 4064 | Values: 589.7 626.5 654.8 673.0 693.4 42652.7 47761.5 47916.5 47932.8 47953.8 46886.8 47807.0 47908.3 47917.3 48280.0 9202.4 9256.7 9296.2 9299.0 9308.6 9136.0 9195.1 9204.4 9209.9 9211.4 9303.9 9417.9 9418.4 9439.6 9445.3 9354.0 9364.2 9364.7 9375.2 9385.6 9118.5 9231.5 9231.6 9237.4 9238.9 44536.6 44649.8 44916.8 45222.0 45330.8 3910.5 4041.4 4703.3 4767.2 4812.9 35939.5 36359.6 36395.8 36511.6 38508.4 4658.4 4700.8 4703.2 4748.6 4832.1 394811.0 395808.0 396072.0 396980.0 399365.0 61839.7 61906.4 61919.0 62033.0 62501.7 40522.4 41133.4 41143.6 43721.8 72758.0 20001.1 20010.0 20068.8 20158.4 20192.5 15279.9 15414.1 15414.5 15415.2 15464.8 21654.2 21806.0 21965.7 22034.3 22119.1 7442.3 7590.4 7652.5 7702.4 7790.3 1093.3 1100.2 1141.6 1198.8 1208.9 35670.5 35910.5 36042.9 36136.5 36322.8 1190.9 1220.2 1260.9 1262.6 1287.6 18565.3 18624.8 18680.3 18684.7 18971.0 668248.0 668623.0 669171.0 669172.0 673132.0 68473.0 68902.7 69491.0 69491.0 69615.7 1407.7 1419.9 1431.8 1453.2 1469.7 33860.0 34493.3 34762.7 34950.0 35505.0 59880.7 59936.4 60092.7 60139.4 60242.7 505433.0 505700.0 505756.0 507597.0 510151.0 32847.7 32868.3 33034.0 33163.2 33227.2 54056.0 54173.0 54955.5 55304.7 55441.7 45265.9 47125.0 47555.5 48483.0 48712.8 46710.0 47048.0 47795.0 47881.3 48205.3 39292.4 44130.6 45094.3 45551.0 47764.5 39746.0 40469.4 41369.6 41512.0 41554.8 30860.0 31191.5 31363.5 31604.2 31695.2 10:23:01 INFO - PROCESS | 4064 | 10:23:01 INFO - PROCESS | 4064 | [#2] jquery.html Cycles:180 Average:30874.30 Median:21584.00 stddev:87580.71 (405.8%) stddev-sans-first:87796.51 10:23:01 INFO - PROCESS | 4064 | Values: 401.7 402.4 417.3 421.0 435.9 19984.7 20752.3 21774.2 21782.7 21890.2 20099.3 20514.7 20532.3 20720.8 20929.6 5175.5 5384.9 5407.1 5415.3 5433.3 5185.6 5284.1 5344.6 5377.3 5390.0 5310.5 5363.6 5367.8 5377.7 5401.0 5373.9 5376.7 5801.5 6056.7 6123.1 5938.3 5971.0 5971.3 5987.0 6014.8 14541.5 14609.5 14768.2 15098.6 15165.5 2373.4 2708.8 2771.9 2967.3 2981.7 13726.4 15295.0 15374.4 16066.2 16394.8 1959.8 1972.9 2014.2 2100.2 2134.3 84303.2 89564.0 91337.0 91438.5 94236.1 9821.7 10308.0 10346.3 10356.1 11551.7 13936.4 14007.8 14051.8 14103.3 14124.1 8412.0 8508.7 8594.0 8627.5 8729.5 8631.4 8817.3 8853.8 8971.0 8997.9 4339.3 4341.3 4346.4 4353.7 4354.0 2005.8 2026.2 2040.6 2085.3 2086.2 1008.1 1021.6 1054.7 1084.1 1152.7 20892.4 21091.0 21156.6 21438.0 21730.0 1049.8 1057.3 1066.8 1134.6 1138.6 11043.3 11735.1 11840.5 11916.3 12021.8 514468.0 531039.0 532361.0 536998.0 539313.0 90169.0 91723.0 97205.5 100573.0 102089.5 1050.6 1086.8 1090.3 1092.2 1098.0 18985.4 19084.0 19146.9 19207.8 19250.8 32732.7 41560.4 44186.6 44792.3 44835.8 60896.7 60978.4 63378.7 63805.4 64818.7 8968.3 9036.7 9184.1 9225.5 9250.7 13950.8 14159.4 14216.5 14275.6 14609.3 5907.9 11033.6 12590.2 12716.1 12806.9 12409.8 12670.0 12788.6 12942.7 13081.8 12155.2 12850.7 12976.5 12991.4 12993.7 8976.1 9015.5 9064.1 9177.2 9321.0 11699.8 11928.1 11941.3 12137.9 12145.8 10:23:01 INFO - PROCESS | 4064 | 10:23:01 INFO - PROCESS | 4064 | [#3] mootools.html Cycles:180 Average:6318.92 Median:4501.16 stddev:3612.88 (80.3%) stddev-sans-first:3605.39 10:23:01 INFO - PROCESS | 4064 | Values: 1569.4 1588.6 1774.2 1880.3 1911.7 8475.8 9041.5 9102.5 9842.1 9849.2 9216.8 9491.2 9504.9 9520.1 9551.3 2461.3 2492.1 2508.6 2508.9 2512.9 2433.5 2562.0 2575.8 2579.6 2582.7 2467.8 2483.6 2499.6 2509.6 2510.8 2363.2 2378.4 2381.0 2462.3 2474.1 2443.3 2447.8 2457.8 2488.7 2490.5 9744.9 9879.3 9888.5 9889.9 9911.0 5571.3 5680.9 5713.7 5718.3 5737.9 3566.6 3571.4 3601.5 3602.3 3699.3 1239.0 1323.7 1329.1 2273.0 2357.8 13581.3 13592.3 13729.2 13730.5 13747.7 4574.2 4697.0 4812.3 4827.6 4866.7 10512.4 10583.7 10586.8 10617.9 10623.9 5598.0 5636.5 5659.4 5660.0 5675.2 4688.8 5165.6 5249.4 5262.4 5277.9 3966.0 4026.0 4031.3 4097.5 4111.1 1136.9 1147.1 1147.5 1148.9 1178.1 1017.7 1018.6 1079.4 1086.5 1089.1 6298.4 6350.1 6484.4 6607.1 6703.2 950.3 963.3 1005.3 1023.8 1037.6 4393.7 4395.9 4498.9 4503.5 4531.4 11728.2 11986.9 12048.8 12059.3 12089.9 11169.4 11470.1 11933.3 11959.1 11989.6 8850.6 9083.5 9095.6 9103.8 9110.2 6374.6 6586.0 6594.5 6623.1 6656.9 10888.1 11016.8 11194.9 11340.1 11397.6 11202.9 11242.7 11370.9 11379.7 11515.2 8176.0 8335.4 8542.4 8599.3 8861.7 9474.1 9475.4 9490.2 9530.2 9574.8 8209.0 8265.5 8303.3 8405.3 8413.6 8219.2 8237.0 8302.5 8364.4 8501.6 7898.5 7902.5 7932.4 7950.6 7956.8 5474.1 5708.7 5797.6 5811.9 5812.4 5524.9 5595.4 5635.9 5670.5 5710.1 10:23:01 INFO - PROCESS | 4064 | 10:23:01 INFO - PROCESS | 4064 | [#4] prototype.html Cycles:180 Average:4952.61 Median:5520.67 stddev:1447.66 (26.2%) stddev-sans-first:1409.89 10:23:01 INFO - PROCESS | 4064 | Values: 349.3 349.4 352.3 354.7 356.3 5844.7 5845.8 5858.9 5867.6 5893.1 5684.4 5788.2 5804.6 5824.1 5842.0 4462.3 4482.1 4491.8 4520.3 4526.3 4482.4 4497.6 4499.3 4506.0 4524.8 4477.5 4483.0 4512.5 4539.5 4548.5 4361.8 4460.7 4480.5 4492.8 4506.2 3911.5 3926.2 3953.0 3953.3 3970.8 5677.5 5681.6 5699.9 5708.0 5737.9 5089.0 5107.1 5162.6 5175.1 5187.9 6034.1 6035.0 6069.5 6089.4 6109.8 4294.8 4355.2 4357.5 4362.1 4403.9 5927.9 6124.5 6261.5 6353.6 6365.6 4348.7 4384.3 4393.0 4396.9 4402.1 4428.5 4458.2 4459.8 4468.2 4473.4 4972.4 5052.7 5157.4 5165.2 5188.7 5984.6 6029.2 6033.4 6049.2 6090.7 1520.8 1529.9 1540.4 1540.8 1544.8 944.5 982.6 984.9 989.8 991.7 5262.7 5296.8 5299.7 5332.0 5340.8 5458.3 5554.0 5555.9 5592.0 5599.7 4895.0 5212.0 5235.9 5239.9 5243.9 2914.8 2917.1 2930.1 2931.9 2936.5 5630.0 5655.9 5692.3 5731.7 5732.7 5190.9 5493.8 5534.4 5573.2 5590.8 5591.9 5600.7 5683.5 5728.3 5728.5 5154.4 5464.0 5518.7 5522.6 5539.6 5378.5 5427.3 5431.6 5454.7 5491.3 6303.1 6427.2 6444.8 6526.2 6609.6 4458.8 4492.7 4508.7 4514.0 4516.3 6196.4 6299.1 6372.4 6385.2 6428.9 6120.7 6137.5 6163.0 6173.2 6176.8 5883.8 6054.2 6117.4 6120.7 6137.3 5990.3 6057.0 6098.9 6108.7 6117.5 6106.4 6157.8 6163.9 6165.7 6165.9 5859.2 6013.1 6039.1 6043.6 6059.9 10:23:01 INFO - PROCESS | 4064 | 10:23:01 INFO - PROCESS | 4064 | [#5] yui.html Cycles:180 Average:23409.30 Median:4049.90 stddev:34806.22 (859.4%) stddev-sans-first:34862.49 10:23:01 INFO - PROCESS | 4064 | Values: 807.1 820.3 833.2 857.8 932.0 16899.1 17338.8 17483.5 17542.3 17593.8 16631.2 16892.8 16910.9 16973.7 17008.4 868.3 890.2 910.6 911.9 912.2 903.8 905.6 906.4 906.9 907.1 951.6 955.6 955.8 958.6 960.5 947.9 950.9 952.6 953.0 953.2 703.7 703.8 705.1 705.4 707.1 16829.5 16852.8 16878.2 16883.4 16936.4 15429.8 15600.6 15603.7 15701.5 15960.7 13508.5 13573.2 13623.5 13632.8 13853.0 4194.3 4211.1 4214.7 4232.4 4326.2 97249.5 97451.5 97877.0 97960.0 98231.0 12350.4 12526.2 12570.6 12773.4 12897.9 21927.5 22996.7 23669.2 23687.6 23754.4 9011.2 9068.6 9072.6 9098.6 9142.9 5159.7 5163.7 5226.6 5244.4 5343.1 3894.1 4040.2 4059.6 4062.4 4081.8 689.3 690.6 702.3 709.6 714.5 684.8 807.4 822.7 824.3 824.8 10394.2 10520.5 11224.6 11536.5 11612.8 677.9 735.3 741.0 796.3 815.4 5140.4 5357.7 5364.4 5457.8 5530.8 137316.0 138708.0 139667.0 140565.0 141855.0 83940.6 87522.6 121127.0 122592.0 122651.4 63186.1 90559.5 99898.5 101045.0 103091.5 9452.7 10263.2 10361.9 10394.8 10406.6 59082.0 59133.4 59867.0 61381.0 62407.4 49326.0 70427.6 87621.0 88003.0 89722.6 12684.7 12971.7 13175.9 13383.3 13438.9 15240.3 15356.5 15527.4 15854.1 15975.5 14236.0 14550.8 14718.5 15560.9 15644.2 13275.7 13799.4 13971.1 14472.4 14772.3 14183.9 14229.6 14390.2 14399.9 14512.9 11377.4 11723.1 11927.7 12084.8 12542.2 11354.3 11819.5 12034.5 12102.0 12178.8 10:23:01 INFO - PROCESS | 4064 | -------- Summary: end -------- 10:23:01 INFO - PROCESS | 4064 | 10:23:01 INFO - TEST-INFO | 4064: exit 0 10:23:01 INFO - TEST-OK | dromaeo_css | took 1111050ms 10:23:01 INFO - TEST-START | kraken 10:23:01 INFO - operating with platform_type : linux_ 10:23:01 INFO - Initialising browser for kraken test... 10:23:01 INFO - TEST-INFO | started process 4329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk9ZAIz/profile http://localhost:34111/getInfo.html) 10:23:05 INFO - PROCESS | 4329 | __metrics Screen width/height:1600/1200 10:23:05 INFO - PROCESS | 4329 | colorDepth:24 10:23:05 INFO - PROCESS | 4329 | Browser inner width/height: 1024/697 10:23:05 INFO - PROCESS | 4329 | __metrics 10:23:06 ERROR - PROCESS | 4329 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:23:07 INFO - TEST-INFO | 4329: exit 0 10:23:07 INFO - Browser initialized. 10:23:07 INFO - Running cycle 1/1 for kraken test... 10:23:07 INFO - TEST-INFO | started process 4453 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk9ZAIz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:23:19 INFO - PROCESS | 4453 | RSS: Main: 153014272 10:23:19 INFO - PROCESS | 4453 | 10:23:21 INFO - PROCESS | 4453 | Cycle 1(1): loaded http://localhost:34111/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34111/tests/kraken/driver.html?testName=audio-beat-detection) 10:23:22 INFO - PROCESS | 4453 | RSS: Main: 158158848 10:23:22 INFO - PROCESS | 4453 | 10:23:25 INFO - PROCESS | 4453 | Cycle 1(1): loaded http://localhost:34111/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34111/tests/kraken/driver.html?testName=audio-dft) 10:23:25 INFO - PROCESS | 4453 | RSS: Main: 156585984 10:23:25 INFO - PROCESS | 4453 | 10:23:28 INFO - PROCESS | 4453 | Cycle 1(1): loaded http://localhost:34111/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34111/tests/kraken/driver.html?testName=audio-fft) 10:23:29 INFO - PROCESS | 4453 | RSS: Main: 157483008 10:23:29 INFO - PROCESS | 4453 | 10:23:31 INFO - PROCESS | 4453 | Cycle 1(1): loaded http://localhost:34111/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34111/tests/kraken/driver.html?testName=audio-oscillator) 10:23:32 INFO - PROCESS | 4453 | RSS: Main: 156921856 10:23:32 INFO - PROCESS | 4453 | 10:23:34 INFO - PROCESS | 4453 | Cycle 1(1): loaded http://localhost:34111/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34111/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:23:34 INFO - PROCESS | 4453 | RSS: Main: 156934144 10:23:34 INFO - PROCESS | 4453 | 10:23:38 INFO - PROCESS | 4453 | Cycle 1(1): loaded http://localhost:34111/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34111/tests/kraken/driver.html?testName=imaging-darkroom) 10:23:38 INFO - PROCESS | 4453 | RSS: Main: 156332032 10:23:38 INFO - PROCESS | 4453 | 10:23:42 INFO - PROCESS | 4453 | Cycle 1(1): loaded http://localhost:34111/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34111/tests/kraken/driver.html?testName=imaging-desaturate) 10:23:42 INFO - PROCESS | 4453 | RSS: Main: 155209728 10:23:42 INFO - PROCESS | 4453 | 10:23:45 INFO - PROCESS | 4453 | Cycle 1(1): loaded http://localhost:34111/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34111/tests/kraken/driver.html?testName=json-parse-financial) 10:23:46 INFO - PROCESS | 4453 | RSS: Main: 156594176 10:23:46 INFO - PROCESS | 4453 | 10:23:47 INFO - PROCESS | 4453 | Cycle 1(1): loaded http://localhost:34111/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34111/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:23:48 INFO - PROCESS | 4453 | RSS: Main: 156553216 10:23:48 INFO - PROCESS | 4453 | 10:23:50 INFO - PROCESS | 4453 | Cycle 1(1): loaded http://localhost:34111/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34111/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:23:50 INFO - PROCESS | 4453 | RSS: Main: 156708864 10:23:50 INFO - PROCESS | 4453 | 10:23:52 INFO - PROCESS | 4453 | Cycle 1(1): loaded http://localhost:34111/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34111/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:23:53 INFO - PROCESS | 4453 | RSS: Main: 156860416 10:23:53 INFO - PROCESS | 4453 | 10:23:55 INFO - PROCESS | 4453 | Cycle 1(1): loaded http://localhost:34111/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34111/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:23:56 INFO - PROCESS | 4453 | RSS: Main: 157921280 10:23:56 INFO - PROCESS | 4453 | 10:23:59 INFO - PROCESS | 4453 | Cycle 1(1): loaded http://localhost:34111/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34111/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:23:59 INFO - PROCESS | 4453 | RSS: Main: 157503488 10:23:59 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | Cycle 1(1): loaded http://localhost:34111/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34111/tests/kraken/driver.html?testName=ai-astar) 10:24:01 INFO - PROCESS | 4453 | RSS: Main: 158736384 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | __start_tp_report 10:24:01 INFO - PROCESS | 4453 | _x_x_mozilla_page_load 10:24:01 INFO - PROCESS | 4453 | _x_x_mozilla_page_load_details 10:24:01 INFO - PROCESS | 4453 | |i|pagename|runs| 10:24:01 INFO - PROCESS | 4453 | |0;ai-astar;102;112;105;112;112;114;110;111;111;110 10:24:01 INFO - PROCESS | 4453 | |1;audio-beat-detection;146;122;146;170;117;147;152;118;163;122 10:24:01 INFO - PROCESS | 4453 | |2;audio-dft;163;161;163;162;163;163;161;161;164;165 10:24:01 INFO - PROCESS | 4453 | |3;audio-fft;76;75;76;178;75;76;75;76;172;75 10:24:01 INFO - PROCESS | 4453 | |4;audio-oscillator;84;84;145;84;85;84;129;84;85;151 10:24:01 INFO - PROCESS | 4453 | |5;imaging-gaussian-blur;117;117;117;117;117;118;120;118;117;118 10:24:01 INFO - PROCESS | 4453 | |6;imaging-darkroom;147;147;148;148;147;148;147;146;151;148 10:24:01 INFO - PROCESS | 4453 | |7;imaging-desaturate;95;96;97;95;96;96;96;96;96;96 10:24:01 INFO - PROCESS | 4453 | |8;json-parse-financial;52;52;55;51;57;52;52;53;51;51 10:24:01 INFO - PROCESS | 4453 | |9;json-stringify-tinderbox;60;62;61;61;61;62;59;60;61;60 10:24:01 INFO - PROCESS | 4453 | |10;stanford-crypto-aes;76;73;74;73;72;72;72;81;77;74 10:24:01 INFO - PROCESS | 4453 | |11;stanford-crypto-ccm;117;127;137;121;130;127;116;117;159;127 10:24:01 INFO - PROCESS | 4453 | |12;stanford-crypto-pbkdf2;153;150;154;159;149;157;156;154;149;151 10:24:01 INFO - PROCESS | 4453 | |13;stanford-crypto-sha256-iterative;61;63;65;64;62;61;63;61;61;69 10:24:01 INFO - PROCESS | 4453 | __end_tp_report 10:24:01 INFO - PROCESS | 4453 | __start_cc_report 10:24:01 INFO - PROCESS | 4453 | _x_x_mozilla_cycle_collect,866 10:24:01 INFO - PROCESS | 4453 | __end_cc_report 10:24:01 INFO - PROCESS | 4453 | __startTimestamp1473096241784__endTimestamp 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | ------- Summary: start ------- 10:24:01 INFO - PROCESS | 4453 | Number of tests: 14 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:3.63 (3.3%) stddev-sans-first:2.49 10:24:01 INFO - PROCESS | 4453 | Values: 102.0 112.0 105.0 112.0 112.0 114.0 110.0 111.0 111.0 110.0 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:146.50 stddev:19.30 (13.2%) stddev-sans-first:20.37 10:24:01 INFO - PROCESS | 4453 | Values: 146.0 122.0 146.0 170.0 117.0 147.0 152.0 118.0 163.0 122.0 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 10:24:01 INFO - PROCESS | 4453 | Values: 163.0 161.0 163.0 162.0 163.0 163.0 161.0 161.0 164.0 165.0 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | [#3] audio-fft Cycles:10 Average:95.40 Median:75.50 stddev:41.98 (55.6%) stddev-sans-first:43.93 10:24:01 INFO - PROCESS | 4453 | Values: 76.0 75.0 76.0 178.0 75.0 76.0 75.0 76.0 172.0 75.0 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:84.00 stddev:28.23 (33.6%) stddev-sans-first:29.23 10:24:01 INFO - PROCESS | 4453 | Values: 84.0 84.0 145.0 84.0 85.0 84.0 129.0 84.0 85.0 151.0 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.97 (0.8%) stddev-sans-first:1.00 10:24:01 INFO - PROCESS | 4453 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 120.0 118.0 117.0 118.0 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.34 (0.9%) stddev-sans-first:1.39 10:24:01 INFO - PROCESS | 4453 | Values: 147.0 147.0 148.0 148.0 147.0 148.0 147.0 146.0 151.0 148.0 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 10:24:01 INFO - PROCESS | 4453 | Values: 95.0 96.0 97.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:52.00 stddev:1.96 (3.8%) stddev-sans-first:2.06 10:24:01 INFO - PROCESS | 4453 | Values: 52.0 52.0 55.0 51.0 57.0 52.0 52.0 53.0 51.0 51.0 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.95 (1.6%) stddev-sans-first:0.97 10:24:01 INFO - PROCESS | 4453 | Values: 60.0 62.0 61.0 61.0 61.0 62.0 59.0 60.0 61.0 60.0 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:74.00 stddev:2.88 (3.9%) stddev-sans-first:2.99 10:24:01 INFO - PROCESS | 4453 | Values: 76.0 73.0 74.0 73.0 72.0 72.0 72.0 81.0 77.0 74.0 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:127.00 stddev:12.84 (10.1%) stddev-sans-first:13.01 10:24:01 INFO - PROCESS | 4453 | Values: 117.0 127.0 137.0 121.0 130.0 127.0 116.0 117.0 159.0 127.0 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.20 Median:154.00 stddev:3.46 (2.2%) stddev-sans-first:3.67 10:24:01 INFO - PROCESS | 4453 | Values: 153.0 150.0 154.0 159.0 149.0 157.0 156.0 154.0 149.0 151.0 10:24:01 INFO - PROCESS | 4453 | 10:24:01 INFO - PROCESS | 4453 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:2.54 (4.0%) stddev-sans-first:2.59 10:24:01 INFO - PROCESS | 4453 | Values: 61.0 63.0 65.0 64.0 62.0 61.0 63.0 61.0 61.0 69.0 10:24:01 INFO - PROCESS | 4453 | -------- Summary: end -------- 10:24:01 INFO - PROCESS | 4453 | 10:24:02 INFO - TEST-INFO | 4453: exit 0 10:24:02 INFO - TEST-OK | kraken | took 60895ms 10:24:02 INFO - SUITE-END | took 1171s 10:24:02 INFO - Completed test suite (00:19:32) 10:24:02 INFO - javascript benchmark 10:24:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7830.505544975408, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3291.111399922021, 3292.259241670623, 3304.9504257436142, 3318.70131688148, 3327.2680010397703, 5755.712214389285, 5781.537477001835, 5787.21872547206, 5845.3570107288215, 5857.794977175799, 5765.250517432728, 5775.249217601706, 5792.073268277077, 5832.591718579701, 5852.180694702734, 5287.021900948327, 5303.549198318147, 5311.654742441749, 5340.54605358545, 5382.1926710993275, 5155.7164355960595, 5179.948200518003, 5185.222216667492, 5222.973885130588, 5254.81608143715, 5208.140656791625, 5218.191180367049, 5222.086134926391, 5264.552513036378, 5268.420473747885, 5216.165413533854, 5264.368275806889, 5265.447128051576, 5276.604254680895, 5287.576993840503, 5098.082345177866, 5130.4356520782685, 5133.486651334874, 5172.069027575035, 5173.224016397533, 5652.576056795757, 5696.601237913348, 5716.0, 5733.082706766897, 5750.0, 6098.756049758004, 6144.139820425144, 6148.784792532285, 6151.261848578154, 6154.876902461926, 6083.513318934474, 6133.202683651097, 6177.752889884399, 6181.474574661114, 6187.226596675416, 5766.596338256324, 5824.621399609012, 5863.384344643836, 5884.735186916599, 5912.763489460416, 6332.651704156316, 6364.109024736541, 6395.20059992501, 6432.099506069154, 6442.0, 5837.562182836219, 5949.494292985059, 6117.694115294217, 6120.418560236771, 6134.263888333428, 6107.236595425572, 6127.172831667668, 6138.817583427401, 6202.503799696014, 6205.255369355616, 6176.69116544171, 6179.876402472015, 6185.628862268279, 6193.659348735772, 6201.534884883652, 5952.434518720715, 6098.054801505774, 6130.816075517741, 6182.28903676074, 6192.783252586138, 4716.882077948078, 4721.126591580569, 4724.527547245248, 4743.66794324394, 4749.430068391746, 4215.072684009513, 4215.873523794291, 4215.936760948588, 4231.2806822839575, 4235.618794308527, 5842.328132264759, 5863.149843272701, 5969.283685957713, 6022.09668549721, 6024.457798798129, 6167.321594624587, 6183.721732522047, 6224.315325314212, 6249.281332646804, 6250.593711408744, 5969.641821490724, 5982.880342393128, 6013.218281623361, 6015.939840601538, 6019.789307374221, 5019.924701129413, 5110.310108135429, 5125.461826508237, 5131.947950670104, 5143.588512918957, 6437.871242575216, 6499.772507962199, 6534.967325163344, 6551.1155993941165, 6551.21385433751, 6259.906101408392, 6266.530010249158, 6284.497240220863, 6294.213223347082, 6318.526110541636, 6120.0, 6131.529590167291, 6482.481401487964, 6509.804705858832, 6590.044443555562, 5855.765769369177, 5932.406759324033, 5963.612365196248, 5965.254343207099, 5985.0, 5976.521878249642, 6051.909221361771, 6053.061775424816, 6053.4551890330085, 6092.116643086639, 5820.097884827858, 5946.524278057832, 5947.851303717442, 5956.5532585055425, 5966.164736936746, 5974.850628734316, 6001.639901605918, 6054.848628784315, 6102.755889764359, 6109.11417844419, 5997.700114994145, 6054.485368743706, 6056.06131049688, 6059.575829691879, 6068.878622427438, 5995.250593675791, 6016.699165041643, 6033.668148251888, 6053.969730151321, 6077.4834139098675, 5931.288245410578, 6000.09998500211, 6023.849403764941, 6032.75868965254, 6041.78853740117], "value": 5688.837517061425, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.7464090441111, 626.4549841637775, 654.7970129259929, 672.959622422655, 693.3932808792307, 42652.72041838746, 47761.522384776144, 47916.52083479164, 47932.76033619831, 47953.76023119884, 46886.76556617221, 47807.0, 47908.28137577939, 47917.28124078133, 48280.03439931199, 9202.35583509153, 9256.72229833106, 9296.20982216509, 9298.953505232499, 9308.581113849894, 9135.954320228422, 9195.08049195082, 9204.40171388861, 9209.861852072225, 9211.355205135644, 9303.906960930371, 9417.858732119024, 9418.387804792701, 9439.575219115157, 9445.29160312976, 9354.0, 9364.204042656382, 9364.672236471759, 9375.249980001618, 9385.57764900581, 9118.452892826452, 9231.492267925261, 9231.630734770668, 9237.399569027992, 9238.937522184968, 44536.55463445389, 44649.776751116035, 44916.77541612304, 45222.0, 45330.77334613306, 3910.4720862683457, 4041.353383458662, 4703.341532185496, 4767.213409787381, 4812.879678008043, 35939.4609080864, 36359.63640363589, 36395.81802090999, 36511.63488365136, 38508.42237366442, 4658.394408726844, 4700.835470758507, 4703.247480403119, 4748.6438517111355, 4832.057748738997, 394811.0, 395808.0, 396072.01963990286, 396980.0, 399365.0, 61839.6908015457, 61906.38093619096, 61919.0, 62033.0, 62501.68749156316, 40522.39216411756, 41133.38299925504, 41143.58856411457, 43721.78139109284, 72758.0, 20001.099950502263, 20010.0, 20068.799312006984, 20158.39524814258, 20192.495187620134, 15279.92360038215, 15414.075155490706, 15414.46049388266, 15415.152166630944, 15464.768028479582, 21654.242101526685, 21806.0, 21965.67051494229, 22034.33896983093, 22119.115235390727, 7442.255774422514, 7590.3927685785, 7652.540847549165, 7702.382499675131, 7790.259925307087, 1093.3057508482011, 1100.2243418390017, 1141.5776162819643, 1198.7662405830954, 1208.9214201076902, 35670.464943025356, 35910.46134307988, 36042.918712438666, 36136.457953130724, 36322.81838590843, 1190.9285442873456, 1220.2190598017276, 1260.9093134438644, 1262.5896583610363, 1287.6265882893856, 18565.25738970426, 18624.813751862308, 18680.25278988825, 18684.719729204073, 18971.0, 668248.0, 668623.0, 669171.0, 669172.0, 673132.0, 68472.97290540645, 68902.65548672224, 69491.0, 69491.0, 69615.65192174108, 1407.7325308191412, 1419.936102875373, 1431.7637589797775, 1453.157168842069, 1469.7427950108688, 33860.0, 34493.31013379668, 34762.65237347695, 34950.0, 35505.0, 59880.70059649848, 59936.40063599308, 60092.69953650379, 60139.39860601338, 60242.69878650579, 505433.0, 505700.0, 505756.0, 507597.0, 510151.0, 32847.67152328446, 32868.34263314673, 33034.0, 33163.17092072718, 33227.16932076718, 54056.0, 54173.0, 54955.45044549663, 55304.72347638236, 55441.722791385786, 45265.87619478804, 47125.0, 47555.52444475649, 48483.0, 48712.75643621759, 46710.0, 47048.0, 47795.0, 47881.281780774014, 48205.276920845514, 39292.410613841384, 44130.55869441265, 45094.32358514691, 45551.0, 47764.5223547774, 39746.00634984148, 40469.39295910505, 41369.586304136574, 41512.0, 41554.79222603868, 30860.0, 31191.532127018567, 31363.529547056354, 31604.209894751897, 31695.207619809687], "value": 22279.662235682546, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.6726368010072, 402.41448692152926, 417.3239352249356, 420.9747415155091, 435.9128174365128, 19984.70022949655, 20752.27367042152, 21774.237901673445, 21782.673259901094, 21890.23384181554, 20099.29652462164, 20514.692279615818, 20532.28137015201, 20720.792792072076, 20929.58140837186, 5175.482451754832, 5384.865378365553, 5407.080796264625, 5415.323084614423, 5433.293671822657, 5185.55922746567, 5284.101702710529, 5344.625876188668, 5377.300950876381, 5390.0, 5310.522053015228, 5363.6245462817615, 5367.838964831061, 5377.6824677953955, 5401.0, 5373.919391209135, 5376.704281264529, 5801.535877129841, 6056.666883321415, 6123.050927106306, 5938.257717785277, 5971.0, 5971.343152253248, 5986.97006514969, 6014.8496287592725, 14541.491047813275, 14609.48866789668, 14768.187749673763, 15098.622534436618, 15165.469208577646, 2373.3829204406807, 2708.8103832731717, 2771.8614069296655, 2967.2581854536365, 2981.7465515431213, 13726.382312795848, 15295.0, 15374.385024599003, 16066.196690165445, 16394.754078688828, 1959.823615874578, 1972.8816271023784, 2014.1540552967788, 2100.19142630087, 2134.2956824247963, 84303.15696843015, 89564.0, 91337.0, 91438.54280728554, 94236.05763942341, 9821.705348839547, 10308.0, 10346.32748871321, 10356.067953884187, 11551.711207219887, 13936.442542298195, 14007.789883151761, 14051.78922316166, 14103.294835258195, 14124.081934674214, 8411.98742854322, 8508.74473765788, 8593.95703021481, 8627.48235105883, 8729.519876406732, 8631.352648551383, 8817.250533704708, 8853.822923541622, 8971.0, 8997.865032024525, 4339.284018136972, 4341.261985462479, 4346.434963454731, 4353.73877567347, 4354.0, 2005.7836091119395, 2026.1996511377922, 2040.5918816236813, 2085.3118470904565, 2086.1863873089505, 1008.0625018732502, 1021.6219998600417, 1054.7046826888484, 1084.1326938449367, 1152.6772503698978, 20892.37322880316, 21091.0, 21156.576868462544, 21438.0, 21730.0, 1049.8372752223418, 1057.2916146182076, 1066.8453074304182, 1134.6199023327279, 1138.612871623652, 11043.337399756041, 11735.119866010084, 11840.526378944918, 11916.285022898654, 12021.75956480883, 514468.0, 531039.0, 532361.0, 536998.0, 539313.0, 90169.0, 91723.0, 97205.51397242969, 100573.0, 102089.48955255325, 1050.6427814543092, 1086.750047489082, 1090.2913106480692, 1092.224520590374, 1097.9945100274447, 18985.43043708691, 19084.0, 19146.904265478584, 19207.847529148297, 19250.80749192546, 32732.672673272962, 41560.376594350506, 44186.55813441824, 44792.328115077646, 44835.77582112199, 60896.69551652214, 60978.39021609727, 63378.68310658417, 63805.36194637994, 64818.67590662016, 8968.327375446997, 9036.683716069905, 9184.12750788674, 9225.538723063686, 9250.676226332045, 13950.79073813914, 14159.43362265539, 14216.50242241558, 14275.571732848031, 14609.342579584158, 5907.91138132937, 11033.558657653604, 12590.181638193855, 12716.109872308849, 12806.935965320114, 12409.751804964031, 12670.049746268882, 12788.616341509769, 12942.676433089247, 13081.803772943224, 12155.209911355734, 12850.67873303175, 12976.480940762263, 12991.350432478528, 12993.675158121123, 8976.147266009719, 9015.459072455673, 9064.093590640883, 9177.174054335143, 9321.0, 11699.766004680028, 11928.105392095455, 11941.283522988648, 12137.939310303393, 12145.757084858076], "value": 9594.339217221745, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1569.4036266218839, 1588.586967388479, 1774.1572752942354, 1880.3418803418797, 1911.6941289393699, 8475.83048339033, 9041.547922603877, 9102.499362535058, 9842.065003824635, 9849.162821160193, 9216.815663686722, 9491.19324857388, 9504.904950950488, 9520.143187113159, 9551.283653725963, 2461.2985299189736, 2492.0530198524534, 2508.598624220125, 2508.8745562721792, 2512.899484020646, 2433.4889673168655, 2561.9871900640564, 2575.793936485086, 2579.57437022891, 2582.702989156243, 2467.7532246775268, 2483.615039668854, 2499.600063989762, 2509.648649189115, 2510.8493490390542, 2363.243761996162, 2378.3816207786012, 2380.9999999999914, 2462.298245000184, 2474.072222916406, 2443.2670198940245, 2447.7919376852988, 2457.7665121813397, 2488.664030355897, 2490.464550121714, 9744.853827192597, 9879.308448408614, 9888.505574721235, 9889.901100989042, 9910.950445247727, 5571.275734154575, 5680.857978550528, 5713.714314284311, 5718.313802343704, 5737.856553586152, 3566.5898421681577, 3571.4107172316535, 3601.5137956375816, 3602.3342726382552, 3699.2601479704167, 1239.0, 1323.6955500234903, 1329.0829327763813, 2272.9545409091893, 2357.7642235776457, 13581.253031083286, 13592.320383980861, 13729.244891530961, 13730.51943181984, 13747.656308592364, 4574.199515084847, 4697.0, 4812.302216178635, 4827.589654879374, 4866.7079975200895, 10512.42181680015, 10583.682489525327, 10586.788264234672, 10617.946910265398, 10623.893761062445, 5598.0, 5636.4927156556105, 5659.405762394971, 5659.971700141473, 5675.2054712340305, 4688.8124475021295, 5165.638405311592, 5249.448807875195, 5262.368515778131, 5277.868053298622, 3966.0, 4025.9798701006307, 4031.294523458383, 4097.528784189797, 4111.075008123148, 1136.8635763708407, 1147.0880649883363, 1147.4951021550492, 1148.8626260002538, 1178.092868491257, 1017.730301470111, 1018.6383833739064, 1079.4063265204106, 1086.4567716141928, 1089.05796486039, 6298.401651843067, 6350.0792385103905, 6484.351564843478, 6607.141071660653, 6703.162104736908, 950.2872845365976, 963.3112324687742, 1005.2561104782409, 1023.7542989682571, 1037.6316407675317, 4393.692441529062, 4395.912081758347, 4498.865034048984, 4503.459584849839, 4531.43357080365, 11728.179027467995, 11986.880131198577, 12048.759024819454, 12059.336736479403, 12089.879101209051, 11169.38568378747, 11470.082393408507, 11933.343666098448, 11959.103067269816, 11989.580364687194, 8850.601722922484, 9083.545822708838, 9095.636174552943, 9103.81792364149, 9110.225630821322, 6374.649394283359, 6586.0, 6594.505412094016, 6623.138991931018, 6656.900146497709, 10888.074513666426, 11016.834747478633, 11194.944025279821, 11340.09279257674, 11397.601083962354, 11202.887971120184, 11242.66272011841, 11370.94314528422, 11379.658610241706, 11515.193936424705, 8176.0, 8335.374846886387, 8542.359323050672, 8599.312055035458, 8861.689840855539, 9474.099960503741, 9475.384100033476, 9490.240780737386, 9530.189933855423, 9574.760630984281, 8208.958955205186, 8265.504069755834, 8303.294219991369, 8405.285550728257, 8413.621387037476, 8219.219174178443, 8237.0, 8302.501849889026, 8364.372672049742, 8501.617427215913, 7898.486598371088, 7902.525848449111, 7932.405069619686, 7950.602469876599, 7956.84086318282, 5474.09677403224, 5708.686022268649, 5797.565182611237, 5811.94188058114, 5812.408197524078, 5524.889502209853, 5595.356533998643, 5635.859103522281, 5670.546356291405, 5710.086386178192], "value": 5053.364819622668, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.26305495404694, 349.44089456869006, 352.3059572641896, 354.6719284661687, 356.274980414856, 5844.678542680156, 5845.7953971611005, 5858.88282234355, 5867.55993300502, 5893.116032595102, 5684.4315568443135, 5788.176724331833, 5804.622699524528, 5824.126381042835, 5842.0, 4462.263726485126, 4482.1259854328255, 4491.752953587551, 4520.254158063915, 4526.298423744309, 4482.377808981733, 4497.595216430521, 4499.302608095734, 4505.954940450586, 4524.796384162721, 4477.507474177838, 4482.97758511207, 4512.481064677555, 4539.523350048247, 4548.499665036843, 4361.781910904458, 4460.66545009124, 4480.484744254387, 4492.820287188509, 4506.1663592235545, 3911.4523966644692, 3926.2147570486018, 3952.960470395317, 3953.327934251184, 3970.801459927021, 5677.545796336283, 5681.630694004918, 5699.857503562444, 5708.0, 5737.885242295172, 5089.0, 5107.106256405114, 5162.561182299509, 5175.146100893348, 5187.922181167285, 6034.125051867454, 6035.0, 6069.484093852028, 6089.421504957067, 6109.84725381869, 4294.7974567121255, 4355.150745604608, 4357.542458041891, 4362.1275744851155, 4403.911921761547, 5927.940720592782, 6124.488959526618, 6261.46777523911, 6353.555251132422, 6365.612895164313, 4348.695591308578, 4384.254676704968, 4393.0, 4396.856817227544, 4402.141582391403, 4428.4685837699035, 4458.197524445631, 4459.843905463294, 4468.240399132155, 4473.418455600751, 4972.378452693413, 5052.696838189647, 5157.432682404932, 5165.173572228426, 5188.662736922088, 5984.640921544721, 6029.246344206974, 6033.366496517802, 6049.1833602463985, 6090.725917333731, 1520.817501899757, 1529.9311530981133, 1540.4069433268048, 1540.8151021877447, 1544.7605621128744, 944.4805357053593, 982.5873133284038, 984.9359791613665, 989.7773001074845, 991.6727479931606, 5262.71055091966, 5296.814611488579, 5299.721119918395, 5332.040232758063, 5340.786368545215, 5458.344998600193, 5553.972230138824, 5555.916661250085, 5592.0, 5599.664020158803, 4894.975525122423, 5212.009718153538, 5235.947640523546, 5239.947600523946, 5243.947560524422, 2914.810537315068, 2917.0665387076356, 2930.1063175731606, 2931.9267018324713, 2936.471435141695, 5629.971850140805, 5655.9253741788925, 5692.260006199251, 5731.656100633975, 5732.656040637575, 5190.870228244324, 5493.807716729895, 5534.363548191929, 5573.1855413016165, 5590.8043218487155, 5591.8602034948635, 5600.719964001783, 5683.488486036276, 5728.341240757283, 5728.455796699307, 5154.433012368711, 5464.0, 5518.696471694096, 5522.641028333306, 5539.587405211645, 5378.489043540857, 5427.294451721251, 5431.582945589175, 5454.727263636882, 5491.32514583056, 6303.149074875017, 6427.228732552124, 6444.8388790280615, 6526.24948130971, 6609.636469994197, 4458.777061146865, 4492.685512014258, 4508.729476231437, 4514.029483661028, 4516.322551617283, 6196.442320191204, 6299.11812346281, 6372.426481616677, 6385.233771947396, 6428.935710642833, 6120.724567394389, 6137.478314343152, 6162.969185154046, 6173.197484327009, 6176.845578860564, 5883.794067207627, 6054.182685337423, 6117.3576774439825, 6120.663363515049, 6137.294211165595, 5990.251218597676, 6057.0, 6098.908516372347, 6108.6945652716295, 6117.541184411098, 6106.389361063858, 6157.753689852535, 6163.9383606163365, 6165.72254248551, 6165.907511387422, 5859.2382990211, 6013.135927862377, 6039.124326972652, 6043.612772954746, 6059.878802424015], "value": 4489.237180934177, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.140395478815, 820.331429884644, 833.1793183714044, 857.8241460500598, 931.9813603727921, 16899.070551119683, 17338.82661173388, 17483.475495735118, 17542.298308067693, 17593.82406175938, 16631.168441577935, 16892.83107168928, 16910.915445422786, 16973.660526789456, 17008.4047058353, 868.3400615532178, 890.243293200779, 910.6266430763388, 911.8723378726984, 912.2473958983865, 903.7785742493065, 905.551751882819, 906.4425378392274, 906.9410488318238, 907.120093509295, 951.6050838901847, 955.6320816485668, 955.8375076237022, 958.6213445688949, 960.4957397366404, 947.8720372749694, 950.9381890177116, 952.5903861339622, 953.0231512699469, 953.2088366655694, 703.6657587645878, 703.8451540661098, 705.0517054561658, 705.3933617089299, 707.091387566979, 16829.49511514644, 16852.831471685247, 16878.240479178465, 16883.40908068224, 16936.407225747163, 15429.768553471707, 15600.622473686552, 15603.687926241526, 15701.528954131394, 15960.680786384208, 13508.459661613524, 13573.242718640306, 13623.455061797516, 13632.795508067387, 13852.961027922946, 4194.328907374806, 4211.144453899847, 4214.726042807208, 4232.365145228209, 4326.242907491176, 97249.51375243149, 97451.45812469177, 97877.0, 97960.0, 98231.0, 12350.44423000967, 12526.248425094524, 12570.622881313575, 12773.361331933365, 12897.935510322575, 21927.451813704785, 22996.65505017426, 23669.171578994654, 23687.644685329735, 23754.406139846644, 9011.188992990663, 9068.591913363915, 9072.649145598109, 9098.590563424661, 9142.862857057149, 5159.716215608102, 5163.690178589221, 5226.555742761831, 5244.423113457517, 5343.118385466432, 3894.1432884765304, 4040.1919616076902, 4059.6143366380147, 4062.370332598452, 4081.77550234734, 689.2659317826599, 690.6305126757161, 702.3117345001824, 709.5848928376957, 714.5498336048256, 684.7911387027004, 807.3823525003377, 822.7038266224155, 824.2664029014182, 824.8350329934037, 10394.22043346752, 10520.526576304084, 11224.551017959353, 11536.538538458368, 11612.825807612893, 677.8745932002595, 735.3014636095623, 740.9666565004587, 796.303234669664, 815.3558688635911, 5140.357455318085, 5357.7053262070185, 5364.409914909357, 5457.781688732406, 5530.834074977757, 137316.0, 138708.0, 139667.0, 140565.0, 141855.0, 83940.58029709812, 87522.56238718766, 121127.0, 122592.0, 122651.38674306571, 63186.0522092169, 90559.54720226357, 99898.50050749845, 101045.0, 103091.48454257831, 9452.669156579761, 10263.23025773085, 10361.896381036093, 10394.792104157723, 10406.635767748092, 59082.0, 59133.40866591279, 59867.0, 61381.0, 62407.37592624016, 49326.0, 70427.64786176241, 87621.0, 88003.0, 89722.55138724265, 12684.682882928, 12971.675708107372, 13175.934120329337, 13383.263920484467, 13438.865611344152, 15240.314185861442, 15356.462523811613, 15527.37890484368, 15854.132804164417, 15975.520734377988, 14236.0, 14550.781738273723, 14718.484853030093, 15560.92219538895, 15644.217789110271, 13275.66810829737, 13799.379027943565, 13971.09187902783, 14472.421103155755, 14772.33524491379, 14183.858161418253, 14229.573112806633, 14390.208538530482, 14399.856001439852, 14512.927435362755, 11377.374244416636, 11723.120765942758, 11927.701807454883, 12084.818727719266, 12542.1847579907, 11354.26197297173, 11819.527218911147, 12034.458449369975, 12102.0, 12178.756424871275], "value": 8355.942210889134, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 105.0, 112.0, 112.0, 114.0, 110.0, 111.0, 111.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 146.0, 170.0, 117.0, 147.0, 152.0, 118.0, 163.0, 122.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 162.0, 163.0, 163.0, 161.0, 161.0, 164.0, 165.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 178.0, 75.0, 76.0, 75.0, 76.0, 172.0, 75.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 145.0, 84.0, 85.0, 84.0, 129.0, 84.0, 85.0, 151.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 120.0, 118.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 146.0, 151.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 55.0, 51.0, 57.0, 52.0, 52.0, 53.0, 51.0, 51.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 61.0, 62.0, 59.0, 60.0, 61.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 74.0, 73.0, 72.0, 72.0, 72.0, 81.0, 77.0, 74.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 127.0, 137.0, 121.0, 130.0, 127.0, 116.0, 117.0, 159.0, 127.0], "value": 127.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 154.0, 159.0, 149.0, 157.0, 156.0, 154.0, 149.0, 151.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 65.0, 64.0, 62.0, 61.0, 63.0, 61.0, 61.0, 69.0], "value": 63.0, "unit": "score"}]}]} 10:24:03 INFO - Return code: 0 10:24:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:24:03 ERROR - # TBPL SUCCESS # 10:24:03 INFO - Running post-action listener: _resource_record_post_action 10:24:03 INFO - [mozharness: 2016-09-05 17:24:03.095858Z] Finished run-tests step (success) 10:24:03 INFO - Running post-run listener: _resource_record_post_run 10:24:03 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 692224; Write bytes: 328445952; Read time: 116; Write time: 271016 10:24:03 INFO - TinderboxPrint: CPU usage
13.3% 10:24:03 INFO - TinderboxPrint: I/O read bytes / time
692,224 / 116 10:24:03 INFO - TinderboxPrint: I/O write bytes / time
328,445,952 / 271,016 10:24:03 INFO - TinderboxPrint: CPU idle
8,225.2 (86.7%) 10:24:03 INFO - TinderboxPrint: CPU user
1,203.9 (12.7%) 10:24:03 INFO - TinderboxPrint: Swap in / out
0 / 0 10:24:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 79372288; Read time: 0; Write time: 98620 10:24:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 688128; Write bytes: 248586240; Read time: 104; Write time: 172184 10:24:03 INFO - Running post-run listener: _upload_blobber_files 10:24:03 INFO - Blob upload gear active. 10:24:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:24:03 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:03 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:03 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:04 INFO - (blobuploader) - INFO - Open directory for files ... 10:24:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:24:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:24:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:04 INFO - (blobuploader) - INFO - Done attempting. 10:24:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:24:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:24:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:05 INFO - (blobuploader) - INFO - Done attempting. 10:24:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:24:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:24:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:24:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:24:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:24:09 INFO - (blobuploader) - INFO - Done attempting. 10:24:09 INFO - (blobuploader) - INFO - Iteration through files over. 10:24:09 INFO - Return code: 0 10:24:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:24:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:24:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25d1ad60e8cb1bbfbfbf09d3d1371f8ccb9df0d716e9cb341766c41455d682a32be620043c32d4a2faf645806c6d95543af4a6713016003f4645f18956d17b5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f16312611cd95377cfbd3a5c4e2e5e1af21a23ceac9017bfdd1214ea1b58064f4b5b1c4ac7d94a055392c2c9cf070a65db60bc89fdb747a8f7030a0096972d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85b00b908c2d062e854e3bc01c7e859eb41018025dab087616d30a333c7f1797098feef9e3c879ba9d6ba7910a0a12fcc846c3a3ce6e4895372ed456c19fcfe8"} 10:24:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:24:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:24:09 INFO - Contents: 10:24:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25d1ad60e8cb1bbfbfbf09d3d1371f8ccb9df0d716e9cb341766c41455d682a32be620043c32d4a2faf645806c6d95543af4a6713016003f4645f18956d17b5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f16312611cd95377cfbd3a5c4e2e5e1af21a23ceac9017bfdd1214ea1b58064f4b5b1c4ac7d94a055392c2c9cf070a65db60bc89fdb747a8f7030a0096972d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85b00b908c2d062e854e3bc01c7e859eb41018025dab087616d30a333c7f1797098feef9e3c879ba9d6ba7910a0a12fcc846c3a3ce6e4895372ed456c19fcfe8"} 10:24:09 INFO - Running post-run listener: copy_logs_to_upload_dir 10:24:09 INFO - Copying logs to upload dir... 10:24:09 INFO - mkdir: /builds/slave/test/build/upload/logs 10:24:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1678.847056 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 58 secs) (at 2016-09-05 10:24:09.429588) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-05 10:24:09.433088) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25d1ad60e8cb1bbfbfbf09d3d1371f8ccb9df0d716e9cb341766c41455d682a32be620043c32d4a2faf645806c6d95543af4a6713016003f4645f18956d17b5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f16312611cd95377cfbd3a5c4e2e5e1af21a23ceac9017bfdd1214ea1b58064f4b5b1c4ac7d94a055392c2c9cf070a65db60bc89fdb747a8f7030a0096972d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85b00b908c2d062e854e3bc01c7e859eb41018025dab087616d30a333c7f1797098feef9e3c879ba9d6ba7910a0a12fcc846c3a3ce6e4895372ed456c19fcfe8"} 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.011367 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/25d1ad60e8cb1bbfbfbf09d3d1371f8ccb9df0d716e9cb341766c41455d682a32be620043c32d4a2faf645806c6d95543af4a6713016003f4645f18956d17b5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0f16312611cd95377cfbd3a5c4e2e5e1af21a23ceac9017bfdd1214ea1b58064f4b5b1c4ac7d94a055392c2c9cf070a65db60bc89fdb747a8f7030a0096972d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85b00b908c2d062e854e3bc01c7e859eb41018025dab087616d30a333c7f1797098feef9e3c879ba9d6ba7910a0a12fcc846c3a3ce6e4895372ed456c19fcfe8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-05 10:24:09.459651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 10:24:09.460011) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1473092659.873582-2009984199 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-05 10:24:09.547613) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-05 10:24:09.548043) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-05 10:24:09.548674) ========= ========= Total master_lag: 0.18 =========