builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1477423245.52 results: success (0) buildid: 20161025093138 builduid: f62c4c7d8aa54d90b04b8b17a4ae587c revision: 4d922532989dbbd59fdf07233d4f07bd5a153919 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 12:20:45.521803) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 12:20:45.522318) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 12:20:45.522703) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 12:20:45.546106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 12:20:45.546403) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-25 12:20:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.1M=0.001s 2016-10-25 12:20:45 (20.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 12:20:45.679805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 12:20:45.680114) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015010 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 12:20:45.733433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 12:20:45.733798) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4d922532989dbbd59fdf07233d4f07bd5a153919 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 4d922532989dbbd59fdf07233d4f07bd5a153919 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-25 12:20:46,088 truncating revision to first 12 chars 2016-10-25 12:20:46,088 Setting DEBUG logging. 2016-10-25 12:20:46,088 attempt 1/10 2016-10-25 12:20:46,088 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/4d922532989d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 12:20:46,391 unpacking tar archive at: mozilla-beta-4d922532989d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646802 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 12:20:46.394484) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 12:20:46.394789) ========= script_repo_revision: 4d922532989dbbd59fdf07233d4f07bd5a153919 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 12:20:46.395178) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 12:20:46.395476) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 12:20:46.404215) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-10-25 12:20:46.404619) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:20:46 INFO - MultiFileLogger online at 20161025 12:20:46 in /builds/slave/test 12:20:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:20:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:20:46 INFO - {'append_to_log': False, 12:20:46 INFO - 'base_work_dir': '/builds/slave/test', 12:20:46 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:20:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:20:46 INFO - 'branch': 'Mozilla-Beta', 12:20:46 INFO - 'buildbot_json_path': 'buildprops.json', 12:20:46 INFO - 'config_files': ('talos/linux_config.py',), 12:20:46 INFO - 'default_actions': ('clobber', 12:20:46 INFO - 'read-buildbot-config', 12:20:46 INFO - 'download-and-extract', 12:20:46 INFO - 'populate-webroot', 12:20:46 INFO - 'create-virtualenv', 12:20:46 INFO - 'install', 12:20:46 INFO - 'run-tests'), 12:20:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:20:46 INFO - 'download_minidump_stackwalk': True, 12:20:46 INFO - 'download_symbols': 'ondemand', 12:20:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:20:46 INFO - 'tooltool.py': '/tools/tooltool.py', 12:20:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:20:46 INFO - '/tools/misc-python/virtualenv.py')}, 12:20:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:20:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:20:46 INFO - 'installer_path': 'installer.exe', 12:20:46 INFO - 'log_level': 'info', 12:20:46 INFO - 'log_name': 'talos', 12:20:46 INFO - 'log_to_console': True, 12:20:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:20:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:20:46 INFO - 'opt_config_files': (), 12:20:46 INFO - 'pip_index': False, 12:20:46 INFO - 'sps_profile': False, 12:20:46 INFO - 'sps_profile_interval': 0, 12:20:46 INFO - 'suite': 'dromaeojs-e10s', 12:20:46 INFO - 'system_bits': '32', 12:20:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:20:46 INFO - 'title': 'talos-linux64-ix-057', 12:20:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:20:46 INFO - 'use_talos_json': True, 12:20:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:20:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:20:46 INFO - 'work_dir': 'build'} 12:20:46 INFO - [mozharness: 2016-10-25 19:20:46.842586Z] Running clobber step. 12:20:46 INFO - Running pre-action listener: _resource_record_pre_action 12:20:46 INFO - Running main action method: clobber 12:20:46 INFO - rmtree: /builds/slave/test/build 12:20:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:20:47 INFO - Running post-action listener: _resource_record_post_action 12:20:47 INFO - [mozharness: 2016-10-25 19:20:47.814621Z] Finished clobber step (success) 12:20:47 INFO - [mozharness: 2016-10-25 19:20:47.814722Z] Running read-buildbot-config step. 12:20:47 INFO - Running pre-action listener: _resource_record_pre_action 12:20:47 INFO - Running main action method: read_buildbot_config 12:20:47 INFO - Using buildbot properties: 12:20:47 INFO - { 12:20:47 INFO - "project": "", 12:20:47 INFO - "product": "firefox", 12:20:47 INFO - "script_repo_revision": "production", 12:20:47 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 12:20:47 INFO - "repository": "", 12:20:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 12:20:47 INFO - "buildid": "20161025093138", 12:20:47 INFO - "pgo_build": "True", 12:20:47 INFO - "basedir": "/builds/slave/test", 12:20:47 INFO - "buildnumber": 301, 12:20:47 INFO - "slavename": "talos-linux64-ix-057", 12:20:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:20:47 INFO - "platform": "ubuntu64_hw", 12:20:47 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:20:47 INFO - "branch": "mozilla-beta", 12:20:47 INFO - "repo_path": "releases/mozilla-beta", 12:20:47 INFO - "revision": "4d922532989dbbd59fdf07233d4f07bd5a153919", 12:20:47 INFO - "stage_platform": "linux64-pgo", 12:20:47 INFO - "builduid": "f62c4c7d8aa54d90b04b8b17a4ae587c", 12:20:47 INFO - "slavebuilddir": "test" 12:20:47 INFO - } 12:20:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 12:20:47 INFO - Running post-action listener: _resource_record_post_action 12:20:47 INFO - [mozharness: 2016-10-25 19:20:47.817159Z] Finished read-buildbot-config step (success) 12:20:47 INFO - [mozharness: 2016-10-25 19:20:47.817247Z] Running download-and-extract step. 12:20:47 INFO - Running pre-action listener: _resource_record_pre_action 12:20:47 INFO - Running main action method: download_and_extract 12:20:47 INFO - mkdir: /builds/slave/test/build/tests 12:20: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')]} 12:20:47 INFO - https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:20:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 12:20:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 12:20:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 12:20:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:20:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 12:20:47 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 12:20:47 INFO - retry: Failed, sleeping 30 seconds before retrying 12:21:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 12:21:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 12:21:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 12:21:17 INFO - retry: Failed, sleeping 60 seconds before retrying 12:22:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 12:22:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 12:22:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 12:22:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 12:22:17 INFO - Caught exception: HTTP Error 404: Not Found 12:22:17 INFO - Caught exception: HTTP Error 404: Not Found 12:22:17 INFO - Caught exception: HTTP Error 404: Not Found 12:22:17 INFO - trying https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 12:22:17 INFO - Downloading https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 12:22:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:22:18 INFO - Downloaded 1327 bytes. 12:22:18 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 12:22:18 INFO - Using the following test package requirements: 12:22:18 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 12:22:18 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:22:18 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 12:22:18 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'jsshell-linux-x86_64.zip'], 12:22:18 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:22:18 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 12:22:18 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 12:22:18 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 12:22:18 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:22:18 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 12:22:18 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:22:18 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:22:18 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')]} 12:22:18 INFO - https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:22:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:22:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:22:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:22:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:22:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:22:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 12:22:18 INFO - retry: Failed, sleeping 30 seconds before retrying 12:22:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 12:22:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:22:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 12:22:48 INFO - retry: Failed, sleeping 60 seconds before retrying 12:23:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 12:23:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:23:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 12:23:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 12:23:48 INFO - Caught exception: HTTP Error 404: Not Found 12:23:48 INFO - Caught exception: HTTP Error 404: Not Found 12:23:48 INFO - Caught exception: HTTP Error 404: Not Found 12:23:48 INFO - trying https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:23:48 INFO - Downloading https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:23:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:23:50 INFO - Downloaded 21774800 bytes. 12:23:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:23:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:23:51 INFO - Return code: 0 12:23:51 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:23:51 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')]} 12:23:51 INFO - https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:23:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:23:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:23:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:23:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:23:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:23:51 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 12:23:51 INFO - retry: Failed, sleeping 30 seconds before retrying 12:24:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 12:24:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:24:21 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 12:24:21 INFO - retry: Failed, sleeping 60 seconds before retrying 12:25:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 12:25:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:25:21 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 12:25:21 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 12:25:21 INFO - Caught exception: HTTP Error 404: Not Found 12:25:21 INFO - Caught exception: HTTP Error 404: Not Found 12:25:21 INFO - Caught exception: HTTP Error 404: Not Found 12:25:21 INFO - trying https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:25:21 INFO - Downloading https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 12:25:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:25:22 INFO - Downloaded 21774800 bytes. 12:25:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:25:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:25:23 INFO - Return code: 0 12:25:23 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')]} 12:25:23 INFO - https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:25:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 12:25:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 12:25:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 12:25:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:25:23 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 12:25:23 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 12:25:23 INFO - retry: Failed, sleeping 30 seconds before retrying 12:25:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 12:25:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 12:25:53 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 12:25:53 INFO - retry: Failed, sleeping 60 seconds before retrying 12:26:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 12:26:53 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 12:26:53 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 12:26:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 12:26:53 INFO - Caught exception: HTTP Error 404: Not Found 12:26:53 INFO - Caught exception: HTTP Error 404: Not Found 12:26:53 INFO - Caught exception: HTTP Error 404: Not Found 12:26:53 INFO - trying https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 12:26:53 INFO - Downloading https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 12:26:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:26:55 INFO - Downloaded 14413762 bytes. 12:26:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:26:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:26:55 INFO - Return code: 0 12:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:26:55 INFO - https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:26:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 12:26:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 12:26:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 12:26:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:26:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 12:26:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 12:26:55 INFO - retry: Failed, sleeping 30 seconds before retrying 12:27:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 12:27:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 12:27:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 12:27:25 INFO - retry: Failed, sleeping 60 seconds before retrying 12:28:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 12:28:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 12:28:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 12:28:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 12:28:25 INFO - Caught exception: HTTP Error 404: Not Found 12:28:25 INFO - Caught exception: HTTP Error 404: Not Found 12:28:25 INFO - Caught exception: HTTP Error 404: Not Found 12:28:25 INFO - trying https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 12:28:25 INFO - Downloading https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 12:28:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:28:27 INFO - Downloaded 56791185 bytes. 12:28:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 12:28:27 INFO - mkdir: /builds/slave/test/properties 12:28:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:28:27 INFO - Writing to file /builds/slave/test/properties/build_url 12:28:27 INFO - Contents: 12:28:27 INFO - build_url:https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 12:28:28 INFO - Running post-action listener: _resource_record_post_action 12:28:28 INFO - Running post-action listener: set_extra_try_arguments 12:28:28 INFO - [mozharness: 2016-10-25 19:28:28.147540Z] Finished download-and-extract step (success) 12:28:28 INFO - [mozharness: 2016-10-25 19:28:28.147772Z] Running populate-webroot step. 12:28:28 INFO - Running pre-action listener: _resource_record_pre_action 12:28:28 INFO - Running main action method: populate_webroot 12:28:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:28:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:28:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:28:28 INFO - '--tppagecycles', 12:28:28 INFO - '7'], 12:28:28 INFO - 'tests': ['tsvgm']}}, 12:28:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:28:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:28:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:28:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:28:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:28:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:28:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:28 INFO - 'talos_options': ['--disable-e10s'], 12:28:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:28:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:28:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:28 INFO - 'talos_options': ['--disable-e10s'], 12:28:28 INFO - 'tests': ['damp', 'tps']}, 12:28:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:28 INFO - 'tests': ['damp', 'tps']}, 12:28:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:28:28 INFO - 'tests': ['dromaeo_dom']}, 12:28:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:28:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:28:28 INFO - 'tests': ['basic_compositor_video']}, 12:28:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:28:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:28:28 INFO - 'tests': ['a11yr', 12:28:28 INFO - 'ts_paint', 12:28:28 INFO - 'tpaint', 12:28:28 INFO - 'sessionrestore', 12:28:28 INFO - 'sessionrestore_no_auto_restore', 12:28:28 INFO - 'tabpaint']}, 12:28:28 INFO - 'other-e10s': {'tests': ['a11yr', 12:28:28 INFO - 'ts_paint', 12:28:28 INFO - 'tpaint', 12:28:28 INFO - 'sessionrestore', 12:28:28 INFO - 'sessionrestore_no_auto_restore', 12:28:28 INFO - 'tabpaint']}, 12:28:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:28:28 INFO - 'ts_paint', 12:28:28 INFO - 'tpaint', 12:28:28 INFO - 'sessionrestore', 12:28:28 INFO - 'sessionrestore_no_auto_restore', 12:28:28 INFO - 'tabpaint']}, 12:28:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:28:28 INFO - 'ts_paint', 12:28:28 INFO - 'tpaint', 12:28:28 INFO - 'sessionrestore', 12:28:28 INFO - 'sessionrestore_no_auto_restore', 12:28:28 INFO - 'tabpaint']}, 12:28:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:28:28 INFO - 'tests': ['a11yr', 12:28:28 INFO - 'ts_paint', 12:28:28 INFO - 'tpaint', 12:28:28 INFO - 'sessionrestore', 12:28:28 INFO - 'sessionrestore_no_auto_restore', 12:28:28 INFO - 'tabpaint']}, 12:28:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:28:28 INFO - 'tests': ['a11yr', 12:28:28 INFO - 'ts_paint', 12:28:28 INFO - 'tpaint', 12:28:28 INFO - 'sessionrestore', 12:28:28 INFO - 'sessionrestore_no_auto_restore', 12:28:28 INFO - 'tabpaint']}, 12:28:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:28:28 INFO - 'tests': ['tsvgx', 12:28:28 INFO - 'tsvgr_opacity', 12:28:28 INFO - 'tart', 12:28:28 INFO - 'tscrollx', 12:28:28 INFO - 'cart']}, 12:28:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:28:28 INFO - 'tsvgr_opacity', 12:28:28 INFO - 'tart', 12:28:28 INFO - 'tscrollx', 12:28:28 INFO - 'cart']}, 12:28:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:28 INFO - 'talos_options': ['--disable-e10s'], 12:28:28 INFO - 'tests': ['tp5o']}, 12:28:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:28 INFO - 'tests': ['tp5o']}, 12:28:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:28 INFO - 'talos_options': ['--disable-e10s', 12:28:28 INFO - '--xperf_path', 12:28:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:28:28 INFO - 'tests': ['tp5n']}, 12:28:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:28 INFO - 'talos_options': ['--xperf_path', 12:28:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:28:28 INFO - 'tests': ['tp5n']}}, 12:28:28 INFO - 'talos.zip': {'path': '', 12:28:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:28:28 INFO - Running post-action listener: _resource_record_post_action 12:28:28 INFO - [mozharness: 2016-10-25 19:28:28.167172Z] Finished populate-webroot step (success) 12:28:28 INFO - [mozharness: 2016-10-25 19:28:28.167261Z] Running create-virtualenv step. 12:28:28 INFO - Running pre-action listener: _resource_record_pre_action 12:28:28 INFO - Running main action method: create_virtualenv 12:28:28 INFO - Creating virtualenv /builds/slave/test/build/venv 12:28:28 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 12:28:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:28:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:28:28 INFO - Using real prefix '/usr' 12:28:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:28:28 INFO - Installing distribute.............................................................................................................................................................................................done. 12:28:30 INFO - Installing pip.................done. 12:28:30 INFO - Return code: 0 12:28:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:28: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')]} 12:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28: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')]} 12:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:30 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 0x20e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2317400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6570>, '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 0x23a7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', '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 12:28:30 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 12:28:30 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 12:28:30 INFO - Using env: {'DISPLAY': ':0', 12:28:30 INFO - 'HOME': '/home/cltbld', 12:28:30 INFO - 'LANG': 'en_US.UTF-8', 12:28:30 INFO - 'LANGUAGE': 'en_US:en', 12:28:30 INFO - 'LOGNAME': 'cltbld', 12:28:30 INFO - 'MAIL': '/var/mail/cltbld', 12:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:30 INFO - 'MOZ_NO_REMOTE': '1', 12:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:30 INFO - 'NO_EM_RESTART': '1', 12:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:30 INFO - 'PWD': '/builds/slave/test', 12:28:30 INFO - 'SHELL': '/bin/bash', 12:28:30 INFO - 'SHLVL': '1', 12:28:30 INFO - 'TERM': 'linux', 12:28:30 INFO - 'TMOUT': '86400', 12:28:30 INFO - 'USER': 'cltbld', 12:28:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', 12:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:30 INFO - '_': '/tools/buildbot/bin/python'} 12:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:30 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 12:28:30 INFO - Cleaning up... 12:28:30 INFO - Return code: 0 12:28:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:28: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')]} 12:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28: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')]} 12:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:30 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 0x20e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2317400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6570>, '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 0x23a7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', '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 12:28:30 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 12:28:30 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 12:28:30 INFO - Using env: {'DISPLAY': ':0', 12:28:30 INFO - 'HOME': '/home/cltbld', 12:28:30 INFO - 'LANG': 'en_US.UTF-8', 12:28:30 INFO - 'LANGUAGE': 'en_US:en', 12:28:30 INFO - 'LOGNAME': 'cltbld', 12:28:30 INFO - 'MAIL': '/var/mail/cltbld', 12:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:30 INFO - 'MOZ_NO_REMOTE': '1', 12:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:30 INFO - 'NO_EM_RESTART': '1', 12:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:30 INFO - 'PWD': '/builds/slave/test', 12:28:30 INFO - 'SHELL': '/bin/bash', 12:28:30 INFO - 'SHLVL': '1', 12:28:30 INFO - 'TERM': 'linux', 12:28:30 INFO - 'TMOUT': '86400', 12:28:30 INFO - 'USER': 'cltbld', 12:28:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', 12:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:30 INFO - '_': '/tools/buildbot/bin/python'} 12:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:31 INFO - Downloading/unpacking psutil>=3.1.1 12:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:28:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:28:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:28:33 INFO - Installing collected packages: psutil 12:28:33 INFO - Running setup.py install for psutil 12:28:33 INFO - building 'psutil._psutil_linux' extension 12:28:33 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 12:28:33 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 12:28:33 INFO - building 'psutil._psutil_posix' extension 12:28:33 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 12:28:33 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 12:28:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:28:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:28:33 INFO - Successfully installed psutil 12:28:33 INFO - Cleaning up... 12:28:33 INFO - Return code: 0 12:28:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:28:33 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')]} 12:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:33 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')]} 12:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:33 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 0x20e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2317400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6570>, '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 0x23a7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', '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 12:28:33 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 12:28:33 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 12:28:33 INFO - Using env: {'DISPLAY': ':0', 12:28:33 INFO - 'HOME': '/home/cltbld', 12:28:33 INFO - 'LANG': 'en_US.UTF-8', 12:28:33 INFO - 'LANGUAGE': 'en_US:en', 12:28:33 INFO - 'LOGNAME': 'cltbld', 12:28:33 INFO - 'MAIL': '/var/mail/cltbld', 12:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:33 INFO - 'MOZ_NO_REMOTE': '1', 12:28:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:33 INFO - 'NO_EM_RESTART': '1', 12:28:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:33 INFO - 'PWD': '/builds/slave/test', 12:28:33 INFO - 'SHELL': '/bin/bash', 12:28:33 INFO - 'SHLVL': '1', 12:28:33 INFO - 'TERM': 'linux', 12:28:33 INFO - 'TMOUT': '86400', 12:28:33 INFO - 'USER': 'cltbld', 12:28:33 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', 12:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:33 INFO - '_': '/tools/buildbot/bin/python'} 12:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:28:33 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 12:28:33 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 12:28:33 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 12:28:33 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 12:28:33 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 12:28:33 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 12:28:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:28:35 INFO - Installing collected packages: mozsystemmonitor 12:28:35 INFO - Running setup.py install for mozsystemmonitor 12:28:36 INFO - Successfully installed mozsystemmonitor 12:28:36 INFO - Cleaning up... 12:28:36 INFO - Return code: 0 12:28:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2317400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6570>, '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 0x23a7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', '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 12:28:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:28:36 INFO - Using env: {'DISPLAY': ':0', 12:28:36 INFO - 'HOME': '/home/cltbld', 12:28:36 INFO - 'LANG': 'en_US.UTF-8', 12:28:36 INFO - 'LANGUAGE': 'en_US:en', 12:28:36 INFO - 'LOGNAME': 'cltbld', 12:28:36 INFO - 'MAIL': '/var/mail/cltbld', 12:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:36 INFO - 'MOZ_NO_REMOTE': '1', 12:28:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:36 INFO - 'NO_EM_RESTART': '1', 12:28:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:36 INFO - 'PWD': '/builds/slave/test', 12:28:36 INFO - 'SHELL': '/bin/bash', 12:28:36 INFO - 'SHLVL': '1', 12:28:36 INFO - 'TERM': 'linux', 12:28:36 INFO - 'TMOUT': '86400', 12:28:36 INFO - 'USER': 'cltbld', 12:28:36 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', 12:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:36 INFO - '_': '/tools/buildbot/bin/python'} 12:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:36 INFO - Downloading/unpacking jsonschema==2.5.1 12:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:28:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:28:38 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 12:28:38 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 12:28:38 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 12:28:38 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 12:28:38 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 12:28:38 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 12:28:38 INFO - Downloading functools32-3.2.3-2.tar.gz 12:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:28:38 INFO - warning: no files found matching '*.txt' 12:28:38 INFO - no previously-included directories found matching 'build' 12:28:38 INFO - no previously-included directories found matching 'dist' 12:28:38 INFO - no previously-included directories found matching '.git*' 12:28:38 INFO - Installing collected packages: jsonschema, functools32 12:28:38 INFO - Running setup.py install for functools32 12:28:38 INFO - warning: no files found matching '*.txt' 12:28:38 INFO - no previously-included directories found matching 'build' 12:28:38 INFO - no previously-included directories found matching 'dist' 12:28:38 INFO - no previously-included directories found matching '.git*' 12:28:38 INFO - Successfully installed jsonschema functools32 12:28:38 INFO - Cleaning up... 12:28:38 INFO - Return code: 0 12:28:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:28:38 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')]} 12:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:38 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')]} 12:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:38 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 0x20e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2317400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6570>, '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 0x23a7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', '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 12:28:38 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 12:28:38 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 12:28:38 INFO - Using env: {'DISPLAY': ':0', 12:28:38 INFO - 'HOME': '/home/cltbld', 12:28:38 INFO - 'LANG': 'en_US.UTF-8', 12:28:38 INFO - 'LANGUAGE': 'en_US:en', 12:28:38 INFO - 'LOGNAME': 'cltbld', 12:28:38 INFO - 'MAIL': '/var/mail/cltbld', 12:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:38 INFO - 'MOZ_NO_REMOTE': '1', 12:28:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:38 INFO - 'NO_EM_RESTART': '1', 12:28:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:38 INFO - 'PWD': '/builds/slave/test', 12:28:38 INFO - 'SHELL': '/bin/bash', 12:28:38 INFO - 'SHLVL': '1', 12:28:38 INFO - 'TERM': 'linux', 12:28:38 INFO - 'TMOUT': '86400', 12:28:38 INFO - 'USER': 'cltbld', 12:28:38 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', 12:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:38 INFO - '_': '/tools/buildbot/bin/python'} 12:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:28:39 INFO - Cleaning up... 12:28:39 INFO - Return code: 0 12:28:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:28:39 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')]} 12:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:39 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')]} 12:28:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:39 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 0x20e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2317400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6570>, '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 0x23a7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', '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 12:28:39 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 12:28:39 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 12:28:39 INFO - Using env: {'DISPLAY': ':0', 12:28:39 INFO - 'HOME': '/home/cltbld', 12:28:39 INFO - 'LANG': 'en_US.UTF-8', 12:28:39 INFO - 'LANGUAGE': 'en_US:en', 12:28:39 INFO - 'LOGNAME': 'cltbld', 12:28:39 INFO - 'MAIL': '/var/mail/cltbld', 12:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:39 INFO - 'MOZ_NO_REMOTE': '1', 12:28:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:39 INFO - 'NO_EM_RESTART': '1', 12:28:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:39 INFO - 'PWD': '/builds/slave/test', 12:28:39 INFO - 'SHELL': '/bin/bash', 12:28:39 INFO - 'SHLVL': '1', 12:28:39 INFO - 'TERM': 'linux', 12:28:39 INFO - 'TMOUT': '86400', 12:28:39 INFO - 'USER': 'cltbld', 12:28:39 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', 12:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:39 INFO - '_': '/tools/buildbot/bin/python'} 12:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:39 INFO - Downloading/unpacking blobuploader==1.2.4 12:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:41 INFO - Downloading blobuploader-1.2.4.tar.gz 12:28:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:28:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:28:41 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 12:28:41 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 12:28:41 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 12:28:41 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 12:28:41 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 12:28:41 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 12:28:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:28:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:28:41 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 12:28:41 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 12:28:41 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 12:28:41 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 12:28:41 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 12:28:41 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 12:28:41 INFO - Downloading docopt-0.6.1.tar.gz 12:28:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:28:42 INFO - Installing collected packages: blobuploader, requests, docopt 12:28:42 INFO - Running setup.py install for blobuploader 12:28:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:28:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:28:42 INFO - Running setup.py install for requests 12:28:42 INFO - Running setup.py install for docopt 12:28:42 INFO - Successfully installed blobuploader requests docopt 12:28:42 INFO - Cleaning up... 12:28:42 INFO - Return code: 0 12:28:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:42 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 0x20e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2317400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6570>, '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 0x23a7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', '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 12:28:42 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 12:28:42 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 12:28:42 INFO - Using env: {'DISPLAY': ':0', 12:28:42 INFO - 'HOME': '/home/cltbld', 12:28:42 INFO - 'LANG': 'en_US.UTF-8', 12:28:42 INFO - 'LANGUAGE': 'en_US:en', 12:28:42 INFO - 'LOGNAME': 'cltbld', 12:28:42 INFO - 'MAIL': '/var/mail/cltbld', 12:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:42 INFO - 'MOZ_NO_REMOTE': '1', 12:28:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:42 INFO - 'NO_EM_RESTART': '1', 12:28:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:42 INFO - 'PWD': '/builds/slave/test', 12:28:42 INFO - 'SHELL': '/bin/bash', 12:28:42 INFO - 'SHLVL': '1', 12:28:42 INFO - 'TERM': 'linux', 12:28:42 INFO - 'TMOUT': '86400', 12:28:42 INFO - 'USER': 'cltbld', 12:28:42 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', 12:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:42 INFO - '_': '/tools/buildbot/bin/python'} 12:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:28:42 INFO - Running setup.py (path:/tmp/pip-mXavxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:28:42 INFO - Running setup.py (path:/tmp/pip-UpeOIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:28:43 INFO - Running setup.py (path:/tmp/pip-qjOKrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:28:43 INFO - Running setup.py (path:/tmp/pip-gO8ou5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:28:43 INFO - Running setup.py (path:/tmp/pip-1J5ZNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:28:43 INFO - Running setup.py (path:/tmp/pip-2sYuzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:28:43 INFO - Running setup.py (path:/tmp/pip-vDEq7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:28:43 INFO - Running setup.py (path:/tmp/pip-oNaapF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:28:43 INFO - Running setup.py (path:/tmp/pip-aUGG5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:28:43 INFO - Running setup.py (path:/tmp/pip-uJQk52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:28:43 INFO - Running setup.py (path:/tmp/pip-TKLJtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:28:43 INFO - Running setup.py (path:/tmp/pip-DYHWTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:28:43 INFO - Running setup.py (path:/tmp/pip-rnWKwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:28:43 INFO - Running setup.py (path:/tmp/pip-C0bHS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:43 INFO - Running setup.py (path:/tmp/pip-XLKjCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:28:43 INFO - Running setup.py (path:/tmp/pip-vshJ52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:28:44 INFO - Running setup.py (path:/tmp/pip-bDnI3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:28:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:28:44 INFO - Running setup.py install for manifestparser 12:28:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:28:44 INFO - Running setup.py install for mozcrash 12:28:44 INFO - Running setup.py install for mozdebug 12:28:44 INFO - Running setup.py install for mozdevice 12:28:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:28:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:28:44 INFO - Running setup.py install for mozfile 12:28:44 INFO - Running setup.py install for mozhttpd 12:28:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:28:44 INFO - Running setup.py install for mozinfo 12:28:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:28:44 INFO - Running setup.py install for mozInstall 12:28:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:28:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:28:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:28:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:28:44 INFO - Running setup.py install for mozleak 12:28:45 INFO - Running setup.py install for mozlog 12:28:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:28:45 INFO - Running setup.py install for moznetwork 12:28:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:28:45 INFO - Running setup.py install for mozprocess 12:28:45 INFO - Running setup.py install for mozprofile 12:28:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:28:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:28:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:28:45 INFO - Running setup.py install for mozrunner 12:28:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:28:45 INFO - Running setup.py install for mozscreenshot 12:28:45 INFO - Running setup.py install for moztest 12:28:45 INFO - Running setup.py install for mozversion 12:28:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:28:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:28:45 INFO - Cleaning up... 12:28:45 INFO - Return code: 0 12:28:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:28:45 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')]} 12:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:45 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')]} 12:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:45 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 0x20e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2317400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6570>, '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 0x23a7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', '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 12:28:45 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 12:28:45 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 12:28:45 INFO - Using env: {'DISPLAY': ':0', 12:28:45 INFO - 'HOME': '/home/cltbld', 12:28:45 INFO - 'LANG': 'en_US.UTF-8', 12:28:45 INFO - 'LANGUAGE': 'en_US:en', 12:28:45 INFO - 'LOGNAME': 'cltbld', 12:28:45 INFO - 'MAIL': '/var/mail/cltbld', 12:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:45 INFO - 'MOZ_NO_REMOTE': '1', 12:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:45 INFO - 'NO_EM_RESTART': '1', 12:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:45 INFO - 'PWD': '/builds/slave/test', 12:28:45 INFO - 'SHELL': '/bin/bash', 12:28:45 INFO - 'SHLVL': '1', 12:28:45 INFO - 'TERM': 'linux', 12:28:45 INFO - 'TMOUT': '86400', 12:28:45 INFO - 'USER': 'cltbld', 12:28:45 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', 12:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:45 INFO - '_': '/tools/buildbot/bin/python'} 12:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:28:46 INFO - Running setup.py (path:/tmp/pip-ZATsfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:28:46 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)) 12:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:28:46 INFO - Running setup.py (path:/tmp/pip-kau_r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:28:46 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)) 12:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:28:46 INFO - Running setup.py (path:/tmp/pip-CxgH9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:28:46 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)) 12:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:28:46 INFO - Running setup.py (path:/tmp/pip-N7U8ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:28:46 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)) 12:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:28:46 INFO - Running setup.py (path:/tmp/pip-jhyl7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:28:46 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)) 12:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:28:46 INFO - Running setup.py (path:/tmp/pip-CjmVGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:28:46 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)) 12:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:28:46 INFO - Running setup.py (path:/tmp/pip-Eha3s7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:28:46 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)) 12:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:28:46 INFO - Running setup.py (path:/tmp/pip-toZ6cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:28:46 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)) 12:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:28:46 INFO - Running setup.py (path:/tmp/pip-cVoCWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:28:46 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)) 12:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:28:46 INFO - Running setup.py (path:/tmp/pip-CpaMdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:28:46 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)) 12:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:28:46 INFO - Running setup.py (path:/tmp/pip-GpQhSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:28:46 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)) 12:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:28:46 INFO - Running setup.py (path:/tmp/pip-bR_GVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:28:47 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)) 12:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:28:47 INFO - Running setup.py (path:/tmp/pip-rK2y3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:28:47 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)) 12:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:28:47 INFO - Running setup.py (path:/tmp/pip-tEQce3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:28:47 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)) 12:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:47 INFO - Running setup.py (path:/tmp/pip-EvkLSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:28:47 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)) 12:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:28:47 INFO - Running setup.py (path:/tmp/pip-NFc97I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:28:47 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)) 12:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:28:47 INFO - Running setup.py (path:/tmp/pip-3ASiLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:28:47 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)) 12:28:47 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)) 12:28:47 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)) 12:28:47 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)) 12:28:47 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)) 12:28:47 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)) 12:28:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:49 INFO - Downloading blessings-1.6.tar.gz 12:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:28:49 INFO - Installing collected packages: blessings 12:28:49 INFO - Running setup.py install for blessings 12:28:49 INFO - Successfully installed blessings 12:28:49 INFO - Cleaning up... 12:28:49 INFO - Return code: 0 12:28:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:28:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:28:49 INFO - Reading from file tmpfile_stdout 12:28:49 INFO - Current package versions: 12:28:49 INFO - argparse == 1.2.1 12:28:49 INFO - blessings == 1.6 12:28:49 INFO - blobuploader == 1.2.4 12:28:49 INFO - docopt == 0.6.1 12:28:49 INFO - functools32 == 3.2.3-2 12:28:49 INFO - jsonschema == 2.5.1 12:28:49 INFO - manifestparser == 1.1 12:28:49 INFO - mozInstall == 1.12 12:28:49 INFO - mozcrash == 0.17 12:28:49 INFO - mozdebug == 0.1 12:28:49 INFO - mozdevice == 0.48 12:28:49 INFO - mozfile == 1.2 12:28:49 INFO - mozhttpd == 0.7 12:28:49 INFO - mozinfo == 0.9 12:28:49 INFO - mozleak == 0.1 12:28:49 INFO - mozlog == 3.3 12:28:49 INFO - moznetwork == 0.27 12:28:49 INFO - mozprocess == 0.23 12:28:49 INFO - mozprofile == 0.28 12:28:49 INFO - mozrunner == 6.12 12:28:49 INFO - mozscreenshot == 0.1 12:28:49 INFO - mozsystemmonitor == 0.3 12:28:49 INFO - moztest == 0.7 12:28:49 INFO - mozversion == 1.4 12:28:49 INFO - psutil == 3.1.1 12:28:49 INFO - requests == 1.2.3 12:28:49 INFO - wsgiref == 0.1.2 12:28:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:49 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 0x20e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2317400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6570>, '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 0x23a7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', '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 12:28:49 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 12:28:49 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 12:28:49 INFO - Using env: {'DISPLAY': ':0', 12:28:49 INFO - 'HOME': '/home/cltbld', 12:28:49 INFO - 'LANG': 'en_US.UTF-8', 12:28:49 INFO - 'LANGUAGE': 'en_US:en', 12:28:49 INFO - 'LOGNAME': 'cltbld', 12:28:49 INFO - 'MAIL': '/var/mail/cltbld', 12:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:49 INFO - 'MOZ_NO_REMOTE': '1', 12:28:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:49 INFO - 'NO_EM_RESTART': '1', 12:28:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:49 INFO - 'PWD': '/builds/slave/test', 12:28:49 INFO - 'SHELL': '/bin/bash', 12:28:49 INFO - 'SHLVL': '1', 12:28:49 INFO - 'TERM': 'linux', 12:28:49 INFO - 'TMOUT': '86400', 12:28:49 INFO - 'USER': 'cltbld', 12:28:49 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', 12:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:49 INFO - '_': '/tools/buildbot/bin/python'} 12:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:49 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)) 12:28:49 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)) 12:28:49 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)) 12:28:49 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)) 12:28:49 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)) 12:28:49 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)) 12:28:49 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)) 12:28:49 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)) 12:28:49 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)) 12:28:49 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)) 12:28:49 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)) 12:28:49 INFO - Cleaning up... 12:28:50 INFO - Return code: 0 12:28:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x224b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2317400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6570>, '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 0x23a7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', '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 12:28:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:28:50 INFO - Using env: {'DISPLAY': ':0', 12:28:50 INFO - 'HOME': '/home/cltbld', 12:28:50 INFO - 'LANG': 'en_US.UTF-8', 12:28:50 INFO - 'LANGUAGE': 'en_US:en', 12:28:50 INFO - 'LOGNAME': 'cltbld', 12:28:50 INFO - 'MAIL': '/var/mail/cltbld', 12:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:50 INFO - 'MOZ_NO_REMOTE': '1', 12:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:50 INFO - 'NO_EM_RESTART': '1', 12:28:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:50 INFO - 'PWD': '/builds/slave/test', 12:28:50 INFO - 'SHELL': '/bin/bash', 12:28:50 INFO - 'SHLVL': '1', 12:28:50 INFO - 'TERM': 'linux', 12:28:50 INFO - 'TMOUT': '86400', 12:28:50 INFO - 'USER': 'cltbld', 12:28:50 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', 12:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:50 INFO - '_': '/tools/buildbot/bin/python'} 12:28:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:28:50 INFO - Cleaning up... 12:28:50 INFO - Return code: 0 12:28:50 INFO - Running post-action listener: _resource_record_post_action 12:28:50 INFO - Running post-action listener: _start_resource_monitoring 12:28:50 INFO - Starting resource monitoring. 12:28:50 INFO - [mozharness: 2016-10-25 19:28:50.276906Z] Finished create-virtualenv step (success) 12:28:50 INFO - [mozharness: 2016-10-25 19:28:50.277413Z] Running install step. 12:28:50 INFO - Running pre-action listener: _resource_record_pre_action 12:28:50 INFO - Running main action method: install 12:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:28:50 INFO - Reading from file tmpfile_stdout 12:28:50 INFO - Detecting whether we're running mozinstall >=1.0... 12:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:28:50 INFO - Reading from file tmpfile_stdout 12:28:50 INFO - Output received: 12:28:50 INFO - Usage: mozinstall [options] installer 12:28:50 INFO - Options: 12:28:50 INFO - -h, --help show this help message and exit 12:28:50 INFO - -d DEST, --destination=DEST 12:28:50 INFO - Directory to install application into. [default: 12:28:50 INFO - "/builds/slave/test"] 12:28:50 INFO - --app=APP Application being installed. [default: firefox] 12:28:50 INFO - mkdir: /builds/slave/test/build/application 12:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:29:04 INFO - Reading from file tmpfile_stdout 12:29:04 INFO - Output received: 12:29:04 INFO - /builds/slave/test/build/application/firefox/firefox 12:29:04 INFO - Running post-action listener: _resource_record_post_action 12:29:04 INFO - [mozharness: 2016-10-25 19:29:04.522287Z] Finished install step (success) 12:29:04 INFO - [mozharness: 2016-10-25 19:29:04.522565Z] Running run-tests step. 12:29:04 INFO - Running pre-action listener: _resource_record_pre_action 12:29:04 INFO - Running main action method: run_tests 12:29:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:29:04 INFO - Python 2.7.3 12:29:04 INFO - Return code: 0 12:29:04 INFO - grabbing minidump binary from tooltool 12:29:04 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')]} 12:29:04 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 0x23a6570>, '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 0x23a7470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a7900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:29:04 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 12:29:04 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 12:29:04 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 12:29:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:29:04 INFO - Return code: 0 12:29:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:29:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:29:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:29:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:29:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:29:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:29:04 INFO - Using env: {'DISPLAY': ':0', 12:29:04 INFO - 'HOME': '/home/cltbld', 12:29:04 INFO - 'LANG': 'en_US.UTF-8', 12:29:04 INFO - 'LANGUAGE': 'en_US:en', 12:29:04 INFO - 'LOGNAME': 'cltbld', 12:29:04 INFO - 'MAIL': '/var/mail/cltbld', 12:29:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:29:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:04 INFO - 'MOZ_NO_REMOTE': '1', 12:29:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:04 INFO - 'NO_EM_RESTART': '1', 12:29:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:04 INFO - 'PWD': '/builds/slave/test', 12:29:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:29:04 INFO - 'SHELL': '/bin/bash', 12:29:04 INFO - 'SHLVL': '1', 12:29:04 INFO - 'TERM': 'linux', 12:29:04 INFO - 'TMOUT': '86400', 12:29:04 INFO - 'USER': 'cltbld', 12:29:04 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381', 12:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:04 INFO - '_': '/tools/buildbot/bin/python'} 12:29:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:29:04 INFO - mozversion application_buildid: 20161025093138 12:29:04 INFO - mozversion application_changeset: 4d922532989dbbd59fdf07233d4f07bd5a153919 12:29:04 INFO - mozversion application_display_name: Firefox 12:29:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:29:04 INFO - mozversion application_name: Firefox 12:29:04 INFO - mozversion application_remotingname: firefox 12:29:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:29:04 INFO - mozversion application_vendor: Mozilla 12:29:04 INFO - mozversion application_version: 50.0 12:29:04 INFO - mozversion platform_buildid: 20161025093138 12:29:04 INFO - mozversion platform_changeset: 4d922532989dbbd59fdf07233d4f07bd5a153919 12:29:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:29:04 INFO - mozversion platform_version: 50.0 12:29:04 INFO - using testdate: 1477423744 12:29:04 INFO - actual date: 1477423744 12:29:04 INFO - starting webserver on 'localhost:41161' 12:29:04 INFO - SUITE-START | Running 2 tests 12:29:04 INFO - TEST-START | dromaeo_css 12:29:04 INFO - operating with platform_type : linux_ 12:29:04 INFO - Initialising browser for dromaeo_css test... 12:29:04 INFO - TEST-INFO | started process 10815 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5wUddb/profile http://localhost:41161/getInfo.html) 12:29:09 INFO - PROCESS | 10815 | __metrics Screen width/height:1600/1200 12:29:09 INFO - PROCESS | 10815 | colorDepth:24 12:29:09 INFO - PROCESS | 10815 | Browser inner width/height: 1024/697 12:29:09 INFO - PROCESS | 10815 | __metrics 12:29:10 ERROR - PROCESS | 10815 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 12:29:10 INFO - TEST-INFO | 10815: exit 0 12:29:10 INFO - Browser initialized. 12:29:10 INFO - Running cycle 1/1 for dromaeo_css test... 12:29:10 INFO - TEST-INFO | started process 10940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5wUddb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:29:22 INFO - PROCESS | 10940 | RSS: Main: 150216704 12:29:22 INFO - PROCESS | 10940 | 12:30:12 INFO - PROCESS | 10940 | 1477423812209 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] 12:32:20 INFO - PROCESS | 10940 | Cycle 1(1): loaded http://localhost:41161/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41161/tests/dromaeo/cssquery-ext.html) 12:32:21 INFO - PROCESS | 10940 | RSS: Main: 158466048 12:32:21 INFO - PROCESS | 10940 | 12:35:23 INFO - PROCESS | 10940 | Cycle 1(1): loaded http://localhost:41161/tests/dromaeo/cssquery-ext.html (next: http://localhost:41161/tests/dromaeo/cssquery-jquery.html) 12:35:24 INFO - PROCESS | 10940 | RSS: Main: 155914240 12:35:24 INFO - PROCESS | 10940 | 12:38:25 INFO - PROCESS | 10940 | Cycle 1(1): loaded http://localhost:41161/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41161/tests/dromaeo/cssquery-mootools.html) 12:38:26 INFO - PROCESS | 10940 | RSS: Main: 154931200 12:38:26 INFO - PROCESS | 10940 | 12:41:28 INFO - PROCESS | 10940 | Cycle 1(1): loaded http://localhost:41161/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41161/tests/dromaeo/cssquery-prototype.html) 12:41:28 INFO - PROCESS | 10940 | RSS: Main: 156692480 12:41:28 INFO - PROCESS | 10940 | 12:44:31 INFO - PROCESS | 10940 | Cycle 1(1): loaded http://localhost:41161/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41161/tests/dromaeo/cssquery-yui.html) 12:44:31 INFO - PROCESS | 10940 | RSS: Main: 157278208 12:44:31 INFO - PROCESS | 10940 | 12:47:34 INFO - PROCESS | 10940 | Cycle 1(1): loaded http://localhost:41161/tests/dromaeo/cssquery-yui.html (next: http://localhost:41161/tests/dromaeo/cssquery-dojo.html) 12:47:34 INFO - PROCESS | 10940 | RSS: Main: 156917760 12:47:34 INFO - PROCESS | 10940 | 12:47:34 INFO - PROCESS | 10940 | __start_tp_report 12:47:34 INFO - PROCESS | 10940 | _x_x_mozilla_page_load 12:47:34 INFO - PROCESS | 10940 | _x_x_mozilla_page_load_details 12:47:34 INFO - PROCESS | 10940 | |i|pagename|runs| 12:47:34 INFO - PROCESS | 10940 | |0;dojo.html;3224.500202468617;3242.967570324297;3247.4804031354956;3249.610046794385;3260.6739326067395;5589.888202235953;5621.971890140544;5663.292088488939;5693.3452652944925;5701.144828275761;5677.801276955307;5728.770849166029;5732.5987180897355;5745.396733342991;5745.482906538411;5118.692878427288;5201.297824793661;5213.817516386927;5251.422343542207;5276.103062479368;5247.291615631898;5259.921101183466;5264.8157314494;5270.525652691257;5292.867678308035;5089.491050894918;5113.642045056848;5230.92153617696;5235.816746413876;5241.637174334663;5210.557102646279;5267.868303292429;5285.49787770165;5292.497212764782;5318.813841515567;5190.480951904817;5243.973780131075;5255.789768409259;5257.684538927677;5259.447757985433;5538.0585300499015;5595.356533998602;5694.914576281318;5746.166805813175;5812.389699081577;6056.57603967718;6159.7536098556;6160.476359509447;6161.229846269216;6176.289726681444;6190.133381326573;6196.132541444156;6199.504039676815;6204.069389591552;6224.159738435344;5546.722663866791;5551.333839939233;5762.645972577355;5785.797497087582;5805.854853628651;6054.878902421927;6149.0776383542825;6172.814815555541;6205.5345849061505;6206.906896396557;5913.319968203626;5965.343812180657;5974.1934838796205;5979.073243647154;5983.910241346383;5885.028970219866;5980.730867110903;6000.639961602318;6036.577439579275;6052.12244224585;6037.577369584174;6154.953657878172;6158.692065396713;6159.3224745277985;6159.876802463926;6098.969505152446;6123;6144.5084393248435;6146.815595532141;6154.476869466145;4537.387452693844;4624.1676498230645;4670.486246512881;4694.530546945278;4698.436187657503;4114.074333274989;4192.622663960258;4202.957970420257;4204.663626909901;4220.662347012231;5951.642901425928;5967.433093856077;5971.990746498878;5982;5996.640201587831;5843.3864444233595;6057.757689692451;6235.438810507076;6238.095476155932;6241.21984751906;5854.882902342015;5874.559408044413;5882.205902203148;5938;5967.5524335675;5268.446813084571;5269.578433725293;5276.34045744282;5279.287296215039;5279.709615971082;6127.080937859268;6220.471259942865;6256.624602523863;6338.239411270677;6425.742970281136;6170.197874276495;6176.073588961692;6180.505559555225;6187.288461826947;6187.443130118131;6307.96846015767;6345.936540634534;6369.490440764635;6382.36176382358;6387.840303992437;5804.21643078179;5960.314563825043;6015.157877897185;6054.939450605614;6073.48375388097;6202.038684003806;6211.130441738251;6214.316425193316;6220;6220.315765265726;6013.299793280227;6045.425684559959;6056.545759068;6065.2418447694035;6099.359567245376;5806.2451881255165;5969.76120955157;6006.669633170043;6048.969755151196;6055.72749226277;6054.212952316171;6073.726682299395;6087.543434242538;6093.29927058394;6122.632642041492;6072.72672729737;6104.572679912363;6118.296395914349;6131.540134489842;6138.938610613836;5723;5795.536357091507;5886.823395298148;5954.225950626565;5966.3138739043825 12:47:34 INFO - PROCESS | 10940 | |1;ext.html;593.2821286243645;623.5074291309866;646.9741210351586;667.156047599786;702.2591166319537;42051.36922946158;47162.820929476824;47227.29159062617;47228.763856180674;47302.290465643;46258.76870615651;46576.53423465764;46928.530714692846;46940.061198776006;46956.53043469564;9057.275417966563;9249.583768730423;9264.980852106262;9265.397749146285;9270.67552635658;9258.12047855456;9291.303152263574;9322.347435679505;9329.253659707207;9374;9397.81204375912;9400.576974036185;9418;9461.526923653824;9483.90516094837;9280.582373793195;9346.252299816033;9360.719178424659;9378.53107344637;9421.952890235574;9225.90774092264;9289.767755806091;9309.581068851918;9313.441193528342;9324.720258392259;44846.55153448456;44880.55119448796;45277.09445811098;45313.77343113296;45436.09127817458;3672.559292884844;3940.2316548273097;4237.576242375738;4339.978300108479;4548.340490628841;35971.4604280936;36025.27949441023;36120;36643.63356366429;37562.62437375619;4609.331646911212;4680.063987202573;4699.953000469985;4709.293605959099;4727.810887564493;373696;376238;376677.11661441793;378437;379626;65951.34048659548;66255;66303;66313.66843165753;66657.66671166613;40898.1820363591;41592.1681566367;41660.58339416628;43634.56365436369;43721.34417983733;17265.56836079108;17366.826331736775;17368.305267789146;17374.13129343553;17387.65224695499;12456.377181140906;12464.439100240512;12484.250944943333;12490.562830301078;12544.435500402504;21163.894180528998;21182;21214.681779773317;21379.465513361978;21429.892850535958;7640.550463298351;7759.185285544936;7821.804454888559;7875.763727088197;7894.64474098667;1026.1175389165312;1058.5871510111062;1078.0513148429332;1148.6037317125579;1234.2902830872285;34210;34873;35029.64970350315;35093.29813403718;35410.291794163975;1121.9046381057537;1150.1891166727437;1168.199783148546;1223.1071317937956;1225.7732319520917;16584;17086.316547338214;17552.210150543255;17654;17728.55678608045;657630;657845;659593;661698;664261;65176.34823651703;66315.33684663188;66334;66348.6682566584;66411.33588664052;1449.985500144985;1466.5673626280272;1485.4875068101487;1505.902116362433;1526.5344070058516;31914.36171276608;31938.92396994188;32292;32363.838180808943;32939.50590741093;56657;57385.71307143437;57403.42596573981;57523;57563;556070;556147;558683;561542;566307;29946;30014;30017.549736753528;50974.74512627413;51786.48213517967;50026;53086.73456632692;53754.46245537651;54386.728066359414;54406.18390724063;44776;47397.763011184725;47675.761621191676;48411.5158848407;49286.50713492963;45494;46567.30149047835;47594.5240547604;47756;48792.268115979;45825.77087114543;45980.7700961493;46804.53195468002;47045;47242.29136563023;38605.613943861325;41301.79349103235;41458.37812432876;41588.79205603953;42570.5742942579;30727.2318192047;31416.214594635316;31706.841465792524;31808.36383272368;32120 12:47:34 INFO - PROCESS | 10940 | |2;jquery.html;405.32918020675794;408.77721641705267;412.1386302627509;428.17576165880683;432.5263836099472;19299;20940.37178884632;20968.37094887152;21059.2629257976;21732.782672173274;20407.387778366636;20411.693824592643;20824.8958755206;21224.8938755306;21381;5729.312482502095;5924.466797988181;5926.259217597801;5926.436988486087;5931.703414829241;5659.405762394951;5789.421057894198;5801.6519008859395;5835.35811060783;5900.29196496421;5774.451427114438;5775.162601422791;5782.277215348082;5782.479576838084;5794.5943783935145;5562.276904002474;5765.855853603652;5799.159121927318;5839.7664093436215;5940.049592065292;5761.222234998263;5766.336871259775;5774.249347584787;5986.281646202484;5991.221141251609;14933.10401375921;14973;15124.54626361211;15229;15330.616734581614;2469.715982661999;2530.304166354249;2556.9872150639126;2662.5739881618847;2664.6136310234906;10798.622048228353;11160;11492.597759078391;12197.679330136461;15344.386224551004;1938.6316599845984;1959.3827944197533;1959.9412017639493;2021.7472815898013;2023.8482113841521;83737.16262837354;84465;84895;86394.13605863924;86421.56789216014;11691.590794322157;11711.238769479956;12097.939510302393;12160.939195303967;12233.816492752616;13369.66575835612;14025.438982440588;14131.505397311044;16976.83023169777;17035.914820426067;7707.267809558083;7794.3764498839955;8010.3992200584025;8095.2714255717265;8125.878111828328;7770.145284018753;7809.399073189982;7858.096318923397;7910.5649189295145;8077.7576672699915;4455.443069616298;4462.799174037111;4486.753228572395;4499.370088187657;4570.702904311209;2057.249104077001;2174.9342822017097;2176.5320456102013;2202.79493337194;2231.6317807561895;888.617894305442;972.9027097290215;1027.6660085472251;1054.5887104029434;1055.2191378380096;19621.60756784856;19760;19851.503712407306;20201.494962626053;20720.689189662167;965.0587308585957;1000.924930630191;1015.751140970467;1034.6275340877278;1161.7676464707092;10840.945795271131;11280.379579123228;11321.886781132249;11344.092472602171;11498.25261358009;464776;470935;471845;530810;549236;65971.67014164898;97668;98259.50870245746;98954;100551.49724251332;1058.6929790360864;1073.3023534702506;1085.2891356161726;1093.6445655162104;1097.7200813792592;15844.683106337578;17836.55408614795;17906.0151691653;18068.81931180724;18204.271829127218;40843.59156408398;42868.35697464478;43191.56808431875;43225.7838710817;43424.34863476987;59881;59977.70011150091;60135.097973529555;61122;61710.382896170464;8757.168069033432;8902.510361930155;8947.955260223658;9033.187013168847;9080.772980675272;13194.736105278032;13311.733765324832;13485.595432137052;13625.318734063456;13711.108777929801;10980.792112867419;11254.099672026054;11261.873812618673;11560.190786644855;11613.593524226611;11299.2655477397;11382.601608943647;11492.597759078391;11929.403529823649;12066.155369124428;10427.94786026065;11458.598949037078;11595.072394208612;11715.589954351557;11807.586734464252;8678.739637810875;8689.652413903626;8743.956280218557;8820.470771753715;8935.731928042169;5045.672031317952;5937.970310148422;11397.715057123638;11438.428078596204;11490.138239631893 12:47:34 INFO - PROCESS | 10940 | |3;mootools.html;1533.6932613477304;1568.8431156884312;1703.1143805221286;1806.4580625812252;1824.7810262768462;8085.797855053626;9031.277497800176;9218.216451601613;9906.35608685436;9924.553395097211;8895.822083558325;9197.586108625112;9216.953915230415;9222.86165707515;9247.398919070272;2506.072753081358;2555.3739333863136;2556.322574517754;2560.039985005623;2560.7823335016546;2474.9628755568683;2506.548821212181;2507.611320245365;2509.6862892138483;2512.899484020637;2467.358486793438;2486.1298545509107;2490.0537795637633;2490.950180996379;2502.4244423782543;2364.290712786166;2370.395549134968;2370.9407264818433;2413.4207790130417;2422.1280339077916;2352.4589344450874;2368.052778888441;2385.3798012516695;2388.4984153327823;2410.6384042393606;9784.755381115458;9838.852417213748;9857.753556161082;9868.60525578976;9870.654527091518;5362.168863826074;5553.250311207976;5589.860253493654;5681.176229446707;5688.004599195125;3485.5120283160377;3516.7010804081683;3530.223350862806;3547.627499112582;3607.188382613917;1220.1215125109907;1226.5952235762177;1229.416027386993;1240.3054289597853;1254.2161149281699;13596.59210223695;13598.660033499144;13645.454181832714;13652.385642646104;13716.65708357279;4908.803647854117;4933.432655244621;4988.326575912278;4990.176620857518;5190.065788158092;11448.771024579462;11486.483108260149;11487.655370338904;11492.597759078391;11496.655100347003;5667.603267771216;5669.34802497718;5677.3471050829685;5677.489025987681;5696.259486266758;4459.353393757887;5153.2270159476375;5209.270702101709;5225.503577160163;5260.2109683547005;4337.869863904025;4389.209942210369;4484.887877803081;4511.413516242867;4654.743989080633;1380.378829526717;1409.4503143773936;1409.4925826702379;1416.4759039155372;1434.2326855132453;905.4838741917044;1059.247933966892;1084.3060441317564;1095.479647167589;1113.8496302999154;6478.125453063871;6600.339966003457;6744.022116793038;6761.661916904135;6853.246142924274;476.7830637060129;483.2606112647655;1066.568039943824;1111.6382431521322;1132.3206076354122;4232.36514522824;4431.711938724037;4447.199504089295;4459.509453960061;4492.663050271242;11931.642050738492;12291.446884890202;12376.381180940916;12400.069994750429;12406.565770198;12090.214136081127;12118.81821772674;12145.149839511327;12263.141580089308;12295.139340246276;8184;8346.624401901807;8982.461052336881;9037.954810226038;9117.954410227907;6695.933040669531;6706.966465167643;6902.344277293649;6923.89614155778;7038.929610704033;11042.668719938414;11221.326720396803;11285.984261416512;11311.7737645245;11340.886591133984;11097.667069987914;11191.776164476501;11290;11349.092072634334;11378.31730096197;8231.547264900488;8291.709790157316;8366.748997530083;8555.786105347168;8582.613782379683;9384.296177786557;9432.292578056811;9541.904580954379;9553.61785528571;9557.330986830855;8272.214139656722;8536.829263414573;8595.613197406257;8629.87055194185;8641.611127499153;8161.673533058849;8343.499390036617;8430.494170349799;8482.236598706146;8502.914970850212;7155.3202445767565;7394.223606521237;7491.70033198666;7503.362214211853;7514.47398682087;5707.5433965281845;5782.277215348082;5850.063989761617;5861.472467477947;5879.7060146993335;5808.767649293981;5821.912671309849;5905.143754155538;5928.4960778334325;5980.252468441445 12:47:34 INFO - PROCESS | 10940 | |4;prototype.html;357.3763782200061;360.12848905648326;360.72404610472995;363.95450568678916;364.4787953226884;5903.321118071423;5927.88144237115;5928.88142237155;5935.317438494574;5944.4947179489745;5536.335639723239;5701.800436984707;5767.769289228426;5858.970705146479;5870.70646467677;4459.57634024768;4540.614047805941;4549.727016379012;4561.384213131235;4583.472900616422;4564.84023059193;4580;4580.335851301559;4607.8156873725175;4619.53804619537;4461.39771130898;4547.613452856511;4563.543645635443;4596.724621312438;4601;4471.3293006049025;4492.146492166495;4493.438320209973;4502.41468609082;4523.615492683126;3992.5608183100126;4011.6991225658194;4012.9799351003057;4026.4966879140106;4039.1719697462245;5617.9719101404235;5678.971605141989;5708.229389032469;5709.115087161496;5712.742926568314;5142.537171654569;5153.922691159635;5168.431472538018;5170;5225.399079105913;6052.636841789506;6088.512918966517;6100.664463454508;6105.32841387447;6129.295131059941;4287.91424171518;4336.653067754603;4359.716618419792;4377.9781101094295;4396.868093957187;6070.453659170652;6273.1844860167885;6330.430261276507;6335.144755458046;6390.424861762417;4405.801738921757;4449.710768800018;4460.643148548108;4464.6428285737065;4471.150481408522;4525.094981003813;4537.4328208973875;4541.000979784442;4542.091581683677;4542.11428771393;4909.656324057353;5097.209932460474;5164.5539249010335;5175.922361164586;5201.29782479368;6081.118237855486;6097.756089756449;6104.17593624855;6111.786087486917;6154.261488621304;1554.7046061248327;1583.1530131379657;1587.4205914841232;1589.6025993501626;1594.8644365229086;955.5699935029264;1002.8367094170727;1004.9497525123714;1019.5259204469957;1019.6686077024997;5222.947770522246;5241;5266.34170728659;5272.92090618641;5308.601854860824;5526.557875369961;5533.6403133796175;5536.252605898233;5570.220169176318;5594.552435805126;5016.322796422436;5159.226116082617;5240.764165612557;5267.578593712494;5289.629725919226;2925.5611658251005;2933.5453004784295;2970.277239201258;3035.7723170762283;3054.5796204764447;5556.277683901067;5570.916436253459;5614.792819543818;5685.516731077904;5752.913706294409;5988.550858685616;6383.776567820104;6459.450946669492;6466.579672321284;6467.223933128054;6572.943581234749;6600.273969863311;6604.801855944329;6607.636579988147;6639.900401493981;6175.900193934084;6302.180716507009;6326.683665816783;6347.746090156526;6381.425671689571;6254.3745625437095;6260.843478913063;6286.648370600343;6306.306306306395;6309.558330916791;6270.7491700331475;6464.866594024055;6469.935300646934;6488;6527.281998980014;4428.68999170055;4448.575526338218;4455.933161002523;4469.530699276659;4508.790692560556;6254;6291.276503202191;6368.044793281045;6387;6424.38968298011;6138;6153.630782153085;6156.876862462816;6168.660723660242;6215.9378406215355;5907.940920590739;6157.84605384869;6204.751809927552;6211.316755156839;6255.718492667932;6078.756849725962;6136.747523812386;6150.2927163375;6151.9384806151365;6166.568340216142;6239.906401404073;6273.498120150286;6273.62358258506;6288;6312.936870631419;5834.766609335579;6032.280799971987;6048.879022419615;6087.086936959315;6090 12:47:34 INFO - PROCESS | 10940 | |5;yui.html;791.608153963788;821.2649678537709;826.2439867521218;831.7629475599456;880.6301353431558;16841.410550630713;18061.63876722465;18176.909115454404;18184.363547275832;18244.54388640283;16395.4261600844;16514.33942642293;16560.58598535037;16583.83416165838;16606.83393166068;727.9890801637953;850.897892252929;865.7229686500323;877.8683197520392;881.9382643214977;861.6165806216205;865.9870101948444;867.453504292295;868.5179725252482;868.7350358140765;938.7043081429362;939.8120375924842;940.050548945563;946.1106559833735;947.3273975477385;931.7903471718877;935.2190920581323;936.3071327217878;937;940.9952950235273;686.1902954513672;686.4474098350826;688.6763221285987;688.8209065642919;689.8034060292792;16106.275217615235;16144.515664530083;16153.838461615469;16206.270717817726;16231.91884040584;15343.372233239983;16165.83834161655;16205.270762815702;16247.593810154722;16297.266623001993;13634.659133521642;13714.451421943111;13723.862761372358;14008.22954737489;14158.858411415857;4113.465249517543;4158.209940111369;4178.498580170399;4184.958150418518;4356.390105385249;67817.66091169562;70818.64590677065;88337.11662883354;88381;88385;12537.498500060077;12709.682257943625;12719.364031798557;12840.48638054486;12881.613551593467;22867.19964801224;23171.189008384627;23174.304770856903;23193;23193.652095218586;9449.244060475145;9510.857337139949;9557.283203759745;9686.515674216402;9688.660896868576;5019.397672279277;5023.572996295283;5033.219850923113;5098.821541246039;5116.283720279164;3817.10298079951;3977.085270387769;4022.2759903217116;4022.879313620596;4025.939610905839;645.502962718704;647.9967600161968;664.455146779636;669.7321071571313;671.9126513553207;626.6459450410504;644.6712176789778;689.1110467496873;693.9444844412435;729.0849983271067;9548.761280967892;9918.30571859963;10328.225383096298;10356.275060745826;10462.843057354146;599.9850003749941;694.8500232115856;715.2311265389727;722.9457790665721;750.2422553221286;5108.565771909355;5160.92258616121;5170.45710200431;5280.419153893145;5290.232916227203;76924.23075769171;91759.5412022949;119978;127823;136985.315073424;112929;114953;115686;117797;118035;100911;102531;103141;103644.48177759063;105901.47049264704;9831.950840245752;10096.34373765703;10112.443815590213;10173.38959662393;10222.897771022195;55405.16892246539;56643;56790.716046419504;57156.42843571511;58508;48733.51266487432;49544.77048532753;82462.58768706118;85511.57244213739;86267;11571.13216508782;11782.764344712887;11832.70418239551;11930.403479826147;12154.878451215374;14212.360443780262;14481.203533805741;14636.926815365856;14681.48614798477;14718.77921831152;12784.296863672587;13003.349832508526;13133;13188.934055329662;14374;11844.585439509576;12095.57665481704;12277.38613069325;12505.56230531927;12642.478808295717;12463.750724985632;13981.021328507313;14251;14477.782833257721;15378.769318460456;12116.21244619097;12207.328596926898;12230.938845305716;12266.938665306974;12675.556355527513;12760.74478510443;13123.934380328037;13175.209487430784;13517.391717372939;13734.65663358424 12:47:34 INFO - PROCESS | 10940 | __end_tp_report 12:47:34 INFO - PROCESS | 10940 | __start_cc_report 12:47:34 INFO - PROCESS | 10940 | _x_x_mozilla_cycle_collect,340 12:47:34 INFO - PROCESS | 10940 | __end_cc_report 12:47:34 INFO - PROCESS | 10940 | __startTimestamp1477424854309__endTimestamp 12:47:34 INFO - PROCESS | 10940 | 12:47:34 INFO - PROCESS | 10940 | ------- Summary: start ------- 12:47:34 INFO - PROCESS | 10940 | Number of tests: 6 12:47:34 INFO - PROCESS | 10940 | 12:47:34 INFO - PROCESS | 10940 | [#0] dojo.html Cycles:165 Average:5700.29 Median:5967.43 stddev:657.70 (11.0%) stddev-sans-first:630.38 12:47:34 INFO - PROCESS | 10940 | Values: 3224.5 3243.0 3247.5 3249.6 3260.7 5589.9 5622.0 5663.3 5693.3 5701.1 5677.8 5728.8 5732.6 5745.4 5745.5 5118.7 5201.3 5213.8 5251.4 5276.1 5247.3 5259.9 5264.8 5270.5 5292.9 5089.5 5113.6 5230.9 5235.8 5241.6 5210.6 5267.9 5285.5 5292.5 5318.8 5190.5 5244.0 5255.8 5257.7 5259.4 5538.1 5595.4 5694.9 5746.2 5812.4 6056.6 6159.8 6160.5 6161.2 6176.3 6190.1 6196.1 6199.5 6204.1 6224.2 5546.7 5551.3 5762.6 5785.8 5805.9 6054.9 6149.1 6172.8 6205.5 6206.9 5913.3 5965.3 5974.2 5979.1 5983.9 5885.0 5980.7 6000.6 6036.6 6052.1 6037.6 6155.0 6158.7 6159.3 6159.9 6099.0 6123.0 6144.5 6146.8 6154.5 4537.4 4624.2 4670.5 4694.5 4698.4 4114.1 4192.6 4203.0 4204.7 4220.7 5951.6 5967.4 5972.0 5982.0 5996.6 5843.4 6057.8 6235.4 6238.1 6241.2 5854.9 5874.6 5882.2 5938.0 5967.6 5268.4 5269.6 5276.3 5279.3 5279.7 6127.1 6220.5 6256.6 6338.2 6425.7 6170.2 6176.1 6180.5 6187.3 6187.4 6308.0 6345.9 6369.5 6382.4 6387.8 5804.2 5960.3 6015.2 6054.9 6073.5 6202.0 6211.1 6214.3 6220.0 6220.3 6013.3 6045.4 6056.5 6065.2 6099.4 5806.2 5969.8 6006.7 6049.0 6055.7 6054.2 6073.7 6087.5 6093.3 6122.6 6072.7 6104.6 6118.3 6131.5 6138.9 5723.0 5795.5 5886.8 5954.2 5966.3 12:47:34 INFO - PROCESS | 10940 | 12:47:34 INFO - PROCESS | 10940 | [#1] ext.html Cycles:180 Average:69790.09 Median:46571.92 stddev:145247.69 (311.9%) stddev-sans-first:145562.23 12:47:34 INFO - PROCESS | 10940 | Values: 593.3 623.5 647.0 667.2 702.3 42051.4 47162.8 47227.3 47228.8 47302.3 46258.8 46576.5 46928.5 46940.1 46956.5 9057.3 9249.6 9265.0 9265.4 9270.7 9258.1 9291.3 9322.3 9329.3 9374.0 9397.8 9400.6 9418.0 9461.5 9483.9 9280.6 9346.3 9360.7 9378.5 9422.0 9225.9 9289.8 9309.6 9313.4 9324.7 44846.6 44880.6 45277.1 45313.8 45436.1 3672.6 3940.2 4237.6 4340.0 4548.3 35971.5 36025.3 36120.0 36643.6 37562.6 4609.3 4680.1 4700.0 4709.3 4727.8 373696.0 376238.0 376677.1 378437.0 379626.0 65951.3 66255.0 66303.0 66313.7 66657.7 40898.2 41592.2 41660.6 43634.6 43721.3 17265.6 17366.8 17368.3 17374.1 17387.7 12456.4 12464.4 12484.3 12490.6 12544.4 21163.9 21182.0 21214.7 21379.5 21429.9 7640.6 7759.2 7821.8 7875.8 7894.6 1026.1 1058.6 1078.1 1148.6 1234.3 34210.0 34873.0 35029.6 35093.3 35410.3 1121.9 1150.2 1168.2 1223.1 1225.8 16584.0 17086.3 17552.2 17654.0 17728.6 657630.0 657845.0 659593.0 661698.0 664261.0 65176.3 66315.3 66334.0 66348.7 66411.3 1450.0 1466.6 1485.5 1505.9 1526.5 31914.4 31938.9 32292.0 32363.8 32939.5 56657.0 57385.7 57403.4 57523.0 57563.0 556070.0 556147.0 558683.0 561542.0 566307.0 29946.0 30014.0 30017.5 50974.7 51786.5 50026.0 53086.7 53754.5 54386.7 54406.2 44776.0 47397.8 47675.8 48411.5 49286.5 45494.0 46567.3 47594.5 47756.0 48792.3 45825.8 45980.8 46804.5 47045.0 47242.3 38605.6 41301.8 41458.4 41588.8 42570.6 30727.2 31416.2 31706.8 31808.4 32120.0 12:47:34 INFO - PROCESS | 10940 | 12:47:34 INFO - PROCESS | 10940 | [#2] jquery.html Cycles:180 Average:29374.45 Median:2350.67 stddev:82347.84 (3503.2%) stddev-sans-first:82550.12 12:47:34 INFO - PROCESS | 10940 | Values: 405.3 408.8 412.1 428.2 432.5 19299.0 20940.4 20968.4 21059.3 21732.8 20407.4 20411.7 20824.9 21224.9 21381.0 5729.3 5924.5 5926.3 5926.4 5931.7 5659.4 5789.4 5801.7 5835.4 5900.3 5774.5 5775.2 5782.3 5782.5 5794.6 5562.3 5765.9 5799.2 5839.8 5940.0 5761.2 5766.3 5774.2 5986.3 5991.2 14933.1 14973.0 15124.5 15229.0 15330.6 2469.7 2530.3 2557.0 2662.6 2664.6 10798.6 11160.0 11492.6 12197.7 15344.4 1938.6 1959.4 1959.9 2021.7 2023.8 83737.2 84465.0 84895.0 86394.1 86421.6 11691.6 11711.2 12097.9 12160.9 12233.8 13369.7 14025.4 14131.5 16976.8 17035.9 7707.3 7794.4 8010.4 8095.3 8125.9 7770.1 7809.4 7858.1 7910.6 8077.8 4455.4 4462.8 4486.8 4499.4 4570.7 2057.2 2174.9 2176.5 2202.8 2231.6 888.6 972.9 1027.7 1054.6 1055.2 19621.6 19760.0 19851.5 20201.5 20720.7 965.1 1000.9 1015.8 1034.6 1161.8 10840.9 11280.4 11321.9 11344.1 11498.3 464776.0 470935.0 471845.0 530810.0 549236.0 65971.7 97668.0 98259.5 98954.0 100551.5 1058.7 1073.3 1085.3 1093.6 1097.7 15844.7 17836.6 17906.0 18068.8 18204.3 40843.6 42868.4 43191.6 43225.8 43424.3 59881.0 59977.7 60135.1 61122.0 61710.4 8757.2 8902.5 8948.0 9033.2 9080.8 13194.7 13311.7 13485.6 13625.3 13711.1 10980.8 11254.1 11261.9 11560.2 11613.6 11299.3 11382.6 11492.6 11929.4 12066.2 10427.9 11458.6 11595.1 11715.6 11807.6 8678.7 8689.7 8744.0 8820.5 8935.7 5045.7 5938.0 11397.7 11438.4 11490.1 12:47:34 INFO - PROCESS | 10940 | 12:47:34 INFO - PROCESS | 10940 | [#3] mootools.html Cycles:180 Average:6356.12 Median:4502.04 stddev:3672.47 (81.6%) stddev-sans-first:3664.90 12:47:34 INFO - PROCESS | 10940 | Values: 1533.7 1568.8 1703.1 1806.5 1824.8 8085.8 9031.3 9218.2 9906.4 9924.6 8895.8 9197.6 9217.0 9222.9 9247.4 2506.1 2555.4 2556.3 2560.0 2560.8 2475.0 2506.5 2507.6 2509.7 2512.9 2467.4 2486.1 2490.1 2491.0 2502.4 2364.3 2370.4 2370.9 2413.4 2422.1 2352.5 2368.1 2385.4 2388.5 2410.6 9784.8 9838.9 9857.8 9868.6 9870.7 5362.2 5553.3 5589.9 5681.2 5688.0 3485.5 3516.7 3530.2 3547.6 3607.2 1220.1 1226.6 1229.4 1240.3 1254.2 13596.6 13598.7 13645.5 13652.4 13716.7 4908.8 4933.4 4988.3 4990.2 5190.1 11448.8 11486.5 11487.7 11492.6 11496.7 5667.6 5669.3 5677.3 5677.5 5696.3 4459.4 5153.2 5209.3 5225.5 5260.2 4337.9 4389.2 4484.9 4511.4 4654.7 1380.4 1409.5 1409.5 1416.5 1434.2 905.5 1059.2 1084.3 1095.5 1113.8 6478.1 6600.3 6744.0 6761.7 6853.2 476.8 483.3 1066.6 1111.6 1132.3 4232.4 4431.7 4447.2 4459.5 4492.7 11931.6 12291.4 12376.4 12400.1 12406.6 12090.2 12118.8 12145.1 12263.1 12295.1 8184.0 8346.6 8982.5 9038.0 9118.0 6695.9 6707.0 6902.3 6923.9 7038.9 11042.7 11221.3 11286.0 11311.8 11340.9 11097.7 11191.8 11290.0 11349.1 11378.3 8231.5 8291.7 8366.7 8555.8 8582.6 9384.3 9432.3 9541.9 9553.6 9557.3 8272.2 8536.8 8595.6 8629.9 8641.6 8161.7 8343.5 8430.5 8482.2 8502.9 7155.3 7394.2 7491.7 7503.4 7514.5 5707.5 5782.3 5850.1 5861.5 5879.7 5808.8 5821.9 5905.1 5928.5 5980.3 12:47:34 INFO - PROCESS | 10940 | 12:47:34 INFO - PROCESS | 10940 | [#4] prototype.html Cycles:180 Average:5077.34 Median:5582.73 stddev:1507.27 (27.0%) stddev-sans-first:1469.28 12:47:34 INFO - PROCESS | 10940 | Values: 357.4 360.1 360.7 364.0 364.5 5903.3 5927.9 5928.9 5935.3 5944.5 5536.3 5701.8 5767.8 5859.0 5870.7 4459.6 4540.6 4549.7 4561.4 4583.5 4564.8 4580.0 4580.3 4607.8 4619.5 4461.4 4547.6 4563.5 4596.7 4601.0 4471.3 4492.1 4493.4 4502.4 4523.6 3992.6 4011.7 4013.0 4026.5 4039.2 5618.0 5679.0 5708.2 5709.1 5712.7 5142.5 5153.9 5168.4 5170.0 5225.4 6052.6 6088.5 6100.7 6105.3 6129.3 4287.9 4336.7 4359.7 4378.0 4396.9 6070.5 6273.2 6330.4 6335.1 6390.4 4405.8 4449.7 4460.6 4464.6 4471.2 4525.1 4537.4 4541.0 4542.1 4542.1 4909.7 5097.2 5164.6 5175.9 5201.3 6081.1 6097.8 6104.2 6111.8 6154.3 1554.7 1583.2 1587.4 1589.6 1594.9 955.6 1002.8 1004.9 1019.5 1019.7 5222.9 5241.0 5266.3 5272.9 5308.6 5526.6 5533.6 5536.3 5570.2 5594.6 5016.3 5159.2 5240.8 5267.6 5289.6 2925.6 2933.5 2970.3 3035.8 3054.6 5556.3 5570.9 5614.8 5685.5 5752.9 5988.6 6383.8 6459.5 6466.6 6467.2 6572.9 6600.3 6604.8 6607.6 6639.9 6175.9 6302.2 6326.7 6347.7 6381.4 6254.4 6260.8 6286.6 6306.3 6309.6 6270.7 6464.9 6469.9 6488.0 6527.3 4428.7 4448.6 4455.9 4469.5 4508.8 6254.0 6291.3 6368.0 6387.0 6424.4 6138.0 6153.6 6156.9 6168.7 6215.9 5907.9 6157.8 6204.8 6211.3 6255.7 6078.8 6136.7 6150.3 6151.9 6166.6 6239.9 6273.5 6273.6 6288.0 6312.9 5834.8 6032.3 6048.9 6087.1 6090.0 12:47:34 INFO - PROCESS | 10940 | 12:47:34 INFO - PROCESS | 10940 | [#5] yui.html Cycles:180 Average:22258.69 Median:3897.09 stddev:32469.06 (833.2%) stddev-sans-first:32520.13 12:47:34 INFO - PROCESS | 10940 | Values: 791.6 821.3 826.2 831.8 880.6 16841.4 18061.6 18176.9 18184.4 18244.5 16395.4 16514.3 16560.6 16583.8 16606.8 728.0 850.9 865.7 877.9 881.9 861.6 866.0 867.5 868.5 868.7 938.7 939.8 940.1 946.1 947.3 931.8 935.2 936.3 937.0 941.0 686.2 686.4 688.7 688.8 689.8 16106.3 16144.5 16153.8 16206.3 16231.9 15343.4 16165.8 16205.3 16247.6 16297.3 13634.7 13714.5 13723.9 14008.2 14158.9 4113.5 4158.2 4178.5 4185.0 4356.4 67817.7 70818.6 88337.1 88381.0 88385.0 12537.5 12709.7 12719.4 12840.5 12881.6 22867.2 23171.2 23174.3 23193.0 23193.7 9449.2 9510.9 9557.3 9686.5 9688.7 5019.4 5023.6 5033.2 5098.8 5116.3 3817.1 3977.1 4022.3 4022.9 4025.9 645.5 648.0 664.5 669.7 671.9 626.6 644.7 689.1 693.9 729.1 9548.8 9918.3 10328.2 10356.3 10462.8 600.0 694.9 715.2 722.9 750.2 5108.6 5160.9 5170.5 5280.4 5290.2 76924.2 91759.5 119978.0 127823.0 136985.3 112929.0 114953.0 115686.0 117797.0 118035.0 100911.0 102531.0 103141.0 103644.5 105901.5 9832.0 10096.3 10112.4 10173.4 10222.9 55405.2 56643.0 56790.7 57156.4 58508.0 48733.5 49544.8 82462.6 85511.6 86267.0 11571.1 11782.8 11832.7 11930.4 12154.9 14212.4 14481.2 14636.9 14681.5 14718.8 12784.3 13003.3 13133.0 13188.9 14374.0 11844.6 12095.6 12277.4 12505.6 12642.5 12463.8 13981.0 14251.0 14477.8 15378.8 12116.2 12207.3 12230.9 12266.9 12675.6 12760.7 13123.9 13175.2 13517.4 13734.7 12:47:34 INFO - PROCESS | 10940 | -------- Summary: end -------- 12:47:34 INFO - PROCESS | 10940 | 12:47:35 INFO - TEST-INFO | 10940: exit 0 12:47:35 INFO - TEST-OK | dromaeo_css | took 1110253ms 12:47:35 INFO - TEST-START | kraken 12:47:35 INFO - operating with platform_type : linux_ 12:47:35 INFO - Initialising browser for kraken test... 12:47:35 INFO - TEST-INFO | started process 11182 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgNAmBO/profile http://localhost:41161/getInfo.html) 12:47:39 INFO - PROCESS | 11182 | __metrics Screen width/height:1600/1200 12:47:39 INFO - PROCESS | 11182 | colorDepth:24 12:47:39 INFO - PROCESS | 11182 | Browser inner width/height: 1024/697 12:47:39 INFO - PROCESS | 11182 | __metrics 12:47:40 ERROR - PROCESS | 11182 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 12:47:40 INFO - TEST-INFO | 11182: exit 0 12:47:40 INFO - Browser initialized. 12:47:40 INFO - Running cycle 1/1 for kraken test... 12:47:40 INFO - TEST-INFO | started process 11307 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgNAmBO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:47:52 INFO - PROCESS | 11307 | RSS: Main: 150450176 12:47:52 INFO - PROCESS | 11307 | 12:47:55 INFO - PROCESS | 11307 | Cycle 1(1): loaded http://localhost:41161/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41161/tests/kraken/driver.html?testName=audio-beat-detection) 12:47:56 INFO - PROCESS | 11307 | RSS: Main: 157356032 12:47:56 INFO - PROCESS | 11307 | 12:47:58 INFO - PROCESS | 11307 | Cycle 1(1): loaded http://localhost:41161/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41161/tests/kraken/driver.html?testName=audio-dft) 12:47:59 INFO - PROCESS | 11307 | RSS: Main: 155754496 12:47:59 INFO - PROCESS | 11307 | 12:48:02 INFO - PROCESS | 11307 | Cycle 1(1): loaded http://localhost:41161/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41161/tests/kraken/driver.html?testName=audio-fft) 12:48:02 INFO - PROCESS | 11307 | RSS: Main: 157007872 12:48:02 INFO - PROCESS | 11307 | 12:48:04 INFO - PROCESS | 11307 | Cycle 1(1): loaded http://localhost:41161/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41161/tests/kraken/driver.html?testName=audio-oscillator) 12:48:05 INFO - PROCESS | 11307 | RSS: Main: 156225536 12:48:05 INFO - PROCESS | 11307 | 12:48:07 INFO - PROCESS | 11307 | Cycle 1(1): loaded http://localhost:41161/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41161/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:48:08 INFO - PROCESS | 11307 | RSS: Main: 155815936 12:48:08 INFO - PROCESS | 11307 | 12:48:11 INFO - PROCESS | 11307 | Cycle 1(1): loaded http://localhost:41161/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41161/tests/kraken/driver.html?testName=imaging-darkroom) 12:48:11 INFO - PROCESS | 11307 | RSS: Main: 155787264 12:48:11 INFO - PROCESS | 11307 | 12:48:15 INFO - PROCESS | 11307 | Cycle 1(1): loaded http://localhost:41161/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41161/tests/kraken/driver.html?testName=imaging-desaturate) 12:48:15 INFO - PROCESS | 11307 | RSS: Main: 156712960 12:48:15 INFO - PROCESS | 11307 | 12:48:18 INFO - PROCESS | 11307 | Cycle 1(1): loaded http://localhost:41161/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41161/tests/kraken/driver.html?testName=json-parse-financial) 12:48:19 INFO - PROCESS | 11307 | RSS: Main: 156590080 12:48:19 INFO - PROCESS | 11307 | 12:48:20 INFO - PROCESS | 11307 | Cycle 1(1): loaded http://localhost:41161/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41161/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:48:21 INFO - PROCESS | 11307 | RSS: Main: 156127232 12:48:21 INFO - PROCESS | 11307 | 12:48:23 INFO - PROCESS | 11307 | Cycle 1(1): loaded http://localhost:41161/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41161/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:48:23 INFO - PROCESS | 11307 | RSS: Main: 156864512 12:48:23 INFO - PROCESS | 11307 | 12:48:25 INFO - PROCESS | 11307 | Cycle 1(1): loaded http://localhost:41161/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41161/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:48:26 INFO - PROCESS | 11307 | RSS: Main: 156921856 12:48:26 INFO - PROCESS | 11307 | 12:48:29 INFO - PROCESS | 11307 | Cycle 1(1): loaded http://localhost:41161/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41161/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:48:29 INFO - PROCESS | 11307 | RSS: Main: 156467200 12:48:29 INFO - PROCESS | 11307 | 12:48:32 INFO - PROCESS | 11307 | Cycle 1(1): loaded http://localhost:41161/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41161/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:48:33 INFO - PROCESS | 11307 | RSS: Main: 156753920 12:48:33 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | Cycle 1(1): loaded http://localhost:41161/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41161/tests/kraken/driver.html?testName=ai-astar) 12:48:34 INFO - PROCESS | 11307 | RSS: Main: 158965760 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | __start_tp_report 12:48:34 INFO - PROCESS | 11307 | _x_x_mozilla_page_load 12:48:34 INFO - PROCESS | 11307 | _x_x_mozilla_page_load_details 12:48:34 INFO - PROCESS | 11307 | |i|pagename|runs| 12:48:34 INFO - PROCESS | 11307 | |0;ai-astar;99;110;103;110;111;111;110;111;111;111 12:48:34 INFO - PROCESS | 11307 | |1;audio-beat-detection;148;118;146;170;119;148;140;116;167;118 12:48:34 INFO - PROCESS | 11307 | |2;audio-dft;163;164;162;161;162;163;162;163;162;167 12:48:34 INFO - PROCESS | 11307 | |3;audio-fft;74;76;75;172;76;75;75;76;162;76 12:48:34 INFO - PROCESS | 11307 | |4;audio-oscillator;85;93;145;84;84;84;146;83;85;140 12:48:34 INFO - PROCESS | 11307 | |5;imaging-gaussian-blur;118;116;118;117;117;118;117;117;119;117 12:48:34 INFO - PROCESS | 11307 | |6;imaging-darkroom;148;147;149;147;148;146;147;147;147;148 12:48:34 INFO - PROCESS | 11307 | |7;imaging-desaturate;96;96;96;96;95;95;95;95;95;95 12:48:34 INFO - PROCESS | 11307 | |8;json-parse-financial;51;52;51;51;58;52;53;51;50;51 12:48:34 INFO - PROCESS | 11307 | |9;json-stringify-tinderbox;60;60;60;60;60;59;61;60;63;61 12:48:34 INFO - PROCESS | 11307 | |10;stanford-crypto-aes;74;81;74;74;73;73;74;73;73;73 12:48:34 INFO - PROCESS | 11307 | |11;stanford-crypto-ccm;140;134;127;134;126;122;132;123;158;125 12:48:34 INFO - PROCESS | 11307 | |12;stanford-crypto-pbkdf2;154;153;156;150;150;161;159;149;152;152 12:48:34 INFO - PROCESS | 11307 | |13;stanford-crypto-sha256-iterative;66;63;62;62;63;62;62;62;60;63 12:48:34 INFO - PROCESS | 11307 | __end_tp_report 12:48:34 INFO - PROCESS | 11307 | __start_cc_report 12:48:34 INFO - PROCESS | 11307 | _x_x_mozilla_cycle_collect,853 12:48:34 INFO - PROCESS | 11307 | __end_cc_report 12:48:34 INFO - PROCESS | 11307 | __startTimestamp1477424914912__endTimestamp 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | ------- Summary: start ------- 12:48:34 INFO - PROCESS | 11307 | Number of tests: 14 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | [#0] ai-astar Cycles:10 Average:108.70 Median:111.00 stddev:4.19 (3.8%) stddev-sans-first:2.59 12:48:34 INFO - PROCESS | 11307 | Values: 99.0 110.0 103.0 110.0 111.0 111.0 110.0 111.0 111.0 111.0 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:147.00 stddev:20.46 (13.9%) stddev-sans-first:21.44 12:48:34 INFO - PROCESS | 11307 | Values: 148.0 118.0 146.0 170.0 119.0 148.0 140.0 116.0 167.0 118.0 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.66 (1.0%) stddev-sans-first:1.76 12:48:34 INFO - PROCESS | 11307 | Values: 163.0 164.0 162.0 161.0 162.0 163.0 162.0 163.0 162.0 167.0 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.50 stddev:38.71 (51.3%) stddev-sans-first:40.40 12:48:34 INFO - PROCESS | 11307 | Values: 74.0 76.0 75.0 172.0 76.0 75.0 75.0 76.0 162.0 76.0 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:84.00 stddev:28.31 (33.7%) stddev-sans-first:29.28 12:48:34 INFO - PROCESS | 11307 | Values: 85.0 93.0 145.0 84.0 84.0 84.0 146.0 83.0 85.0 140.0 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.87 12:48:34 INFO - PROCESS | 11307 | Values: 118.0 116.0 118.0 117.0 117.0 118.0 117.0 117.0 119.0 117.0 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 12:48:34 INFO - PROCESS | 11307 | Values: 148.0 147.0 149.0 147.0 148.0 146.0 147.0 147.0 147.0 148.0 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 12:48:34 INFO - PROCESS | 11307 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:51.50 stddev:2.26 (4.4%) stddev-sans-first:2.37 12:48:34 INFO - PROCESS | 11307 | Values: 51.0 52.0 51.0 51.0 58.0 52.0 53.0 51.0 50.0 51.0 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.00 stddev:1.07 (1.8%) stddev-sans-first:1.13 12:48:34 INFO - PROCESS | 11307 | Values: 60.0 60.0 60.0 60.0 60.0 59.0 61.0 60.0 63.0 61.0 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.00 stddev:2.44 (3.3%) stddev-sans-first:2.59 12:48:34 INFO - PROCESS | 11307 | Values: 74.0 81.0 74.0 74.0 73.0 73.0 74.0 73.0 73.0 73.0 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:133.00 stddev:10.74 (8.1%) stddev-sans-first:11.01 12:48:34 INFO - PROCESS | 11307 | Values: 140.0 134.0 127.0 134.0 126.0 122.0 132.0 123.0 158.0 125.0 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:153.50 stddev:3.98 (2.6%) stddev-sans-first:4.22 12:48:34 INFO - PROCESS | 11307 | Values: 154.0 153.0 156.0 150.0 150.0 161.0 159.0 149.0 152.0 152.0 12:48:34 INFO - PROCESS | 11307 | 12:48:34 INFO - PROCESS | 11307 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.50 stddev:1.51 (2.4%) stddev-sans-first:0.93 12:48:34 INFO - PROCESS | 11307 | Values: 66.0 63.0 62.0 62.0 63.0 62.0 62.0 62.0 60.0 63.0 12:48:34 INFO - PROCESS | 11307 | -------- Summary: end -------- 12:48:34 INFO - PROCESS | 11307 | 12:48:35 INFO - TEST-INFO | 11307: exit 0 12:48:35 INFO - TEST-OK | kraken | took 60841ms 12:48:35 INFO - SUITE-END | took 1171s 12:48:36 INFO - Completed test suite (00:19:31) 12:48:36 INFO - javascript benchmark 12:48:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7743.688784813017, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3224.500202468617, 3242.967570324297, 3247.4804031354956, 3249.610046794385, 3260.6739326067395, 5589.888202235953, 5621.971890140544, 5663.292088488939, 5693.3452652944925, 5701.144828275761, 5677.801276955307, 5728.770849166029, 5732.5987180897355, 5745.396733342991, 5745.482906538411, 5118.692878427288, 5201.297824793661, 5213.817516386927, 5251.422343542207, 5276.103062479368, 5247.291615631898, 5259.921101183466, 5264.8157314494, 5270.525652691257, 5292.867678308035, 5089.491050894918, 5113.642045056848, 5230.92153617696, 5235.816746413876, 5241.637174334663, 5210.557102646279, 5267.868303292429, 5285.49787770165, 5292.497212764782, 5318.813841515567, 5190.480951904817, 5243.973780131075, 5255.789768409259, 5257.684538927677, 5259.447757985433, 5538.0585300499015, 5595.356533998602, 5694.914576281318, 5746.166805813175, 5812.389699081577, 6056.57603967718, 6159.7536098556, 6160.476359509447, 6161.229846269216, 6176.289726681444, 6190.133381326573, 6196.132541444156, 6199.504039676815, 6204.069389591552, 6224.159738435344, 5546.722663866791, 5551.333839939233, 5762.645972577355, 5785.797497087582, 5805.854853628651, 6054.878902421927, 6149.0776383542825, 6172.814815555541, 6205.5345849061505, 6206.906896396557, 5913.319968203626, 5965.343812180657, 5974.1934838796205, 5979.073243647154, 5983.910241346383, 5885.028970219866, 5980.730867110903, 6000.639961602318, 6036.577439579275, 6052.12244224585, 6037.577369584174, 6154.953657878172, 6158.692065396713, 6159.3224745277985, 6159.876802463926, 6098.969505152446, 6123.0, 6144.5084393248435, 6146.815595532141, 6154.476869466145, 4537.387452693844, 4624.1676498230645, 4670.486246512881, 4694.530546945278, 4698.436187657503, 4114.074333274989, 4192.622663960258, 4202.957970420257, 4204.663626909901, 4220.662347012231, 5951.642901425928, 5967.433093856077, 5971.990746498878, 5982.0, 5996.640201587831, 5843.3864444233595, 6057.757689692451, 6235.438810507076, 6238.095476155932, 6241.21984751906, 5854.882902342015, 5874.559408044413, 5882.205902203148, 5938.0, 5967.5524335675, 5268.446813084571, 5269.578433725293, 5276.34045744282, 5279.287296215039, 5279.709615971082, 6127.080937859268, 6220.471259942865, 6256.624602523863, 6338.239411270677, 6425.742970281136, 6170.197874276495, 6176.073588961692, 6180.505559555225, 6187.288461826947, 6187.443130118131, 6307.96846015767, 6345.936540634534, 6369.490440764635, 6382.36176382358, 6387.840303992437, 5804.21643078179, 5960.314563825043, 6015.157877897185, 6054.939450605614, 6073.48375388097, 6202.038684003806, 6211.130441738251, 6214.316425193316, 6220.0, 6220.315765265726, 6013.299793280227, 6045.425684559959, 6056.545759068, 6065.2418447694035, 6099.359567245376, 5806.2451881255165, 5969.76120955157, 6006.669633170043, 6048.969755151196, 6055.72749226277, 6054.212952316171, 6073.726682299395, 6087.543434242538, 6093.29927058394, 6122.632642041492, 6072.72672729737, 6104.572679912363, 6118.296395914349, 6131.540134489842, 6138.938610613836, 5723.0, 5795.536357091507, 5886.823395298148, 5954.225950626565, 5966.3138739043825], "value": 5654.678517830194, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.2821286243645, 623.5074291309866, 646.9741210351586, 667.156047599786, 702.2591166319537, 42051.36922946158, 47162.820929476824, 47227.29159062617, 47228.763856180674, 47302.290465643, 46258.76870615651, 46576.53423465764, 46928.530714692846, 46940.061198776006, 46956.53043469564, 9057.275417966563, 9249.583768730423, 9264.980852106262, 9265.397749146285, 9270.67552635658, 9258.12047855456, 9291.303152263574, 9322.347435679505, 9329.253659707207, 9374.0, 9397.81204375912, 9400.576974036185, 9418.0, 9461.526923653824, 9483.90516094837, 9280.582373793195, 9346.252299816033, 9360.719178424659, 9378.53107344637, 9421.952890235574, 9225.90774092264, 9289.767755806091, 9309.581068851918, 9313.441193528342, 9324.720258392259, 44846.55153448456, 44880.55119448796, 45277.09445811098, 45313.77343113296, 45436.09127817458, 3672.559292884844, 3940.2316548273097, 4237.576242375738, 4339.978300108479, 4548.340490628841, 35971.4604280936, 36025.27949441023, 36120.0, 36643.63356366429, 37562.62437375619, 4609.331646911212, 4680.063987202573, 4699.953000469985, 4709.293605959099, 4727.810887564493, 373696.0, 376238.0, 376677.11661441793, 378437.0, 379626.0, 65951.34048659548, 66255.0, 66303.0, 66313.66843165753, 66657.66671166613, 40898.1820363591, 41592.1681566367, 41660.58339416628, 43634.56365436369, 43721.34417983733, 17265.56836079108, 17366.826331736775, 17368.305267789146, 17374.13129343553, 17387.65224695499, 12456.377181140906, 12464.439100240512, 12484.250944943333, 12490.562830301078, 12544.435500402504, 21163.894180528998, 21182.0, 21214.681779773317, 21379.465513361978, 21429.892850535958, 7640.550463298351, 7759.185285544936, 7821.804454888559, 7875.763727088197, 7894.64474098667, 1026.1175389165312, 1058.5871510111062, 1078.0513148429332, 1148.6037317125579, 1234.2902830872285, 34210.0, 34873.0, 35029.64970350315, 35093.29813403718, 35410.291794163975, 1121.9046381057537, 1150.1891166727437, 1168.199783148546, 1223.1071317937956, 1225.7732319520917, 16584.0, 17086.316547338214, 17552.210150543255, 17654.0, 17728.55678608045, 657630.0, 657845.0, 659593.0, 661698.0, 664261.0, 65176.34823651703, 66315.33684663188, 66334.0, 66348.6682566584, 66411.33588664052, 1449.985500144985, 1466.5673626280272, 1485.4875068101487, 1505.902116362433, 1526.5344070058516, 31914.36171276608, 31938.92396994188, 32292.0, 32363.838180808943, 32939.50590741093, 56657.0, 57385.71307143437, 57403.42596573981, 57523.0, 57563.0, 556070.0, 556147.0, 558683.0, 561542.0, 566307.0, 29946.0, 30014.0, 30017.549736753528, 50974.74512627413, 51786.48213517967, 50026.0, 53086.73456632692, 53754.46245537651, 54386.728066359414, 54406.18390724063, 44776.0, 47397.763011184725, 47675.761621191676, 48411.5158848407, 49286.50713492963, 45494.0, 46567.30149047835, 47594.5240547604, 47756.0, 48792.268115979, 45825.77087114543, 45980.7700961493, 46804.53195468002, 47045.0, 47242.29136563023, 38605.613943861325, 41301.79349103235, 41458.37812432876, 41588.79205603953, 42570.5742942579, 30727.2318192047, 31416.214594635316, 31706.841465792524, 31808.36383272368, 32120.0], "value": 21889.327811397583, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.32918020675794, 408.77721641705267, 412.1386302627509, 428.17576165880683, 432.5263836099472, 19299.0, 20940.37178884632, 20968.37094887152, 21059.2629257976, 21732.782672173274, 20407.387778366636, 20411.693824592643, 20824.8958755206, 21224.8938755306, 21381.0, 5729.312482502095, 5924.466797988181, 5926.259217597801, 5926.436988486087, 5931.703414829241, 5659.405762394951, 5789.421057894198, 5801.6519008859395, 5835.35811060783, 5900.29196496421, 5774.451427114438, 5775.162601422791, 5782.277215348082, 5782.479576838084, 5794.5943783935145, 5562.276904002474, 5765.855853603652, 5799.159121927318, 5839.7664093436215, 5940.049592065292, 5761.222234998263, 5766.336871259775, 5774.249347584787, 5986.281646202484, 5991.221141251609, 14933.10401375921, 14973.0, 15124.54626361211, 15229.0, 15330.616734581614, 2469.715982661999, 2530.304166354249, 2556.9872150639126, 2662.5739881618847, 2664.6136310234906, 10798.622048228353, 11160.0, 11492.597759078391, 12197.679330136461, 15344.386224551004, 1938.6316599845984, 1959.3827944197533, 1959.9412017639493, 2021.7472815898013, 2023.8482113841521, 83737.16262837354, 84465.0, 84895.0, 86394.13605863924, 86421.56789216014, 11691.590794322157, 11711.238769479956, 12097.939510302393, 12160.939195303967, 12233.816492752616, 13369.66575835612, 14025.438982440588, 14131.505397311044, 16976.83023169777, 17035.914820426067, 7707.267809558083, 7794.3764498839955, 8010.3992200584025, 8095.2714255717265, 8125.878111828328, 7770.145284018753, 7809.399073189982, 7858.096318923397, 7910.5649189295145, 8077.7576672699915, 4455.443069616298, 4462.799174037111, 4486.753228572395, 4499.370088187657, 4570.702904311209, 2057.249104077001, 2174.9342822017097, 2176.5320456102013, 2202.79493337194, 2231.6317807561895, 888.617894305442, 972.9027097290215, 1027.6660085472251, 1054.5887104029434, 1055.2191378380096, 19621.60756784856, 19760.0, 19851.503712407306, 20201.494962626053, 20720.689189662167, 965.0587308585957, 1000.924930630191, 1015.751140970467, 1034.6275340877278, 1161.7676464707092, 10840.945795271131, 11280.379579123228, 11321.886781132249, 11344.092472602171, 11498.25261358009, 464776.0, 470935.0, 471845.0, 530810.0, 549236.0, 65971.67014164898, 97668.0, 98259.50870245746, 98954.0, 100551.49724251332, 1058.6929790360864, 1073.3023534702506, 1085.2891356161726, 1093.6445655162104, 1097.7200813792592, 15844.683106337578, 17836.55408614795, 17906.0151691653, 18068.81931180724, 18204.271829127218, 40843.59156408398, 42868.35697464478, 43191.56808431875, 43225.7838710817, 43424.34863476987, 59881.0, 59977.70011150091, 60135.097973529555, 61122.0, 61710.382896170464, 8757.168069033432, 8902.510361930155, 8947.955260223658, 9033.187013168847, 9080.772980675272, 13194.736105278032, 13311.733765324832, 13485.595432137052, 13625.318734063456, 13711.108777929801, 10980.792112867419, 11254.099672026054, 11261.873812618673, 11560.190786644855, 11613.593524226611, 11299.2655477397, 11382.601608943647, 11492.597759078391, 11929.403529823649, 12066.155369124428, 10427.94786026065, 11458.598949037078, 11595.072394208612, 11715.589954351557, 11807.586734464252, 8678.739637810875, 8689.652413903626, 8743.956280218557, 8820.470771753715, 8935.731928042169, 5045.672031317952, 5937.970310148422, 11397.715057123638, 11438.428078596204, 11490.138239631893], "value": 9328.149852613611, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1533.6932613477304, 1568.8431156884312, 1703.1143805221286, 1806.4580625812252, 1824.7810262768462, 8085.797855053626, 9031.277497800176, 9218.216451601613, 9906.35608685436, 9924.553395097211, 8895.822083558325, 9197.586108625112, 9216.953915230415, 9222.86165707515, 9247.398919070272, 2506.072753081358, 2555.3739333863136, 2556.322574517754, 2560.039985005623, 2560.7823335016546, 2474.9628755568683, 2506.548821212181, 2507.611320245365, 2509.6862892138483, 2512.899484020637, 2467.358486793438, 2486.1298545509107, 2490.0537795637633, 2490.950180996379, 2502.4244423782543, 2364.290712786166, 2370.395549134968, 2370.9407264818433, 2413.4207790130417, 2422.1280339077916, 2352.4589344450874, 2368.052778888441, 2385.3798012516695, 2388.4984153327823, 2410.6384042393606, 9784.755381115458, 9838.852417213748, 9857.753556161082, 9868.60525578976, 9870.654527091518, 5362.168863826074, 5553.250311207976, 5589.860253493654, 5681.176229446707, 5688.004599195125, 3485.5120283160377, 3516.7010804081683, 3530.223350862806, 3547.627499112582, 3607.188382613917, 1220.1215125109907, 1226.5952235762177, 1229.416027386993, 1240.3054289597853, 1254.2161149281699, 13596.59210223695, 13598.660033499144, 13645.454181832714, 13652.385642646104, 13716.65708357279, 4908.803647854117, 4933.432655244621, 4988.326575912278, 4990.176620857518, 5190.065788158092, 11448.771024579462, 11486.483108260149, 11487.655370338904, 11492.597759078391, 11496.655100347003, 5667.603267771216, 5669.34802497718, 5677.3471050829685, 5677.489025987681, 5696.259486266758, 4459.353393757887, 5153.2270159476375, 5209.270702101709, 5225.503577160163, 5260.2109683547005, 4337.869863904025, 4389.209942210369, 4484.887877803081, 4511.413516242867, 4654.743989080633, 1380.378829526717, 1409.4503143773936, 1409.4925826702379, 1416.4759039155372, 1434.2326855132453, 905.4838741917044, 1059.247933966892, 1084.3060441317564, 1095.479647167589, 1113.8496302999154, 6478.125453063871, 6600.339966003457, 6744.022116793038, 6761.661916904135, 6853.246142924274, 476.7830637060129, 483.2606112647655, 1066.568039943824, 1111.6382431521322, 1132.3206076354122, 4232.36514522824, 4431.711938724037, 4447.199504089295, 4459.509453960061, 4492.663050271242, 11931.642050738492, 12291.446884890202, 12376.381180940916, 12400.069994750429, 12406.565770198, 12090.214136081127, 12118.81821772674, 12145.149839511327, 12263.141580089308, 12295.139340246276, 8184.0, 8346.624401901807, 8982.461052336881, 9037.954810226038, 9117.954410227907, 6695.933040669531, 6706.966465167643, 6902.344277293649, 6923.89614155778, 7038.929610704033, 11042.668719938414, 11221.326720396803, 11285.984261416512, 11311.7737645245, 11340.886591133984, 11097.667069987914, 11191.776164476501, 11290.0, 11349.092072634334, 11378.31730096197, 8231.547264900488, 8291.709790157316, 8366.748997530083, 8555.786105347168, 8582.613782379683, 9384.296177786557, 9432.292578056811, 9541.904580954379, 9553.61785528571, 9557.330986830855, 8272.214139656722, 8536.829263414573, 8595.613197406257, 8629.87055194185, 8641.611127499153, 8161.673533058849, 8343.499390036617, 8430.494170349799, 8482.236598706146, 8502.914970850212, 7155.3202445767565, 7394.223606521237, 7491.70033198666, 7503.362214211853, 7514.47398682087, 5707.5433965281845, 5782.277215348082, 5850.063989761617, 5861.472467477947, 5879.7060146993335, 5808.767649293981, 5821.912671309849, 5905.143754155538, 5928.4960778334325, 5980.252468441445], "value": 5038.146247807932, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.3763782200061, 360.12848905648326, 360.72404610472995, 363.95450568678916, 364.4787953226884, 5903.321118071423, 5927.88144237115, 5928.88142237155, 5935.317438494574, 5944.4947179489745, 5536.335639723239, 5701.800436984707, 5767.769289228426, 5858.970705146479, 5870.70646467677, 4459.57634024768, 4540.614047805941, 4549.727016379012, 4561.384213131235, 4583.472900616422, 4564.84023059193, 4580.0, 4580.335851301559, 4607.8156873725175, 4619.53804619537, 4461.39771130898, 4547.613452856511, 4563.543645635443, 4596.724621312438, 4601.0, 4471.3293006049025, 4492.146492166495, 4493.438320209973, 4502.41468609082, 4523.615492683126, 3992.5608183100126, 4011.6991225658194, 4012.9799351003057, 4026.4966879140106, 4039.1719697462245, 5617.9719101404235, 5678.971605141989, 5708.229389032469, 5709.115087161496, 5712.742926568314, 5142.537171654569, 5153.922691159635, 5168.431472538018, 5170.0, 5225.399079105913, 6052.636841789506, 6088.512918966517, 6100.664463454508, 6105.32841387447, 6129.295131059941, 4287.91424171518, 4336.653067754603, 4359.716618419792, 4377.9781101094295, 4396.868093957187, 6070.453659170652, 6273.1844860167885, 6330.430261276507, 6335.144755458046, 6390.424861762417, 4405.801738921757, 4449.710768800018, 4460.643148548108, 4464.6428285737065, 4471.150481408522, 4525.094981003813, 4537.4328208973875, 4541.000979784442, 4542.091581683677, 4542.11428771393, 4909.656324057353, 5097.209932460474, 5164.5539249010335, 5175.922361164586, 5201.29782479368, 6081.118237855486, 6097.756089756449, 6104.17593624855, 6111.786087486917, 6154.261488621304, 1554.7046061248327, 1583.1530131379657, 1587.4205914841232, 1589.6025993501626, 1594.8644365229086, 955.5699935029264, 1002.8367094170727, 1004.9497525123714, 1019.5259204469957, 1019.6686077024997, 5222.947770522246, 5241.0, 5266.34170728659, 5272.92090618641, 5308.601854860824, 5526.557875369961, 5533.6403133796175, 5536.252605898233, 5570.220169176318, 5594.552435805126, 5016.322796422436, 5159.226116082617, 5240.764165612557, 5267.578593712494, 5289.629725919226, 2925.5611658251005, 2933.5453004784295, 2970.277239201258, 3035.7723170762283, 3054.5796204764447, 5556.277683901067, 5570.916436253459, 5614.792819543818, 5685.516731077904, 5752.913706294409, 5988.550858685616, 6383.776567820104, 6459.450946669492, 6466.579672321284, 6467.223933128054, 6572.943581234749, 6600.273969863311, 6604.801855944329, 6607.636579988147, 6639.900401493981, 6175.900193934084, 6302.180716507009, 6326.683665816783, 6347.746090156526, 6381.425671689571, 6254.3745625437095, 6260.843478913063, 6286.648370600343, 6306.306306306395, 6309.558330916791, 6270.7491700331475, 6464.866594024055, 6469.935300646934, 6488.0, 6527.281998980014, 4428.68999170055, 4448.575526338218, 4455.933161002523, 4469.530699276659, 4508.790692560556, 6254.0, 6291.276503202191, 6368.044793281045, 6387.0, 6424.38968298011, 6138.0, 6153.630782153085, 6156.876862462816, 6168.660723660242, 6215.9378406215355, 5907.940920590739, 6157.84605384869, 6204.751809927552, 6211.316755156839, 6255.718492667932, 6078.756849725962, 6136.747523812386, 6150.2927163375, 6151.9384806151365, 6166.568340216142, 6239.906401404073, 6273.498120150286, 6273.62358258506, 6288.0, 6312.936870631419, 5834.766609335579, 6032.280799971987, 6048.879022419615, 6087.086936959315, 6090.0], "value": 4596.546247053212, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.608153963788, 821.2649678537709, 826.2439867521218, 831.7629475599456, 880.6301353431558, 16841.410550630713, 18061.63876722465, 18176.909115454404, 18184.363547275832, 18244.54388640283, 16395.4261600844, 16514.33942642293, 16560.58598535037, 16583.83416165838, 16606.83393166068, 727.9890801637953, 850.897892252929, 865.7229686500323, 877.8683197520392, 881.9382643214977, 861.6165806216205, 865.9870101948444, 867.453504292295, 868.5179725252482, 868.7350358140765, 938.7043081429362, 939.8120375924842, 940.050548945563, 946.1106559833735, 947.3273975477385, 931.7903471718877, 935.2190920581323, 936.3071327217878, 937.0, 940.9952950235273, 686.1902954513672, 686.4474098350826, 688.6763221285987, 688.8209065642919, 689.8034060292792, 16106.275217615235, 16144.515664530083, 16153.838461615469, 16206.270717817726, 16231.91884040584, 15343.372233239983, 16165.83834161655, 16205.270762815702, 16247.593810154722, 16297.266623001993, 13634.659133521642, 13714.451421943111, 13723.862761372358, 14008.22954737489, 14158.858411415857, 4113.465249517543, 4158.209940111369, 4178.498580170399, 4184.958150418518, 4356.390105385249, 67817.66091169562, 70818.64590677065, 88337.11662883354, 88381.0, 88385.0, 12537.498500060077, 12709.682257943625, 12719.364031798557, 12840.48638054486, 12881.613551593467, 22867.19964801224, 23171.189008384627, 23174.304770856903, 23193.0, 23193.652095218586, 9449.244060475145, 9510.857337139949, 9557.283203759745, 9686.515674216402, 9688.660896868576, 5019.397672279277, 5023.572996295283, 5033.219850923113, 5098.821541246039, 5116.283720279164, 3817.10298079951, 3977.085270387769, 4022.2759903217116, 4022.879313620596, 4025.939610905839, 645.502962718704, 647.9967600161968, 664.455146779636, 669.7321071571313, 671.9126513553207, 626.6459450410504, 644.6712176789778, 689.1110467496873, 693.9444844412435, 729.0849983271067, 9548.761280967892, 9918.30571859963, 10328.225383096298, 10356.275060745826, 10462.843057354146, 599.9850003749941, 694.8500232115856, 715.2311265389727, 722.9457790665721, 750.2422553221286, 5108.565771909355, 5160.92258616121, 5170.45710200431, 5280.419153893145, 5290.232916227203, 76924.23075769171, 91759.5412022949, 119978.0, 127823.0, 136985.315073424, 112929.0, 114953.0, 115686.0, 117797.0, 118035.0, 100911.0, 102531.0, 103141.0, 103644.48177759063, 105901.47049264704, 9831.950840245752, 10096.34373765703, 10112.443815590213, 10173.38959662393, 10222.897771022195, 55405.16892246539, 56643.0, 56790.716046419504, 57156.42843571511, 58508.0, 48733.51266487432, 49544.77048532753, 82462.58768706118, 85511.57244213739, 86267.0, 11571.13216508782, 11782.764344712887, 11832.70418239551, 11930.403479826147, 12154.878451215374, 14212.360443780262, 14481.203533805741, 14636.926815365856, 14681.48614798477, 14718.77921831152, 12784.296863672587, 13003.349832508526, 13133.0, 13188.934055329662, 14374.0, 11844.585439509576, 12095.57665481704, 12277.38613069325, 12505.56230531927, 12642.478808295717, 12463.750724985632, 13981.021328507313, 14251.0, 14477.782833257721, 15378.769318460456, 12116.21244619097, 12207.328596926898, 12230.938845305716, 12266.938665306974, 12675.556355527513, 12760.74478510443, 13123.934380328037, 13175.209487430784, 13517.391717372939, 13734.65663358424], "value": 8063.2076992483335, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 103.0, 110.0, 111.0, 111.0, 110.0, 111.0, 111.0, 111.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 146.0, 170.0, 119.0, 148.0, 140.0, 116.0, 167.0, 118.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 161.0, 162.0, 163.0, 162.0, 163.0, 162.0, 167.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 172.0, 76.0, 75.0, 75.0, 76.0, 162.0, 76.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 93.0, 145.0, 84.0, 84.0, 84.0, 146.0, 83.0, 85.0, 140.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 119.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 51.0, 51.0, 58.0, 52.0, 53.0, 51.0, 50.0, 51.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 61.0, 60.0, 63.0, 61.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 81.0, 74.0, 74.0, 73.0, 73.0, 74.0, 73.0, 73.0, 73.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 127.0, 134.0, 126.0, 122.0, 132.0, 123.0, 158.0, 125.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 156.0, 150.0, 150.0, 161.0, 159.0, 149.0, 152.0, 152.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 60.0, 63.0], "value": 62.5, "unit": "score"}]}]} 12:48:36 INFO - Return code: 0 12:48:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:48:36 ERROR - # TBPL SUCCESS # 12:48:36 INFO - Running post-action listener: _resource_record_post_action 12:48:36 INFO - [mozharness: 2016-10-25 19:48:36.210473Z] Finished run-tests step (success) 12:48:36 INFO - Running post-run listener: _resource_record_post_run 12:48:36 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288694272; Read time: 16; Write time: 162396 12:48:36 INFO - TinderboxPrint: CPU usage
13.2% 12:48:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:48:36 INFO - TinderboxPrint: I/O write bytes / time
288,694,272 / 162,396 12:48:36 INFO - TinderboxPrint: CPU idle
8,207.9 (86.8%) 12:48:36 INFO - TinderboxPrint: CPU user
1,194.5 (12.6%) 12:48:36 INFO - TinderboxPrint: Swap in / out
0 / 0 12:48:36 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 71323648; Read time: 0; Write time: 34828 12:48:36 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 216797184; Read time: 0; Write time: 127520 12:48:36 INFO - Running post-run listener: _upload_blobber_files 12:48:36 INFO - Blob upload gear active. 12:48:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:48:36 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 12:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:48:37 INFO - (blobuploader) - INFO - Open directory for files ... 12:48:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:48:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:48:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:48:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:48:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:48:40 INFO - (blobuploader) - INFO - Done attempting. 12:48:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:48:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:48:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:48:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:48:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:48:41 INFO - (blobuploader) - INFO - Done attempting. 12:48:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:48:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:48:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:48:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:48:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:48:42 INFO - (blobuploader) - INFO - Done attempting. 12:48:42 INFO - (blobuploader) - INFO - Iteration through files over. 12:48:42 INFO - Return code: 0 12:48:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:48:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:48:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25181486cdaf357b80580b3c57cea0a82ddcf4851424850076d494df6c7b53d29c6b9cfc123157d6a97885712ee55cc575ed9879797a716f28f74f6674e5fbff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e492e7da26cc2c2b83846236635e9f4660aa0eafe3e0b4c885c514581014d938cbfe758ff7e965a7c8c1cb095bcde8163776ec22bc8d649810c20ae357c0db3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2d4daa7f5b828af3bbebbdf51bfe2fceb083c058a426a58601f0adc1231bf338bef91b947a9a6e86875710d0c40609349ecf2bcba801354c533c64f83e5764c5"} 12:48:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:48:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:48:42 INFO - Contents: 12:48:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25181486cdaf357b80580b3c57cea0a82ddcf4851424850076d494df6c7b53d29c6b9cfc123157d6a97885712ee55cc575ed9879797a716f28f74f6674e5fbff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e492e7da26cc2c2b83846236635e9f4660aa0eafe3e0b4c885c514581014d938cbfe758ff7e965a7c8c1cb095bcde8163776ec22bc8d649810c20ae357c0db3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2d4daa7f5b828af3bbebbdf51bfe2fceb083c058a426a58601f0adc1231bf338bef91b947a9a6e86875710d0c40609349ecf2bcba801354c533c64f83e5764c5"} 12:48:42 INFO - Running post-run listener: copy_logs_to_upload_dir 12:48:42 INFO - Copying logs to upload dir... 12:48:42 INFO - mkdir: /builds/slave/test/build/upload/logs 12:48:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1675.597510 ========= master_lag: 0.52 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 56 secs) (at 2016-10-25 12:48:42.522369) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 12:48:42.526760) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25181486cdaf357b80580b3c57cea0a82ddcf4851424850076d494df6c7b53d29c6b9cfc123157d6a97885712ee55cc575ed9879797a716f28f74f6674e5fbff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e492e7da26cc2c2b83846236635e9f4660aa0eafe3e0b4c885c514581014d938cbfe758ff7e965a7c8c1cb095bcde8163776ec22bc8d649810c20ae357c0db3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2d4daa7f5b828af3bbebbdf51bfe2fceb083c058a426a58601f0adc1231bf338bef91b947a9a6e86875710d0c40609349ecf2bcba801354c533c64f83e5764c5"} build_url:https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/JsXQOb2aQxurIphyLTm2_Q/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25181486cdaf357b80580b3c57cea0a82ddcf4851424850076d494df6c7b53d29c6b9cfc123157d6a97885712ee55cc575ed9879797a716f28f74f6674e5fbff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6e492e7da26cc2c2b83846236635e9f4660aa0eafe3e0b4c885c514581014d938cbfe758ff7e965a7c8c1cb095bcde8163776ec22bc8d649810c20ae357c0db3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2d4daa7f5b828af3bbebbdf51bfe2fceb083c058a426a58601f0adc1231bf338bef91b947a9a6e86875710d0c40609349ecf2bcba801354c533c64f83e5764c5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 12:48:42.557754) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 12:48:42.558110) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=934fc3100db09dcb9af4d4b6000001ab-1477419947.473171-1671131381 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 12:48:42.607091) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 12:48:42.609383) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 12:48:42.609685) ========= ========= Total master_lag: 0.65 =========