builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0246 starttime: 1489485100.97 results: success (0) buildid: 20170314011736 builduid: 034812972ca04ca5a144ecc62eb9e1e1 revision: b727bf4a09acc7ebbc5265429665fb846e5c9058 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 02:51:40.971364) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 02:51:40.972145) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 02:51:40.972435) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 02:51:41.001288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 02:51:41.001591) ========= 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.fBlI8WGF7E/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.fuyUdTtx4U/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 --2017-03-14 02:51:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.24M=0.001s 2017-03-14 02:51:41 (8.24 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.178670 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 02:51:41.203472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 02:51:41.203814) ========= 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.fBlI8WGF7E/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.fuyUdTtx4U/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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.021157 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 02:51:41.254481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-14 02:51:41.254829) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b727bf4a09acc7ebbc5265429665fb846e5c9058 --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 b727bf4a09acc7ebbc5265429665fb846e5c9058 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fBlI8WGF7E/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.fuyUdTtx4U/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 2017-03-14 02:51:41,347 truncating revision to first 12 chars 2017-03-14 02:51:41,347 Setting DEBUG logging. 2017-03-14 02:51:41,347 attempt 1/10 2017-03-14 02:51:41,347 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b727bf4a09ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-14 02:51:42,884 unpacking tar archive at: mozilla-aurora-b727bf4a09ac/testing/mozharness/ program finished with exit code 0 elapsedTime=1.800743 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-14 02:51:43.078379) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 02:51:43.081733) ========= script_repo_revision: b727bf4a09acc7ebbc5265429665fb846e5c9058 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 02:51:43.082115) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 02:51:43.082380) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 02:51:43.102067) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2017-03-14 02:51:43.102381) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.fBlI8WGF7E/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.fuyUdTtx4U/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:51:43 INFO - MultiFileLogger online at 20170314 02:51:43 in /builds/slave/test 02:51:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:51:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:51:43 INFO - {'append_to_log': False, 02:51:43 INFO - 'base_work_dir': '/builds/slave/test', 02:51:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:51:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:51:43 INFO - 'branch': 'Mozilla-Aurora', 02:51:43 INFO - 'buildbot_json_path': 'buildprops.json', 02:51:43 INFO - 'config_files': ('talos/mac_config.py',), 02:51:43 INFO - 'default_actions': ('clobber', 02:51:43 INFO - 'read-buildbot-config', 02:51:43 INFO - 'download-and-extract', 02:51:43 INFO - 'populate-webroot', 02:51:43 INFO - 'create-virtualenv', 02:51:43 INFO - 'install', 02:51:43 INFO - 'run-tests'), 02:51:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:51:43 INFO - 'download_minidump_stackwalk': True, 02:51:43 INFO - 'download_symbols': 'ondemand', 02:51:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:51:43 INFO - 'tooltool.py': '/tools/tooltool.py', 02:51:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:51:43 INFO - '/tools/misc-python/virtualenv.py')}, 02:51:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:51:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:51:43 INFO - 'gecko_profile': False, 02:51:43 INFO - 'gecko_profile_interval': 0, 02:51:43 INFO - 'installer_path': 'installer.exe', 02:51:43 INFO - 'log_level': 'info', 02:51:43 INFO - 'log_name': 'talos', 02:51:43 INFO - 'log_to_console': True, 02:51:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:51:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:51:43 INFO - 'opt_config_files': (), 02:51:43 INFO - 'pip_index': False, 02:51:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:51:43 INFO - 'cmd': ('bash', 02:51:43 INFO - '-c', 02:51:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:51:43 INFO - 'enabled': True, 02:51:43 INFO - 'halt_on_failure': False, 02:51:43 INFO - 'name': 'check_screen_resolution'},), 02:51:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:51:43 INFO - 'cmd': ('bash', 02:51:43 INFO - '-c', 02:51:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:51:43 INFO - 'enabled': True, 02:51:43 INFO - 'halt_on_failure': False, 02:51:43 INFO - 'name': 'check_screen_resolution'},), 02:51:43 INFO - 'run_cmd_checks_enabled': True, 02:51:43 INFO - 'suite': 'dromaeojs', 02:51:43 INFO - 'system_bits': '32', 02:51:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:51:43 INFO - 'title': 't-yosemite-r7-0246', 02:51:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:51:43 INFO - 'use_talos_json': True, 02:51:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:51:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:51:43 INFO - 'work_dir': 'build'} 02:51:43 INFO - [mozharness: 2017-03-14 09:51:43.311937Z] Running clobber step. 02:51:43 INFO - Running pre-action listener: _resource_record_pre_action 02:51:43 INFO - Running main action method: clobber 02:51:43 INFO - rmtree: /builds/slave/test/build 02:51:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:51:45 INFO - Running post-action listener: _resource_record_post_action 02:51:45 INFO - [mozharness: 2017-03-14 09:51:45.390622Z] Finished clobber step (success) 02:51:45 INFO - [mozharness: 2017-03-14 09:51:45.390800Z] Running read-buildbot-config step. 02:51:45 INFO - Running pre-action listener: _resource_record_pre_action 02:51:45 INFO - Running main action method: read_buildbot_config 02:51:45 INFO - Using buildbot properties: 02:51:45 INFO - { 02:51:45 INFO - "project": "", 02:51:45 INFO - "product": "firefox", 02:51:45 INFO - "script_repo_revision": "production", 02:51:45 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:51:45 INFO - "repository": "", 02:51:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:51:45 INFO - "buildid": "20170314011736", 02:51:45 INFO - "pgo_build": "False", 02:51:45 INFO - "basedir": "/builds/slave/test", 02:51:45 INFO - "buildnumber": 85, 02:51:45 INFO - "slavename": "t-yosemite-r7-0246", 02:51:45 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 02:51:45 INFO - "platform": "yosemite_r7", 02:51:45 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:51:45 INFO - "branch": "mozilla-aurora", 02:51:45 INFO - "repo_path": "releases/mozilla-aurora", 02:51:45 INFO - "revision": "b727bf4a09acc7ebbc5265429665fb846e5c9058", 02:51:45 INFO - "stage_platform": "macosx64", 02:51:45 INFO - "builduid": "034812972ca04ca5a144ecc62eb9e1e1", 02:51:45 INFO - "slavebuilddir": "test" 02:51:45 INFO - } 02:51:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:51:45 INFO - Running post-action listener: _resource_record_post_action 02:51:45 INFO - [mozharness: 2017-03-14 09:51:45.396596Z] Finished read-buildbot-config step (success) 02:51:45 INFO - [mozharness: 2017-03-14 09:51:45.396831Z] Running download-and-extract step. 02:51:45 INFO - Running pre-action listener: _resource_record_pre_action 02:51:45 INFO - Running main action method: download_and_extract 02:51:45 INFO - mkdir: /builds/slave/test/build/tests 02:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:51:45 INFO - trying https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:51:45 INFO - Downloading https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:51:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:51:46 INFO - Downloaded 1199 bytes. 02:51:46 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:51:46 INFO - Using the following test package requirements: 02:51:46 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:51:46 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:51:46 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:51:46 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:51:46 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:51:46 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:51:46 INFO - u'jsshell-mac.zip'], 02:51:46 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:51:46 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:51:46 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:51:46 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:51:46 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:51:46 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:51:46 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:51:46 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:51:46 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:51:46 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:51:46 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:51:46 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:51:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:51:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:51:46 INFO - Fetch https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:51:48 INFO - Expected file size: 51780247 02:51:48 INFO - Obtained file size: 51780247 02:52:04 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:52:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:52:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:52:04 INFO - Fetch https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:52:05 INFO - Expected file size: 51780247 02:52:05 INFO - Obtained file size: 51780247 02:52:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:52:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:52:20 INFO - Fetch https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:52:21 INFO - Expected file size: 14404424 02:52:21 INFO - Obtained file size: 14404424 02:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:22 INFO - trying https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:52:22 INFO - Downloading https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:52:31 INFO - Downloaded 74624736 bytes. 02:52:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:52:31 INFO - mkdir: /builds/slave/test/properties 02:52:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:52:31 INFO - Writing to file /builds/slave/test/properties/build_url 02:52:31 INFO - Contents: 02:52:31 INFO - build_url:https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:52:33 INFO - Running post-action listener: _resource_record_post_action 02:52:33 INFO - Running post-action listener: set_extra_try_arguments 02:52:33 INFO - [mozharness: 2017-03-14 09:52:33.122198Z] Finished download-and-extract step (success) 02:52:33 INFO - [mozharness: 2017-03-14 09:52:33.122317Z] Running populate-webroot step. 02:52:33 INFO - Running pre-action listener: _resource_record_pre_action 02:52:33 INFO - Running main action method: populate_webroot 02:52:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:52:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:52:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:52:33 INFO - '--tppagecycles', 02:52:33 INFO - '7'], 02:52:33 INFO - 'tests': ['tsvgm']}}, 02:52:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:52:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:52:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:52:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:52:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:52:33 INFO - 'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:52:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:52:33 INFO - 'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['damp', 'tps']}, 02:52:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:52:33 INFO - 'tests': ['damp', 'tps']}, 02:52:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['dromaeo_dom']}, 02:52:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:52:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['basic_compositor_video']}, 02:52:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:52:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'other-e10s': {'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['tsvgx', 02:52:33 INFO - 'tsvgr_opacity', 02:52:33 INFO - 'tart', 02:52:33 INFO - 'tscrollx', 02:52:33 INFO - 'cart', 02:52:33 INFO - 'tsvg_static']}, 02:52:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:52:33 INFO - 'tsvgr_opacity', 02:52:33 INFO - 'tart', 02:52:33 INFO - 'tscrollx', 02:52:33 INFO - 'cart', 02:52:33 INFO - 'tsvg_static']}, 02:52:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:52:33 INFO - 'talos_options': ['--disable-e10s'], 02:52:33 INFO - 'tests': ['tp5o']}, 02:52:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:52:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:52:33 INFO - 'talos_options': ['--disable-e10s', 02:52:33 INFO - '--xperf_path', 02:52:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:33 INFO - 'tests': ['tp5n']}, 02:52:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:52:33 INFO - 'talos_options': ['--xperf_path', 02:52:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:33 INFO - 'tests': ['tp5n']}}, 02:52:33 INFO - 'talos.zip': {'path': '', 02:52:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:52:33 INFO - Running post-action listener: _resource_record_post_action 02:52:33 INFO - [mozharness: 2017-03-14 09:52:33.141931Z] Finished populate-webroot step (success) 02:52:33 INFO - [mozharness: 2017-03-14 09:52:33.142036Z] Running create-virtualenv step. 02:52:33 INFO - Running pre-action listener: _resource_record_pre_action 02:52:33 INFO - Running main action method: create_virtualenv 02:52:33 INFO - Creating virtualenv /builds/slave/test/build/venv 02:52:33 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:52:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:52:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:52:33 INFO - Using real prefix '/tools/python27' 02:52:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:52:33 INFO - Installing distribute.............................................................................................................................................................................................done. 02:52:36 INFO - Installing pip.................done. 02:52:36 INFO - Return code: 0 02:52:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:52:37 INFO - Reading from file tmpfile_stdout 02:52:37 INFO - Output received: 02:52:37 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:52:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107099b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10709c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf82d9c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e77d30>, '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 0x106d9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e6cbe8>, '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.fBlI8WGF7E/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.fuyUdTtx4U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:52:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:52:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBlI8WGF7E/Render', 02:52:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:37 INFO - 'HOME': '/Users/cltbld', 02:52:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:37 INFO - 'LOGNAME': 'cltbld', 02:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:37 INFO - 'MOZ_NO_REMOTE': '1', 02:52:37 INFO - 'NO_EM_RESTART': '1', 02:52:37 INFO - 'PAGER': '/bin/cat', 02:52:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:37 INFO - 'PWD': '/builds/slave/test', 02:52:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:37 INFO - 'SHELL': '/bin/bash', 02:52:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuyUdTtx4U/Listeners', 02:52:37 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 02:52:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:37 INFO - 'USER': 'cltbld', 02:52:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:37 INFO - 'XPC_FLAGS': '0x0', 02:52:37 INFO - 'XPC_SERVICE_NAME': '0', 02:52:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:38 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:52:38 INFO - Cleaning up... 02:52:38 INFO - Return code: 0 02:52:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107099b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10709c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf82d9c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e77d30>, '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 0x106d9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e6cbe8>, '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.fBlI8WGF7E/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.fuyUdTtx4U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:52:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:52:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBlI8WGF7E/Render', 02:52:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:38 INFO - 'HOME': '/Users/cltbld', 02:52:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:38 INFO - 'LOGNAME': 'cltbld', 02:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:38 INFO - 'MOZ_NO_REMOTE': '1', 02:52:38 INFO - 'NO_EM_RESTART': '1', 02:52:38 INFO - 'PAGER': '/bin/cat', 02:52:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:38 INFO - 'PWD': '/builds/slave/test', 02:52:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:38 INFO - 'SHELL': '/bin/bash', 02:52:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuyUdTtx4U/Listeners', 02:52:38 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 02:52:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:38 INFO - 'USER': 'cltbld', 02:52:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:38 INFO - 'XPC_FLAGS': '0x0', 02:52:38 INFO - 'XPC_SERVICE_NAME': '0', 02:52:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:38 INFO - Downloading/unpacking psutil>=3.1.1 02:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:52:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:42 INFO - Installing collected packages: psutil 02:52:42 INFO - Running setup.py install for psutil 02:52:42 INFO - building 'psutil._psutil_osx' extension 02:52:42 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:52:43 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:52:43 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:52:43 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:52:43 INFO - building 'psutil._psutil_posix' extension 02:52:43 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:52:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:52:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:52:43 INFO - ^ 02:52:43 INFO - 1 warning generated. 02:52:43 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:52:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:43 INFO - Successfully installed psutil 02:52:43 INFO - Cleaning up... 02:52:43 INFO - Return code: 0 02:52:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:43 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 0x107099b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10709c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf82d9c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e77d30>, '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 0x106d9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e6cbe8>, '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.fBlI8WGF7E/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.fuyUdTtx4U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:52:43 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:52:43 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:52:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBlI8WGF7E/Render', 02:52:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:43 INFO - 'HOME': '/Users/cltbld', 02:52:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:43 INFO - 'LOGNAME': 'cltbld', 02:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:43 INFO - 'MOZ_NO_REMOTE': '1', 02:52:43 INFO - 'NO_EM_RESTART': '1', 02:52:43 INFO - 'PAGER': '/bin/cat', 02:52:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:43 INFO - 'PWD': '/builds/slave/test', 02:52:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:43 INFO - 'SHELL': '/bin/bash', 02:52:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuyUdTtx4U/Listeners', 02:52:43 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 02:52:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:43 INFO - 'USER': 'cltbld', 02:52:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:43 INFO - 'XPC_FLAGS': '0x0', 02:52:43 INFO - 'XPC_SERVICE_NAME': '0', 02:52:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:52:44 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:52:44 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:52:44 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:52:44 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:52:44 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:52:44 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:52:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:52:46 INFO - Installing collected packages: mozsystemmonitor 02:52:46 INFO - Running setup.py install for mozsystemmonitor 02:52:46 INFO - Successfully installed mozsystemmonitor 02:52:46 INFO - Cleaning up... 02:52:47 INFO - Return code: 0 02:52:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:47 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 0x107099b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10709c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf82d9c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e77d30>, '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 0x106d9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e6cbe8>, '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.fBlI8WGF7E/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.fuyUdTtx4U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:52:47 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:52:47 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:52:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBlI8WGF7E/Render', 02:52:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:47 INFO - 'HOME': '/Users/cltbld', 02:52:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:47 INFO - 'LOGNAME': 'cltbld', 02:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:47 INFO - 'MOZ_NO_REMOTE': '1', 02:52:47 INFO - 'NO_EM_RESTART': '1', 02:52:47 INFO - 'PAGER': '/bin/cat', 02:52:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:47 INFO - 'PWD': '/builds/slave/test', 02:52:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:47 INFO - 'SHELL': '/bin/bash', 02:52:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuyUdTtx4U/Listeners', 02:52:47 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 02:52:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:47 INFO - 'USER': 'cltbld', 02:52:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:47 INFO - 'XPC_FLAGS': '0x0', 02:52:47 INFO - 'XPC_SERVICE_NAME': '0', 02:52:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:47 INFO - Downloading/unpacking jsonschema==2.5.1 02:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:52:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:52:49 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:52:49 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:52:49 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:52:49 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:52:49 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:52:49 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:52:50 INFO - Downloading functools32-3.2.3-2.tar.gz 02:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:52:50 INFO - warning: no files found matching '*.txt' 02:52:50 INFO - no previously-included directories found matching 'build' 02:52:50 INFO - no previously-included directories found matching 'dist' 02:52:50 INFO - no previously-included directories found matching '.git*' 02:52:50 INFO - Installing collected packages: jsonschema, functools32 02:52:50 INFO - Running setup.py install for functools32 02:52:50 INFO - warning: no files found matching '*.txt' 02:52:50 INFO - no previously-included directories found matching 'build' 02:52:50 INFO - no previously-included directories found matching 'dist' 02:52:50 INFO - no previously-included directories found matching '.git*' 02:52:50 INFO - Successfully installed jsonschema functools32 02:52:50 INFO - Cleaning up... 02:52:50 INFO - Return code: 0 02:52:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107099b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10709c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf82d9c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e77d30>, '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 0x106d9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e6cbe8>, '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.fBlI8WGF7E/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.fuyUdTtx4U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:52:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBlI8WGF7E/Render', 02:52:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:50 INFO - 'HOME': '/Users/cltbld', 02:52:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:50 INFO - 'LOGNAME': 'cltbld', 02:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:50 INFO - 'MOZ_NO_REMOTE': '1', 02:52:50 INFO - 'NO_EM_RESTART': '1', 02:52:50 INFO - 'PAGER': '/bin/cat', 02:52:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:50 INFO - 'PWD': '/builds/slave/test', 02:52:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:50 INFO - 'SHELL': '/bin/bash', 02:52:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuyUdTtx4U/Listeners', 02:52:50 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 02:52:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:50 INFO - 'USER': 'cltbld', 02:52:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:50 INFO - 'XPC_FLAGS': '0x0', 02:52:50 INFO - 'XPC_SERVICE_NAME': '0', 02:52:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:52:50 INFO - Cleaning up... 02:52:50 INFO - Return code: 0 02:52:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107099b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10709c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf82d9c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e77d30>, '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 0x106d9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e6cbe8>, '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.fBlI8WGF7E/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.fuyUdTtx4U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:52:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBlI8WGF7E/Render', 02:52:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:50 INFO - 'HOME': '/Users/cltbld', 02:52:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:50 INFO - 'LOGNAME': 'cltbld', 02:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:50 INFO - 'MOZ_NO_REMOTE': '1', 02:52:50 INFO - 'NO_EM_RESTART': '1', 02:52:50 INFO - 'PAGER': '/bin/cat', 02:52:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:50 INFO - 'PWD': '/builds/slave/test', 02:52:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:50 INFO - 'SHELL': '/bin/bash', 02:52:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuyUdTtx4U/Listeners', 02:52:50 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 02:52:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:50 INFO - 'USER': 'cltbld', 02:52:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:50 INFO - 'XPC_FLAGS': '0x0', 02:52:50 INFO - 'XPC_SERVICE_NAME': '0', 02:52:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:51 INFO - Downloading/unpacking blobuploader==1.2.4 02:52:51 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:52:51 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:52:51 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:52:51 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:52:51 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:52:51 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:52:53 INFO - Downloading blobuploader-1.2.4.tar.gz 02:52:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:52:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:52:53 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:52:53 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:52:53 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:52:53 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:52:53 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:52:53 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:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:52:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:55 INFO - Downloading docopt-0.6.1.tar.gz 02:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:52:55 INFO - Installing collected packages: blobuploader, requests, docopt 02:52:55 INFO - Running setup.py install for blobuploader 02:52:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:52:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:52:55 INFO - Running setup.py install for requests 02:52:55 INFO - Running setup.py install for docopt 02:52:55 INFO - Successfully installed blobuploader requests docopt 02:52:55 INFO - Cleaning up... 02:52:56 INFO - Return code: 0 02:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:56 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:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:56 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:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:56 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 0x107099b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10709c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf82d9c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e77d30>, '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 0x106d9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e6cbe8>, '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.fBlI8WGF7E/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.fuyUdTtx4U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:52:56 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:52:56 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:52:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBlI8WGF7E/Render', 02:52:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:56 INFO - 'HOME': '/Users/cltbld', 02:52:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:56 INFO - 'LOGNAME': 'cltbld', 02:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:56 INFO - 'MOZ_NO_REMOTE': '1', 02:52:56 INFO - 'NO_EM_RESTART': '1', 02:52:56 INFO - 'PAGER': '/bin/cat', 02:52:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:56 INFO - 'PWD': '/builds/slave/test', 02:52:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:56 INFO - 'SHELL': '/bin/bash', 02:52:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuyUdTtx4U/Listeners', 02:52:56 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 02:52:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:56 INFO - 'USER': 'cltbld', 02:52:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:56 INFO - 'XPC_FLAGS': '0x0', 02:52:56 INFO - 'XPC_SERVICE_NAME': '0', 02:52:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:56 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-VM_9Ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:56 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-9oKLO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:56 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-PkYSmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:56 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-L9P7OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:56 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-4Z0NRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:56 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-AUqPs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:57 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-oCcJUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:57 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-l_i6Ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:57 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-ss5QzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:57 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-ieDyUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:57 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-KK5W1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:57 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-9vbLdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:57 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-xsnAYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:57 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-fq07DD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:57 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-OLKBX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:57 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-7v1AKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:58 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-sWACJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:52:58 INFO - Running setup.py install for manifestparser 02:52:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:52:58 INFO - Running setup.py install for mozcrash 02:52:58 INFO - Running setup.py install for mozdebug 02:52:58 INFO - Running setup.py install for mozdevice 02:52:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:52:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:52:58 INFO - Running setup.py install for mozfile 02:52:58 INFO - Running setup.py install for mozhttpd 02:52:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:52:59 INFO - Running setup.py install for mozinfo 02:52:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:52:59 INFO - Running setup.py install for mozInstall 02:52:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:52:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:52:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:52:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:52:59 INFO - Running setup.py install for mozleak 02:52:59 INFO - Running setup.py install for mozlog 02:52:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:52:59 INFO - Running setup.py install for moznetwork 02:52:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:52:59 INFO - Running setup.py install for mozprocess 02:52:59 INFO - Running setup.py install for mozprofile 02:53:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:53:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:53:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:53:00 INFO - Running setup.py install for mozrunner 02:53:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:53:00 INFO - Running setup.py install for mozscreenshot 02:53:00 INFO - Running setup.py install for moztest 02:53:00 INFO - Running setup.py install for mozversion 02:53:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:53:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:53:00 INFO - Cleaning up... 02:53:00 INFO - Return code: 0 02:53:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:00 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 0x107099b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10709c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf82d9c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e77d30>, '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 0x106d9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e6cbe8>, '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.fBlI8WGF7E/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.fuyUdTtx4U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:53:00 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:53:00 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:53:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBlI8WGF7E/Render', 02:53:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:00 INFO - 'HOME': '/Users/cltbld', 02:53:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:00 INFO - 'LOGNAME': 'cltbld', 02:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:00 INFO - 'MOZ_NO_REMOTE': '1', 02:53:00 INFO - 'NO_EM_RESTART': '1', 02:53:00 INFO - 'PAGER': '/bin/cat', 02:53:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:00 INFO - 'PWD': '/builds/slave/test', 02:53:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:00 INFO - 'SHELL': '/bin/bash', 02:53:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuyUdTtx4U/Listeners', 02:53:00 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 02:53:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:00 INFO - 'USER': 'cltbld', 02:53:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:00 INFO - 'XPC_FLAGS': '0x0', 02:53:00 INFO - 'XPC_SERVICE_NAME': '0', 02:53:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-01Bisc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:01 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:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-GlRhdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-roFZ2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:01 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:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-5zab2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-iOKcaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:01 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:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-4f17TM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:01 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:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-xev7aO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:01 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:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-FWf0W7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:01 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:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:01 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-CM3wfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:01 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:53:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:02 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-1UixQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:02 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:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:02 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-aSLHBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:02 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:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:02 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-n7j_Tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:02 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-o5rBfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:02 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:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:02 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-ieuB7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:02 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-vQjYdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:02 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:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:02 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-dPyjOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:02 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-AKDgui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:02 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:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:02 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:53:02 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:53:02 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:53:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:05 INFO - Downloading blessings-1.6.tar.gz 02:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:53:05 INFO - Installing collected packages: blessings 02:53:05 INFO - Running setup.py install for blessings 02:53:05 INFO - Successfully installed blessings 02:53:05 INFO - Cleaning up... 02:53:05 INFO - Return code: 0 02:53:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:53:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:06 INFO - Reading from file tmpfile_stdout 02:53:06 INFO - Current package versions: 02:53:06 INFO - blessings == 1.6 02:53:06 INFO - blobuploader == 1.2.4 02:53:06 INFO - docopt == 0.6.1 02:53:06 INFO - functools32 == 3.2.3-2 02:53:06 INFO - jsonschema == 2.5.1 02:53:06 INFO - manifestparser == 1.1 02:53:06 INFO - mozInstall == 1.12 02:53:06 INFO - mozcrash == 1.0 02:53:06 INFO - mozdebug == 0.1 02:53:06 INFO - mozdevice == 0.49 02:53:06 INFO - mozfile == 1.2 02:53:06 INFO - mozhttpd == 0.7 02:53:06 INFO - mozinfo == 0.9 02:53:06 INFO - mozleak == 0.1 02:53:06 INFO - mozlog == 3.4 02:53:06 INFO - moznetwork == 0.27 02:53:06 INFO - mozprocess == 0.25 02:53:06 INFO - mozprofile == 0.28 02:53:06 INFO - mozrunner == 6.13 02:53:06 INFO - mozscreenshot == 0.1 02:53:06 INFO - mozsystemmonitor == 0.3 02:53:06 INFO - moztest == 0.8 02:53:06 INFO - mozversion == 1.4 02:53:06 INFO - psutil == 3.1.1 02:53:06 INFO - requests == 1.2.3 02:53:06 INFO - wsgiref == 0.1.2 02:53:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:06 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 0x107099b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10709c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf82d9c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e77d30>, '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 0x106d9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e6cbe8>, '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.fBlI8WGF7E/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.fuyUdTtx4U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:53:06 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:53:06 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:53:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBlI8WGF7E/Render', 02:53:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:06 INFO - 'HOME': '/Users/cltbld', 02:53:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:06 INFO - 'LOGNAME': 'cltbld', 02:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:06 INFO - 'MOZ_NO_REMOTE': '1', 02:53:06 INFO - 'NO_EM_RESTART': '1', 02:53:06 INFO - 'PAGER': '/bin/cat', 02:53:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:06 INFO - 'PWD': '/builds/slave/test', 02:53:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:06 INFO - 'SHELL': '/bin/bash', 02:53:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuyUdTtx4U/Listeners', 02:53:06 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 02:53:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:06 INFO - 'USER': 'cltbld', 02:53:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:06 INFO - 'XPC_FLAGS': '0x0', 02:53:06 INFO - 'XPC_SERVICE_NAME': '0', 02:53:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:06 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:53:06 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:53:06 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:53:06 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:53:06 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:53:06 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:53:06 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:53:06 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:53:06 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:53:06 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:53:06 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:53:06 INFO - Cleaning up... 02:53:06 INFO - Return code: 0 02:53:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:06 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 0x107099b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10709c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf82d9c7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e77d30>, '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 0x106d9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e6cbe8>, '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.fBlI8WGF7E/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.fuyUdTtx4U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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:53:06 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:53:06 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:53:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBlI8WGF7E/Render', 02:53:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:06 INFO - 'HOME': '/Users/cltbld', 02:53:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:06 INFO - 'LOGNAME': 'cltbld', 02:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:06 INFO - 'MOZ_NO_REMOTE': '1', 02:53:06 INFO - 'NO_EM_RESTART': '1', 02:53:06 INFO - 'PAGER': '/bin/cat', 02:53:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:06 INFO - 'PWD': '/builds/slave/test', 02:53:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:06 INFO - 'SHELL': '/bin/bash', 02:53:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuyUdTtx4U/Listeners', 02:53:06 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 02:53:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:06 INFO - 'USER': 'cltbld', 02:53:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:06 INFO - 'XPC_FLAGS': '0x0', 02:53:06 INFO - 'XPC_SERVICE_NAME': '0', 02:53:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:53:06 INFO - Cleaning up... 02:53:06 INFO - Return code: 0 02:53:06 INFO - Running post-action listener: _resource_record_post_action 02:53:06 INFO - Running post-action listener: _start_resource_monitoring 02:53:06 INFO - Starting resource monitoring. 02:53:06 INFO - [mozharness: 2017-03-14 09:53:06.670004Z] Finished create-virtualenv step (success) 02:53:06 INFO - [mozharness: 2017-03-14 09:53:06.670988Z] Running install step. 02:53:06 INFO - Running pre-action listener: _resource_record_pre_action 02:53:06 INFO - Running main action method: install 02:53:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:06 INFO - Reading from file tmpfile_stdout 02:53:06 INFO - Detecting whether we're running mozinstall >=1.0... 02:53:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:53:07 INFO - Reading from file tmpfile_stdout 02:53:07 INFO - Output received: 02:53:07 INFO - Usage: mozinstall [options] installer 02:53:07 INFO - Options: 02:53:07 INFO - -h, --help show this help message and exit 02:53:07 INFO - -d DEST, --destination=DEST 02:53:07 INFO - Directory to install application into. [default: 02:53:07 INFO - "/builds/slave/test"] 02:53:07 INFO - --app=APP Application being installed. [default: firefox] 02:53:07 INFO - mkdir: /builds/slave/test/build/application 02:53:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:53:27 INFO - Reading from file tmpfile_stdout 02:53:27 INFO - Output received: 02:53:27 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:53:27 INFO - Running post-action listener: _resource_record_post_action 02:53:27 INFO - [mozharness: 2017-03-14 09:53:27.028317Z] Finished install step (success) 02:53:27 INFO - [mozharness: 2017-03-14 09:53:27.028454Z] Running run-tests step. 02:53:27 INFO - Running pre-action listener: _resource_record_pre_action 02:53:27 INFO - Running main action method: run_tests 02:53:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:53:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:53:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:53:27 INFO - 2017-03-14 02:53:27.043 screenresolution[1941:13848] starting screenresolution argv=screenresolution get 02:53:27 INFO - 2017-03-14 02:53:27.045 screenresolution[1941:13848] Display 0: 1600x1200x32@60 02:53:27 INFO - 2017-03-14 02:53:27.052 screenresolution[1942:13850] starting screenresolution argv=screenresolution list 02:53:27 INFO - Available Modes on Display 0 02:53:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:53:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:53:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:53:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:53:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:53:27 INFO - Intel Iris: 02:53:27 INFO - Chipset Model: Intel Iris 02:53:27 INFO - Type: GPU 02:53:27 INFO - Bus: Built-In 02:53:27 INFO - VRAM (Dynamic, Max): 1536 MB 02:53:27 INFO - Vendor: Intel (0x8086) 02:53:27 INFO - Device ID: 0x0a2e 02:53:27 INFO - Revision ID: 0x0009 02:53:27 INFO - Displays: 02:53:27 INFO - Display: 02:53:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:53:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:53:27 INFO - Display Serial Number: 1600x1200 60 02:53:27 INFO - Main Display: Yes 02:53:27 INFO - Mirror: Off 02:53:27 INFO - Online: Yes 02:53:27 INFO - Rotation: Supported 02:53:27 INFO - Return code: 0 02:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:53:27 INFO - Python 2.7.3 02:53:27 INFO - Return code: 0 02:53:27 INFO - grabbing minidump binary from tooltool 02:53: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:53:27 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 0x106e77d30>, '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 0x106d9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106e6cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:53:27 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:53:27 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:53:27 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:53:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:53:27 INFO - Return code: 0 02:53:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:53:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:53:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:53:27 INFO - ENV: RUST_BACKTRACE is now 1 02:53:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:53:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0246', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0246 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fBlI8WGF7E/Render', 02:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:27 INFO - 'HOME': '/Users/cltbld', 02:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:27 INFO - 'LOGNAME': 'cltbld', 02:53:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:53:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:27 INFO - 'MOZ_NO_REMOTE': '1', 02:53:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:53:27 INFO - 'NO_EM_RESTART': '1', 02:53:27 INFO - 'PAGER': '/bin/cat', 02:53:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:27 INFO - 'PWD': '/builds/slave/test', 02:53:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:27 INFO - 'RUST_BACKTRACE': '1', 02:53:27 INFO - 'SHELL': '/bin/bash', 02:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuyUdTtx4U/Listeners', 02:53:27 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 02:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:27 INFO - 'USER': 'cltbld', 02:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:27 INFO - 'XPC_FLAGS': '0x0', 02:53:27 INFO - 'XPC_SERVICE_NAME': '0', 02:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0246', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:53:27 INFO - mozversion application_buildid: 20170314011736 02:53:27 INFO - mozversion application_changeset: b727bf4a09acc7ebbc5265429665fb846e5c9058 02:53:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:53:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:53:27 INFO - mozversion application_name: Firefox 02:53:27 INFO - mozversion application_remotingname: firefox-dev 02:53:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:53:27 INFO - mozversion application_vendor: Mozilla 02:53:27 INFO - mozversion application_version: 54.0a2 02:53:27 INFO - mozversion platform_buildid: 20170314011736 02:53:27 INFO - mozversion platform_changeset: b727bf4a09acc7ebbc5265429665fb846e5c9058 02:53:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:53:27 INFO - mozversion platform_version: 54.0a2 02:53:27 INFO - using testdate: 1489485207 02:53:27 INFO - actual date: 1489485207 02:53:27 INFO - starting webserver on 'localhost:51297' 02:53:27 INFO - SUITE-START | Running 2 tests 02:53:27 INFO - TEST-START | dromaeo_css 02:53:27 INFO - operating with platform_type : mac_ 02:53:27 INFO - Initialising browser for dromaeo_css test... 02:53:27 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpWgwzVW/profile http://localhost:51297/getInfo.html) 02:53:29 INFO - PROCESS | 1952 | __metrics Screen width/height:1600/1200 02:53:29 INFO - PROCESS | 1952 | colorDepth:24 02:53:29 INFO - PROCESS | 1952 | Browser inner width/height: 1024/689 02:53:29 INFO - PROCESS | 1952 | __metrics 02:53:30 INFO - PROCESS | 1952 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:53:30 INFO - PROCESS | 1952 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:53:30 INFO - TEST-INFO | 1952: exit 0 02:53:30 INFO - Browser initialized. 02:53:30 INFO - Running cycle 1/1 for dromaeo_css test... 02:53:30 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpWgwzVW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:42 INFO - PROCESS | 1954 | RSS: Main: 214327296 02:53:42 INFO - PROCESS | 1954 | 02:56:47 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51297/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51297/tests/dromaeo/cssquery-ext.html) 02:56:49 INFO - PROCESS | 1954 | RSS: Main: 415969280 02:56:49 INFO - PROCESS | 1954 | 02:58:32 INFO - PROCESS | 1954 | ************************* 02:58:32 INFO - PROCESS | 1954 | A coding exception was thrown and uncaught in a Task. 02:58:32 INFO - PROCESS | 1954 | 02:58:32 ERROR - PROCESS | 1954 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:58:32 INFO - PROCESS | 1954 | Full stack: 02:58:32 INFO - PROCESS | 1954 | ************************* 02:59:52 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51297/tests/dromaeo/cssquery-ext.html (next: http://localhost:51297/tests/dromaeo/cssquery-jquery.html) 02:59:53 INFO - PROCESS | 1954 | RSS: Main: 351887360 02:59:53 INFO - PROCESS | 1954 | 03:02:56 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51297/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51297/tests/dromaeo/cssquery-mootools.html) 03:02:56 INFO - PROCESS | 1954 | RSS: Main: 329981952 03:02:56 INFO - PROCESS | 1954 | 03:05:59 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51297/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51297/tests/dromaeo/cssquery-prototype.html) 03:05:59 INFO - PROCESS | 1954 | RSS: Main: 333438976 03:05:59 INFO - PROCESS | 1954 | 03:09:03 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51297/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51297/tests/dromaeo/cssquery-yui.html) 03:09:04 INFO - PROCESS | 1954 | RSS: Main: 330395648 03:09:04 INFO - PROCESS | 1954 | 03:12:07 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:51297/tests/dromaeo/cssquery-yui.html (next: http://localhost:51297/tests/dromaeo/cssquery-dojo.html) 03:12:07 INFO - PROCESS | 1954 | RSS: Main: 410836992 03:12:07 INFO - PROCESS | 1954 | 03:12:07 INFO - PROCESS | 1954 | __start_tp_report 03:12:07 INFO - PROCESS | 1954 | _x_x_mozilla_page_load 03:12:07 INFO - PROCESS | 1954 | _x_x_mozilla_page_load_details 03:12:07 INFO - PROCESS | 1954 | |i|pagename|runs| 03:12:07 INFO - PROCESS | 1954 | |0;dojo.html;3405.6083550391704;3423.8116903570294;3426.4860270959343;3445.5520782298313;3493.301339732053;6010.549208809341;6046.7581296748185;6097.809298190727;6130.528673118453;6143.600665956709;5987.6407415555095;6035.9698201509045;6048.546359023069;6061.484773794233;6072.908906366408;5374.6506477078865;5405.5135037846585;5407.783688652449;5418.83743487696;5526.640768350065;5343.7060961647285;5354.892902141974;5519.448055194469;5519.889602207953;5523.475269849378;5390.326209223847;5435.510804027636;5443.047466693332;5447.45525447456;5464;5459.890802183954;5462.344518657746;5462.836114916519;5468.699221542814;5480.26016487775;5289.603279753996;5401;5431.755570999315;5445.401005889349;5462.289902312674;6061.878762424771;6071.241094863142;6092.939070609282;6102.26772787264;6113.052476866093;5265.894682106336;6347.936520634781;6368.554201205918;6372.107904893319;6380.553361264713;6392.520560957901;6392.872142557169;6401.231852177769;6415.967920160369;6451.967740161316;6112.052631842072;6155.630662160284;6165.815025549241;6173.969130154321;6198.3801619838105;6675.365840245217;6682.732690692415;6699.899501507482;6703.296153903867;6704.83237919051;6200.162977998003;6264.123022776815;6279.3720627937755;6355;6367.204099487564;6346.9682651586445;6354.904676429857;6400.519961002943;6483.157189565326;6509.544331896816;6431.935680643133;6432.163818703539;6433.710483028275;6446.580972236789;6450.161479007699;6448.097266382711;6458.2895881453005;6464.030395440722;6485.254195767548;6487;5097.158968770112;5146.330976972969;5150.175971844487;5153.484651534816;5236.345456817898;4629.004763975761;4649.418822647169;4654;4665.370175026328;4677.812887484462;5864.618799778001;5905.498032667186;5907.232059832194;5907.586468947218;5910.645361278337;6239.594426362362;6367.808965731036;6370.872582548416;6376.521760867953;6392.872142557123;6098.664573448503;6108.969455152695;6109;6134.171886795226;6143.692815359214;5735.799247026417;5739.13912913058;5740;5740.0815869460685;5742.856428589319;6421.261554921057;6474.902876456763;6739.6967136478;6763.864722705518;6764.289749576322;6367.044943258548;6370.58591191571;6373.521985850987;6377.713002914973;6381.489480841615;6628.5691430056895;6653.833654158685;6716.261211266659;6751.156105486814;6753.358430949052;6451.580647257913;6459.806205813833;6464.385883341075;6477.967610161919;6480.157579514633;6495.512836537184;6504.4796416285635;6509.707063182263;6525.184351956005;6546.214454265519;6179.196704428396;6180.721867516063;6238.001919692827;6289.559730818799;6313.494920406449;6221.595596286227;6294.842628934313;6295.622262664255;6317.084022816758;6380.9361906380345;6306.873862522632;6338.651374174465;6340.270868849957;6343.746250149942;6345.0482427636225;6230.408111229426;6375.458086062737;6388.009858471944;6402.6158430494315;6413.967930160319;6124.418180272867;6129.358790882775;6189.5048396129105;6203.968980155251;6335 03:12:07 INFO - PROCESS | 1954 | |1;ext.html;729.6133049483772;787.519613036048;811.5820352518452;867.6225841758835;878.3061381508609;27325.45349093017;30839.074827755147;37677;38226.426603600965;38351.808240958824;38071.42892856609;38300.808495957484;38414.423783643266;39788.80105599468;39798.0050498737;9070.27437804974;9240.353175277733;9263.444193348421;9270.443773373585;9272.7681807955;7362.153352364493;7554.508956917783;10860.076893464025;11013.669589912315;11182.384968826711;11029.61396351128;11051.502682379312;11061.889381106166;11068.667939961813;11091.611793587226;11012.339259644406;11032.172587055962;11038.558457661684;11042.503087361089;11043.558257669683;7192.172900116501;7348.669309881015;10470.685879423629;10629.73425664357;10658.946705266424;37967.620323796684;38125.80937095325;38138.80930595329;38156.80921595374;38158.42762358567;3797.3354662933875;3815.5802861685193;3843.673287770543;3891.630295121959;3892.5767964688835;26370.47259054808;27471;28303;28408.00571979971;28423.85788071067;3010.909672709822;3019.743321817648;3119.32934419101;3140.905772826819;3245.140037889961;279180;316599;319949;322879;322892;49673.25490117651;49820;49861.750691246314;50010.74994625076;50156.74921625369;51834.963300733776;51977.96044079097;52031;52035;52077;14265.42938282478;14371;14391;14395.136291822524;14413.423463061361;10699.518521666543;12648.367581621067;12648.620541383772;12658;12681.93659031699;9999.150072243941;10046.949765251127;13573.981951353688;13649.454021839214;13792.241426721626;5665.838503106853;5677.318721753416;6062.605930614496;6111.480524155408;6118.357572454917;1134.6085600467825;1137.6643890052455;1138.7950168969498;1140.2987162894926;1187.4478367559127;21861.78138218629;26755.598666020025;26893.596596051077;27011.864940675172;27153.321166970985;1236.7093732972744;1249.0382405547678;1267.2833979906459;1288.9806652900213;1296.3777386854174;13473.393697283645;13680.247586382844;13793.655158620913;13818.65453363674;13857.930710346383;447355;447546;447885;449765;450359;54333.72833135809;54696.72651636796;54743.45256547463;54785.1782223267;54873.725631371584;1420.566727148209;1455.4978532406303;1458.5697219320539;1463.7731151671508;1466.8899832512604;24435.75564244335;25121.748782511942;25851.0952116675;25863.353416164748;26005.739942600332;43561.91095222645;43935.78032109819;44112;44176.7791161055;45399.77300113478;433167;504976;506888;508006;510595;30321.848390757907;30654.693453065185;30676.386472269984;30681;30689.386212276077;27820.74806633747;34869;35607.287854242255;36416.08959776027;37811.43282850814;30321.696783031886;30702.692973069985;30768.923087691823;30813.383732325678;31775.04674859758;23308.883455582614;30160.24599385033;30652.386952261277;31295.687043129277;31490;30660.926867559527;31171.84414077915;31293.530597040608;31305.8434707825;31337.529937050505;26957.191284261502;27844.721552784213;27942.44115117727;27988.86005569959;28127.015554455495;15970.680586387974;21970.19149794951;22003;22075.344349173556;22258.88870555637 03:12:07 INFO - PROCESS | 1954 | |2;jquery.html;357.4905759293007;388.49689651900786;411.8126252555086;420.657164411005;454.1552711955762;12441.751164976695;14241;16540.917295413536;19980.60038799227;20558.69161962572;18456.354027609035;19304.613907721836;20382.898085509587;21932.561348773015;21981;6043.305019922699;6167.907481387771;6269.749210031593;6357.364263573651;6364.840878978016;6165.352637972993;6225.2529696436495;6232.407921247474;6250.843728906768;6266.467350275232;4045.777482238476;4185.932587190262;4223.97888010561;6066.423689749488;7182.892256616155;6897.586144831326;7107.005019297302;7129.643517824088;7148.49960502765;7160.212376638539;6964.547304425196;6967.094277743911;6969.6166710830885;6972.58164510131;6979;23637.763622363902;23970.041198352046;24343.44393838657;24559.50880982388;24710;2847.9288017799513;2872.5116730155714;2885.2786803299177;2906.2734316420897;2908.6800451950267;15455.459058932884;15471.226438678133;15627.906046576743;15806.525804225892;15951.13975758717;1980.8118228768244;1987.6322880267053;2042.5804066174014;2047.7440319960006;2049.5081180516718;114695.42652286768;117578;126171.73828261692;151302.24348878296;163260;15166.545003649908;17642.94142351463;18609.348672796386;19517.609647807247;19620.509487262934;26567.86716066446;30258.697413026028;30259.546106808415;30338.241543961136;30408.087757367313;9504.904950950402;9945.403275803475;10007.599696012077;10015.198784097254;10164.33931794431;6154.292256390572;7863.741801311877;8273.1726827318;8394.622241999003;8539.48763074205;7025.718971241093;8769.91230087691;8938.50838203905;8962.641494340154;8973.93599472125;3867.439221312894;3910.511186101737;3947.8420863165725;3953.288408086572;3965.5439624442984;874.9325822496544;911.6399022386121;971.820213260549;1000.9749756256152;1008.6620981971122;15784.816138789636;19027.429177124708;19667.803321966883;19795.20819167246;20181.192752290037;866.9653213871375;902.1700035966926;905.6649039855296;972.7033254857195;981.4209616326401;9576.042395760507;10278.537465814057;10475.319104258198;10491;10523.473826308655;714127;756208;759527;809973;817077;151573;154188;157070;159501.20249398678;163193;1179.6814859987926;1215.1433239566084;1263.7030297879992;1265.0638527489775;1270.2949862826035;18032.639347213244;18278.543036424195;18369.72445413293;18836.986082226776;19152.329668462095;52831.47168528265;57596.71201643965;57753;59948.40051599603;60202.89289874833;77395;77706.2229377699;77791;79654.6017269933;79902.60048699952;8567.614457349559;9430.151286384258;10020.398776073458;10301.021402966706;10515.526801293807;11626.128040396836;11871.465784039912;11915.52337906474;12078.577249796215;12291.32397718134;10407.427591482541;10416.427096509764;10633.840492392466;10752.946235269086;10766.246362754531;9933.900660993297;10262.794744105226;10304.175665946856;10310.32982856112;10508.316959397614;9473.621055157992;10547;10752.83870741955;10845.620403285848;10871.456427178451;8789.208971192624;10280.845787313046;10472.68581942543;10549.525271362654;10571.94714026425;10360.119389851947;10489.895101048893;10533.26267161322;10556.577736890438;10701.41502596639 03:12:07 INFO - PROCESS | 1954 | |3;mootools.html;1531.3721374236566;1539.5073576455532;1568.9137097459636;1591.9124448155353;1595.9920200398997;10708.946455267722;11267.887321126796;11295.039921606653;11307.491162897668;11322.773544529104;10710.678679639605;10907.945460272707;11128.38793866337;11182.105431565476;11268.774624507505;2351.259353303708;2384.177458776719;2385.8210634202505;2391.689080419552;2393.4614711689906;1994;2003.699445083242;2323.767623237671;2372.074890792592;2376.7504412036747;2339.63735620979;2352.7882490575844;2365.136725095345;2367.609344458171;2368.95262094758;2293.140072472823;2314.432963923841;2326.639370897514;2327.104064934995;2328.918487852917;2300.1489448903844;2371.8814059296965;2374.7150341958904;2376.7742064503846;2377.5363804058215;9333.90666093344;11020.063294619968;11107.055900248488;11109;11126.443677816158;4677.789499472532;5527.060399732015;5688.772449102031;5702.971485142589;5710;3323.18581947422;3405.1316914186973;3600.837962291703;3602.2075143468396;3606.6213047629885;1109.4674556212983;1147.4836323654388;1209.558511143435;1216.8843959823803;1222.2238878312335;12316.5073397064;12568.685782855411;12744.80882786759;15345.846541534553;15404.53786386399;4083.4283200351974;4222.4299719538085;4229.598188172119;4232.307077169157;4447.466304043535;11430.942845285721;11436.428178591037;11458.484368203452;11490.080793536497;11520.193586448868;5546.251256080458;5552.972235138798;5554.972225138848;5555.194496797942;5558.833235002957;4843.927341089887;5095.15929871567;5160.458151893997;5164.92252616211;5171.172612382076;3046.405950839565;3748.100455890621;3783.621637836194;3827.158025234444;3828.578856325802;836.3560058754725;973.6543527047796;977.3842479238034;984.4290311619244;988.7330420786491;922.8246633139817;934.9906500934903;940.8118376324762;946.9242460603135;976.3312131190157;6614.140161778938;6646.202455705346;6676.198856137197;6868.450523958071;6873.278305777922;993.7863359377768;1001.9248556358302;1003.5383723487132;1049.2078480746986;1058.7564860082225;4152.750834949913;4177.3316269396755;4180.163967206571;4220.514640816284;4259.574042595716;13326.200427974352;13779.517716879862;13805.585832425044;13824.377902994389;13824.930875345559;12939;13454.52909148175;13575.253361065235;13735.175889446666;13748.65628359299;9936.701898943043;10246.53890574911;10253.58985640566;10255.641052563124;10257.025582569644;6536.182977127859;6803.183617965876;6981.685824137824;6983.266756990646;7038.683259253448;12094.637160885188;12442.31567263773;12444.626661200178;12494.937525312678;12501.624951251477;12432;12530.624081277576;12569.748605028031;12882.613521594367;12924.966002719571;9194.49430281341;9509.524523773645;9512.762180945256;9512.857307140537;9522.190613797904;8592.78518037029;10161.390316581028;10293.794124117327;10384.221183411426;10397.740056498647;9007.144321289466;9189.724308270763;9226.907730922605;9306.395084319498;9454;8878.911210887809;8928.017918028881;8973.865392018994;9043.276537877086;9058.411203271766;7848.097468790934;8035.55804430762;8051.919480805117;8054.597270136587;8055.476394034369;5818;5883.176355310175;5926.970365148147;6035.728392222449;6086.817395478142;5841.4450627190345;6033.366496517802;6056.9697151513965;6082.239720034996;6264.373562643699 03:12:07 INFO - PROCESS | 1954 | |4;prototype.html;307.6093361430983;316.41305378522844;378.9204267103908;385.0182035808687;386.1196472043738;4941.925871111936;5015.3730783652045;5040.117979353608;5056.69659820411;5122.410922743886;4227.746335219889;4854.4514130081725;4855.854324370266;5010.922651629908;5013.598912087034;3210.839458027101;3413.259237788721;3893.6301051400073;3987.581303963071;4019.974906398879;3415.453527435611;4095.5188090123456;4099.098198396348;4113.814878330482;4155.376693495985;4066.3493840985448;4073.8370465181506;4102.154030686188;4151.937720934188;4178.22702799983;3548.0793722936173;3754.1365485938113;3801.7454240100838;3952.9011774705864;4010.5509262034625;3211.1260421922484;3371.477420999749;3626.2412729826015;3764.4729737836724;3780.867669631577;4152.896177595554;4209.295235429656;4537.82352353354;4557.635389168859;4794.9280760788615;4733.360996265529;4750.144973904696;4771.761411929424;4793.089313030548;4867.756612169413;4639.028412924494;4801.423829140491;4971.0554994551285;4989.525995030466;5278.709670968095;4230.069384735353;4242.957570424287;4258.276093064186;4289.721168124062;4304.504981927056;5051.045138593964;5129.230615407681;5264.92102618461;5371.892562148774;5392.352917649907;4200.327947528381;4505.279155335131;4705.60002399793;4748.976255118771;4779.426468823764;4299.290617048215;4365.079365079355;4483.583670084964;4567.520410356931;4610.792514336863;3921.568627450978;4752.643551733634;4932.605391568666;4993.850184494471;5051.747412629427;4273.67947403946;4860.809101770089;5058;5250.7637156328055;5307.389650190277;1460.5399299220924;1514.4472267622239;1538.0774032459426;1631.7144499712504;1666.6583350413136;1236.9010479161645;1302.3867694042508;1364.7543442180504;1384.508499482669;1387.6392138044182;4176.749395036308;4244.405783190356;4449.86528435247;4514.532776847538;4816.8073277069225;4729.456112547033;4791.712497250176;5463.508284254357;5481.56070548602;5512.6692398456225;4276.3799249109325;4314.144917685426;4364.41080454141;4664.416947881515;4741.146593613183;2260.3896947823996;2397.688300520921;2486.532945562127;2828.349479619699;2830.306574889124;5087.64386492942;5492.780288788404;5559.971405290034;5575.553955683617;5616.9157462638095;4976.377952755905;5048.72232027242;5217.339157029942;5549.667019978814;5562.886103280727;5343;5406.324209473816;5443.510084092451;5487.368952570346;5651.095824668033;4734.5559604321015;5365.865853353541;5470.8085217017215;5581.6371935824045;5593.468620481048;4660.440747110369;5137.922931155961;5319.122344813062;5340.626156169031;5506.504414602705;5243.8164664236565;5330.853866418739;5340.412554619066;5465.344158700981;5634.070378387521;3462.342154990544;4119.8970025748395;4123.237201117803;4332.573758695141;4348.847790327323;4852.902941941071;4972.950270497394;4986.7257300848805;5203;5458.426865179099;5236.9738151309;5237.2667826505085;5277.683338999673;5278.97360513195;5298.682079075268;5213.661112027706;5221.582273418041;5232.424433312256;5305.257263983122;5339.3058902342445;4157.9376309355985;4921.997581475369;5105.2086926526445;5147.639665223398;5155.793768249378;4185.393117997813;4781.207047357241;5115.283860259492;5242.842714718565;5287.339082614673;3990;4406.691531592758;4533.387992620954;4549.044700612908;4914.476512281204 03:12:07 INFO - PROCESS | 1954 | |5;yui.html;724.9238829922855;738.117949050884;765.2118318132323;767.6238643064896;831.1854382704947;15233.542993710193;15817.36730530779;15935.362585496567;16068.678626427465;16285.674286514262;14479.420823167087;14785.778213326808;14845.703085938301;14932.253387330617;15053.698926021472;923.7598224461638;954.3176628710471;961.1829944547114;961.3126614470652;965.9420434773901;915.4919019943928;945.2768631996528;948.2461443152711;952.1430712358863;959.357230655459;999.6151481679569;1000.8348622477318;1005.2159315733703;1006.014106175948;1007.1841808135397;998.7952469743685;1000.2548101664233;1000.7648202672366;1001.9348742331762;1002.6290272599113;743.7917383132732;745.5489428895548;747.2676776758807;749.9287567681062;750.1448348882278;15812.683746325125;16117.597060073593;16175.948563343345;16464.42374516898;16793.496195114167;13140.86859131406;13919.791203131961;14000.22998735069;14184.29078546079;14314.284285785669;10582;11744;11809.586664466702;11936.462859171359;11997.760044799143;2878.654561452639;3286.2441638423297;3327.900162995114;3379.5606571145595;3435.57055368079;101570.4921475388;120298.39850800777;121263.3936830319;128403;128578.3571082148;10514.684559463229;10765.30025548337;10796.838047429295;10973.341599504056;11418.029467495357;22065.669014964787;22588.209412670476;22599;22644.660330095063;22655.546889062458;7535.111763501687;7662.770116896502;7663.463557551029;7748.92251077482;7828.960855195687;4287.292596721569;4376.737395756265;4409.272470042407;4417.226985277628;4431.512533621299;3238.6761323867427;3346.782459140148;3347.0460918638073;3349.497575363715;3355.9496607550905;573.7446836157869;583.7577405376805;584.6287607369266;584.7427132061879;586.293516312842;558.7234319012034;576.824068659063;597.2832600878962;638.8881945659491;647.8607099473636;9216.815663686688;10034.953544647902;10228.590856365661;10397.896021039693;10722.73193170177;545.9972700136553;552.2241251042292;572.5562688916124;612.7365232949875;629.6505439481041;4971.130052240844;5049.9585540064045;5101.591872650179;5114.948850511521;5126.92309615356;88029.11970880209;103279;105751.88496230186;106328;107360.24239151592;56697;59579.687383142795;73959.63020184972;77161.61419192981;91269.54365228131;60675.786484270066;70733.64633176802;72887;84093.57953210195;88866;11151.179470832043;11287.266327689002;11425;11454.828177577176;11545.595904143314;53026.40920772383;53471.732641336544;53601;55523.72238138784;56119.71940140273;47621.76189119032;63910.68044659933;68158.29604259934;69072.6546367285;69630;10993.61522346714;13904.899494357991;13952.511662091778;14124.152550846982;14990.250487475365;14922.776158357416;15352.769708454158;15451.304691289144;15472.690546189238;15750.291236894138;13873.930630347188;13991.930040349733;14076.718465630835;14425;14446.783298250744;13712.862871371159;13970.646885219863;14257.429702812185;14293.35679894428;14949.327280272631;13559.389827457591;13802.585922422344;13993.440262389797;14011.929940350641;14162.937779666772;11323;11521.423928803693;11713.941430292794;11765.529378825093;11823.467943942715;10933.398663073607;11054.889451105386;11106.555737770399;11113.722156946142;11240.83138752903 03:12:07 INFO - PROCESS | 1954 | __end_tp_report 03:12:07 INFO - PROCESS | 1954 | __start_cc_report 03:12:07 INFO - PROCESS | 1954 | _x_x_mozilla_cycle_collect,2140 03:12:07 INFO - PROCESS | 1954 | __end_cc_report 03:12:07 INFO - PROCESS | 1954 | __startTimestamp1489486327780__endTimestamp 03:12:07 INFO - PROCESS | 1954 | 03:12:07 INFO - PROCESS | 1954 | ------- Summary: start ------- 03:12:07 INFO - PROCESS | 1954 | Number of tests: 6 03:12:07 INFO - PROCESS | 1954 | 03:12:07 INFO - PROCESS | 1954 | [#0] dojo.html Cycles:165 Average:5997.56 Median:6203.97 stddev:664.47 (10.7%) stddev-sans-first:634.64 03:12:07 INFO - PROCESS | 1954 | Values: 3405.6 3423.8 3426.5 3445.6 3493.3 6010.5 6046.8 6097.8 6130.5 6143.6 5987.6 6036.0 6048.5 6061.5 6072.9 5374.7 5405.5 5407.8 5418.8 5526.6 5343.7 5354.9 5519.4 5519.9 5523.5 5390.3 5435.5 5443.0 5447.5 5464.0 5459.9 5462.3 5462.8 5468.7 5480.3 5289.6 5401.0 5431.8 5445.4 5462.3 6061.9 6071.2 6092.9 6102.3 6113.1 5265.9 6347.9 6368.6 6372.1 6380.6 6392.5 6392.9 6401.2 6416.0 6452.0 6112.1 6155.6 6165.8 6174.0 6198.4 6675.4 6682.7 6699.9 6703.3 6704.8 6200.2 6264.1 6279.4 6355.0 6367.2 6347.0 6354.9 6400.5 6483.2 6509.5 6431.9 6432.2 6433.7 6446.6 6450.2 6448.1 6458.3 6464.0 6485.3 6487.0 5097.2 5146.3 5150.2 5153.5 5236.3 4629.0 4649.4 4654.0 4665.4 4677.8 5864.6 5905.5 5907.2 5907.6 5910.6 6239.6 6367.8 6370.9 6376.5 6392.9 6098.7 6109.0 6109.0 6134.2 6143.7 5735.8 5739.1 5740.0 5740.1 5742.9 6421.3 6474.9 6739.7 6763.9 6764.3 6367.0 6370.6 6373.5 6377.7 6381.5 6628.6 6653.8 6716.3 6751.2 6753.4 6451.6 6459.8 6464.4 6478.0 6480.2 6495.5 6504.5 6509.7 6525.2 6546.2 6179.2 6180.7 6238.0 6289.6 6313.5 6221.6 6294.8 6295.6 6317.1 6380.9 6306.9 6338.7 6340.3 6343.7 6345.0 6230.4 6375.5 6388.0 6402.6 6414.0 6124.4 6129.4 6189.5 6204.0 6335.0 03:12:07 INFO - PROCESS | 1954 | 03:12:07 INFO - PROCESS | 1954 | [#1] ext.html Cycles:180 Average:54737.25 Median:30735.81 stddev:113191.94 (368.3%) stddev-sans-first:113436.84 03:12:07 INFO - PROCESS | 1954 | Values: 729.6 787.5 811.6 867.6 878.3 27325.5 30839.1 37677.0 38226.4 38351.8 38071.4 38300.8 38414.4 39788.8 39798.0 9070.3 9240.4 9263.4 9270.4 9272.8 7362.2 7554.5 10860.1 11013.7 11182.4 11029.6 11051.5 11061.9 11068.7 11091.6 11012.3 11032.2 11038.6 11042.5 11043.6 7192.2 7348.7 10470.7 10629.7 10658.9 37967.6 38125.8 38138.8 38156.8 38158.4 3797.3 3815.6 3843.7 3891.6 3892.6 26370.5 27471.0 28303.0 28408.0 28423.9 3010.9 3019.7 3119.3 3140.9 3245.1 279180.0 316599.0 319949.0 322879.0 322892.0 49673.3 49820.0 49861.8 50010.7 50156.7 51835.0 51978.0 52031.0 52035.0 52077.0 14265.4 14371.0 14391.0 14395.1 14413.4 10699.5 12648.4 12648.6 12658.0 12681.9 9999.2 10046.9 13574.0 13649.5 13792.2 5665.8 5677.3 6062.6 6111.5 6118.4 1134.6 1137.7 1138.8 1140.3 1187.4 21861.8 26755.6 26893.6 27011.9 27153.3 1236.7 1249.0 1267.3 1289.0 1296.4 13473.4 13680.2 13793.7 13818.7 13857.9 447355.0 447546.0 447885.0 449765.0 450359.0 54333.7 54696.7 54743.5 54785.2 54873.7 1420.6 1455.5 1458.6 1463.8 1466.9 24435.8 25121.7 25851.1 25863.4 26005.7 43561.9 43935.8 44112.0 44176.8 45399.8 433167.0 504976.0 506888.0 508006.0 510595.0 30321.8 30654.7 30676.4 30681.0 30689.4 27820.7 34869.0 35607.3 36416.1 37811.4 30321.7 30702.7 30768.9 30813.4 31775.0 23308.9 30160.2 30652.4 31295.7 31490.0 30660.9 31171.8 31293.5 31305.8 31337.5 26957.2 27844.7 27942.4 27988.9 28127.0 15970.7 21970.2 22003.0 22075.3 22258.9 03:12:07 INFO - PROCESS | 1954 | 03:12:07 INFO - PROCESS | 1954 | [#2] jquery.html Cycles:180 Average:42104.59 Median:24156.74 stddev:128392.14 (531.5%) stddev-sans-first:128714.05 03:12:07 INFO - PROCESS | 1954 | Values: 357.5 388.5 411.8 420.7 454.2 12441.8 14241.0 16540.9 19980.6 20558.7 18456.4 19304.6 20382.9 21932.6 21981.0 6043.3 6167.9 6269.7 6357.4 6364.8 6165.4 6225.3 6232.4 6250.8 6266.5 4045.8 4185.9 4224.0 6066.4 7182.9 6897.6 7107.0 7129.6 7148.5 7160.2 6964.5 6967.1 6969.6 6972.6 6979.0 23637.8 23970.0 24343.4 24559.5 24710.0 2847.9 2872.5 2885.3 2906.3 2908.7 15455.5 15471.2 15627.9 15806.5 15951.1 1980.8 1987.6 2042.6 2047.7 2049.5 114695.4 117578.0 126171.7 151302.2 163260.0 15166.5 17642.9 18609.3 19517.6 19620.5 26567.9 30258.7 30259.5 30338.2 30408.1 9504.9 9945.4 10007.6 10015.2 10164.3 6154.3 7863.7 8273.2 8394.6 8539.5 7025.7 8769.9 8938.5 8962.6 8973.9 3867.4 3910.5 3947.8 3953.3 3965.5 874.9 911.6 971.8 1001.0 1008.7 15784.8 19027.4 19667.8 19795.2 20181.2 867.0 902.2 905.7 972.7 981.4 9576.0 10278.5 10475.3 10491.0 10523.5 714127.0 756208.0 759527.0 809973.0 817077.0 151573.0 154188.0 157070.0 159501.2 163193.0 1179.7 1215.1 1263.7 1265.1 1270.3 18032.6 18278.5 18369.7 18837.0 19152.3 52831.5 57596.7 57753.0 59948.4 60202.9 77395.0 77706.2 77791.0 79654.6 79902.6 8567.6 9430.2 10020.4 10301.0 10515.5 11626.1 11871.5 11915.5 12078.6 12291.3 10407.4 10416.4 10633.8 10752.9 10766.2 9933.9 10262.8 10304.2 10310.3 10508.3 9473.6 10547.0 10752.8 10845.6 10871.5 8789.2 10280.8 10472.7 10549.5 10571.9 10360.1 10489.9 10533.3 10556.6 10701.4 03:12:07 INFO - PROCESS | 1954 | 03:12:07 INFO - PROCESS | 1954 | [#3] mootools.html Cycles:180 Average:6688.95 Median:2719.93 stddev:4183.37 (153.8%) stddev-sans-first:4177.16 03:12:07 INFO - PROCESS | 1954 | Values: 1531.4 1539.5 1568.9 1591.9 1596.0 10708.9 11267.9 11295.0 11307.5 11322.8 10710.7 10907.9 11128.4 11182.1 11268.8 2351.3 2384.2 2385.8 2391.7 2393.5 1994.0 2003.7 2323.8 2372.1 2376.8 2339.6 2352.8 2365.1 2367.6 2369.0 2293.1 2314.4 2326.6 2327.1 2328.9 2300.1 2371.9 2374.7 2376.8 2377.5 9333.9 11020.1 11107.1 11109.0 11126.4 4677.8 5527.1 5688.8 5703.0 5710.0 3323.2 3405.1 3600.8 3602.2 3606.6 1109.5 1147.5 1209.6 1216.9 1222.2 12316.5 12568.7 12744.8 15345.8 15404.5 4083.4 4222.4 4229.6 4232.3 4447.5 11430.9 11436.4 11458.5 11490.1 11520.2 5546.3 5553.0 5555.0 5555.2 5558.8 4843.9 5095.2 5160.5 5164.9 5171.2 3046.4 3748.1 3783.6 3827.2 3828.6 836.4 973.7 977.4 984.4 988.7 922.8 935.0 940.8 946.9 976.3 6614.1 6646.2 6676.2 6868.5 6873.3 993.8 1001.9 1003.5 1049.2 1058.8 4152.8 4177.3 4180.2 4220.5 4259.6 13326.2 13779.5 13805.6 13824.4 13824.9 12939.0 13454.5 13575.3 13735.2 13748.7 9936.7 10246.5 10253.6 10255.6 10257.0 6536.2 6803.2 6981.7 6983.3 7038.7 12094.6 12442.3 12444.6 12494.9 12501.6 12432.0 12530.6 12569.7 12882.6 12925.0 9194.5 9509.5 9512.8 9512.9 9522.2 8592.8 10161.4 10293.8 10384.2 10397.7 9007.1 9189.7 9226.9 9306.4 9454.0 8878.9 8928.0 8973.9 9043.3 9058.4 7848.1 8035.6 8051.9 8054.6 8055.5 5818.0 5883.2 5927.0 6035.7 6086.8 5841.4 6033.4 6057.0 6082.2 6264.4 03:12:07 INFO - PROCESS | 1954 | 03:12:07 INFO - PROCESS | 1954 | [#4] prototype.html Cycles:180 Average:4374.10 Median:4749.56 stddev:1204.76 (25.4%) stddev-sans-first:1168.83 03:12:07 INFO - PROCESS | 1954 | Values: 307.6 316.4 378.9 385.0 386.1 4941.9 5015.4 5040.1 5056.7 5122.4 4227.7 4854.5 4855.9 5010.9 5013.6 3210.8 3413.3 3893.6 3987.6 4020.0 3415.5 4095.5 4099.1 4113.8 4155.4 4066.3 4073.8 4102.2 4151.9 4178.2 3548.1 3754.1 3801.7 3952.9 4010.6 3211.1 3371.5 3626.2 3764.5 3780.9 4152.9 4209.3 4537.8 4557.6 4794.9 4733.4 4750.1 4771.8 4793.1 4867.8 4639.0 4801.4 4971.1 4989.5 5278.7 4230.1 4243.0 4258.3 4289.7 4304.5 5051.0 5129.2 5264.9 5371.9 5392.4 4200.3 4505.3 4705.6 4749.0 4779.4 4299.3 4365.1 4483.6 4567.5 4610.8 3921.6 4752.6 4932.6 4993.9 5051.7 4273.7 4860.8 5058.0 5250.8 5307.4 1460.5 1514.4 1538.1 1631.7 1666.7 1236.9 1302.4 1364.8 1384.5 1387.6 4176.7 4244.4 4449.9 4514.5 4816.8 4729.5 4791.7 5463.5 5481.6 5512.7 4276.4 4314.1 4364.4 4664.4 4741.1 2260.4 2397.7 2486.5 2828.3 2830.3 5087.6 5492.8 5560.0 5575.6 5616.9 4976.4 5048.7 5217.3 5549.7 5562.9 5343.0 5406.3 5443.5 5487.4 5651.1 4734.6 5365.9 5470.8 5581.6 5593.5 4660.4 5137.9 5319.1 5340.6 5506.5 5243.8 5330.9 5340.4 5465.3 5634.1 3462.3 4119.9 4123.2 4332.6 4348.8 4852.9 4973.0 4986.7 5203.0 5458.4 5237.0 5237.3 5277.7 5279.0 5298.7 5213.7 5221.6 5232.4 5305.3 5339.3 4157.9 4922.0 5105.2 5147.6 5155.8 4185.4 4781.2 5115.3 5242.8 5287.3 3990.0 4406.7 4533.4 4549.0 4914.5 03:12:07 INFO - PROCESS | 1954 | 03:12:07 INFO - PROCESS | 1954 | [#5] yui.html Cycles:180 Average:20547.06 Median:19429.58 stddev:29568.30 (152.2%) stddev-sans-first:29613.78 03:12:07 INFO - PROCESS | 1954 | Values: 724.9 738.1 765.2 767.6 831.2 15233.5 15817.4 15935.4 16068.7 16285.7 14479.4 14785.8 14845.7 14932.3 15053.7 923.8 954.3 961.2 961.3 965.9 915.5 945.3 948.2 952.1 959.4 999.6 1000.8 1005.2 1006.0 1007.2 998.8 1000.3 1000.8 1001.9 1002.6 743.8 745.5 747.3 749.9 750.1 15812.7 16117.6 16175.9 16464.4 16793.5 13140.9 13919.8 14000.2 14184.3 14314.3 10582.0 11744.0 11809.6 11936.5 11997.8 2878.7 3286.2 3327.9 3379.6 3435.6 101570.5 120298.4 121263.4 128403.0 128578.4 10514.7 10765.3 10796.8 10973.3 11418.0 22065.7 22588.2 22599.0 22644.7 22655.5 7535.1 7662.8 7663.5 7748.9 7829.0 4287.3 4376.7 4409.3 4417.2 4431.5 3238.7 3346.8 3347.0 3349.5 3355.9 573.7 583.8 584.6 584.7 586.3 558.7 576.8 597.3 638.9 647.9 9216.8 10035.0 10228.6 10397.9 10722.7 546.0 552.2 572.6 612.7 629.7 4971.1 5050.0 5101.6 5114.9 5126.9 88029.1 103279.0 105751.9 106328.0 107360.2 56697.0 59579.7 73959.6 77161.6 91269.5 60675.8 70733.6 72887.0 84093.6 88866.0 11151.2 11287.3 11425.0 11454.8 11545.6 53026.4 53471.7 53601.0 55523.7 56119.7 47621.8 63910.7 68158.3 69072.7 69630.0 10993.6 13904.9 13952.5 14124.2 14990.3 14922.8 15352.8 15451.3 15472.7 15750.3 13873.9 13991.9 14076.7 14425.0 14446.8 13712.9 13970.6 14257.4 14293.4 14949.3 13559.4 13802.6 13993.4 14011.9 14162.9 11323.0 11521.4 11713.9 11765.5 11823.5 10933.4 11054.9 11106.6 11113.7 11240.8 03:12:07 INFO - PROCESS | 1954 | -------- Summary: end -------- 03:12:07 INFO - PROCESS | 1954 | 03:12:08 INFO - TEST-INFO | 1954: exit 0 03:12:08 INFO - TEST-OK | dromaeo_css | took 1120844ms 03:12:08 INFO - TEST-START | kraken 03:12:08 INFO - operating with platform_type : mac_ 03:12:08 INFO - Initialising browser for kraken test... 03:12:08 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpttqRU0/profile http://localhost:51297/getInfo.html) 03:12:10 INFO - PROCESS | 1958 | __metrics Screen width/height:1600/1200 03:12:10 INFO - PROCESS | 1958 | colorDepth:24 03:12:10 INFO - PROCESS | 1958 | Browser inner width/height: 1024/689 03:12:10 INFO - PROCESS | 1958 | __metrics 03:12:10 INFO - PROCESS | 1958 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:12:10 INFO - PROCESS | 1958 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:12:11 INFO - TEST-INFO | 1958: exit 0 03:12:11 INFO - Browser initialized. 03:12:11 INFO - Running cycle 1/1 for kraken test... 03:12:11 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpttqRU0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:23 INFO - PROCESS | 1959 | RSS: Main: 214040576 03:12:23 INFO - PROCESS | 1959 | 03:12:26 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51297/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51297/tests/kraken/driver.html?testName=audio-beat-detection) 03:12:27 INFO - PROCESS | 1959 | RSS: Main: 267673600 03:12:27 INFO - PROCESS | 1959 | 03:12:30 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51297/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51297/tests/kraken/driver.html?testName=audio-dft) 03:12:30 INFO - PROCESS | 1959 | RSS: Main: 277504000 03:12:30 INFO - PROCESS | 1959 | 03:12:33 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51297/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51297/tests/kraken/driver.html?testName=audio-fft) 03:12:34 INFO - PROCESS | 1959 | RSS: Main: 375271424 03:12:34 INFO - PROCESS | 1959 | 03:12:36 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51297/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51297/tests/kraken/driver.html?testName=audio-oscillator) 03:12:37 INFO - PROCESS | 1959 | RSS: Main: 277626880 03:12:37 INFO - PROCESS | 1959 | 03:12:39 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51297/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51297/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:12:40 INFO - PROCESS | 1959 | RSS: Main: 280408064 03:12:40 INFO - PROCESS | 1959 | 03:12:43 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51297/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51297/tests/kraken/driver.html?testName=imaging-darkroom) 03:12:44 INFO - PROCESS | 1959 | RSS: Main: 322007040 03:12:44 INFO - PROCESS | 1959 | 03:12:47 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51297/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51297/tests/kraken/driver.html?testName=imaging-desaturate) 03:12:47 INFO - PROCESS | 1959 | RSS: Main: 320950272 03:12:47 INFO - PROCESS | 1959 | 03:12:50 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51297/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51297/tests/kraken/driver.html?testName=json-parse-financial) 03:12:51 INFO - PROCESS | 1959 | RSS: Main: 319627264 03:12:51 INFO - PROCESS | 1959 | 03:12:53 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51297/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51297/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:12:53 INFO - PROCESS | 1959 | RSS: Main: 295772160 03:12:53 INFO - PROCESS | 1959 | 03:12:55 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51297/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51297/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:12:56 INFO - PROCESS | 1959 | RSS: Main: 297734144 03:12:56 INFO - PROCESS | 1959 | 03:12:58 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51297/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51297/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:12:59 INFO - PROCESS | 1959 | RSS: Main: 308244480 03:12:59 INFO - PROCESS | 1959 | 03:13:02 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51297/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:13:02 INFO - PROCESS | 1959 | RSS: Main: 320888832 03:13:02 INFO - PROCESS | 1959 | 03:13:05 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51297/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:13:06 INFO - PROCESS | 1959 | RSS: Main: 315031552 03:13:06 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:51297/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51297/tests/kraken/driver.html?testName=ai-astar) 03:13:08 INFO - PROCESS | 1959 | RSS: Main: 359862272 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | __start_tp_report 03:13:08 INFO - PROCESS | 1959 | _x_x_mozilla_page_load 03:13:08 INFO - PROCESS | 1959 | _x_x_mozilla_page_load_details 03:13:08 INFO - PROCESS | 1959 | |i|pagename|runs| 03:13:08 INFO - PROCESS | 1959 | |0;ai-astar;118;117;115;115;117;115;116;116;115;116 03:13:08 INFO - PROCESS | 1959 | |1;audio-beat-detection;133;108;109;143;112;107;108;107;128;108 03:13:08 INFO - PROCESS | 1959 | |2;audio-dft;198;186;184;183;183;188;183;184;183;185 03:13:08 INFO - PROCESS | 1959 | |3;audio-fft;83;76;84;115;67;62;61;60;79;60 03:13:08 INFO - PROCESS | 1959 | |4;audio-oscillator;94;93;119;100;69;68;81;68;68;86 03:13:08 INFO - PROCESS | 1959 | |5;imaging-gaussian-blur;126;133;87;87;88;87;94;134;89;87 03:13:08 INFO - PROCESS | 1959 | |6;imaging-darkroom;94;93;95;93;93;93;95;93;93;93 03:13:08 INFO - PROCESS | 1959 | |7;imaging-desaturate;86;84;85;83;83;91;133;84;84;86 03:13:08 INFO - PROCESS | 1959 | |8;json-parse-financial;64;63;60;61;65;66;64;66;64;63 03:13:08 INFO - PROCESS | 1959 | |9;json-stringify-tinderbox;53;58;63;68;60;56;57;57;57;56 03:13:08 INFO - PROCESS | 1959 | |10;stanford-crypto-aes;83;87;87;87;85;84;84;90;88;96 03:13:08 INFO - PROCESS | 1959 | |11;stanford-crypto-ccm;139;153;143;150;133;121;149;144;219;176 03:13:08 INFO - PROCESS | 1959 | |12;stanford-crypto-pbkdf2;168;165;166;165;166;164;166;166;166;167 03:13:08 INFO - PROCESS | 1959 | |13;stanford-crypto-sha256-iterative;66;66;66;66;65;64;63;64;65;64 03:13:08 INFO - PROCESS | 1959 | __end_tp_report 03:13:08 INFO - PROCESS | 1959 | __start_cc_report 03:13:08 INFO - PROCESS | 1959 | _x_x_mozilla_cycle_collect,2245 03:13:08 INFO - PROCESS | 1959 | __end_cc_report 03:13:08 INFO - PROCESS | 1959 | __startTimestamp1489486388407__endTimestamp 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | ------- Summary: start ------- 03:13:08 INFO - PROCESS | 1959 | Number of tests: 14 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | [#0] ai-astar Cycles:10 Average:116.00 Median:116.00 stddev:1.05 (0.9%) stddev-sans-first:0.83 03:13:08 INFO - PROCESS | 1959 | Values: 118.0 117.0 115.0 115.0 117.0 115.0 116.0 116.0 115.0 116.0 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | [#1] audio-beat-detection Cycles:10 Average:116.30 Median:110.50 stddev:13.25 (12.0%) stddev-sans-first:12.60 03:13:08 INFO - PROCESS | 1959 | Values: 133.0 108.0 109.0 143.0 112.0 107.0 108.0 107.0 128.0 108.0 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | [#2] audio-dft Cycles:10 Average:185.70 Median:184.50 stddev:4.62 (2.5%) stddev-sans-first:1.73 03:13:08 INFO - PROCESS | 1959 | Values: 198.0 186.0 184.0 183.0 183.0 188.0 183.0 184.0 183.0 185.0 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | [#3] audio-fft Cycles:10 Average:74.70 Median:71.50 stddev:17.13 (24.0%) stddev-sans-first:17.90 03:13:08 INFO - PROCESS | 1959 | Values: 83.0 76.0 84.0 115.0 67.0 62.0 61.0 60.0 79.0 60.0 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | [#4] audio-oscillator Cycles:10 Average:84.60 Median:75.00 stddev:17.21 (22.9%) stddev-sans-first:17.91 03:13:08 INFO - PROCESS | 1959 | Values: 94.0 93.0 119.0 100.0 69.0 68.0 81.0 68.0 68.0 86.0 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | [#5] imaging-gaussian-blur Cycles:10 Average:101.20 Median:87.00 stddev:20.77 (23.9%) stddev-sans-first:20.00 03:13:08 INFO - PROCESS | 1959 | Values: 126.0 133.0 87.0 87.0 88.0 87.0 94.0 134.0 89.0 87.0 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:93.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 03:13:08 INFO - PROCESS | 1959 | Values: 94.0 93.0 95.0 93.0 93.0 93.0 95.0 93.0 93.0 93.0 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | [#7] imaging-desaturate Cycles:10 Average:89.90 Median:84.50 stddev:15.32 (18.1%) stddev-sans-first:16.19 03:13:08 INFO - PROCESS | 1959 | Values: 86.0 84.0 85.0 83.0 83.0 91.0 133.0 84.0 84.0 86.0 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:1.96 (3.1%) stddev-sans-first:2.07 03:13:08 INFO - PROCESS | 1959 | Values: 64.0 63.0 60.0 61.0 65.0 66.0 64.0 66.0 64.0 63.0 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:57.50 stddev:4.25 (7.4%) stddev-sans-first:4.01 03:13:08 INFO - PROCESS | 1959 | Values: 53.0 58.0 63.0 68.0 60.0 56.0 57.0 57.0 57.0 56.0 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:3.78 (4.3%) stddev-sans-first:3.71 03:13:08 INFO - PROCESS | 1959 | Values: 83.0 87.0 87.0 87.0 85.0 84.0 84.0 90.0 88.0 96.0 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | [#11] stanford-crypto-ccm Cycles:10 Average:152.70 Median:149.50 stddev:27.31 (18.3%) stddev-sans-first:28.51 03:13:08 INFO - PROCESS | 1959 | Values: 139.0 153.0 143.0 150.0 133.0 121.0 149.0 144.0 219.0 176.0 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:166.00 stddev:1.10 (0.7%) stddev-sans-first:0.87 03:13:08 INFO - PROCESS | 1959 | Values: 168.0 165.0 166.0 165.0 166.0 164.0 166.0 166.0 166.0 167.0 03:13:08 INFO - PROCESS | 1959 | 03:13:08 INFO - PROCESS | 1959 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.50 stddev:1.10 (1.7%) stddev-sans-first:1.09 03:13:08 INFO - PROCESS | 1959 | Values: 66.0 66.0 66.0 66.0 65.0 64.0 63.0 64.0 65.0 64.0 03:13:08 INFO - PROCESS | 1959 | -------- Summary: end -------- 03:13:08 INFO - PROCESS | 1959 | 03:13:09 INFO - TEST-INFO | 1959: exit 0 03:13:09 INFO - TEST-OK | kraken | took 60978ms 03:13:09 INFO - SUITE-END | took 1181s 03:13:09 INFO - Completed test suite (00:19:41) 03:13:09 INFO - javascript benchmark 03:13:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7543.181686557802, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3405.6083550391704, 3423.8116903570294, 3426.4860270959343, 3445.5520782298313, 3493.301339732053, 6010.549208809341, 6046.7581296748185, 6097.809298190727, 6130.528673118453, 6143.600665956709, 5987.6407415555095, 6035.9698201509045, 6048.546359023069, 6061.484773794233, 6072.908906366408, 5374.6506477078865, 5405.5135037846585, 5407.783688652449, 5418.83743487696, 5526.640768350065, 5343.7060961647285, 5354.892902141974, 5519.448055194469, 5519.889602207953, 5523.475269849378, 5390.326209223847, 5435.510804027636, 5443.047466693332, 5447.45525447456, 5464.0, 5459.890802183954, 5462.344518657746, 5462.836114916519, 5468.699221542814, 5480.26016487775, 5289.603279753996, 5401.0, 5431.755570999315, 5445.401005889349, 5462.289902312674, 6061.878762424771, 6071.241094863142, 6092.939070609282, 6102.26772787264, 6113.052476866093, 5265.894682106336, 6347.936520634781, 6368.554201205918, 6372.107904893319, 6380.553361264713, 6392.520560957901, 6392.872142557169, 6401.231852177769, 6415.967920160369, 6451.967740161316, 6112.052631842072, 6155.630662160284, 6165.815025549241, 6173.969130154321, 6198.3801619838105, 6675.365840245217, 6682.732690692415, 6699.899501507482, 6703.296153903867, 6704.83237919051, 6200.162977998003, 6264.123022776815, 6279.3720627937755, 6355.0, 6367.204099487564, 6346.9682651586445, 6354.904676429857, 6400.519961002943, 6483.157189565326, 6509.544331896816, 6431.935680643133, 6432.163818703539, 6433.710483028275, 6446.580972236789, 6450.161479007699, 6448.097266382711, 6458.2895881453005, 6464.030395440722, 6485.254195767548, 6487.0, 5097.158968770112, 5146.330976972969, 5150.175971844487, 5153.484651534816, 5236.345456817898, 4629.004763975761, 4649.418822647169, 4654.0, 4665.370175026328, 4677.812887484462, 5864.618799778001, 5905.498032667186, 5907.232059832194, 5907.586468947218, 5910.645361278337, 6239.594426362362, 6367.808965731036, 6370.872582548416, 6376.521760867953, 6392.872142557123, 6098.664573448503, 6108.969455152695, 6109.0, 6134.171886795226, 6143.692815359214, 5735.799247026417, 5739.13912913058, 5740.0, 5740.0815869460685, 5742.856428589319, 6421.261554921057, 6474.902876456763, 6739.6967136478, 6763.864722705518, 6764.289749576322, 6367.044943258548, 6370.58591191571, 6373.521985850987, 6377.713002914973, 6381.489480841615, 6628.5691430056895, 6653.833654158685, 6716.261211266659, 6751.156105486814, 6753.358430949052, 6451.580647257913, 6459.806205813833, 6464.385883341075, 6477.967610161919, 6480.157579514633, 6495.512836537184, 6504.4796416285635, 6509.707063182263, 6525.184351956005, 6546.214454265519, 6179.196704428396, 6180.721867516063, 6238.001919692827, 6289.559730818799, 6313.494920406449, 6221.595596286227, 6294.842628934313, 6295.622262664255, 6317.084022816758, 6380.9361906380345, 6306.873862522632, 6338.651374174465, 6340.270868849957, 6343.746250149942, 6345.0482427636225, 6230.408111229426, 6375.458086062737, 6388.009858471944, 6402.6158430494315, 6413.967930160319, 6124.418180272867, 6129.358790882775, 6189.5048396129105, 6203.968980155251, 6335.0], "value": 5954.004407236897, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.6133049483772, 787.519613036048, 811.5820352518452, 867.6225841758835, 878.3061381508609, 27325.45349093017, 30839.074827755147, 37677.0, 38226.426603600965, 38351.808240958824, 38071.42892856609, 38300.808495957484, 38414.423783643266, 39788.80105599468, 39798.0050498737, 9070.27437804974, 9240.353175277733, 9263.444193348421, 9270.443773373585, 9272.7681807955, 7362.153352364493, 7554.508956917783, 10860.076893464025, 11013.669589912315, 11182.384968826711, 11029.61396351128, 11051.502682379312, 11061.889381106166, 11068.667939961813, 11091.611793587226, 11012.339259644406, 11032.172587055962, 11038.558457661684, 11042.503087361089, 11043.558257669683, 7192.172900116501, 7348.669309881015, 10470.685879423629, 10629.73425664357, 10658.946705266424, 37967.620323796684, 38125.80937095325, 38138.80930595329, 38156.80921595374, 38158.42762358567, 3797.3354662933875, 3815.5802861685193, 3843.673287770543, 3891.630295121959, 3892.5767964688835, 26370.47259054808, 27471.0, 28303.0, 28408.00571979971, 28423.85788071067, 3010.909672709822, 3019.743321817648, 3119.32934419101, 3140.905772826819, 3245.140037889961, 279180.0, 316599.0, 319949.0, 322879.0, 322892.0, 49673.25490117651, 49820.0, 49861.750691246314, 50010.74994625076, 50156.74921625369, 51834.963300733776, 51977.96044079097, 52031.0, 52035.0, 52077.0, 14265.42938282478, 14371.0, 14391.0, 14395.136291822524, 14413.423463061361, 10699.518521666543, 12648.367581621067, 12648.620541383772, 12658.0, 12681.93659031699, 9999.150072243941, 10046.949765251127, 13573.981951353688, 13649.454021839214, 13792.241426721626, 5665.838503106853, 5677.318721753416, 6062.605930614496, 6111.480524155408, 6118.357572454917, 1134.6085600467825, 1137.6643890052455, 1138.7950168969498, 1140.2987162894926, 1187.4478367559127, 21861.78138218629, 26755.598666020025, 26893.596596051077, 27011.864940675172, 27153.321166970985, 1236.7093732972744, 1249.0382405547678, 1267.2833979906459, 1288.9806652900213, 1296.3777386854174, 13473.393697283645, 13680.247586382844, 13793.655158620913, 13818.65453363674, 13857.930710346383, 447355.0, 447546.0, 447885.0, 449765.0, 450359.0, 54333.72833135809, 54696.72651636796, 54743.45256547463, 54785.1782223267, 54873.725631371584, 1420.566727148209, 1455.4978532406303, 1458.5697219320539, 1463.7731151671508, 1466.8899832512604, 24435.75564244335, 25121.748782511942, 25851.0952116675, 25863.353416164748, 26005.739942600332, 43561.91095222645, 43935.78032109819, 44112.0, 44176.7791161055, 45399.77300113478, 433167.0, 504976.0, 506888.0, 508006.0, 510595.0, 30321.848390757907, 30654.693453065185, 30676.386472269984, 30681.0, 30689.386212276077, 27820.74806633747, 34869.0, 35607.287854242255, 36416.08959776027, 37811.43282850814, 30321.696783031886, 30702.692973069985, 30768.923087691823, 30813.383732325678, 31775.04674859758, 23308.883455582614, 30160.24599385033, 30652.386952261277, 31295.687043129277, 31490.0, 30660.926867559527, 31171.84414077915, 31293.530597040608, 31305.8434707825, 31337.529937050505, 26957.191284261502, 27844.721552784213, 27942.44115117727, 27988.86005569959, 28127.015554455495, 15970.680586387974, 21970.19149794951, 22003.0, 22075.344349173556, 22258.88870555637], "value": 18249.72197751579, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.4905759293007, 388.49689651900786, 411.8126252555086, 420.657164411005, 454.1552711955762, 12441.751164976695, 14241.0, 16540.917295413536, 19980.60038799227, 20558.69161962572, 18456.354027609035, 19304.613907721836, 20382.898085509587, 21932.561348773015, 21981.0, 6043.305019922699, 6167.907481387771, 6269.749210031593, 6357.364263573651, 6364.840878978016, 6165.352637972993, 6225.2529696436495, 6232.407921247474, 6250.843728906768, 6266.467350275232, 4045.777482238476, 4185.932587190262, 4223.97888010561, 6066.423689749488, 7182.892256616155, 6897.586144831326, 7107.005019297302, 7129.643517824088, 7148.49960502765, 7160.212376638539, 6964.547304425196, 6967.094277743911, 6969.6166710830885, 6972.58164510131, 6979.0, 23637.763622363902, 23970.041198352046, 24343.44393838657, 24559.50880982388, 24710.0, 2847.9288017799513, 2872.5116730155714, 2885.2786803299177, 2906.2734316420897, 2908.6800451950267, 15455.459058932884, 15471.226438678133, 15627.906046576743, 15806.525804225892, 15951.13975758717, 1980.8118228768244, 1987.6322880267053, 2042.5804066174014, 2047.7440319960006, 2049.5081180516718, 114695.42652286768, 117578.0, 126171.73828261692, 151302.24348878296, 163260.0, 15166.545003649908, 17642.94142351463, 18609.348672796386, 19517.609647807247, 19620.509487262934, 26567.86716066446, 30258.697413026028, 30259.546106808415, 30338.241543961136, 30408.087757367313, 9504.904950950402, 9945.403275803475, 10007.599696012077, 10015.198784097254, 10164.33931794431, 6154.292256390572, 7863.741801311877, 8273.1726827318, 8394.622241999003, 8539.48763074205, 7025.718971241093, 8769.91230087691, 8938.50838203905, 8962.641494340154, 8973.93599472125, 3867.439221312894, 3910.511186101737, 3947.8420863165725, 3953.288408086572, 3965.5439624442984, 874.9325822496544, 911.6399022386121, 971.820213260549, 1000.9749756256152, 1008.6620981971122, 15784.816138789636, 19027.429177124708, 19667.803321966883, 19795.20819167246, 20181.192752290037, 866.9653213871375, 902.1700035966926, 905.6649039855296, 972.7033254857195, 981.4209616326401, 9576.042395760507, 10278.537465814057, 10475.319104258198, 10491.0, 10523.473826308655, 714127.0, 756208.0, 759527.0, 809973.0, 817077.0, 151573.0, 154188.0, 157070.0, 159501.20249398678, 163193.0, 1179.6814859987926, 1215.1433239566084, 1263.7030297879992, 1265.0638527489775, 1270.2949862826035, 18032.639347213244, 18278.543036424195, 18369.72445413293, 18836.986082226776, 19152.329668462095, 52831.47168528265, 57596.71201643965, 57753.0, 59948.40051599603, 60202.89289874833, 77395.0, 77706.2229377699, 77791.0, 79654.6017269933, 79902.60048699952, 8567.614457349559, 9430.151286384258, 10020.398776073458, 10301.021402966706, 10515.526801293807, 11626.128040396836, 11871.465784039912, 11915.52337906474, 12078.577249796215, 12291.32397718134, 10407.427591482541, 10416.427096509764, 10633.840492392466, 10752.946235269086, 10766.246362754531, 9933.900660993297, 10262.794744105226, 10304.175665946856, 10310.32982856112, 10508.316959397614, 9473.621055157992, 10547.0, 10752.83870741955, 10845.620403285848, 10871.456427178451, 8789.208971192624, 10280.845787313046, 10472.68581942543, 10549.525271362654, 10571.94714026425, 10360.119389851947, 10489.895101048893, 10533.26267161322, 10556.577736890438, 10701.41502596639], "value": 10829.967585395198, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.3721374236566, 1539.5073576455532, 1568.9137097459636, 1591.9124448155353, 1595.9920200398997, 10708.946455267722, 11267.887321126796, 11295.039921606653, 11307.491162897668, 11322.773544529104, 10710.678679639605, 10907.945460272707, 11128.38793866337, 11182.105431565476, 11268.774624507505, 2351.259353303708, 2384.177458776719, 2385.8210634202505, 2391.689080419552, 2393.4614711689906, 1994.0, 2003.699445083242, 2323.767623237671, 2372.074890792592, 2376.7504412036747, 2339.63735620979, 2352.7882490575844, 2365.136725095345, 2367.609344458171, 2368.95262094758, 2293.140072472823, 2314.432963923841, 2326.639370897514, 2327.104064934995, 2328.918487852917, 2300.1489448903844, 2371.8814059296965, 2374.7150341958904, 2376.7742064503846, 2377.5363804058215, 9333.90666093344, 11020.063294619968, 11107.055900248488, 11109.0, 11126.443677816158, 4677.789499472532, 5527.060399732015, 5688.772449102031, 5702.971485142589, 5710.0, 3323.18581947422, 3405.1316914186973, 3600.837962291703, 3602.2075143468396, 3606.6213047629885, 1109.4674556212983, 1147.4836323654388, 1209.558511143435, 1216.8843959823803, 1222.2238878312335, 12316.5073397064, 12568.685782855411, 12744.80882786759, 15345.846541534553, 15404.53786386399, 4083.4283200351974, 4222.4299719538085, 4229.598188172119, 4232.307077169157, 4447.466304043535, 11430.942845285721, 11436.428178591037, 11458.484368203452, 11490.080793536497, 11520.193586448868, 5546.251256080458, 5552.972235138798, 5554.972225138848, 5555.194496797942, 5558.833235002957, 4843.927341089887, 5095.15929871567, 5160.458151893997, 5164.92252616211, 5171.172612382076, 3046.405950839565, 3748.100455890621, 3783.621637836194, 3827.158025234444, 3828.578856325802, 836.3560058754725, 973.6543527047796, 977.3842479238034, 984.4290311619244, 988.7330420786491, 922.8246633139817, 934.9906500934903, 940.8118376324762, 946.9242460603135, 976.3312131190157, 6614.140161778938, 6646.202455705346, 6676.198856137197, 6868.450523958071, 6873.278305777922, 993.7863359377768, 1001.9248556358302, 1003.5383723487132, 1049.2078480746986, 1058.7564860082225, 4152.750834949913, 4177.3316269396755, 4180.163967206571, 4220.514640816284, 4259.574042595716, 13326.200427974352, 13779.517716879862, 13805.585832425044, 13824.377902994389, 13824.930875345559, 12939.0, 13454.52909148175, 13575.253361065235, 13735.175889446666, 13748.65628359299, 9936.701898943043, 10246.53890574911, 10253.58985640566, 10255.641052563124, 10257.025582569644, 6536.182977127859, 6803.183617965876, 6981.685824137824, 6983.266756990646, 7038.683259253448, 12094.637160885188, 12442.31567263773, 12444.626661200178, 12494.937525312678, 12501.624951251477, 12432.0, 12530.624081277576, 12569.748605028031, 12882.613521594367, 12924.966002719571, 9194.49430281341, 9509.524523773645, 9512.762180945256, 9512.857307140537, 9522.190613797904, 8592.78518037029, 10161.390316581028, 10293.794124117327, 10384.221183411426, 10397.740056498647, 9007.144321289466, 9189.724308270763, 9226.907730922605, 9306.395084319498, 9454.0, 8878.911210887809, 8928.017918028881, 8973.865392018994, 9043.276537877086, 9058.411203271766, 7848.097468790934, 8035.55804430762, 8051.919480805117, 8054.597270136587, 8055.476394034369, 5818.0, 5883.176355310175, 5926.970365148147, 6035.728392222449, 6086.817395478142, 5841.4450627190345, 6033.366496517802, 6056.9697151513965, 6082.239720034996, 6264.373562643699], "value": 5082.045411875972, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.6093361430983, 316.41305378522844, 378.9204267103908, 385.0182035808687, 386.1196472043738, 4941.925871111936, 5015.3730783652045, 5040.117979353608, 5056.69659820411, 5122.410922743886, 4227.746335219889, 4854.4514130081725, 4855.854324370266, 5010.922651629908, 5013.598912087034, 3210.839458027101, 3413.259237788721, 3893.6301051400073, 3987.581303963071, 4019.974906398879, 3415.453527435611, 4095.5188090123456, 4099.098198396348, 4113.814878330482, 4155.376693495985, 4066.3493840985448, 4073.8370465181506, 4102.154030686188, 4151.937720934188, 4178.22702799983, 3548.0793722936173, 3754.1365485938113, 3801.7454240100838, 3952.9011774705864, 4010.5509262034625, 3211.1260421922484, 3371.477420999749, 3626.2412729826015, 3764.4729737836724, 3780.867669631577, 4152.896177595554, 4209.295235429656, 4537.82352353354, 4557.635389168859, 4794.9280760788615, 4733.360996265529, 4750.144973904696, 4771.761411929424, 4793.089313030548, 4867.756612169413, 4639.028412924494, 4801.423829140491, 4971.0554994551285, 4989.525995030466, 5278.709670968095, 4230.069384735353, 4242.957570424287, 4258.276093064186, 4289.721168124062, 4304.504981927056, 5051.045138593964, 5129.230615407681, 5264.92102618461, 5371.892562148774, 5392.352917649907, 4200.327947528381, 4505.279155335131, 4705.60002399793, 4748.976255118771, 4779.426468823764, 4299.290617048215, 4365.079365079355, 4483.583670084964, 4567.520410356931, 4610.792514336863, 3921.568627450978, 4752.643551733634, 4932.605391568666, 4993.850184494471, 5051.747412629427, 4273.67947403946, 4860.809101770089, 5058.0, 5250.7637156328055, 5307.389650190277, 1460.5399299220924, 1514.4472267622239, 1538.0774032459426, 1631.7144499712504, 1666.6583350413136, 1236.9010479161645, 1302.3867694042508, 1364.7543442180504, 1384.508499482669, 1387.6392138044182, 4176.749395036308, 4244.405783190356, 4449.86528435247, 4514.532776847538, 4816.8073277069225, 4729.456112547033, 4791.712497250176, 5463.508284254357, 5481.56070548602, 5512.6692398456225, 4276.3799249109325, 4314.144917685426, 4364.41080454141, 4664.416947881515, 4741.146593613183, 2260.3896947823996, 2397.688300520921, 2486.532945562127, 2828.349479619699, 2830.306574889124, 5087.64386492942, 5492.780288788404, 5559.971405290034, 5575.553955683617, 5616.9157462638095, 4976.377952755905, 5048.72232027242, 5217.339157029942, 5549.667019978814, 5562.886103280727, 5343.0, 5406.324209473816, 5443.510084092451, 5487.368952570346, 5651.095824668033, 4734.5559604321015, 5365.865853353541, 5470.8085217017215, 5581.6371935824045, 5593.468620481048, 4660.440747110369, 5137.922931155961, 5319.122344813062, 5340.626156169031, 5506.504414602705, 5243.8164664236565, 5330.853866418739, 5340.412554619066, 5465.344158700981, 5634.070378387521, 3462.342154990544, 4119.8970025748395, 4123.237201117803, 4332.573758695141, 4348.847790327323, 4852.902941941071, 4972.950270497394, 4986.7257300848805, 5203.0, 5458.426865179099, 5236.9738151309, 5237.2667826505085, 5277.683338999673, 5278.97360513195, 5298.682079075268, 5213.661112027706, 5221.582273418041, 5232.424433312256, 5305.257263983122, 5339.3058902342445, 4157.9376309355985, 4921.997581475369, 5105.2086926526445, 5147.639665223398, 5155.793768249378, 4185.393117997813, 4781.207047357241, 5115.283860259492, 5242.842714718565, 5287.339082614673, 3990.0, 4406.691531592758, 4533.387992620954, 4549.044700612908, 4914.476512281204], "value": 4034.433563510173, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.9238829922855, 738.117949050884, 765.2118318132323, 767.6238643064896, 831.1854382704947, 15233.542993710193, 15817.36730530779, 15935.362585496567, 16068.678626427465, 16285.674286514262, 14479.420823167087, 14785.778213326808, 14845.703085938301, 14932.253387330617, 15053.698926021472, 923.7598224461638, 954.3176628710471, 961.1829944547114, 961.3126614470652, 965.9420434773901, 915.4919019943928, 945.2768631996528, 948.2461443152711, 952.1430712358863, 959.357230655459, 999.6151481679569, 1000.8348622477318, 1005.2159315733703, 1006.014106175948, 1007.1841808135397, 998.7952469743685, 1000.2548101664233, 1000.7648202672366, 1001.9348742331762, 1002.6290272599113, 743.7917383132732, 745.5489428895548, 747.2676776758807, 749.9287567681062, 750.1448348882278, 15812.683746325125, 16117.597060073593, 16175.948563343345, 16464.42374516898, 16793.496195114167, 13140.86859131406, 13919.791203131961, 14000.22998735069, 14184.29078546079, 14314.284285785669, 10582.0, 11744.0, 11809.586664466702, 11936.462859171359, 11997.760044799143, 2878.654561452639, 3286.2441638423297, 3327.900162995114, 3379.5606571145595, 3435.57055368079, 101570.4921475388, 120298.39850800777, 121263.3936830319, 128403.0, 128578.3571082148, 10514.684559463229, 10765.30025548337, 10796.838047429295, 10973.341599504056, 11418.029467495357, 22065.669014964787, 22588.209412670476, 22599.0, 22644.660330095063, 22655.546889062458, 7535.111763501687, 7662.770116896502, 7663.463557551029, 7748.92251077482, 7828.960855195687, 4287.292596721569, 4376.737395756265, 4409.272470042407, 4417.226985277628, 4431.512533621299, 3238.6761323867427, 3346.782459140148, 3347.0460918638073, 3349.497575363715, 3355.9496607550905, 573.7446836157869, 583.7577405376805, 584.6287607369266, 584.7427132061879, 586.293516312842, 558.7234319012034, 576.824068659063, 597.2832600878962, 638.8881945659491, 647.8607099473636, 9216.815663686688, 10034.953544647902, 10228.590856365661, 10397.896021039693, 10722.73193170177, 545.9972700136553, 552.2241251042292, 572.5562688916124, 612.7365232949875, 629.6505439481041, 4971.130052240844, 5049.9585540064045, 5101.591872650179, 5114.948850511521, 5126.92309615356, 88029.11970880209, 103279.0, 105751.88496230186, 106328.0, 107360.24239151592, 56697.0, 59579.687383142795, 73959.63020184972, 77161.61419192981, 91269.54365228131, 60675.786484270066, 70733.64633176802, 72887.0, 84093.57953210195, 88866.0, 11151.179470832043, 11287.266327689002, 11425.0, 11454.828177577176, 11545.595904143314, 53026.40920772383, 53471.732641336544, 53601.0, 55523.72238138784, 56119.71940140273, 47621.76189119032, 63910.68044659933, 68158.29604259934, 69072.6546367285, 69630.0, 10993.61522346714, 13904.899494357991, 13952.511662091778, 14124.152550846982, 14990.250487475365, 14922.776158357416, 15352.769708454158, 15451.304691289144, 15472.690546189238, 15750.291236894138, 13873.930630347188, 13991.930040349733, 14076.718465630835, 14425.0, 14446.783298250744, 13712.862871371159, 13970.646885219863, 14257.429702812185, 14293.35679894428, 14949.327280272631, 13559.389827457591, 13802.585922422344, 13993.440262389797, 14011.929940350641, 14162.937779666772, 11323.0, 11521.423928803693, 11713.941430292794, 11765.529378825093, 11823.467943942715, 10933.398663073607, 11054.889451105386, 11106.555737770399, 11113.722156946142, 11240.83138752903], "value": 7634.355274818992, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1454.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 115.0, 115.0, 117.0, 115.0, 116.0, 116.0, 115.0, 116.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 108.0, 109.0, 143.0, 112.0, 107.0, 108.0, 107.0, 128.0, 108.0], "value": 116.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 186.0, 184.0, 183.0, 183.0, 188.0, 183.0, 184.0, 183.0, 185.0], "value": 185.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 76.0, 84.0, 115.0, 67.0, 62.0, 61.0, 60.0, 79.0, 60.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 119.0, 100.0, 69.0, 68.0, 81.0, 68.0, 68.0, 86.0], "value": 84.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 133.0, 87.0, 87.0, 88.0, 87.0, 94.0, 134.0, 89.0, 87.0], "value": 101.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 95.0, 93.0, 93.0, 93.0, 95.0, 93.0, 93.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 83.0, 83.0, 91.0, 133.0, 84.0, 84.0, 86.0], "value": 89.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 60.0, 61.0, 65.0, 66.0, 64.0, 66.0, 64.0, 63.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 63.0, 68.0, 60.0, 56.0, 57.0, 57.0, 57.0, 56.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 87.0, 87.0, 85.0, 84.0, 84.0, 90.0, 88.0, 96.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 153.0, 143.0, 150.0, 133.0, 121.0, 149.0, 144.0, 219.0, 176.0], "value": 152.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 166.0, 165.0, 166.0, 164.0, 166.0, 166.0, 166.0, 167.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 65.0, 64.0, 63.0, 64.0, 65.0, 64.0], "value": 64.9, "unit": "score"}]}]} 03:13:09 INFO - Return code: 0 03:13:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:13:09 ERROR - # TBPL SUCCESS # 03:13:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:13:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:13:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:13:09 INFO - 2017-03-14 03:13:09.767 screenresolution[1963:16367] starting screenresolution argv=screenresolution get 03:13:09 INFO - 2017-03-14 03:13:09.770 screenresolution[1963:16367] Display 0: 1600x1200x32@60 03:13:09 INFO - 2017-03-14 03:13:09.777 screenresolution[1964:16371] starting screenresolution argv=screenresolution list 03:13:09 INFO - Available Modes on Display 0 03:13:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:13:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:13:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:13:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:13:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:13:10 INFO - Intel Iris: 03:13:10 INFO - Chipset Model: Intel Iris 03:13:10 INFO - Type: GPU 03:13:10 INFO - Bus: Built-In 03:13:10 INFO - VRAM (Dynamic, Max): 1536 MB 03:13:10 INFO - Vendor: Intel (0x8086) 03:13:10 INFO - Device ID: 0x0a2e 03:13:10 INFO - Revision ID: 0x0009 03:13:10 INFO - Displays: 03:13:10 INFO - Display: 03:13:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:13:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:13:10 INFO - Display Serial Number: 1600x1200 60 03:13:10 INFO - Main Display: Yes 03:13:10 INFO - Mirror: Off 03:13:10 INFO - Online: Yes 03:13:10 INFO - Rotation: Supported 03:13:10 INFO - Return code: 0 03:13:10 INFO - Running post-action listener: _resource_record_post_action 03:13:10 INFO - [mozharness: 2017-03-14 10:13:10.017182Z] Finished run-tests step (success) 03:13:10 INFO - Running post-run listener: _resource_record_post_run 03:13:10 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 851968; Write bytes: 506264576; Read time: 10; Write time: 1573 03:13:10 INFO - TinderboxPrint: CPU usage
53.6% 03:13:10 INFO - TinderboxPrint: I/O read bytes / time
851,968 / 10 03:13:10 INFO - TinderboxPrint: I/O write bytes / time
506,264,576 / 1,573 03:13:10 INFO - TinderboxPrint: CPU idle
2,229.2 (46.3%) 03:13:10 INFO - TinderboxPrint: CPU system
955.5 (19.9%) 03:13:10 INFO - TinderboxPrint: CPU user
1,625.0 (33.8%) 03:13:10 INFO - TinderboxPrint: Swap in / out
209,444,864 / 0 03:13:10 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206023168; Write bytes: 199569408; Read time: 15730; Write time: 433 03:13:10 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 847872; Write bytes: 295660544; Read time: 9; Write time: 1098 03:13:10 INFO - Running post-run listener: _upload_blobber_files 03:13:10 INFO - Blob upload gear active. 03:13:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:13:10 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 03:13:10 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'] 03:13:10 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 03:13:10 INFO - (blobuploader) - INFO - Open directory for files ... 03:13:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:13:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:13:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:11 INFO - (blobuploader) - INFO - Done attempting. 03:13:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:13:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:13:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:12 INFO - (blobuploader) - INFO - Done attempting. 03:13:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:13:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:13:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:14 INFO - (blobuploader) - INFO - Done attempting. 03:13:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:13:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:13:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:16 INFO - (blobuploader) - INFO - Done attempting. 03:13:16 INFO - (blobuploader) - INFO - Iteration through files over. 03:13:16 INFO - Return code: 0 03:13:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:13:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:13:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8eae8d0a2a47ccf96dabee8515909cc26e290f398670eb1838392652fd7346a7f1f8f6a4993ff9b075016972f584dafb9945736f08ff80ffe4db113511553dff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6337aa7c995e022bb2c8b46ac722c753ee9320882a53a60ad710466b0d556d6c4be9c06111802c8831ed1f4f206971b013aef26ff076f469dc2f0f01c861ee62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b25b8684a2d994c195c8ea4103f724c072ebee61ba76ab324ec45b5366fdc257a4e97de759d95bf5d5f9bf7532e3979094b7d7dbef9bd138129b61d3de6f075c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1ae60d79a4a52d52f1991da0e0da30f51cead51795142927ed8561f2f4293cc8a4409824ab0493b702b91e63b64d80cb78aef81833dbc27ffa0f0ad230e5506"} 03:13:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:13:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:13:16 INFO - Contents: 03:13:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8eae8d0a2a47ccf96dabee8515909cc26e290f398670eb1838392652fd7346a7f1f8f6a4993ff9b075016972f584dafb9945736f08ff80ffe4db113511553dff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6337aa7c995e022bb2c8b46ac722c753ee9320882a53a60ad710466b0d556d6c4be9c06111802c8831ed1f4f206971b013aef26ff076f469dc2f0f01c861ee62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b25b8684a2d994c195c8ea4103f724c072ebee61ba76ab324ec45b5366fdc257a4e97de759d95bf5d5f9bf7532e3979094b7d7dbef9bd138129b61d3de6f075c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1ae60d79a4a52d52f1991da0e0da30f51cead51795142927ed8561f2f4293cc8a4409824ab0493b702b91e63b64d80cb78aef81833dbc27ffa0f0ad230e5506"} 03:13:16 INFO - Running post-run listener: copy_logs_to_upload_dir 03:13:16 INFO - Copying logs to upload dir... 03:13:16 INFO - mkdir: /builds/slave/test/build/upload/logs 03:13:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1293.019212 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2017-03-14 03:13:16.162932) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 03:13:16.166850) ========= 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.fBlI8WGF7E/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.fuyUdTtx4U/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8eae8d0a2a47ccf96dabee8515909cc26e290f398670eb1838392652fd7346a7f1f8f6a4993ff9b075016972f584dafb9945736f08ff80ffe4db113511553dff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6337aa7c995e022bb2c8b46ac722c753ee9320882a53a60ad710466b0d556d6c4be9c06111802c8831ed1f4f206971b013aef26ff076f469dc2f0f01c861ee62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b25b8684a2d994c195c8ea4103f724c072ebee61ba76ab324ec45b5366fdc257a4e97de759d95bf5d5f9bf7532e3979094b7d7dbef9bd138129b61d3de6f075c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1ae60d79a4a52d52f1991da0e0da30f51cead51795142927ed8561f2f4293cc8a4409824ab0493b702b91e63b64d80cb78aef81833dbc27ffa0f0ad230e5506"} build_url:https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/ceyMNs-5Sf-CPMlmzQbtAQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8eae8d0a2a47ccf96dabee8515909cc26e290f398670eb1838392652fd7346a7f1f8f6a4993ff9b075016972f584dafb9945736f08ff80ffe4db113511553dff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6337aa7c995e022bb2c8b46ac722c753ee9320882a53a60ad710466b0d556d6c4be9c06111802c8831ed1f4f206971b013aef26ff076f469dc2f0f01c861ee62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b25b8684a2d994c195c8ea4103f724c072ebee61ba76ab324ec45b5366fdc257a4e97de759d95bf5d5f9bf7532e3979094b7d7dbef9bd138129b61d3de6f075c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f1ae60d79a4a52d52f1991da0e0da30f51cead51795142927ed8561f2f4293cc8a4409824ab0493b702b91e63b64d80cb78aef81833dbc27ffa0f0ad230e5506"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 03:13:16.202621) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 03:13:16.202948) ========= 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.fBlI8WGF7E/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.fuyUdTtx4U/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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.005121 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 03:13:16.254628) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 03:13:16.255387) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 03:13:16.256143) ========= ========= Total master_lag: 0.19 =========