builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0030 starttime: 1477904629.84 results: success (0) buildid: 20161031004002 builduid: f2174131e219431d869ab3bd0ee3e95d revision: b7070c905172e3ead8ee610fff35f86bf9ff9c42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 02:03:49.842663) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 02:03:49.843030) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 02:03:49.843297) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 02:03:49.871291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 02:03:49.871564) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UEuSmBd7JV/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-31 02:03:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to 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% 71.7M=0s 2016-10-31 02:03:50 (71.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.563083 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 02:03:50.457340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 02:03:50.460850) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UEuSmBd7JV/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.027580 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 02:03:50.509616) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 02:03:50.513029) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b7070c905172e3ead8ee610fff35f86bf9ff9c42 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b7070c905172e3ead8ee610fff35f86bf9ff9c42 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UEuSmBd7JV/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-31 02:03:50,592 truncating revision to first 12 chars 2016-10-31 02:03:50,592 Setting DEBUG logging. 2016-10-31 02:03:50,592 attempt 1/10 2016-10-31 02:03:50,592 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b7070c905172?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 02:03:51,015 unpacking tar archive at: mozilla-aurora-b7070c905172/testing/mozharness/ program finished with exit code 0 elapsedTime=0.692932 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 02:03:51.243242) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 02:03:51.243543) ========= script_repo_revision: b7070c905172e3ead8ee610fff35f86bf9ff9c42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 02:03:51.243960) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 02:03:51.244222) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 02:03:51.283528) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-31 02:03:51.284888) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UEuSmBd7JV/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:03:51 INFO - MultiFileLogger online at 20161031 02:03:51 in /builds/slave/test 02:03:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:03:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:03:51 INFO - {'append_to_log': False, 02:03:51 INFO - 'base_work_dir': '/builds/slave/test', 02:03:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:03:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:03:51 INFO - 'branch': 'Mozilla-Aurora', 02:03:51 INFO - 'buildbot_json_path': 'buildprops.json', 02:03:51 INFO - 'config_files': ('talos/mac_config.py',), 02:03:51 INFO - 'default_actions': ('clobber', 02:03:51 INFO - 'read-buildbot-config', 02:03:51 INFO - 'download-and-extract', 02:03:51 INFO - 'populate-webroot', 02:03:51 INFO - 'create-virtualenv', 02:03:51 INFO - 'install', 02:03:51 INFO - 'run-tests'), 02:03:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:03:51 INFO - 'download_minidump_stackwalk': True, 02:03:51 INFO - 'download_symbols': 'ondemand', 02:03:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:03:51 INFO - 'tooltool.py': '/tools/tooltool.py', 02:03:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:03:51 INFO - '/tools/misc-python/virtualenv.py')}, 02:03:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:03:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:03:51 INFO - 'installer_path': 'installer.exe', 02:03:51 INFO - 'log_level': 'info', 02:03:51 INFO - 'log_name': 'talos', 02:03:51 INFO - 'log_to_console': True, 02:03:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:03:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:03:51 INFO - 'opt_config_files': (), 02:03:51 INFO - 'pip_index': False, 02:03:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:03:51 INFO - 'cmd': ('bash', 02:03:51 INFO - '-c', 02:03:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:03:51 INFO - 'enabled': True, 02:03:51 INFO - 'halt_on_failure': False, 02:03:51 INFO - 'name': 'check_screen_resolution'},), 02:03:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:03:51 INFO - 'cmd': ('bash', 02:03:51 INFO - '-c', 02:03:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:03:51 INFO - 'enabled': True, 02:03:51 INFO - 'halt_on_failure': False, 02:03:51 INFO - 'name': 'check_screen_resolution'},), 02:03:51 INFO - 'run_cmd_checks_enabled': True, 02:03:51 INFO - 'sps_profile': False, 02:03:51 INFO - 'sps_profile_interval': 0, 02:03:51 INFO - 'suite': 'dromaeojs-e10s', 02:03:51 INFO - 'system_bits': '32', 02:03:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:03:51 INFO - 'title': 't-yosemite-r7-0030', 02:03:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:03:51 INFO - 'use_talos_json': True, 02:03:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:03:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:03:51 INFO - 'work_dir': 'build'} 02:03:51 INFO - [mozharness: 2016-10-31 09:03:51.498198Z] Running clobber step. 02:03:51 INFO - Running pre-action listener: _resource_record_pre_action 02:03:51 INFO - Running main action method: clobber 02:03:51 INFO - rmtree: /builds/slave/test/build 02:03:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:03:53 INFO - Running post-action listener: _resource_record_post_action 02:03:53 INFO - [mozharness: 2016-10-31 09:03:53.772093Z] Finished clobber step (success) 02:03:53 INFO - [mozharness: 2016-10-31 09:03:53.772223Z] Running read-buildbot-config step. 02:03:53 INFO - Running pre-action listener: _resource_record_pre_action 02:03:53 INFO - Running main action method: read_buildbot_config 02:03:53 INFO - Using buildbot properties: 02:03:53 INFO - { 02:03:53 INFO - "project": "", 02:03:53 INFO - "product": "firefox", 02:03:53 INFO - "script_repo_revision": "production", 02:03:53 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:03:53 INFO - "repository": "", 02:03:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:03:53 INFO - "buildid": "20161031004002", 02:03:53 INFO - "stage_platform": "macosx64", 02:03:53 INFO - "basedir": "/builds/slave/test", 02:03:53 INFO - "nightly_build": "True", 02:03:53 INFO - "buildnumber": 144, 02:03:53 INFO - "slavename": "t-yosemite-r7-0030", 02:03:53 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 02:03:53 INFO - "platform": "yosemite_r7", 02:03:53 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:03:53 INFO - "branch": "mozilla-aurora", 02:03:53 INFO - "repo_path": "releases/mozilla-aurora", 02:03:53 INFO - "revision": "b7070c905172e3ead8ee610fff35f86bf9ff9c42", 02:03:53 INFO - "pgo_build": "False", 02:03:53 INFO - "builduid": "f2174131e219431d869ab3bd0ee3e95d", 02:03:53 INFO - "slavebuilddir": "test" 02:03:53 INFO - } 02:03:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 02:03:53 INFO - Running post-action listener: _resource_record_post_action 02:03:53 INFO - [mozharness: 2016-10-31 09:03:53.775581Z] Finished read-buildbot-config step (success) 02:03:53 INFO - [mozharness: 2016-10-31 09:03:53.775718Z] Running download-and-extract step. 02:03:53 INFO - Running pre-action listener: _resource_record_pre_action 02:03:53 INFO - Running main action method: download_and_extract 02:03:53 INFO - mkdir: /builds/slave/test/build/tests 02:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:03:53 INFO - trying https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 02:03:53 INFO - Downloading https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:03:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 02:03:54 INFO - Downloaded 1199 bytes. 02:03:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:03:54 INFO - Using the following test package requirements: 02:03:54 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:03:54 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:03:54 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 02:03:54 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:03:54 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 02:03:54 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:03:54 INFO - u'jsshell-mac.zip'], 02:03:54 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:03:54 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 02:03:54 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:03:54 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:03:54 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 02:03:54 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:03:54 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 02:03:54 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:03:54 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 02:03:54 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:03:54 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 02:03:54 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:03:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:03:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:03:54 INFO - Fetch https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:03:55 INFO - Expected file size: 16421566 02:04:02 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:04:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:04:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:04:02 INFO - Fetch https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:04:03 INFO - Expected file size: 16421566 02:04:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 02:04:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:04:09 INFO - Fetch https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 02:04:10 INFO - Expected file size: 14414089 02:04:10 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:10 INFO - trying https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:04:10 INFO - Downloading https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 02:04:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 02:04:14 INFO - Downloaded 115524702 bytes. 02:04:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:04:14 INFO - mkdir: /builds/slave/test/properties 02:04:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:04:14 INFO - Writing to file /builds/slave/test/properties/build_url 02:04:14 INFO - Contents: 02:04:14 INFO - build_url:https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:04:15 INFO - Running post-action listener: _resource_record_post_action 02:04:15 INFO - Running post-action listener: set_extra_try_arguments 02:04:15 INFO - [mozharness: 2016-10-31 09:04:15.322895Z] Finished download-and-extract step (success) 02:04:15 INFO - [mozharness: 2016-10-31 09:04:15.323020Z] Running populate-webroot step. 02:04:15 INFO - Running pre-action listener: _resource_record_pre_action 02:04:15 INFO - Running main action method: populate_webroot 02:04:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:04:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:04:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:04:15 INFO - '--tppagecycles', 02:04:15 INFO - '7'], 02:04:15 INFO - 'tests': ['tsvgm']}}, 02:04:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:04:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:04:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:04:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:04:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:04:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:04:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['damp', 'tps']}, 02:04:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'tests': ['damp', 'tps']}, 02:04:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['dromaeo_dom']}, 02:04:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:04:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['basic_compositor_video']}, 02:04:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:04:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['a11yr', 02:04:15 INFO - 'ts_paint', 02:04:15 INFO - 'tpaint', 02:04:15 INFO - 'sessionrestore', 02:04:15 INFO - 'sessionrestore_no_auto_restore', 02:04:15 INFO - 'tabpaint']}, 02:04:15 INFO - 'other-e10s': {'tests': ['a11yr', 02:04:15 INFO - 'ts_paint', 02:04:15 INFO - 'tpaint', 02:04:15 INFO - 'sessionrestore', 02:04:15 INFO - 'sessionrestore_no_auto_restore', 02:04:15 INFO - 'tabpaint']}, 02:04:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:04:15 INFO - 'ts_paint', 02:04:15 INFO - 'tpaint', 02:04:15 INFO - 'sessionrestore', 02:04:15 INFO - 'sessionrestore_no_auto_restore', 02:04:15 INFO - 'tabpaint']}, 02:04:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:04:15 INFO - 'ts_paint', 02:04:15 INFO - 'tpaint', 02:04:15 INFO - 'sessionrestore', 02:04:15 INFO - 'sessionrestore_no_auto_restore', 02:04:15 INFO - 'tabpaint']}, 02:04:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['a11yr', 02:04:15 INFO - 'ts_paint', 02:04:15 INFO - 'tpaint', 02:04:15 INFO - 'sessionrestore', 02:04:15 INFO - 'sessionrestore_no_auto_restore', 02:04:15 INFO - 'tabpaint']}, 02:04:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['a11yr', 02:04:15 INFO - 'ts_paint', 02:04:15 INFO - 'tpaint', 02:04:15 INFO - 'sessionrestore', 02:04:15 INFO - 'sessionrestore_no_auto_restore', 02:04:15 INFO - 'tabpaint']}, 02:04:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['tsvgx', 02:04:15 INFO - 'tsvgr_opacity', 02:04:15 INFO - 'tart', 02:04:15 INFO - 'tscrollx', 02:04:15 INFO - 'cart']}, 02:04:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:04:15 INFO - 'tsvgr_opacity', 02:04:15 INFO - 'tart', 02:04:15 INFO - 'tscrollx', 02:04:15 INFO - 'cart']}, 02:04:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'talos_options': ['--disable-e10s'], 02:04:15 INFO - 'tests': ['tp5o']}, 02:04:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'tests': ['tp5o']}, 02:04:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'talos_options': ['--disable-e10s', 02:04:15 INFO - '--xperf_path', 02:04:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:04:15 INFO - 'tests': ['tp5n']}, 02:04:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:04:15 INFO - 'talos_options': ['--xperf_path', 02:04:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:04:15 INFO - 'tests': ['tp5n']}}, 02:04:15 INFO - 'talos.zip': {'path': '', 02:04:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:04:15 INFO - Running post-action listener: _resource_record_post_action 02:04:15 INFO - [mozharness: 2016-10-31 09:04:15.341551Z] Finished populate-webroot step (success) 02:04:15 INFO - [mozharness: 2016-10-31 09:04:15.341696Z] Running create-virtualenv step. 02:04:15 INFO - Running pre-action listener: _resource_record_pre_action 02:04:15 INFO - Running main action method: create_virtualenv 02:04:15 INFO - Creating virtualenv /builds/slave/test/build/venv 02:04:15 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 02:04:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:04:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:04:15 INFO - Using real prefix '/tools/python27' 02:04:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:04:16 INFO - Installing distribute.............................................................................................................................................................................................done. 02:04:19 INFO - Installing pip.................done. 02:04:19 INFO - Return code: 0 02:04:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:19 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 0x10c084490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bffa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb730d97e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be98d30>, '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 0x10bcfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be90b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:04:19 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 02:04:19 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 02:04:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 02:04:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:04:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:04:19 INFO - 'HOME': '/Users/cltbld', 02:04:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:04:19 INFO - 'LOGNAME': 'cltbld', 02:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:19 INFO - 'MOZ_NO_REMOTE': '1', 02:04:19 INFO - 'NO_EM_RESTART': '1', 02:04:19 INFO - 'PAGER': '/bin/cat', 02:04:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:19 INFO - 'PWD': '/builds/slave/test', 02:04:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:04:19 INFO - 'SHELL': '/bin/bash', 02:04:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 02:04:19 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 02:04:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:04:19 INFO - 'USER': 'cltbld', 02:04:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:04:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:19 INFO - 'XPC_FLAGS': '0x0', 02:04:19 INFO - 'XPC_SERVICE_NAME': '0', 02:04:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:19 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 02:04:19 INFO - Cleaning up... 02:04:19 INFO - Return code: 0 02:04:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:19 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 0x10c084490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bffa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb730d97e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be98d30>, '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 0x10bcfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be90b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:04:19 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 02:04:19 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 02:04:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 02:04:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:04:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:04:19 INFO - 'HOME': '/Users/cltbld', 02:04:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:04:19 INFO - 'LOGNAME': 'cltbld', 02:04:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:19 INFO - 'MOZ_NO_REMOTE': '1', 02:04:19 INFO - 'NO_EM_RESTART': '1', 02:04:19 INFO - 'PAGER': '/bin/cat', 02:04:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:04:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:19 INFO - 'PWD': '/builds/slave/test', 02:04:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:04:19 INFO - 'SHELL': '/bin/bash', 02:04:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 02:04:19 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 02:04:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:04:19 INFO - 'USER': 'cltbld', 02:04:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:04:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:04:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:19 INFO - 'XPC_FLAGS': '0x0', 02:04:19 INFO - 'XPC_SERVICE_NAME': '0', 02:04:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:04:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:19 INFO - Downloading/unpacking psutil>=3.1.1 02:04:19 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 02:04:19 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 02:04:19 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 02:04:19 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 02:04:19 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 02:04:19 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 02:04:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:04:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:04:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:04:23 INFO - Installing collected packages: psutil 02:04:23 INFO - Running setup.py install for psutil 02:04:23 INFO - building 'psutil._psutil_osx' extension 02:04:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:04:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:04:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:04:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:04:24 INFO - building 'psutil._psutil_posix' extension 02:04:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:04:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:04:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:04:24 INFO - ^ 02:04:24 INFO - 1 warning generated. 02:04:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:04:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:04:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:04:24 INFO - Successfully installed psutil 02:04:24 INFO - Cleaning up... 02:04:24 INFO - Return code: 0 02:04:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:04:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:24 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 0x10c084490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bffa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb730d97e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be98d30>, '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 0x10bcfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be90b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:04:24 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 02:04:24 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 02:04:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 02:04:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:04:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:04:24 INFO - 'HOME': '/Users/cltbld', 02:04:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:04:24 INFO - 'LOGNAME': 'cltbld', 02:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:24 INFO - 'MOZ_NO_REMOTE': '1', 02:04:24 INFO - 'NO_EM_RESTART': '1', 02:04:24 INFO - 'PAGER': '/bin/cat', 02:04:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:24 INFO - 'PWD': '/builds/slave/test', 02:04:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:04:24 INFO - 'SHELL': '/bin/bash', 02:04:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 02:04:24 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 02:04:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:04:24 INFO - 'USER': 'cltbld', 02:04:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:04:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:24 INFO - 'XPC_FLAGS': '0x0', 02:04:24 INFO - 'XPC_SERVICE_NAME': '0', 02:04:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:04:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:04:24 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 02:04:24 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 02:04:24 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 02:04:24 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 02:04:24 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 02:04:24 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 02:04:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:04:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:04:27 INFO - Installing collected packages: mozsystemmonitor 02:04:27 INFO - Running setup.py install for mozsystemmonitor 02:04:27 INFO - Successfully installed mozsystemmonitor 02:04:27 INFO - Cleaning up... 02:04:27 INFO - Return code: 0 02:04:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:04:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:27 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 0x10c084490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bffa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb730d97e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be98d30>, '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 0x10bcfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be90b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:04:27 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 02:04:27 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 02:04:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 02:04:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:04:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:04:27 INFO - 'HOME': '/Users/cltbld', 02:04:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:04:27 INFO - 'LOGNAME': 'cltbld', 02:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:27 INFO - 'MOZ_NO_REMOTE': '1', 02:04:27 INFO - 'NO_EM_RESTART': '1', 02:04:27 INFO - 'PAGER': '/bin/cat', 02:04:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:27 INFO - 'PWD': '/builds/slave/test', 02:04:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:04:27 INFO - 'SHELL': '/bin/bash', 02:04:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 02:04:27 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 02:04:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:04:27 INFO - 'USER': 'cltbld', 02:04:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:04:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:27 INFO - 'XPC_FLAGS': '0x0', 02:04:27 INFO - 'XPC_SERVICE_NAME': '0', 02:04:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:04:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:27 INFO - Downloading/unpacking jsonschema==2.5.1 02:04:27 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 02:04:27 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 02:04:27 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 02:04:27 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 02:04:27 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 02:04:27 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 02:04:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:04:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:04:30 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 02:04:30 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 02:04:30 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 02:04:30 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 02:04:30 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 02:04:30 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 02:04:30 INFO - Downloading functools32-3.2.3-2.tar.gz 02:04:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:04:30 INFO - warning: no files found matching '*.txt' 02:04:30 INFO - no previously-included directories found matching 'build' 02:04:30 INFO - no previously-included directories found matching 'dist' 02:04:30 INFO - no previously-included directories found matching '.git*' 02:04:30 INFO - Installing collected packages: jsonschema, functools32 02:04:30 INFO - Running setup.py install for functools32 02:04:30 INFO - warning: no files found matching '*.txt' 02:04:30 INFO - no previously-included directories found matching 'build' 02:04:30 INFO - no previously-included directories found matching 'dist' 02:04:30 INFO - no previously-included directories found matching '.git*' 02:04:31 INFO - Successfully installed jsonschema functools32 02:04:31 INFO - Cleaning up... 02:04:31 INFO - Return code: 0 02:04:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c084490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bffa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb730d97e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be98d30>, '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 0x10bcfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be90b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:04:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:04:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:04:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 02:04:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:04:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:04:31 INFO - 'HOME': '/Users/cltbld', 02:04:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:04:31 INFO - 'LOGNAME': 'cltbld', 02:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:31 INFO - 'MOZ_NO_REMOTE': '1', 02:04:31 INFO - 'NO_EM_RESTART': '1', 02:04:31 INFO - 'PAGER': '/bin/cat', 02:04:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:31 INFO - 'PWD': '/builds/slave/test', 02:04:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:04:31 INFO - 'SHELL': '/bin/bash', 02:04:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 02:04:31 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 02:04:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:04:31 INFO - 'USER': 'cltbld', 02:04:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:04:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:31 INFO - 'XPC_FLAGS': '0x0', 02:04:31 INFO - 'XPC_SERVICE_NAME': '0', 02:04:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:04:31 INFO - Cleaning up... 02:04:31 INFO - Return code: 0 02:04:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c084490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bffa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb730d97e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be98d30>, '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 0x10bcfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be90b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:04:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:04:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:04:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 02:04:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:04:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:04:31 INFO - 'HOME': '/Users/cltbld', 02:04:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:04:31 INFO - 'LOGNAME': 'cltbld', 02:04:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:31 INFO - 'MOZ_NO_REMOTE': '1', 02:04:31 INFO - 'NO_EM_RESTART': '1', 02:04:31 INFO - 'PAGER': '/bin/cat', 02:04:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:04:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:31 INFO - 'PWD': '/builds/slave/test', 02:04:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:04:31 INFO - 'SHELL': '/bin/bash', 02:04:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 02:04:31 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 02:04:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:04:31 INFO - 'USER': 'cltbld', 02:04:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:04:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:04:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:31 INFO - 'XPC_FLAGS': '0x0', 02:04:31 INFO - 'XPC_SERVICE_NAME': '0', 02:04:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:04:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:31 INFO - Downloading/unpacking blobuploader==1.2.4 02:04: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 02:04: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 02:04: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 02:04: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 02:04: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 02:04: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 02:04:34 INFO - Downloading blobuploader-1.2.4.tar.gz 02:04:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:04:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:04:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:04:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:04:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:04:35 INFO - Downloading docopt-0.6.1.tar.gz 02:04:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:04:35 INFO - Installing collected packages: blobuploader, requests, docopt 02:04:35 INFO - Running setup.py install for blobuploader 02:04:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:04:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:04:35 INFO - Running setup.py install for requests 02:04:35 INFO - Running setup.py install for docopt 02:04:36 INFO - Successfully installed blobuploader requests docopt 02:04:36 INFO - Cleaning up... 02:04:36 INFO - Return code: 0 02:04:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:04: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:36 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 0x10c084490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bffa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb730d97e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be98d30>, '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 0x10bcfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be90b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:04:36 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 02:04:36 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 02:04:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 02:04:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:04:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:04:36 INFO - 'HOME': '/Users/cltbld', 02:04:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:04:36 INFO - 'LOGNAME': 'cltbld', 02:04:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:36 INFO - 'MOZ_NO_REMOTE': '1', 02:04:36 INFO - 'NO_EM_RESTART': '1', 02:04:36 INFO - 'PAGER': '/bin/cat', 02:04:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:04:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:36 INFO - 'PWD': '/builds/slave/test', 02:04:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:04:36 INFO - 'SHELL': '/bin/bash', 02:04:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 02:04:36 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 02:04:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:04:36 INFO - 'USER': 'cltbld', 02:04:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:04:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:04:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:36 INFO - 'XPC_FLAGS': '0x0', 02:04:36 INFO - 'XPC_SERVICE_NAME': '0', 02:04:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:04:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:04:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Lde191-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:04:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-zffxuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:04:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Jb1POG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:04:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-XY9Odj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:04:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-RhJqdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:04:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:04:36 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-uNeXak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:04:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-vLMDvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:04:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-VLpfr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:04:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-ThePrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:04:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-83FP2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:04:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-QBIdAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:04:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-QHStIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:04:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-TeesQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:04:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-sPaVY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:04:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:04:37 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Sh0shA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:04:38 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-AmljUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:04:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:04:38 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-2_yGDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:04:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:04:38 INFO - Running setup.py install for manifestparser 02:04:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:04:38 INFO - Running setup.py install for mozcrash 02:04:38 INFO - Running setup.py install for mozdebug 02:04:38 INFO - Running setup.py install for mozdevice 02:04:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:04:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:04:38 INFO - Running setup.py install for mozfile 02:04:38 INFO - Running setup.py install for mozhttpd 02:04:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:04:39 INFO - Running setup.py install for mozinfo 02:04:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:04:39 INFO - Running setup.py install for mozInstall 02:04:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:04:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:04:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:04:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:04:39 INFO - Running setup.py install for mozleak 02:04:39 INFO - Running setup.py install for mozlog 02:04:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:04:39 INFO - Running setup.py install for moznetwork 02:04:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:04:39 INFO - Running setup.py install for mozprocess 02:04:40 INFO - Running setup.py install for mozprofile 02:04:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:04:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:04:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:04:40 INFO - Running setup.py install for mozrunner 02:04:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:04:40 INFO - Running setup.py install for mozscreenshot 02:04:40 INFO - Running setup.py install for moztest 02:04:40 INFO - Running setup.py install for mozversion 02:04:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:04:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:04:40 INFO - Cleaning up... 02:04:40 INFO - Return code: 0 02:04:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:40 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 0x10c084490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bffa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb730d97e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be98d30>, '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 0x10bcfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be90b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:04:40 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 02:04:40 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 02:04:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 02:04:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:04:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:04:40 INFO - 'HOME': '/Users/cltbld', 02:04:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:04:40 INFO - 'LOGNAME': 'cltbld', 02:04:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:40 INFO - 'MOZ_NO_REMOTE': '1', 02:04:40 INFO - 'NO_EM_RESTART': '1', 02:04:40 INFO - 'PAGER': '/bin/cat', 02:04:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:04:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:40 INFO - 'PWD': '/builds/slave/test', 02:04:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:04:40 INFO - 'SHELL': '/bin/bash', 02:04:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 02:04:40 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 02:04:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:04:40 INFO - 'USER': 'cltbld', 02:04:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:04:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:04:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:40 INFO - 'XPC_FLAGS': '0x0', 02:04:40 INFO - 'XPC_SERVICE_NAME': '0', 02:04:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:04:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:04:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-bPjS2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:04:41 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)) 02:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:04:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Kn6a4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:04:41 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)) 02:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:04:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-VGnTof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:04:41 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)) 02:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:04:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-JhO2xT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:04:41 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)) 02:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:04:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-3Zqsy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:04:41 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)) 02:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:04:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-weELpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:04:41 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)) 02:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:04:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Yf8QNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:04:41 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)) 02:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:04:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-sigZL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:04:41 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)) 02:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:04:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-OwN_13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:04:41 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)) 02:04:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:04:41 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-D0QaRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:04:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 02:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:04:42 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-3uHPfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:04:42 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)) 02:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:04:42 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-rIeeIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:04:42 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)) 02:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:04:42 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-IJKQBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:04:42 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)) 02:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:04:42 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-wT2Cgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:04:42 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)) 02:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:04:42 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-6ac497-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:04:42 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)) 02:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:04:42 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-RmIEfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:04:42 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)) 02:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:04:42 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-bQFy8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:04:42 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)) 02:04:42 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)) 02:04:42 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)) 02:04:42 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)) 02:04:42 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)) 02:04:42 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)) 02:04:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:04:42 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 02:04:42 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 02:04:42 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 02:04:42 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 02:04:42 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 02:04:42 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 02:04:45 INFO - Downloading blessings-1.6.tar.gz 02:04:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:04:45 INFO - Installing collected packages: blessings 02:04:45 INFO - Running setup.py install for blessings 02:04:45 INFO - Successfully installed blessings 02:04:45 INFO - Cleaning up... 02:04:45 INFO - Return code: 0 02:04:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:04:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:04:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:04:46 INFO - Reading from file tmpfile_stdout 02:04:46 INFO - Current package versions: 02:04:46 INFO - blessings == 1.6 02:04:46 INFO - blobuploader == 1.2.4 02:04:46 INFO - docopt == 0.6.1 02:04:46 INFO - functools32 == 3.2.3-2 02:04:46 INFO - jsonschema == 2.5.1 02:04:46 INFO - manifestparser == 1.1 02:04:46 INFO - mozInstall == 1.12 02:04:46 INFO - mozcrash == 0.17 02:04:46 INFO - mozdebug == 0.1 02:04:46 INFO - mozdevice == 0.48 02:04:46 INFO - mozfile == 1.2 02:04:46 INFO - mozhttpd == 0.7 02:04:46 INFO - mozinfo == 0.9 02:04:46 INFO - mozleak == 0.1 02:04:46 INFO - mozlog == 3.4 02:04:46 INFO - moznetwork == 0.27 02:04:46 INFO - mozprocess == 0.23 02:04:46 INFO - mozprofile == 0.28 02:04:46 INFO - mozrunner == 6.12 02:04:46 INFO - mozscreenshot == 0.1 02:04:46 INFO - mozsystemmonitor == 0.3 02:04:46 INFO - moztest == 0.7 02:04:46 INFO - mozversion == 1.4 02:04:46 INFO - psutil == 3.1.1 02:04:46 INFO - requests == 1.2.3 02:04:46 INFO - wsgiref == 0.1.2 02:04:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:46 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 0x10c084490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bffa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb730d97e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be98d30>, '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 0x10bcfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be90b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:04:46 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 02:04:46 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 02:04:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 02:04:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:04:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:04:46 INFO - 'HOME': '/Users/cltbld', 02:04:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:04:46 INFO - 'LOGNAME': 'cltbld', 02:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:46 INFO - 'MOZ_NO_REMOTE': '1', 02:04:46 INFO - 'NO_EM_RESTART': '1', 02:04:46 INFO - 'PAGER': '/bin/cat', 02:04:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:46 INFO - 'PWD': '/builds/slave/test', 02:04:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:04:46 INFO - 'SHELL': '/bin/bash', 02:04:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 02:04:46 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 02:04:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:04:46 INFO - 'USER': 'cltbld', 02:04:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:04:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:46 INFO - 'XPC_FLAGS': '0x0', 02:04:46 INFO - 'XPC_SERVICE_NAME': '0', 02:04:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:46 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)) 02:04:46 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)) 02:04:46 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)) 02:04:46 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)) 02:04:46 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)) 02:04:46 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)) 02:04:46 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)) 02:04:46 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)) 02:04:46 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)) 02:04:46 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)) 02:04:46 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)) 02:04:46 INFO - Cleaning up... 02:04:46 INFO - Return code: 0 02:04:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:04:46 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 0x10c084490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bffa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb730d97e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be98d30>, '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 0x10bcfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be90b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:04:46 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 02:04:46 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 02:04:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 02:04:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:04:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:04:46 INFO - 'HOME': '/Users/cltbld', 02:04:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:04:46 INFO - 'LOGNAME': 'cltbld', 02:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:04:46 INFO - 'MOZ_NO_REMOTE': '1', 02:04:46 INFO - 'NO_EM_RESTART': '1', 02:04:46 INFO - 'PAGER': '/bin/cat', 02:04:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:04:46 INFO - 'PWD': '/builds/slave/test', 02:04:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:04:46 INFO - 'SHELL': '/bin/bash', 02:04:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 02:04:46 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 02:04:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:04:46 INFO - 'USER': 'cltbld', 02:04:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:04:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:04:46 INFO - 'XPC_FLAGS': '0x0', 02:04:46 INFO - 'XPC_SERVICE_NAME': '0', 02:04:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:04:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:04:46 INFO - Cleaning up... 02:04:46 INFO - Return code: 0 02:04:46 INFO - Running post-action listener: _resource_record_post_action 02:04:46 INFO - Running post-action listener: _start_resource_monitoring 02:04:46 INFO - Starting resource monitoring. 02:04:46 INFO - [mozharness: 2016-10-31 09:04:46.602071Z] Finished create-virtualenv step (success) 02:04:46 INFO - [mozharness: 2016-10-31 09:04:46.602994Z] Running install step. 02:04:46 INFO - Running pre-action listener: _resource_record_pre_action 02:04:46 INFO - Running main action method: install 02:04:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:04:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:04:46 INFO - Reading from file tmpfile_stdout 02:04:46 INFO - Detecting whether we're running mozinstall >=1.0... 02:04:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:04:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:04:46 INFO - Reading from file tmpfile_stdout 02:04:46 INFO - Output received: 02:04:46 INFO - Usage: mozinstall [options] installer 02:04:46 INFO - Options: 02:04:46 INFO - -h, --help show this help message and exit 02:04:46 INFO - -d DEST, --destination=DEST 02:04:46 INFO - Directory to install application into. [default: 02:04:46 INFO - "/builds/slave/test"] 02:04:46 INFO - --app=APP Application being installed. [default: firefox] 02:04:46 INFO - mkdir: /builds/slave/test/build/application 02:04:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:04:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:05:19 INFO - Reading from file tmpfile_stdout 02:05:19 INFO - Output received: 02:05:19 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:05:19 INFO - Running post-action listener: _resource_record_post_action 02:05:19 INFO - [mozharness: 2016-10-31 09:05:19.034868Z] Finished install step (success) 02:05:19 INFO - [mozharness: 2016-10-31 09:05:19.035006Z] Running run-tests step. 02:05:19 INFO - Running pre-action listener: _resource_record_pre_action 02:05:19 INFO - Running main action method: run_tests 02:05:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:05:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:05:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:05:19 INFO - 2016-10-31 02:05:19.049 screenresolution[1645:8284] starting screenresolution argv=screenresolution get 02:05:19 INFO - 2016-10-31 02:05:19.052 screenresolution[1645:8284] Display 0: 1600x1200x32@60 02:05:19 INFO - 2016-10-31 02:05:19.058 screenresolution[1646:8286] starting screenresolution argv=screenresolution list 02:05:19 INFO - Available Modes on Display 0 02:05:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:05:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:05:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:05:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:05:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:05:19 INFO - Intel Iris: 02:05:19 INFO - Chipset Model: Intel Iris 02:05:19 INFO - Type: GPU 02:05:19 INFO - Bus: Built-In 02:05:19 INFO - VRAM (Dynamic, Max): 1536 MB 02:05:19 INFO - Vendor: Intel (0x8086) 02:05:19 INFO - Device ID: 0x0a2e 02:05:19 INFO - Revision ID: 0x0009 02:05:19 INFO - Displays: 02:05:19 INFO - Display: 02:05:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:05:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:05:19 INFO - Display Serial Number: 1600x1200 60 02:05:19 INFO - Main Display: Yes 02:05:19 INFO - Mirror: Off 02:05:19 INFO - Online: Yes 02:05:19 INFO - Rotation: Supported 02:05:19 INFO - Return code: 0 02:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:05:19 INFO - Python 2.7.3 02:05:19 INFO - Return code: 0 02:05:19 INFO - grabbing minidump binary from tooltool 02:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:19 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/macosx64/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 0x10be98d30>, '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 0x10bcfedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be90b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:05:19 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:05:19 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:05:19 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:05:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:05:19 INFO - Return code: 0 02:05:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:05:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:05:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:05:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:05:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--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 02:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0030 --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 02:05:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UEuSmBd7JV/Render', 02:05:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:05:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:05:19 INFO - 'HOME': '/Users/cltbld', 02:05:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:05:19 INFO - 'LOGNAME': 'cltbld', 02:05:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:05:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:19 INFO - 'MOZ_NO_REMOTE': '1', 02:05:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:05:19 INFO - 'NO_EM_RESTART': '1', 02:05:19 INFO - 'PAGER': '/bin/cat', 02:05:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:19 INFO - 'PWD': '/builds/slave/test', 02:05:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:05:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:05:19 INFO - 'SHELL': '/bin/bash', 02:05:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners', 02:05:19 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 02:05:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:05:19 INFO - 'USER': 'cltbld', 02:05:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:05:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:19 INFO - 'XPC_FLAGS': '0x0', 02:05:19 INFO - 'XPC_SERVICE_NAME': '0', 02:05:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:05:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--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 02:05:19 INFO - mozversion application_buildid: 20161031004002 02:05:19 INFO - mozversion application_changeset: b7070c905172e3ead8ee610fff35f86bf9ff9c42 02:05:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:05:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:05:19 INFO - mozversion application_name: Firefox 02:05:19 INFO - mozversion application_remotingname: firefox-dev 02:05:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:05:19 INFO - mozversion application_vendor: Mozilla 02:05:19 INFO - mozversion application_version: 51.0a2 02:05:19 INFO - mozversion platform_buildid: 20161031004002 02:05:19 INFO - mozversion platform_changeset: b7070c905172e3ead8ee610fff35f86bf9ff9c42 02:05:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:05:19 INFO - mozversion platform_version: 51.0a2 02:05:19 INFO - using testdate: 1477904719 02:05:19 INFO - actual date: 1477904719 02:05:19 INFO - starting webserver on 'localhost:49272' 02:05:19 INFO - SUITE-START | Running 2 tests 02:05:19 INFO - TEST-START | dromaeo_css 02:05:19 INFO - operating with platform_type : mac_ 02:05:19 INFO - Initialising browser for dromaeo_css test... 02:05:19 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpPqhUyX/profile http://localhost:49272/getInfo.html) 02:05:22 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 02:05:22 INFO - PROCESS | 1656 | colorDepth:24 02:05:22 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 02:05:22 INFO - PROCESS | 1656 | __metrics 02:05:22 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 02:05:23 INFO - TEST-INFO | 1656: exit 0 02:05:23 INFO - Browser initialized. 02:05:23 INFO - Running cycle 1/1 for dromaeo_css test... 02:05:23 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpPqhUyX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:05:35 INFO - PROCESS | 1661 | RSS: Main: 225513472 02:05:35 INFO - PROCESS | 1661 | 02:06:24 INFO - PROCESS | 1661 | 1477904784705 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] 02:08:37 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 02:08:38 INFO - PROCESS | 1661 | RSS: Main: 236793856 02:08:38 INFO - PROCESS | 1661 | 02:11:40 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 02:11:41 INFO - PROCESS | 1661 | RSS: Main: 246779904 02:11:41 INFO - PROCESS | 1661 | 02:14:43 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 02:14:44 INFO - PROCESS | 1661 | RSS: Main: 251219968 02:14:44 INFO - PROCESS | 1661 | 02:17:46 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 02:17:46 INFO - PROCESS | 1661 | RSS: Main: 251486208 02:17:46 INFO - PROCESS | 1661 | 02:20:49 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 02:20:50 INFO - PROCESS | 1661 | RSS: Main: 256131072 02:20:50 INFO - PROCESS | 1661 | 02:23:52 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 02:23:53 INFO - PROCESS | 1661 | RSS: Main: 257748992 02:23:53 INFO - PROCESS | 1661 | 02:23:53 INFO - PROCESS | 1661 | __start_tp_report 02:23:53 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 02:23:53 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 02:23:53 INFO - PROCESS | 1661 | |i|pagename|runs| 02:23:53 INFO - PROCESS | 1661 | |0;dojo.html;3483.0769845990817;3485.651434856514;3498.685118339349;3503.737219708519;3511.4732790081503;5958.940410595898;6015.939840601593;6024.849378765533;6049.848753781158;6065.575409721321;5961.552883533731;5982.581219314649;6038.516918646509;6051.878962420749;6073.271207455112;4500.909981800362;5422.728863556817;5470.042742520043;5475.917861232085;5542.7782888684405;4311.827526898936;5468.644538105031;5490.149026900836;5501.367342755594;5510.980468613299;5364.329458817648;5381.704006279653;5495.587830912677;5510.5316048135755;5540.861478463051;5353.839384818442;5369.6509726867625;5392.541633961118;5446.863828404282;5473.890522189574;5259.316288882459;5351.143816989263;5357.651752636105;5381.354237491487;5392.73036348181;5785.218995435646;5876.4123587641325;5903.055511118243;5955.761769529214;6021.1269365942135;5447.536959358459;6154.907676384858;6196.008638617799;6276.905846412307;6295.968520157416;6301.905471417932;6306.621602703853;6311.905321420182;6372.553921225516;6375.521835862329;6071.726772295257;6073.058675905242;6087.086936959403;6089.238845144357;6102.786402475892;6356.904646430215;6371.74513019474;6414.166158399378;6473.611583305017;6516.120323756232;6199.56603037783;6285.151504546919;6294.779682711083;6301.149344838388;6308.369163083655;5312.096943519611;6242.282137554149;6272.968635156795;6341.714622841983;6354.3645635437015;6236.844078897973;6243.344448832807;6263.185785847811;6299;6303.747850085945;6220.471259942956;6283.3088360280335;6285.654289014148;6287.465565426898;6301.4328710416285;4942.728149951788;5099.286099946011;5116.999999999925;5122.257272695513;5138.794448222029;4248.256555102845;4353.564643535685;4438.201123797748;4464.017916058462;4476.6418686505;4819.49395313494;5223.746300887759;5825.126231065289;6020.608660437058;6091.329953705089;6324.588901721373;6329.113924050636;6363.3636636336;6363.61818290904;6373.936260637427;5985.760569577168;6050.183225264621;6059.424354686298;6101.633901965896;6107.61364822091;5235.947640523622;5290.412876137143;5593.860153496195;5624.465675760796;5626.156076588462;6500.642464664489;6603.7688680895935;6623.536352455282;6646.102776125162;6659;6206.224221972254;6210.813675589739;6238.906416403667;6265.248170219603;6424.164858568356;6360.618362898241;6435.485161187187;6436.356364363526;6462.256840463407;6480.027995800668;6279.654618995816;6288;6291.402316779899;6297.716602752978;6314.116023756769;5940.554458415722;6222.439980401786;6254.124422580933;6277.686115694289;6285.214348206474;6100.328963814066;6198.938010619836;6201.0388389799655;6281.780137695158;6292.244930608356;6243.96878015607;6253.937460625336;6258.530610204344;6287.685615719104;6299.401556852092;6020.578559500968;6056.212692349966;6110.969445152746;6118.847028824315;6249.375062493714;6208.161898143693;6229.190205273286;6254.155688981929;6284.465820405317;6294.213223347082;6192.3807619239515;6192.535559833121;6247.531435142473;6251.468625166912;6259 02:23:53 INFO - PROCESS | 1661 | |1;ext.html;485.0662474736132;505.929958138537;510.61448606302224;512.5822454699418;533.1549494051927;41193;43205.78397108018;43254.783726081325;43294.56705432945;43371.34942975858;43223.78388108055;44178;44600.553994460046;44657.330140047925;44746;9891.802163956734;9972.451515166664;10035.197184225244;10044.995500449933;10085.64700235492;9960.804703435599;10003.249756268273;10004.449755263458;10105.191584673245;10127.797444051115;7858.882116768253;9591.856122158173;10071.04325089119;10083.49582520871;10118.342307749972;8451.492910425333;8460;10052.195824334036;10056.849147262797;10064.798704025952;9959.701208963743;9964.05341492557;9987.151092157175;10020;10022.047905448972;34627.4805877912;41071.94640268005;41689.58310416887;42096.36855447171;42104.57895421068;3392.23674673199;3580.5882323532605;3587.856485740567;3857.4213867920034;4018.839246430139;28042.719572804213;30028.8498557508;30192;30301;32082.71669133232;3141.54447605096;3288.3423315337027;3305.1241421023446;3340.983295083509;3391.643877392863;438466;523091;525800;527205.3639731815;528299;32998.010059698245;33885;64285.35714642887;64776.35223647703;64842;34617.48073778895;35424.82287588597;35632.28735425329;35933;35995;15407.614809629626;15548.76676849848;15604.45384411563;15612.921935390477;15633.687326253412;13199.868001320056;13200.009999250095;13284.667883302802;13318.067735258634;13338.066335356432;7762.107357653942;7782.338501227459;7795.727149549852;7819.452638315263;7859.960700196462;3229.7739158258696;3256.0882952772786;3256.1208473711963;3263.233140212048;3286.6384697683234;842.4818736477145;923.6720964057663;998.3128512813322;1030.2736570717625;1106.3251416635846;30454;30837.69162308393;30967.690323096933;31005.379892402027;31015;1016.6899095775711;1069.1500257295468;1092.9344239345664;1140.4867809485766;1158.1082566423806;13876.098053626683;14091.36588853504;16424.83575164257;16570;16837.242324095445;538882;674468;688398;694223;697430;59342.406575934554;59922.70038649779;59968.70015649981;59977;60145.699271504236;1369.5412036967728;1382.0809161907218;1392.9721405572034;1393.3526300030023;1398.853120422341;30794;31115.53326700056;32139.357212855146;32355.029349119563;32663;43734.56265437305;52121.218181726545;52338.95322093613;52664.73667631637;52725.94548109093;586048;613241;615523;616881;618300.9084954547;27054.594181086904;27227.86386068057;27473.86263068672;27541.31146721268;27604.723952761018;48108.27837582509;49100;49570.760730982016;49708;49754;40224.19551608893;40846.36614535385;40891.795541022104;41020.79489602652;42305;40445;40674.98312542092;41199;41783.1643367137;42022.78988605038;38409.615903840604;38435.80782096072;38632.42051369175;38703.03242418962;39169.60830391774;27336.453270934868;33958;34793.826030870696;35281.294374112884;35784.284314313045;24876.37809054788;26449;26460.470790583695;26561.867190663925;27001.594976074983 02:23:53 INFO - PROCESS | 1661 | |2;jquery.html;322.98385080745965;371.81595110420335;376.1874351400974;380.3439067608374;400.89753178758417;19395.515112122204;19831.603367932632;20984.845833479172;21083.789162108373;21127.366179014654;20257.49356266094;20389.898050509764;20456.284030058952;20781.584368312626;20823.375298741063;5949.25634295713;5981.132735753313;6115.174451449064;6146.108814221935;6234.968825155868;5235.607329450288;6070.089486577004;6172.691365431733;6177.196964394622;6179.3202747697715;6107.877842443148;6117.44942955134;6457.096006559085;6786.219584747768;6823.454123670119;6556.442702370305;6754.493412994045;6787.626680532569;6821.69302381394;6865.416439602614;5974.761009559613;6018.217631707894;6026.3672314406795;6033.577649564532;6039.1545183674325;12840.972722182296;12945.158564693358;13055.477780888754;13306.401211945486;13328.466861325536;2072.554400803819;2210.5689390568846;2255.4135924659545;2432.3067925641285;2914.7522460590876;8725;9574.606348412897;9696.224302055889;10115.140213081897;10525.157987360994;1854.2026928420773;1854.2675643121026;1860.125740901774;1889.896055716935;1904.990475047616;100668.9933100667;117818.41090794577;122406.77593224043;123938;127412;11423.600173993871;11737;11742.354170520703;11786.110583507421;11940.88059119415;14331.641708957359;14506.709865802624;14626.853731462763;14773.704525909636;14798.704025919422;8706.085860984633;8738.30093592511;8743.387962842668;8801.515916624647;8897.73306800797;6440;7228.56628602275;7849.372050235967;8807.735767926972;8843.955780221058;3686.56768006952;4456.9331460028125;4554.134714404253;4581.175388430114;4605.240135377625;1454.549089782171;1783.509534877919;1822.48059303098;1835.3851459761129;1849.9537511562319;898.5462341517623;927.2535608834818;942.2038377570941;952.3333666433524;1043.2853495355705;16884.409045683344;17408.65182696339;18127.637447251243;21040.053197606143;21973;739.840934199139;835.2900034970227;900.145699858294;954.3128947158035;1013.7009582173276;10938.453077346101;11067.833982490269;11575.710607234718;11976.58081967127;11987.460564274628;594959.0252048798;605916;651423;663427;665786;126074.3696281531;126294;128952.35523822322;132964;136191;1012.9392236465835;1013.4628646817346;1053.1837825685154;1054.1566746602687;1057.1120258982492;19416.320428784926;19503;19609.31367402134;19801.504962376057;20127.094280757694;39677.60322396739;45805.54194458146;49311.506884932125;53314.60084296294;57811.421885780604;69766;74253.62873185599;83793.16206838097;87211.56394217988;87732.68400973863;6493.902591461227;8110.918890811253;8163.510189388656;8352.87470687928;8430.536320502431;7775.688972441039;12990.805137922749;13031.869681303066;13090.869091308965;13252.602421927357;10932.836007460053;11309.434528273388;11349.092072634005;11542.13433992437;11584.94207528957;9525.190358819578;10498.422586757802;10798.298110622783;11166;11592.420378981185;9101.590428430603;10513.89486105129;11361;11391.430428478709;11730.824037639271;6087.36082711309;8045.9597702011115;8315.501069935823;8369.076263207391;8395.580220989048;9581.904180958101;10439.269251152651;10707.464626768475;11141.498632561716;11459.770804583695 02:23:53 INFO - PROCESS | 1661 | |3;mootools.html;1402.7054318593096;1516.2570340533139;1623.5454072859604;1725.5341057914363;1875.1468082022682;7958.124606293303;8204.05653349865;8485.406021578485;8997.955010224949;9011.18899299063;7103.112110986127;8420.494770313786;8722.781930451742;8725.563721813916;8815.51514666693;1804.5308219862864;1973.2994786850677;2017.6469117904383;2383.1420688552107;2386.761323867608;2354.19957214547;2356.45801465663;2381.023780250098;2389.602082781566;2400.423898264413;1988.9005549722528;2322.535492901418;2374.287713685896;2385.5586716457424;2404.206611818096;2344.777246161612;2348.049040138738;2360.7285162206394;2363.751806060356;2394.437307232799;2319.501307218939;2354.764523547649;2358.7641235876445;2367.6093444581625;2374.7625237476286;8695.39132260742;8751.956240218822;8791.604377803014;8904.421212621159;8922.375433719642;5221.791128354899;5337.946620533784;5392.649477783932;5395.676259424408;5400.648957817729;3559.893203203908;3595.7303202259673;3734.495843061179;3756.530433695788;3756.549214094326;1071.6195750508534;1099.2470157941837;1109.3011402816173;1110.9111271098293;1132.9376884271362;11353.20527563071;11448.542058317656;11552.942235288854;11595.130365222558;11632.302061876399;4208.873733787991;4561.475430325489;4652.790624421909;4833.951660483421;4838;9601.183899368492;9769.316147869724;9923.900760992297;9936.900630993598;9946.254030947708;5336.17289320156;5357.223202635596;5360.892782144413;5376.7580458878665;5381.569474442035;4378.605925466723;4565.977170114194;4877.5366340197625;4898.804047838046;4903.092927808367;3277.7869438486423;3953.743006704555;4015.3976903464713;4057.9391309130388;4069.145479449349;1123.8538989931258;1304.8629893861198;1311.4491913396396;1319.7228581997697;1324.5033112582782;765.2309429023907;800.335721351277;862.2283056664251;863.8056437301557;931.9207867331353;5552.666839989613;5768.163616275617;5859.179714839841;6140.508759299245;6144.662043587557;970.6556419359239;992.553350992042;1037.0355569320604;1049.2655141401049;1073.3309703411114;3927.0771368728324;4001.199760048002;4089.5705950875326;4107.301758700968;4141.689373297015;10707.250492465453;10804.24370294072;10815.080718139046;10857.131429485622;10864.293820901616;10653.360798352123;10686.25196236256;10785.892141078646;10800.405977671304;10813;8080.515169089874;8082.636281367352;8090.878636820453;8094.878576821352;8231.382646301552;4924.9507504924495;5506.2291279221745;5737.540996720169;5897.941020589911;6058.091286307089;9839;9845.901540984785;9883.456409897524;9932.255080869108;9956.900430995887;9819.852702209615;10037.799244015225;10100.84848727255;10310;10349.741256468347;6988.965055174895;7094.503384763017;7183.604901730246;7287.927120728937;7378.889316660147;8309.542975136426;8403.453775504817;8430.789230269293;8517;8533.957330213309;7414.073240844895;7513.39892808585;7524.209957954336;7550.791873300245;7637.5799331035105;7393;7396.260373962561;7405.111386633638;7414.369778568882;7518.323350898446;6420.133282006869;6565.737370505126;6967.686454109476;7026.648667566499;7133.179684336368;4407.272799987966;5014.57376123019;5023.949760502348;5096.719680417613;5177.870553236199;4360.563943605614;4406.317020861771;5028.823991160438;5065.620078494054;5079.136546787129 02:23:53 INFO - PROCESS | 1661 | |4;prototype.html;266.629385154635;268.40682092575406;296.34359892837375;313.13886811269003;314.64602322387316;4353.86938391848;5531.612787104904;5548.611597188194;5594.412586678402;5648.519875810551;4545.159210519737;5169.043726910524;5221.477852214786;5504.80733174339;5529.391766905647;4224.493060832704;4225.598568136023;4232.9788351058205;4240.257954857888;4262.211490874182;3054.602901622786;4151.294279972397;4259.488861336628;4262.97868510657;4273.764942928137;3756;4117.402976568395;4153.667706583481;4164.937525937114;4185.937210941838;3701.3522633539023;4128.401381799637;4144.585541445861;4147.294959856801;4158.542560318362;2991.925201869949;3598.2803439312243;3614.6385361463645;3622;3628.1836586767768;4440.267355886275;5070.416902056237;5274.5780337572905;5430.3755068167275;5484.91772623411;4736.739479328636;4750.263709125056;4757.357756702835;4764.95235047652;4774.188387974018;4841.685290456145;5841.3282472515775;5857.941420585782;5861.3552509223955;5904.586678932476;3703.2594680500124;3858.479105320802;3901.395283731026;3929.2141571685493;3959.78221197834;5130.9743451282875;5160.458151894072;6104.511639068908;6139.2325959255095;6223.719932603044;3806.54321481424;3864.7874366909527;4005.178938317638;4012.2176175646055;4013.6387725104883;3331.017349881742;3568.8215589220954;3937.0551067743536;4057.350823868167;4165.66674666026;4193;4795.232762757942;4818.229083346648;4833.637477189225;4868.245421959602;4894.951050489521;5105.060077170651;5916.49709774674;5938.376470470625;6017.277926648742;1343.4290426568864;1394.0172178614052;1396.882494004792;1415.7380884536394;1427.7144571085823;821.9725343320849;940.6801687426308;977.9364341317792;980.5587485631495;980.5783513089298;4754.9286760698615;5373.167159090347;5432.017313680478;5450.700211488406;5489.807856724996;5995.280566332068;6007.468095635585;6015.097735339734;6045.6699526104185;6048.788292409745;5204.9219261711105;5369.5167434931045;5400.027994960867;5424.419882877282;5464.754086066137;2367.644853272023;2373.6588827312858;2584.6898372195456;2612.8562929038703;2629.44781595867;4641.791119399568;4701.506341834127;5168.405633352213;5250.343707036621;5298.28473156119;4031.173609410064;4317.352397140454;4471.977640111779;4827.831025914076;4921.114199444134;4439.800208990603;4636.721796692074;4707.223308154116;5238.8166414176085;5286.88524590167;4311.288637374798;4334.826606935687;4654.790534425892;4867;5040.722760248222;4275.722078064916;4433.645308375387;4674.270519907656;4967.577755890645;4988.977259661833;4615.353850460871;4721.905561888674;5154.304168937296;5267.577754006474;5273.442380445557;3329.250918543308;3463.4977928199764;3580.1944562473236;3633.2551826874897;3635.6727894489622;3541.911452213715;4737.839229388822;4793.376861008047;4950.529699678525;5018.5232402921665;4003.8798836034966;4816.735079570657;4831.541003604652;4845.41854977405;4858.392700912386;4342.630876375543;4516.458025037016;4856.757162141808;4875.416029504368;4876.926846097241;4275.451375358507;4683.882902927317;4730.533534604284;4742.834000809955;4788.252287914956;4803.663743538059;4848.763565290828;4859.7327147005835;4872.637879862883;4896.531040687851;4140.923359926501;4523.457185137804;4551.38556294896;4653.744044077473;4781.593564547053 02:23:53 INFO - PROCESS | 1661 | |5;yui.html;600.4805842945851;706.8515611721538;773.7678696391081;783.4398405140323;807.0638059850575;15280.69438611227;15438.61403464914;15692.686146277068;15886.602834929146;15932.123733194685;14254.857451425509;14303.499377521788;14349;14374.06568573042;14398.352074156663;668.6556423441943;694.271015433795;829.7386323308169;857.67408384814;872.2629378175463;812.1147948735877;813.1137060603941;842.7766641839887;855.8031652719878;863.2101627011277;853.5433543054467;896.668232753882;901.6303315640589;902.8916530016407;904.0823564082461;864.0624921959682;873.7902903303193;886.7916039730658;904.1139683110556;904.4708845325492;589.6555852655952;659.1760299625469;676.3304328714586;676.8307923019245;681.1621705302506;12430.440630171664;12457.75084498305;14790.334434950453;14902.70194596102;14975.026623269561;12064.457099430547;14446.494372696905;14613.269336533238;14635.487757928528;14888.404463821542;11363.943180284128;11542.249753765978;11694.006009489203;11988;12100.576479823163;3657.719798070654;3721.497597824286;3752.4934133891848;3822.7706337619834;3835.5397352317623;114758;114913;116495;119881;121292;9454.621815127455;10602.674665666791;11113.722156946142;11129.72175695598;11251.718707032225;23071.423214419774;23079.19222827193;23313.650295245585;23358.416039599146;23591.528169436515;6960.199577048603;6961.512694111364;7044.260352662999;7063.223045464994;7142;4259.701820872571;4278.507971583245;4279.636230920344;4355.934660980088;4384.956150438518;3617.04148400674;3702.9444558331647;3733.4026555750947;3744.307303148926;3744.625537446288;571.2830397850671;648.1541588227315;658.9226614485256;659.1003280522053;659.1529884099006;606.087837804102;631.3150231998242;642.4410762636536;663.2969052804043;675.7026908160492;9523.238140948708;9634.075043848123;9681.66114186;9696.660616878375;9754.92695803461;651.7616528595612;657.1949362031569;669.695288643666;670.2386365883062;694.9617771022643;4298.785060747013;4362.476502819682;4528.547145285511;4649.395578574764;4664.113818374498;112494;115446;121096;123140;176952.23047769614;119879;136450;143539.54072066574;145482.99999999788;152768;117688.41155794167;124155;129584;132315;133690.33154834164;7671.38628909697;8529.573521324033;8958.507282099547;8989.325800565115;9018.368714189945;67787.66106169438;69300.65349673422;70158.64920675365;70372;73471.26528734858;77294;96423.51788241015;98901;99227;101573;11949.283043017447;12092.939535302266;12103.576374826838;12160.270383777002;12327.198732082745;12311.876881231074;12340.876591233973;12822.294773787531;12936.482540698267;12986.155899866479;12183.390830458264;13613.31933403306;14071;14522.49171279;14869.851301487279;13381.799273010718;14281.928590356982;14341.35463904106;14404.495842645458;14840.62898427548;12441.315727635067;13397.799033014708;13502.25737584403;13661.385237664528;13780.448782048607;10488.580456781643;10598.841017384591;10683.358998459806;10949.781004380027;11871.643850684493;8556.401051926305;11711.238769479956;11814.527418903148;11985.801419857944;12006.819897701716 02:23:53 INFO - PROCESS | 1661 | __end_tp_report 02:23:53 INFO - PROCESS | 1661 | __start_cc_report 02:23:53 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,361 02:23:53 INFO - PROCESS | 1661 | __end_cc_report 02:23:53 INFO - PROCESS | 1661 | __startTimestamp1477905833110__endTimestamp 02:23:53 INFO - PROCESS | 1661 | 02:23:53 INFO - PROCESS | 1661 | ------- Summary: start ------- 02:23:53 INFO - PROCESS | 1661 | Number of tests: 6 02:23:53 INFO - PROCESS | 1661 | 02:23:53 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5875.45 Median:6118.85 stddev:663.01 (10.8%) stddev-sans-first:637.93 02:23:53 INFO - PROCESS | 1661 | Values: 3483.1 3485.7 3498.7 3503.7 3511.5 5958.9 6015.9 6024.8 6049.8 6065.6 5961.6 5982.6 6038.5 6051.9 6073.3 4500.9 5422.7 5470.0 5475.9 5542.8 4311.8 5468.6 5490.1 5501.4 5511.0 5364.3 5381.7 5495.6 5510.5 5540.9 5353.8 5369.7 5392.5 5446.9 5473.9 5259.3 5351.1 5357.7 5381.4 5392.7 5785.2 5876.4 5903.1 5955.8 6021.1 5447.5 6154.9 6196.0 6276.9 6296.0 6301.9 6306.6 6311.9 6372.6 6375.5 6071.7 6073.1 6087.1 6089.2 6102.8 6356.9 6371.7 6414.2 6473.6 6516.1 6199.6 6285.2 6294.8 6301.1 6308.4 5312.1 6242.3 6273.0 6341.7 6354.4 6236.8 6243.3 6263.2 6299.0 6303.7 6220.5 6283.3 6285.7 6287.5 6301.4 4942.7 5099.3 5117.0 5122.3 5138.8 4248.3 4353.6 4438.2 4464.0 4476.6 4819.5 5223.7 5825.1 6020.6 6091.3 6324.6 6329.1 6363.4 6363.6 6373.9 5985.8 6050.2 6059.4 6101.6 6107.6 5235.9 5290.4 5593.9 5624.5 5626.2 6500.6 6603.8 6623.5 6646.1 6659.0 6206.2 6210.8 6238.9 6265.2 6424.2 6360.6 6435.5 6436.4 6462.3 6480.0 6279.7 6288.0 6291.4 6297.7 6314.1 5940.6 6222.4 6254.1 6277.7 6285.2 6100.3 6198.9 6201.0 6281.8 6292.2 6244.0 6253.9 6258.5 6287.7 6299.4 6020.6 6056.2 6111.0 6118.8 6249.4 6208.2 6229.2 6254.2 6284.5 6294.2 6192.4 6192.5 6247.5 6251.5 6259.0 02:23:53 INFO - PROCESS | 1661 | 02:23:53 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:71346.26 Median:19760.43 stddev:159974.91 (809.6%) stddev-sans-first:160335.21 02:23:53 INFO - PROCESS | 1661 | Values: 485.1 505.9 510.6 512.6 533.2 41193.0 43205.8 43254.8 43294.6 43371.3 43223.8 44178.0 44600.6 44657.3 44746.0 9891.8 9972.5 10035.2 10045.0 10085.6 9960.8 10003.2 10004.4 10105.2 10127.8 7858.9 9591.9 10071.0 10083.5 10118.3 8451.5 8460.0 10052.2 10056.8 10064.8 9959.7 9964.1 9987.2 10020.0 10022.0 34627.5 41071.9 41689.6 42096.4 42104.6 3392.2 3580.6 3587.9 3857.4 4018.8 28042.7 30028.8 30192.0 30301.0 32082.7 3141.5 3288.3 3305.1 3341.0 3391.6 438466.0 523091.0 525800.0 527205.4 528299.0 32998.0 33885.0 64285.4 64776.4 64842.0 34617.5 35424.8 35632.3 35933.0 35995.0 15407.6 15548.8 15604.5 15612.9 15633.7 13199.9 13200.0 13284.7 13318.1 13338.1 7762.1 7782.3 7795.7 7819.5 7860.0 3229.8 3256.1 3256.1 3263.2 3286.6 842.5 923.7 998.3 1030.3 1106.3 30454.0 30837.7 30967.7 31005.4 31015.0 1016.7 1069.2 1092.9 1140.5 1158.1 13876.1 14091.4 16424.8 16570.0 16837.2 538882.0 674468.0 688398.0 694223.0 697430.0 59342.4 59922.7 59968.7 59977.0 60145.7 1369.5 1382.1 1393.0 1393.4 1398.9 30794.0 31115.5 32139.4 32355.0 32663.0 43734.6 52121.2 52339.0 52664.7 52725.9 586048.0 613241.0 615523.0 616881.0 618300.9 27054.6 27227.9 27473.9 27541.3 27604.7 48108.3 49100.0 49570.8 49708.0 49754.0 40224.2 40846.4 40891.8 41020.8 42305.0 40445.0 40675.0 41199.0 41783.2 42022.8 38409.6 38435.8 38632.4 38703.0 39169.6 27336.5 33958.0 34793.8 35281.3 35784.3 24876.4 26449.0 26460.5 26561.9 27001.6 02:23:53 INFO - PROCESS | 1661 | 02:23:53 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:35775.05 Median:12091.78 stddev:106128.71 (877.7%) stddev-sans-first:106393.04 02:23:53 INFO - PROCESS | 1661 | Values: 323.0 371.8 376.2 380.3 400.9 19395.5 19831.6 20984.8 21083.8 21127.4 20257.5 20389.9 20456.3 20781.6 20823.4 5949.3 5981.1 6115.2 6146.1 6235.0 5235.6 6070.1 6172.7 6177.2 6179.3 6107.9 6117.4 6457.1 6786.2 6823.5 6556.4 6754.5 6787.6 6821.7 6865.4 5974.8 6018.2 6026.4 6033.6 6039.2 12841.0 12945.2 13055.5 13306.4 13328.5 2072.6 2210.6 2255.4 2432.3 2914.8 8725.0 9574.6 9696.2 10115.1 10525.2 1854.2 1854.3 1860.1 1889.9 1905.0 100669.0 117818.4 122406.8 123938.0 127412.0 11423.6 11737.0 11742.4 11786.1 11940.9 14331.6 14506.7 14626.9 14773.7 14798.7 8706.1 8738.3 8743.4 8801.5 8897.7 6440.0 7228.6 7849.4 8807.7 8844.0 3686.6 4456.9 4554.1 4581.2 4605.2 1454.5 1783.5 1822.5 1835.4 1850.0 898.5 927.3 942.2 952.3 1043.3 16884.4 17408.7 18127.6 21040.1 21973.0 739.8 835.3 900.1 954.3 1013.7 10938.5 11067.8 11575.7 11976.6 11987.5 594959.0 605916.0 651423.0 663427.0 665786.0 126074.4 126294.0 128952.4 132964.0 136191.0 1012.9 1013.5 1053.2 1054.2 1057.1 19416.3 19503.0 19609.3 19801.5 20127.1 39677.6 45805.5 49311.5 53314.6 57811.4 69766.0 74253.6 83793.2 87211.6 87732.7 6493.9 8110.9 8163.5 8352.9 8430.5 7775.7 12990.8 13031.9 13090.9 13252.6 10932.8 11309.4 11349.1 11542.1 11584.9 9525.2 10498.4 10798.3 11166.0 11592.4 9101.6 10513.9 11361.0 11391.4 11730.8 6087.4 8046.0 8315.5 8369.1 8395.6 9581.9 10439.3 10707.5 11141.5 11459.8 02:23:53 INFO - PROCESS | 1661 | 02:23:53 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5678.91 Median:4969.76 stddev:3186.44 (64.1%) stddev-sans-first:3179.17 02:23:53 INFO - PROCESS | 1661 | Values: 1402.7 1516.3 1623.5 1725.5 1875.1 7958.1 8204.1 8485.4 8998.0 9011.2 7103.1 8420.5 8722.8 8725.6 8815.5 1804.5 1973.3 2017.6 2383.1 2386.8 2354.2 2356.5 2381.0 2389.6 2400.4 1988.9 2322.5 2374.3 2385.6 2404.2 2344.8 2348.0 2360.7 2363.8 2394.4 2319.5 2354.8 2358.8 2367.6 2374.8 8695.4 8752.0 8791.6 8904.4 8922.4 5221.8 5337.9 5392.6 5395.7 5400.6 3559.9 3595.7 3734.5 3756.5 3756.5 1071.6 1099.2 1109.3 1110.9 1132.9 11353.2 11448.5 11552.9 11595.1 11632.3 4208.9 4561.5 4652.8 4834.0 4838.0 9601.2 9769.3 9923.9 9936.9 9946.3 5336.2 5357.2 5360.9 5376.8 5381.6 4378.6 4566.0 4877.5 4898.8 4903.1 3277.8 3953.7 4015.4 4057.9 4069.1 1123.9 1304.9 1311.4 1319.7 1324.5 765.2 800.3 862.2 863.8 931.9 5552.7 5768.2 5859.2 6140.5 6144.7 970.7 992.6 1037.0 1049.3 1073.3 3927.1 4001.2 4089.6 4107.3 4141.7 10707.3 10804.2 10815.1 10857.1 10864.3 10653.4 10686.3 10785.9 10800.4 10813.0 8080.5 8082.6 8090.9 8094.9 8231.4 4925.0 5506.2 5737.5 5897.9 6058.1 9839.0 9845.9 9883.5 9932.3 9956.9 9819.9 10037.8 10100.8 10310.0 10349.7 6989.0 7094.5 7183.6 7287.9 7378.9 8309.5 8403.5 8430.8 8517.0 8534.0 7414.1 7513.4 7524.2 7550.8 7637.6 7393.0 7396.3 7405.1 7414.4 7518.3 6420.1 6565.7 6967.7 7026.6 7133.2 4407.3 5014.6 5023.9 5096.7 5177.9 4360.6 4406.3 5028.8 5065.6 5079.1 02:23:53 INFO - PROCESS | 1661 | 02:23:53 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4324.21 Median:4733.64 stddev:1294.37 (27.3%) stddev-sans-first:1261.66 02:23:53 INFO - PROCESS | 1661 | Values: 266.6 268.4 296.3 313.1 314.6 4353.9 5531.6 5548.6 5594.4 5648.5 4545.2 5169.0 5221.5 5504.8 5529.4 4224.5 4225.6 4233.0 4240.3 4262.2 3054.6 4151.3 4259.5 4263.0 4273.8 3756.0 4117.4 4153.7 4164.9 4185.9 3701.4 4128.4 4144.6 4147.3 4158.5 2991.9 3598.3 3614.6 3622.0 3628.2 4440.3 5070.4 5274.6 5430.4 5484.9 4736.7 4750.3 4757.4 4765.0 4774.2 4841.7 5841.3 5857.9 5861.4 5904.6 3703.3 3858.5 3901.4 3929.2 3959.8 5131.0 5160.5 6104.5 6139.2 6223.7 3806.5 3864.8 4005.2 4012.2 4013.6 3331.0 3568.8 3937.1 4057.4 4165.7 4193.0 4795.2 4818.2 4833.6 4868.2 4895.0 5105.1 5916.5 5938.4 6017.3 1343.4 1394.0 1396.9 1415.7 1427.7 822.0 940.7 977.9 980.6 980.6 4754.9 5373.2 5432.0 5450.7 5489.8 5995.3 6007.5 6015.1 6045.7 6048.8 5204.9 5369.5 5400.0 5424.4 5464.8 2367.6 2373.7 2584.7 2612.9 2629.4 4641.8 4701.5 5168.4 5250.3 5298.3 4031.2 4317.4 4472.0 4827.8 4921.1 4439.8 4636.7 4707.2 5238.8 5286.9 4311.3 4334.8 4654.8 4867.0 5040.7 4275.7 4433.6 4674.3 4967.6 4989.0 4615.4 4721.9 5154.3 5267.6 5273.4 3329.3 3463.5 3580.2 3633.3 3635.7 3541.9 4737.8 4793.4 4950.5 5018.5 4003.9 4816.7 4831.5 4845.4 4858.4 4342.6 4516.5 4856.8 4875.4 4876.9 4275.5 4683.9 4730.5 4742.8 4788.3 4803.7 4848.8 4859.7 4872.6 4896.5 4140.9 4523.5 4551.4 4653.7 4781.6 02:23:53 INFO - PROCESS | 1661 | 02:23:53 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:25550.16 Median:3680.33 stddev:41167.82 (1118.6%) stddev-sans-first:41240.68 02:23:53 INFO - PROCESS | 1661 | Values: 600.5 706.9 773.8 783.4 807.1 15280.7 15438.6 15692.7 15886.6 15932.1 14254.9 14303.5 14349.0 14374.1 14398.4 668.7 694.3 829.7 857.7 872.3 812.1 813.1 842.8 855.8 863.2 853.5 896.7 901.6 902.9 904.1 864.1 873.8 886.8 904.1 904.5 589.7 659.2 676.3 676.8 681.2 12430.4 12457.8 14790.3 14902.7 14975.0 12064.5 14446.5 14613.3 14635.5 14888.4 11363.9 11542.2 11694.0 11988.0 12100.6 3657.7 3721.5 3752.5 3822.8 3835.5 114758.0 114913.0 116495.0 119881.0 121292.0 9454.6 10602.7 11113.7 11129.7 11251.7 23071.4 23079.2 23313.7 23358.4 23591.5 6960.2 6961.5 7044.3 7063.2 7142.0 4259.7 4278.5 4279.6 4355.9 4385.0 3617.0 3702.9 3733.4 3744.3 3744.6 571.3 648.2 658.9 659.1 659.2 606.1 631.3 642.4 663.3 675.7 9523.2 9634.1 9681.7 9696.7 9754.9 651.8 657.2 669.7 670.2 695.0 4298.8 4362.5 4528.5 4649.4 4664.1 112494.0 115446.0 121096.0 123140.0 176952.2 119879.0 136450.0 143539.5 145483.0 152768.0 117688.4 124155.0 129584.0 132315.0 133690.3 7671.4 8529.6 8958.5 8989.3 9018.4 67787.7 69300.7 70158.6 70372.0 73471.3 77294.0 96423.5 98901.0 99227.0 101573.0 11949.3 12092.9 12103.6 12160.3 12327.2 12311.9 12340.9 12822.3 12936.5 12986.2 12183.4 13613.3 14071.0 14522.5 14869.9 13381.8 14281.9 14341.4 14404.5 14840.6 12441.3 13397.8 13502.3 13661.4 13780.4 10488.6 10598.8 10683.4 10949.8 11871.6 8556.4 11711.2 11814.5 11985.8 12006.8 02:23:53 INFO - PROCESS | 1661 | -------- Summary: end -------- 02:23:53 INFO - PROCESS | 1661 | 02:23:53 INFO - TEST-INFO | 1661: exit 0 02:23:53 INFO - TEST-OK | dromaeo_css | took 1114074ms 02:23:53 INFO - TEST-START | kraken 02:23:53 INFO - operating with platform_type : mac_ 02:23:53 INFO - Initialising browser for kraken test... 02:23:53 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpl5dnar/profile http://localhost:49272/getInfo.html) 02:23:56 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 02:23:56 INFO - PROCESS | 1668 | colorDepth:24 02:23:56 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 02:23:56 INFO - PROCESS | 1668 | __metrics 02:23:56 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 02:23:57 INFO - TEST-INFO | 1668: exit 0 02:23:57 INFO - Browser initialized. 02:23:57 INFO - Running cycle 1/1 for kraken test... 02:23:57 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpl5dnar/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:24:09 INFO - PROCESS | 1671 | RSS: Main: 225378304 02:24:09 INFO - PROCESS | 1671 | 02:24:11 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 02:24:12 INFO - PROCESS | 1671 | RSS: Main: 237871104 02:24:12 INFO - PROCESS | 1671 | 02:24:15 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 02:24:16 INFO - PROCESS | 1671 | RSS: Main: 245497856 02:24:16 INFO - PROCESS | 1671 | 02:24:19 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 02:24:20 INFO - PROCESS | 1671 | RSS: Main: 249327616 02:24:20 INFO - PROCESS | 1671 | 02:24:22 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 02:24:22 INFO - PROCESS | 1671 | RSS: Main: 250630144 02:24:22 INFO - PROCESS | 1671 | 02:24:24 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:24:25 INFO - PROCESS | 1671 | RSS: Main: 250761216 02:24:25 INFO - PROCESS | 1671 | 02:24:28 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 02:24:28 INFO - PROCESS | 1671 | RSS: Main: 251531264 02:24:28 INFO - PROCESS | 1671 | 02:24:31 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 02:24:32 INFO - PROCESS | 1671 | RSS: Main: 251437056 02:24:32 INFO - PROCESS | 1671 | 02:24:35 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 02:24:36 INFO - PROCESS | 1671 | RSS: Main: 251756544 02:24:36 INFO - PROCESS | 1671 | 02:24:37 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:24:38 INFO - PROCESS | 1671 | RSS: Main: 252370944 02:24:38 INFO - PROCESS | 1671 | 02:24:40 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:24:40 INFO - PROCESS | 1671 | RSS: Main: 252022784 02:24:40 INFO - PROCESS | 1671 | 02:24:43 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:24:43 INFO - PROCESS | 1671 | RSS: Main: 251678720 02:24:43 INFO - PROCESS | 1671 | 02:24:46 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:24:47 INFO - PROCESS | 1671 | RSS: Main: 252039168 02:24:47 INFO - PROCESS | 1671 | 02:24:50 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:24:51 INFO - PROCESS | 1671 | RSS: Main: 252059648 02:24:51 INFO - PROCESS | 1671 | 02:24:52 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 02:24:53 INFO - PROCESS | 1671 | RSS: Main: 253833216 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | __start_tp_report 02:24:53 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 02:24:53 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 02:24:53 INFO - PROCESS | 1671 | |i|pagename|runs| 02:24:53 INFO - PROCESS | 1671 | |0;ai-astar;105;118;120;117;120;116;136;118;119;116 02:24:53 INFO - PROCESS | 1671 | |1;audio-beat-detection;142;110;110;141;132;110;144;142;127;138 02:24:53 INFO - PROCESS | 1671 | |2;audio-dft;198;214;171;252;276;216;199;193;196;194 02:24:53 INFO - PROCESS | 1671 | |3;audio-fft;82;59;58;73;60;73;85;82;108;60 02:24:53 INFO - PROCESS | 1671 | |4;audio-oscillator;87;70;88;72;71;69;88;69;71;87 02:24:53 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;90;88;97;132;134;86;90;87;126;87 02:24:53 INFO - PROCESS | 1671 | |6;imaging-darkroom;96;98;100;150;123;96;147;165;130;97 02:24:53 INFO - PROCESS | 1671 | |7;imaging-desaturate;91;95;97;91;97;91;90;94;90;97 02:24:53 INFO - PROCESS | 1671 | |8;json-parse-financial;57;56;60;61;90;60;61;60;60;57 02:24:53 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;67;73;69;76;75;68;91;108;64;94 02:24:53 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;84;87;73;96;111;79;85;85;88;83 02:24:53 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;155;156;154;160;156;154;157;152;205;160 02:24:53 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;233;200;168;212;226;170;170;169;175;173 02:24:53 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;70;67;68;67;70;68;68;68;70;87 02:24:53 INFO - PROCESS | 1671 | __end_tp_report 02:24:53 INFO - PROCESS | 1671 | __start_cc_report 02:24:53 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,958 02:24:53 INFO - PROCESS | 1671 | __end_cc_report 02:24:53 INFO - PROCESS | 1671 | __startTimestamp1477905893088__endTimestamp 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | ------- Summary: start ------- 02:24:53 INFO - PROCESS | 1671 | Number of tests: 14 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:118.50 Median:118.50 stddev:7.52 (6.3%) stddev-sans-first:6.18 02:24:53 INFO - PROCESS | 1671 | Values: 105.0 118.0 120.0 117.0 120.0 116.0 136.0 118.0 119.0 116.0 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:139.50 stddev:14.45 (10.4%) stddev-sans-first:14.62 02:24:53 INFO - PROCESS | 1671 | Values: 142.0 110.0 110.0 141.0 132.0 110.0 144.0 142.0 127.0 138.0 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:210.90 Median:206.50 stddev:31.07 (15.0%) stddev-sans-first:32.61 02:24:53 INFO - PROCESS | 1671 | Values: 198.0 214.0 171.0 252.0 276.0 216.0 199.0 193.0 196.0 194.0 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:74.00 Median:73.00 stddev:15.92 (21.8%) stddev-sans-first:16.62 02:24:53 INFO - PROCESS | 1671 | Values: 82.0 59.0 58.0 73.0 60.0 73.0 85.0 82.0 108.0 60.0 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:79.50 stddev:8.92 (11.2%) stddev-sans-first:8.72 02:24:53 INFO - PROCESS | 1671 | Values: 87.0 70.0 88.0 72.0 71.0 69.0 88.0 69.0 71.0 87.0 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:101.70 Median:87.50 stddev:20.31 (23.2%) stddev-sans-first:21.10 02:24:53 INFO - PROCESS | 1671 | Values: 90.0 88.0 97.0 132.0 134.0 86.0 90.0 87.0 126.0 87.0 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:120.20 Median:130.50 stddev:26.52 (20.3%) stddev-sans-first:26.64 02:24:53 INFO - PROCESS | 1671 | Values: 96.0 98.0 100.0 150.0 123.0 96.0 147.0 165.0 130.0 97.0 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:93.30 Median:94.50 stddev:3.02 (3.2%) stddev-sans-first:3.09 02:24:53 INFO - PROCESS | 1671 | Values: 91.0 95.0 97.0 91.0 97.0 91.0 90.0 94.0 90.0 97.0 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:60.00 stddev:9.93 (16.6%) stddev-sans-first:10.35 02:24:53 INFO - PROCESS | 1671 | Values: 57.0 56.0 60.0 61.0 90.0 60.0 61.0 60.0 60.0 57.0 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:78.50 Median:74.00 stddev:14.37 (19.4%) stddev-sans-first:14.63 02:24:53 INFO - PROCESS | 1671 | Values: 67.0 73.0 69.0 76.0 75.0 68.0 91.0 108.0 64.0 94.0 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:85.00 stddev:10.28 (12.1%) stddev-sans-first:10.84 02:24:53 INFO - PROCESS | 1671 | Values: 84.0 87.0 73.0 96.0 111.0 79.0 85.0 85.0 88.0 83.0 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:160.90 Median:156.50 stddev:15.70 (10.0%) stddev-sans-first:16.51 02:24:53 INFO - PROCESS | 1671 | Values: 155.0 156.0 154.0 160.0 156.0 154.0 157.0 152.0 205.0 160.0 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.60 Median:187.50 stddev:25.75 (13.7%) stddev-sans-first:22.00 02:24:53 INFO - PROCESS | 1671 | Values: 233.0 200.0 168.0 212.0 226.0 170.0 170.0 169.0 175.0 173.0 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:69.00 stddev:5.98 (8.7%) stddev-sans-first:6.34 02:24:53 INFO - PROCESS | 1671 | Values: 70.0 67.0 68.0 67.0 70.0 68.0 68.0 68.0 70.0 87.0 02:24:53 INFO - PROCESS | 1671 | -------- Summary: end -------- 02:24:53 INFO - PROCESS | 1671 | 02:24:53 INFO - TEST-INFO | 1671: exit 0 02:24:53 INFO - TEST-OK | kraken | took 60186ms 02:24:53 INFO - SUITE-END | took 1174s 02:24:54 INFO - Completed test suite (00:19:34) 02:24:54 INFO - javascript benchmark 02:24:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7264.506087988425, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3483.0769845990817, 3485.651434856514, 3498.685118339349, 3503.737219708519, 3511.4732790081503, 5958.940410595898, 6015.939840601593, 6024.849378765533, 6049.848753781158, 6065.575409721321, 5961.552883533731, 5982.581219314649, 6038.516918646509, 6051.878962420749, 6073.271207455112, 4500.909981800362, 5422.728863556817, 5470.042742520043, 5475.917861232085, 5542.7782888684405, 4311.827526898936, 5468.644538105031, 5490.149026900836, 5501.367342755594, 5510.980468613299, 5364.329458817648, 5381.704006279653, 5495.587830912677, 5510.5316048135755, 5540.861478463051, 5353.839384818442, 5369.6509726867625, 5392.541633961118, 5446.863828404282, 5473.890522189574, 5259.316288882459, 5351.143816989263, 5357.651752636105, 5381.354237491487, 5392.73036348181, 5785.218995435646, 5876.4123587641325, 5903.055511118243, 5955.761769529214, 6021.1269365942135, 5447.536959358459, 6154.907676384858, 6196.008638617799, 6276.905846412307, 6295.968520157416, 6301.905471417932, 6306.621602703853, 6311.905321420182, 6372.553921225516, 6375.521835862329, 6071.726772295257, 6073.058675905242, 6087.086936959403, 6089.238845144357, 6102.786402475892, 6356.904646430215, 6371.74513019474, 6414.166158399378, 6473.611583305017, 6516.120323756232, 6199.56603037783, 6285.151504546919, 6294.779682711083, 6301.149344838388, 6308.369163083655, 5312.096943519611, 6242.282137554149, 6272.968635156795, 6341.714622841983, 6354.3645635437015, 6236.844078897973, 6243.344448832807, 6263.185785847811, 6299.0, 6303.747850085945, 6220.471259942956, 6283.3088360280335, 6285.654289014148, 6287.465565426898, 6301.4328710416285, 4942.728149951788, 5099.286099946011, 5116.999999999925, 5122.257272695513, 5138.794448222029, 4248.256555102845, 4353.564643535685, 4438.201123797748, 4464.017916058462, 4476.6418686505, 4819.49395313494, 5223.746300887759, 5825.126231065289, 6020.608660437058, 6091.329953705089, 6324.588901721373, 6329.113924050636, 6363.3636636336, 6363.61818290904, 6373.936260637427, 5985.760569577168, 6050.183225264621, 6059.424354686298, 6101.633901965896, 6107.61364822091, 5235.947640523622, 5290.412876137143, 5593.860153496195, 5624.465675760796, 5626.156076588462, 6500.642464664489, 6603.7688680895935, 6623.536352455282, 6646.102776125162, 6659.0, 6206.224221972254, 6210.813675589739, 6238.906416403667, 6265.248170219603, 6424.164858568356, 6360.618362898241, 6435.485161187187, 6436.356364363526, 6462.256840463407, 6480.027995800668, 6279.654618995816, 6288.0, 6291.402316779899, 6297.716602752978, 6314.116023756769, 5940.554458415722, 6222.439980401786, 6254.124422580933, 6277.686115694289, 6285.214348206474, 6100.328963814066, 6198.938010619836, 6201.0388389799655, 6281.780137695158, 6292.244930608356, 6243.96878015607, 6253.937460625336, 6258.530610204344, 6287.685615719104, 6299.401556852092, 6020.578559500968, 6056.212692349966, 6110.969445152746, 6118.847028824315, 6249.375062493714, 6208.161898143693, 6229.190205273286, 6254.155688981929, 6284.465820405317, 6294.213223347082, 6192.3807619239515, 6192.535559833121, 6247.531435142473, 6251.468625166912, 6259.0], "value": 5834.090644834455, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.0662474736132, 505.929958138537, 510.61448606302224, 512.5822454699418, 533.1549494051927, 41193.0, 43205.78397108018, 43254.783726081325, 43294.56705432945, 43371.34942975858, 43223.78388108055, 44178.0, 44600.553994460046, 44657.330140047925, 44746.0, 9891.802163956734, 9972.451515166664, 10035.197184225244, 10044.995500449933, 10085.64700235492, 9960.804703435599, 10003.249756268273, 10004.449755263458, 10105.191584673245, 10127.797444051115, 7858.882116768253, 9591.856122158173, 10071.04325089119, 10083.49582520871, 10118.342307749972, 8451.492910425333, 8460.0, 10052.195824334036, 10056.849147262797, 10064.798704025952, 9959.701208963743, 9964.05341492557, 9987.151092157175, 10020.0, 10022.047905448972, 34627.4805877912, 41071.94640268005, 41689.58310416887, 42096.36855447171, 42104.57895421068, 3392.23674673199, 3580.5882323532605, 3587.856485740567, 3857.4213867920034, 4018.839246430139, 28042.719572804213, 30028.8498557508, 30192.0, 30301.0, 32082.71669133232, 3141.54447605096, 3288.3423315337027, 3305.1241421023446, 3340.983295083509, 3391.643877392863, 438466.0, 523091.0, 525800.0, 527205.3639731815, 528299.0, 32998.010059698245, 33885.0, 64285.35714642887, 64776.35223647703, 64842.0, 34617.48073778895, 35424.82287588597, 35632.28735425329, 35933.0, 35995.0, 15407.614809629626, 15548.76676849848, 15604.45384411563, 15612.921935390477, 15633.687326253412, 13199.868001320056, 13200.009999250095, 13284.667883302802, 13318.067735258634, 13338.066335356432, 7762.107357653942, 7782.338501227459, 7795.727149549852, 7819.452638315263, 7859.960700196462, 3229.7739158258696, 3256.0882952772786, 3256.1208473711963, 3263.233140212048, 3286.6384697683234, 842.4818736477145, 923.6720964057663, 998.3128512813322, 1030.2736570717625, 1106.3251416635846, 30454.0, 30837.69162308393, 30967.690323096933, 31005.379892402027, 31015.0, 1016.6899095775711, 1069.1500257295468, 1092.9344239345664, 1140.4867809485766, 1158.1082566423806, 13876.098053626683, 14091.36588853504, 16424.83575164257, 16570.0, 16837.242324095445, 538882.0, 674468.0, 688398.0, 694223.0, 697430.0, 59342.406575934554, 59922.70038649779, 59968.70015649981, 59977.0, 60145.699271504236, 1369.5412036967728, 1382.0809161907218, 1392.9721405572034, 1393.3526300030023, 1398.853120422341, 30794.0, 31115.53326700056, 32139.357212855146, 32355.029349119563, 32663.0, 43734.56265437305, 52121.218181726545, 52338.95322093613, 52664.73667631637, 52725.94548109093, 586048.0, 613241.0, 615523.0, 616881.0, 618300.9084954547, 27054.594181086904, 27227.86386068057, 27473.86263068672, 27541.31146721268, 27604.723952761018, 48108.27837582509, 49100.0, 49570.760730982016, 49708.0, 49754.0, 40224.19551608893, 40846.36614535385, 40891.795541022104, 41020.79489602652, 42305.0, 40445.0, 40674.98312542092, 41199.0, 41783.1643367137, 42022.78988605038, 38409.615903840604, 38435.80782096072, 38632.42051369175, 38703.03242418962, 39169.60830391774, 27336.453270934868, 33958.0, 34793.826030870696, 35281.294374112884, 35784.284314313045, 24876.37809054788, 26449.0, 26460.470790583695, 26561.867190663925, 27001.594976074983], "value": 19126.454781334687, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.98385080745965, 371.81595110420335, 376.1874351400974, 380.3439067608374, 400.89753178758417, 19395.515112122204, 19831.603367932632, 20984.845833479172, 21083.789162108373, 21127.366179014654, 20257.49356266094, 20389.898050509764, 20456.284030058952, 20781.584368312626, 20823.375298741063, 5949.25634295713, 5981.132735753313, 6115.174451449064, 6146.108814221935, 6234.968825155868, 5235.607329450288, 6070.089486577004, 6172.691365431733, 6177.196964394622, 6179.3202747697715, 6107.877842443148, 6117.44942955134, 6457.096006559085, 6786.219584747768, 6823.454123670119, 6556.442702370305, 6754.493412994045, 6787.626680532569, 6821.69302381394, 6865.416439602614, 5974.761009559613, 6018.217631707894, 6026.3672314406795, 6033.577649564532, 6039.1545183674325, 12840.972722182296, 12945.158564693358, 13055.477780888754, 13306.401211945486, 13328.466861325536, 2072.554400803819, 2210.5689390568846, 2255.4135924659545, 2432.3067925641285, 2914.7522460590876, 8725.0, 9574.606348412897, 9696.224302055889, 10115.140213081897, 10525.157987360994, 1854.2026928420773, 1854.2675643121026, 1860.125740901774, 1889.896055716935, 1904.990475047616, 100668.9933100667, 117818.41090794577, 122406.77593224043, 123938.0, 127412.0, 11423.600173993871, 11737.0, 11742.354170520703, 11786.110583507421, 11940.88059119415, 14331.641708957359, 14506.709865802624, 14626.853731462763, 14773.704525909636, 14798.704025919422, 8706.085860984633, 8738.30093592511, 8743.387962842668, 8801.515916624647, 8897.73306800797, 6440.0, 7228.56628602275, 7849.372050235967, 8807.735767926972, 8843.955780221058, 3686.56768006952, 4456.9331460028125, 4554.134714404253, 4581.175388430114, 4605.240135377625, 1454.549089782171, 1783.509534877919, 1822.48059303098, 1835.3851459761129, 1849.9537511562319, 898.5462341517623, 927.2535608834818, 942.2038377570941, 952.3333666433524, 1043.2853495355705, 16884.409045683344, 17408.65182696339, 18127.637447251243, 21040.053197606143, 21973.0, 739.840934199139, 835.2900034970227, 900.145699858294, 954.3128947158035, 1013.7009582173276, 10938.453077346101, 11067.833982490269, 11575.710607234718, 11976.58081967127, 11987.460564274628, 594959.0252048798, 605916.0, 651423.0, 663427.0, 665786.0, 126074.3696281531, 126294.0, 128952.35523822322, 132964.0, 136191.0, 1012.9392236465835, 1013.4628646817346, 1053.1837825685154, 1054.1566746602687, 1057.1120258982492, 19416.320428784926, 19503.0, 19609.31367402134, 19801.504962376057, 20127.094280757694, 39677.60322396739, 45805.54194458146, 49311.506884932125, 53314.60084296294, 57811.421885780604, 69766.0, 74253.62873185599, 83793.16206838097, 87211.56394217988, 87732.68400973863, 6493.902591461227, 8110.918890811253, 8163.510189388656, 8352.87470687928, 8430.536320502431, 7775.688972441039, 12990.805137922749, 13031.869681303066, 13090.869091308965, 13252.602421927357, 10932.836007460053, 11309.434528273388, 11349.092072634005, 11542.13433992437, 11584.94207528957, 9525.190358819578, 10498.422586757802, 10798.298110622783, 11166.0, 11592.420378981185, 9101.590428430603, 10513.89486105129, 11361.0, 11391.430428478709, 11730.824037639271, 6087.36082711309, 8045.9597702011115, 8315.501069935823, 8369.076263207391, 8395.580220989048, 9581.904180958101, 10439.269251152651, 10707.464626768475, 11141.498632561716, 11459.770804583695], "value": 9424.214244909565, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1402.7054318593096, 1516.2570340533139, 1623.5454072859604, 1725.5341057914363, 1875.1468082022682, 7958.124606293303, 8204.05653349865, 8485.406021578485, 8997.955010224949, 9011.18899299063, 7103.112110986127, 8420.494770313786, 8722.781930451742, 8725.563721813916, 8815.51514666693, 1804.5308219862864, 1973.2994786850677, 2017.6469117904383, 2383.1420688552107, 2386.761323867608, 2354.19957214547, 2356.45801465663, 2381.023780250098, 2389.602082781566, 2400.423898264413, 1988.9005549722528, 2322.535492901418, 2374.287713685896, 2385.5586716457424, 2404.206611818096, 2344.777246161612, 2348.049040138738, 2360.7285162206394, 2363.751806060356, 2394.437307232799, 2319.501307218939, 2354.764523547649, 2358.7641235876445, 2367.6093444581625, 2374.7625237476286, 8695.39132260742, 8751.956240218822, 8791.604377803014, 8904.421212621159, 8922.375433719642, 5221.791128354899, 5337.946620533784, 5392.649477783932, 5395.676259424408, 5400.648957817729, 3559.893203203908, 3595.7303202259673, 3734.495843061179, 3756.530433695788, 3756.549214094326, 1071.6195750508534, 1099.2470157941837, 1109.3011402816173, 1110.9111271098293, 1132.9376884271362, 11353.20527563071, 11448.542058317656, 11552.942235288854, 11595.130365222558, 11632.302061876399, 4208.873733787991, 4561.475430325489, 4652.790624421909, 4833.951660483421, 4838.0, 9601.183899368492, 9769.316147869724, 9923.900760992297, 9936.900630993598, 9946.254030947708, 5336.17289320156, 5357.223202635596, 5360.892782144413, 5376.7580458878665, 5381.569474442035, 4378.605925466723, 4565.977170114194, 4877.5366340197625, 4898.804047838046, 4903.092927808367, 3277.7869438486423, 3953.743006704555, 4015.3976903464713, 4057.9391309130388, 4069.145479449349, 1123.8538989931258, 1304.8629893861198, 1311.4491913396396, 1319.7228581997697, 1324.5033112582782, 765.2309429023907, 800.335721351277, 862.2283056664251, 863.8056437301557, 931.9207867331353, 5552.666839989613, 5768.163616275617, 5859.179714839841, 6140.508759299245, 6144.662043587557, 970.6556419359239, 992.553350992042, 1037.0355569320604, 1049.2655141401049, 1073.3309703411114, 3927.0771368728324, 4001.199760048002, 4089.5705950875326, 4107.301758700968, 4141.689373297015, 10707.250492465453, 10804.24370294072, 10815.080718139046, 10857.131429485622, 10864.293820901616, 10653.360798352123, 10686.25196236256, 10785.892141078646, 10800.405977671304, 10813.0, 8080.515169089874, 8082.636281367352, 8090.878636820453, 8094.878576821352, 8231.382646301552, 4924.9507504924495, 5506.2291279221745, 5737.540996720169, 5897.941020589911, 6058.091286307089, 9839.0, 9845.901540984785, 9883.456409897524, 9932.255080869108, 9956.900430995887, 9819.852702209615, 10037.799244015225, 10100.84848727255, 10310.0, 10349.741256468347, 6988.965055174895, 7094.503384763017, 7183.604901730246, 7287.927120728937, 7378.889316660147, 8309.542975136426, 8403.453775504817, 8430.789230269293, 8517.0, 8533.957330213309, 7414.073240844895, 7513.39892808585, 7524.209957954336, 7550.791873300245, 7637.5799331035105, 7393.0, 7396.260373962561, 7405.111386633638, 7414.369778568882, 7518.323350898446, 6420.133282006869, 6565.737370505126, 6967.686454109476, 7026.648667566499, 7133.179684336368, 4407.272799987966, 5014.57376123019, 5023.949760502348, 5096.719680417613, 5177.870553236199, 4360.563943605614, 4406.317020861771, 5028.823991160438, 5065.620078494054, 5079.136546787129], "value": 4568.433166005064, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [266.629385154635, 268.40682092575406, 296.34359892837375, 313.13886811269003, 314.64602322387316, 4353.86938391848, 5531.612787104904, 5548.611597188194, 5594.412586678402, 5648.519875810551, 4545.159210519737, 5169.043726910524, 5221.477852214786, 5504.80733174339, 5529.391766905647, 4224.493060832704, 4225.598568136023, 4232.9788351058205, 4240.257954857888, 4262.211490874182, 3054.602901622786, 4151.294279972397, 4259.488861336628, 4262.97868510657, 4273.764942928137, 3756.0, 4117.402976568395, 4153.667706583481, 4164.937525937114, 4185.937210941838, 3701.3522633539023, 4128.401381799637, 4144.585541445861, 4147.294959856801, 4158.542560318362, 2991.925201869949, 3598.2803439312243, 3614.6385361463645, 3622.0, 3628.1836586767768, 4440.267355886275, 5070.416902056237, 5274.5780337572905, 5430.3755068167275, 5484.91772623411, 4736.739479328636, 4750.263709125056, 4757.357756702835, 4764.95235047652, 4774.188387974018, 4841.685290456145, 5841.3282472515775, 5857.941420585782, 5861.3552509223955, 5904.586678932476, 3703.2594680500124, 3858.479105320802, 3901.395283731026, 3929.2141571685493, 3959.78221197834, 5130.9743451282875, 5160.458151894072, 6104.511639068908, 6139.2325959255095, 6223.719932603044, 3806.54321481424, 3864.7874366909527, 4005.178938317638, 4012.2176175646055, 4013.6387725104883, 3331.017349881742, 3568.8215589220954, 3937.0551067743536, 4057.350823868167, 4165.66674666026, 4193.0, 4795.232762757942, 4818.229083346648, 4833.637477189225, 4868.245421959602, 4894.951050489521, 5105.060077170651, 5916.49709774674, 5938.376470470625, 6017.277926648742, 1343.4290426568864, 1394.0172178614052, 1396.882494004792, 1415.7380884536394, 1427.7144571085823, 821.9725343320849, 940.6801687426308, 977.9364341317792, 980.5587485631495, 980.5783513089298, 4754.9286760698615, 5373.167159090347, 5432.017313680478, 5450.700211488406, 5489.807856724996, 5995.280566332068, 6007.468095635585, 6015.097735339734, 6045.6699526104185, 6048.788292409745, 5204.9219261711105, 5369.5167434931045, 5400.027994960867, 5424.419882877282, 5464.754086066137, 2367.644853272023, 2373.6588827312858, 2584.6898372195456, 2612.8562929038703, 2629.44781595867, 4641.791119399568, 4701.506341834127, 5168.405633352213, 5250.343707036621, 5298.28473156119, 4031.173609410064, 4317.352397140454, 4471.977640111779, 4827.831025914076, 4921.114199444134, 4439.800208990603, 4636.721796692074, 4707.223308154116, 5238.8166414176085, 5286.88524590167, 4311.288637374798, 4334.826606935687, 4654.790534425892, 4867.0, 5040.722760248222, 4275.722078064916, 4433.645308375387, 4674.270519907656, 4967.577755890645, 4988.977259661833, 4615.353850460871, 4721.905561888674, 5154.304168937296, 5267.577754006474, 5273.442380445557, 3329.250918543308, 3463.4977928199764, 3580.1944562473236, 3633.2551826874897, 3635.6727894489622, 3541.911452213715, 4737.839229388822, 4793.376861008047, 4950.529699678525, 5018.5232402921665, 4003.8798836034966, 4816.735079570657, 4831.541003604652, 4845.41854977405, 4858.392700912386, 4342.630876375543, 4516.458025037016, 4856.757162141808, 4875.416029504368, 4876.926846097241, 4275.451375358507, 4683.882902927317, 4730.533534604284, 4742.834000809955, 4788.252287914956, 4803.663743538059, 4848.763565290828, 4859.7327147005835, 4872.637879862883, 4896.531040687851, 4140.923359926501, 4523.457185137804, 4551.38556294896, 4653.744044077473, 4781.593564547053], "value": 3924.015886422312, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.4805842945851, 706.8515611721538, 773.7678696391081, 783.4398405140323, 807.0638059850575, 15280.69438611227, 15438.61403464914, 15692.686146277068, 15886.602834929146, 15932.123733194685, 14254.857451425509, 14303.499377521788, 14349.0, 14374.06568573042, 14398.352074156663, 668.6556423441943, 694.271015433795, 829.7386323308169, 857.67408384814, 872.2629378175463, 812.1147948735877, 813.1137060603941, 842.7766641839887, 855.8031652719878, 863.2101627011277, 853.5433543054467, 896.668232753882, 901.6303315640589, 902.8916530016407, 904.0823564082461, 864.0624921959682, 873.7902903303193, 886.7916039730658, 904.1139683110556, 904.4708845325492, 589.6555852655952, 659.1760299625469, 676.3304328714586, 676.8307923019245, 681.1621705302506, 12430.440630171664, 12457.75084498305, 14790.334434950453, 14902.70194596102, 14975.026623269561, 12064.457099430547, 14446.494372696905, 14613.269336533238, 14635.487757928528, 14888.404463821542, 11363.943180284128, 11542.249753765978, 11694.006009489203, 11988.0, 12100.576479823163, 3657.719798070654, 3721.497597824286, 3752.4934133891848, 3822.7706337619834, 3835.5397352317623, 114758.0, 114913.0, 116495.0, 119881.0, 121292.0, 9454.621815127455, 10602.674665666791, 11113.722156946142, 11129.72175695598, 11251.718707032225, 23071.423214419774, 23079.19222827193, 23313.650295245585, 23358.416039599146, 23591.528169436515, 6960.199577048603, 6961.512694111364, 7044.260352662999, 7063.223045464994, 7142.0, 4259.701820872571, 4278.507971583245, 4279.636230920344, 4355.934660980088, 4384.956150438518, 3617.04148400674, 3702.9444558331647, 3733.4026555750947, 3744.307303148926, 3744.625537446288, 571.2830397850671, 648.1541588227315, 658.9226614485256, 659.1003280522053, 659.1529884099006, 606.087837804102, 631.3150231998242, 642.4410762636536, 663.2969052804043, 675.7026908160492, 9523.238140948708, 9634.075043848123, 9681.66114186, 9696.660616878375, 9754.92695803461, 651.7616528595612, 657.1949362031569, 669.695288643666, 670.2386365883062, 694.9617771022643, 4298.785060747013, 4362.476502819682, 4528.547145285511, 4649.395578574764, 4664.113818374498, 112494.0, 115446.0, 121096.0, 123140.0, 176952.23047769614, 119879.0, 136450.0, 143539.54072066574, 145482.99999999788, 152768.0, 117688.41155794167, 124155.0, 129584.0, 132315.0, 133690.33154834164, 7671.38628909697, 8529.573521324033, 8958.507282099547, 8989.325800565115, 9018.368714189945, 67787.66106169438, 69300.65349673422, 70158.64920675365, 70372.0, 73471.26528734858, 77294.0, 96423.51788241015, 98901.0, 99227.0, 101573.0, 11949.283043017447, 12092.939535302266, 12103.576374826838, 12160.270383777002, 12327.198732082745, 12311.876881231074, 12340.876591233973, 12822.294773787531, 12936.482540698267, 12986.155899866479, 12183.390830458264, 13613.31933403306, 14071.0, 14522.49171279, 14869.851301487279, 13381.799273010718, 14281.928590356982, 14341.35463904106, 14404.495842645458, 14840.62898427548, 12441.315727635067, 13397.799033014708, 13502.25737584403, 13661.385237664528, 13780.448782048607, 10488.580456781643, 10598.841017384591, 10683.358998459806, 10949.781004380027, 11871.643850684493, 8556.401051926305, 11711.238769479956, 11814.527418903148, 11985.801419857944, 12006.819897701716], "value": 7795.424109193844, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1574.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 120.0, 117.0, 120.0, 116.0, 136.0, 118.0, 119.0, 116.0], "value": 118.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 110.0, 141.0, 132.0, 110.0, 144.0, 142.0, 127.0, 138.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 214.0, 171.0, 252.0, 276.0, 216.0, 199.0, 193.0, 196.0, 194.0], "value": 210.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 58.0, 73.0, 60.0, 73.0, 85.0, 82.0, 108.0, 60.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 88.0, 72.0, 71.0, 69.0, 88.0, 69.0, 71.0, 87.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 97.0, 132.0, 134.0, 86.0, 90.0, 87.0, 126.0, 87.0], "value": 101.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 100.0, 150.0, 123.0, 96.0, 147.0, 165.0, 130.0, 97.0], "value": 120.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 97.0, 91.0, 97.0, 91.0, 90.0, 94.0, 90.0, 97.0], "value": 93.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 60.0, 61.0, 90.0, 60.0, 61.0, 60.0, 60.0, 57.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 69.0, 76.0, 75.0, 68.0, 91.0, 108.0, 64.0, 94.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 73.0, 96.0, 111.0, 79.0, 85.0, 85.0, 88.0, 83.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 156.0, 154.0, 160.0, 156.0, 154.0, 157.0, 152.0, 205.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [233.0, 200.0, 168.0, 212.0, 226.0, 170.0, 170.0, 169.0, 175.0, 173.0], "value": 189.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 68.0, 67.0, 70.0, 68.0, 68.0, 68.0, 70.0, 87.0], "value": 70.3, "unit": "score"}]}]} 02:24:54 INFO - Return code: 0 02:24:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:24:54 ERROR - # TBPL SUCCESS # 02:24:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:24:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:24:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:24:54 INFO - 2016-10-31 02:24:54.373 screenresolution[1676:11299] starting screenresolution argv=screenresolution get 02:24:54 INFO - 2016-10-31 02:24:54.376 screenresolution[1676:11299] Display 0: 1600x1200x32@60 02:24:54 INFO - 2016-10-31 02:24:54.382 screenresolution[1677:11302] starting screenresolution argv=screenresolution list 02:24:54 INFO - Available Modes on Display 0 02:24:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:24:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:24:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:24:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:24:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:24:54 INFO - Intel Iris: 02:24:54 INFO - Chipset Model: Intel Iris 02:24:54 INFO - Type: GPU 02:24:54 INFO - Bus: Built-In 02:24:54 INFO - VRAM (Dynamic, Max): 1536 MB 02:24:54 INFO - Vendor: Intel (0x8086) 02:24:54 INFO - Device ID: 0x0a2e 02:24:54 INFO - Revision ID: 0x0009 02:24:54 INFO - Displays: 02:24:54 INFO - Display: 02:24:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:24:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:24:54 INFO - Display Serial Number: 1600x1200 60 02:24:54 INFO - Main Display: Yes 02:24:54 INFO - Mirror: Off 02:24:54 INFO - Online: Yes 02:24:54 INFO - Rotation: Supported 02:24:54 INFO - Return code: 0 02:24:54 INFO - Running post-action listener: _resource_record_post_action 02:24:54 INFO - [mozharness: 2016-10-31 09:24:54.619700Z] Finished run-tests step (success) 02:24:54 INFO - Running post-run listener: _resource_record_post_run 02:24:54 INFO - Total resource usage - Wall time: 1207s; CPU: 55.0%; Read bytes: 33266688; Write bytes: 668112896; Read time: 305; Write time: 2062 02:24:54 INFO - TinderboxPrint: CPU usage
54.6% 02:24:54 INFO - TinderboxPrint: I/O read bytes / time
33,266,688 / 305 02:24:54 INFO - TinderboxPrint: I/O write bytes / time
668,112,896 / 2,062 02:24:54 INFO - TinderboxPrint: CPU idle
2,194.6 (45.4%) 02:24:54 INFO - TinderboxPrint: CPU system
983.0 (20.4%) 02:24:54 INFO - TinderboxPrint: CPU user
1,652.1 (34.2%) 02:24:54 INFO - TinderboxPrint: Swap in / out
392,429,568 / 0 02:24:54 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 358550016; Write bytes: 356079616; Read time: 27518; Write time: 735 02:24:54 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 31255552; Write bytes: 300908544; Read time: 283; Write time: 1291 02:24:55 INFO - Running post-run listener: _upload_blobber_files 02:24:55 INFO - Blob upload gear active. 02:24:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:24:55 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 02:24:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:24:55 INFO - (blobuploader) - INFO - Open directory for files ... 02:24:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:24:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:24:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:24:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:24:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:24:56 INFO - (blobuploader) - INFO - Done attempting. 02:24:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:24:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:24:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:24:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:24:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:24:57 INFO - (blobuploader) - INFO - Done attempting. 02:24:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:24:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:24:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:25:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:25:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:25:00 INFO - (blobuploader) - INFO - Done attempting. 02:25:00 INFO - (blobuploader) - INFO - Iteration through files over. 02:25:00 INFO - Return code: 0 02:25:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:25:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:25:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0f084291126d1cc3c2e7edc2495e00f929584e29b7fdfae08385400fb0a8a09115b41d4d29f58e793846cc35a61440ab82e93ce5ccc30c08a34843d1a5a7e14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a48742d5cd8f361adb5da51c1e1a4dd1e66e73b802665d62495ef8ea96b32385b05e32b44bd9fbc549ff80d0e98e3bb76400fc9288d7eab8513fe97ba549f0fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/908a257479c8659f74e47f1da5d07a8265995090fe6a8f8a6c1ba01df01f6a3bac65e9241b2c2db720a7ed40ab914f843345b8f5e65ec166d53096c5a7d6bc79"} 02:25:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:25:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:25:00 INFO - Contents: 02:25:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0f084291126d1cc3c2e7edc2495e00f929584e29b7fdfae08385400fb0a8a09115b41d4d29f58e793846cc35a61440ab82e93ce5ccc30c08a34843d1a5a7e14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a48742d5cd8f361adb5da51c1e1a4dd1e66e73b802665d62495ef8ea96b32385b05e32b44bd9fbc549ff80d0e98e3bb76400fc9288d7eab8513fe97ba549f0fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/908a257479c8659f74e47f1da5d07a8265995090fe6a8f8a6c1ba01df01f6a3bac65e9241b2c2db720a7ed40ab914f843345b8f5e65ec166d53096c5a7d6bc79"} 02:25:00 INFO - Running post-run listener: copy_logs_to_upload_dir 02:25:00 INFO - Copying logs to upload dir... 02:25:00 INFO - mkdir: /builds/slave/test/build/upload/logs 02:25:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.806757 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-31 02:25:00.147020) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 02:25:00.154195) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UEuSmBd7JV/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0f084291126d1cc3c2e7edc2495e00f929584e29b7fdfae08385400fb0a8a09115b41d4d29f58e793846cc35a61440ab82e93ce5ccc30c08a34843d1a5a7e14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a48742d5cd8f361adb5da51c1e1a4dd1e66e73b802665d62495ef8ea96b32385b05e32b44bd9fbc549ff80d0e98e3bb76400fc9288d7eab8513fe97ba549f0fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/908a257479c8659f74e47f1da5d07a8265995090fe6a8f8a6c1ba01df01f6a3bac65e9241b2c2db720a7ed40ab914f843345b8f5e65ec166d53096c5a7d6bc79"} build_url:https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/DOrMCy71SuuIJS9PWaYxIg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f0f084291126d1cc3c2e7edc2495e00f929584e29b7fdfae08385400fb0a8a09115b41d4d29f58e793846cc35a61440ab82e93ce5ccc30c08a34843d1a5a7e14", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a48742d5cd8f361adb5da51c1e1a4dd1e66e73b802665d62495ef8ea96b32385b05e32b44bd9fbc549ff80d0e98e3bb76400fc9288d7eab8513fe97ba549f0fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/908a257479c8659f74e47f1da5d07a8265995090fe6a8f8a6c1ba01df01f6a3bac65e9241b2c2db720a7ed40ab914f843345b8f5e65ec166d53096c5a7d6bc79"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 02:25:00.192910) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 02:25:00.193296) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UEuSmBd7JV/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.TNHAxIwTXB/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005345 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 02:25:00.241559) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 02:25:00.244913) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 02:25:00.245294) ========= ========= Total master_lag: 0.21 =========