builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0321 starttime: 1492677399.5 results: success (0) buildid: 20170420004021 builduid: 046c0cf8cb35499899cf0a80773c0825 revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 01:36:39.501406) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 01:36:39.501838) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 01:36:39.502118) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 01:36:39.526670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:36:39.527020) ========= 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.YavJEyOMZY/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.qeGVaUMk1k/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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-04-20 01:36:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 69.5M=0s 2017-04-20 01:36:39 (69.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091355 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:36:39.641936) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:36:39.642269) ========= 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.YavJEyOMZY/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.qeGVaUMk1k/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.021721 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:36:39.691019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-20 01:36:39.691393) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --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 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YavJEyOMZY/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.qeGVaUMk1k/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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-04-20 01:36:39,784 truncating revision to first 12 chars 2017-04-20 01:36:39,784 Setting DEBUG logging. 2017-04-20 01:36:39,785 attempt 1/10 2017-04-20 01:36:39,785 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/94b7e538af7d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-20 01:36:41,281 unpacking tar archive at: mozilla-aurora-94b7e538af7d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.753880 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-20 01:36:41.469471) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 01:36:41.469809) ========= script_repo_revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 01:36:41.470312) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 01:36:41.470700) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 01:36:41.490950) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-20 01:36:41.491339) ========= /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.YavJEyOMZY/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.qeGVaUMk1k/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:36:41 INFO - MultiFileLogger online at 20170420 01:36:41 in /builds/slave/test 01:36:41 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 01:36:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:36:41 INFO - {'append_to_log': False, 01:36:41 INFO - 'base_work_dir': '/builds/slave/test', 01:36:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:36:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:36:41 INFO - 'branch': 'Mozilla-Aurora', 01:36:41 INFO - 'buildbot_json_path': 'buildprops.json', 01:36:41 INFO - 'config_files': ('talos/mac_config.py',), 01:36:41 INFO - 'default_actions': ('clobber', 01:36:41 INFO - 'read-buildbot-config', 01:36:41 INFO - 'download-and-extract', 01:36:41 INFO - 'populate-webroot', 01:36:41 INFO - 'create-virtualenv', 01:36:41 INFO - 'install', 01:36:41 INFO - 'run-tests'), 01:36:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:36:41 INFO - 'download_minidump_stackwalk': True, 01:36:41 INFO - 'download_symbols': 'ondemand', 01:36:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:36:41 INFO - 'tooltool.py': '/tools/tooltool.py', 01:36:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:36:41 INFO - '/tools/misc-python/virtualenv.py')}, 01:36:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:36:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:36:41 INFO - 'gecko_profile': False, 01:36:41 INFO - 'gecko_profile_interval': 0, 01:36:41 INFO - 'installer_path': 'installer.exe', 01:36:41 INFO - 'log_level': 'info', 01:36:41 INFO - 'log_name': 'talos', 01:36:41 INFO - 'log_to_console': True, 01:36:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:36:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:36:41 INFO - 'opt_config_files': (), 01:36:41 INFO - 'pip_index': False, 01:36:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:36:41 INFO - 'cmd': ('bash', 01:36:41 INFO - '-c', 01:36:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:36:41 INFO - 'enabled': True, 01:36:41 INFO - 'halt_on_failure': False, 01:36:41 INFO - 'name': 'check_screen_resolution'},), 01:36:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:36:41 INFO - 'cmd': ('bash', 01:36:41 INFO - '-c', 01:36:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:36:41 INFO - 'enabled': True, 01:36:41 INFO - 'halt_on_failure': False, 01:36:41 INFO - 'name': 'check_screen_resolution'},), 01:36:41 INFO - 'run_cmd_checks_enabled': True, 01:36:41 INFO - 'suite': 'dromaeojs', 01:36:41 INFO - 'system_bits': '32', 01:36:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:36:41 INFO - 'title': 't-yosemite-r7-0321', 01:36:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:36:41 INFO - 'use_talos_json': True, 01:36:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:36:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:36:41 INFO - 'work_dir': 'build'} 01:36:41 INFO - [mozharness: 2017-04-20 08:36:41.702263Z] Running clobber step. 01:36:41 INFO - Running pre-action listener: _resource_record_pre_action 01:36:41 INFO - Running main action method: clobber 01:36:41 INFO - rmtree: /builds/slave/test/build 01:36:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:36:43 INFO - Running post-action listener: _resource_record_post_action 01:36:43 INFO - [mozharness: 2017-04-20 08:36:43.592039Z] Finished clobber step (success) 01:36:43 INFO - [mozharness: 2017-04-20 08:36:43.592168Z] Running read-buildbot-config step. 01:36:43 INFO - Running pre-action listener: _resource_record_pre_action 01:36:43 INFO - Running main action method: read_buildbot_config 01:36:43 INFO - Using buildbot properties: 01:36:43 INFO - { 01:36:43 INFO - "project": "", 01:36:43 INFO - "product": "firefox", 01:36:43 INFO - "script_repo_revision": "production", 01:36:43 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 01:36:43 INFO - "repository": "", 01:36:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 01:36:43 INFO - "buildid": "20170420004021", 01:36:43 INFO - "stage_platform": "macosx64", 01:36:43 INFO - "basedir": "/builds/slave/test", 01:36:43 INFO - "nightly_build": "True", 01:36:43 INFO - "buildnumber": 98, 01:36:43 INFO - "slavename": "t-yosemite-r7-0321", 01:36:43 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 01:36:43 INFO - "platform": "yosemite_r7", 01:36:43 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:36:43 INFO - "branch": "mozilla-aurora", 01:36:43 INFO - "repo_path": "releases/mozilla-aurora", 01:36:43 INFO - "revision": "94b7e538af7dbb9a6567cad9125c2f5411e7fb80", 01:36:43 INFO - "pgo_build": "False", 01:36:43 INFO - "builduid": "046c0cf8cb35499899cf0a80773c0825", 01:36:43 INFO - "slavebuilddir": "test" 01:36:43 INFO - } 01:36:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 01:36:43 INFO - Running post-action listener: _resource_record_post_action 01:36:43 INFO - [mozharness: 2017-04-20 08:36:43.595639Z] Finished read-buildbot-config step (success) 01:36:43 INFO - [mozharness: 2017-04-20 08:36:43.595752Z] Running download-and-extract step. 01:36:43 INFO - Running pre-action listener: _resource_record_pre_action 01:36:43 INFO - Running main action method: download_and_extract 01:36:43 INFO - mkdir: /builds/slave/test/build/tests 01:36: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')]} 01:36:43 INFO - trying https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 01:36:43 INFO - Downloading https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/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 01:36:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/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 01:36:44 INFO - Downloaded 1199 bytes. 01:36:44 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:36:44 INFO - Using the following test package requirements: 01:36:44 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:36:44 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:44 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 01:36:44 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:44 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 01:36:44 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:44 INFO - u'jsshell-mac.zip'], 01:36:44 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:44 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 01:36:44 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:36:44 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:44 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 01:36:44 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:44 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 01:36:44 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:44 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 01:36:44 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:36:44 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 01:36:44 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:36:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:36:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:36:44 INFO - Fetch https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:36:46 INFO - Expected file size: 51791352 01:36:46 INFO - Obtained file size: 51791352 01:37:02 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 01:37:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:37:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:37:02 INFO - Fetch https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:37:04 INFO - Expected file size: 51791352 01:37:04 INFO - Obtained file size: 51791352 01:37:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 01:37:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:37:18 INFO - Fetch https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 01:37:19 INFO - Expected file size: 14404424 01:37:19 INFO - Obtained file size: 14404424 01:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:19 INFO - trying https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:37:19 INFO - Downloading https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 01:37:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/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 01:37:22 INFO - Downloaded 74778539 bytes. 01:37:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:37:22 INFO - mkdir: /builds/slave/test/properties 01:37:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:37:22 INFO - Writing to file /builds/slave/test/properties/build_url 01:37:22 INFO - Contents: 01:37:22 INFO - build_url:https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:37:23 INFO - Running post-action listener: _resource_record_post_action 01:37:23 INFO - Running post-action listener: set_extra_try_arguments 01:37:23 INFO - [mozharness: 2017-04-20 08:37:23.253131Z] Finished download-and-extract step (success) 01:37:23 INFO - [mozharness: 2017-04-20 08:37:23.253242Z] Running populate-webroot step. 01:37:23 INFO - Running pre-action listener: _resource_record_pre_action 01:37:23 INFO - Running main action method: populate_webroot 01:37:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:37:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:37:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:37:23 INFO - '--tppagecycles', 01:37:23 INFO - '7'], 01:37:23 INFO - 'tests': ['tsvgm']}}, 01:37:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:37:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:37:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:37:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:37:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:37:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:37:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:37:23 INFO - 'talos_options': ['--disable-e10s'], 01:37:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:37:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:37:23 INFO - 'talos_options': ['--disable-e10s'], 01:37:23 INFO - 'tests': ['damp', 'tps']}, 01:37:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:37:23 INFO - 'tests': ['damp', 'tps']}, 01:37:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:37:23 INFO - 'tests': ['dromaeo_dom']}, 01:37:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:37:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:37:23 INFO - 'tests': ['basic_compositor_video']}, 01:37:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:37:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:37:23 INFO - 'tests': ['a11yr', 01:37:23 INFO - 'ts_paint', 01:37:23 INFO - 'tpaint', 01:37:23 INFO - 'sessionrestore', 01:37:23 INFO - 'sessionrestore_no_auto_restore', 01:37:23 INFO - 'tabpaint']}, 01:37:23 INFO - 'other-e10s': {'tests': ['a11yr', 01:37:23 INFO - 'ts_paint', 01:37:23 INFO - 'tpaint', 01:37:23 INFO - 'sessionrestore', 01:37:23 INFO - 'sessionrestore_no_auto_restore', 01:37:23 INFO - 'tabpaint']}, 01:37:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:37:23 INFO - 'ts_paint', 01:37:23 INFO - 'tpaint', 01:37:23 INFO - 'sessionrestore', 01:37:23 INFO - 'sessionrestore_no_auto_restore', 01:37:23 INFO - 'tabpaint']}, 01:37:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:37:23 INFO - 'ts_paint', 01:37:23 INFO - 'tpaint', 01:37:23 INFO - 'sessionrestore', 01:37:23 INFO - 'sessionrestore_no_auto_restore', 01:37:23 INFO - 'tabpaint']}, 01:37:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:37:23 INFO - 'tests': ['a11yr', 01:37:23 INFO - 'ts_paint', 01:37:23 INFO - 'tpaint', 01:37:23 INFO - 'sessionrestore', 01:37:23 INFO - 'sessionrestore_no_auto_restore', 01:37:23 INFO - 'tabpaint']}, 01:37:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:37:23 INFO - 'tests': ['a11yr', 01:37:23 INFO - 'ts_paint', 01:37:23 INFO - 'tpaint', 01:37:23 INFO - 'sessionrestore', 01:37:23 INFO - 'sessionrestore_no_auto_restore', 01:37:23 INFO - 'tabpaint']}, 01:37:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:37:23 INFO - 'tests': ['tsvgx', 01:37:23 INFO - 'tsvgr_opacity', 01:37:23 INFO - 'tart', 01:37:23 INFO - 'tscrollx', 01:37:23 INFO - 'cart', 01:37:23 INFO - 'tsvg_static']}, 01:37:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:37:23 INFO - 'tsvgr_opacity', 01:37:23 INFO - 'tart', 01:37:23 INFO - 'tscrollx', 01:37:23 INFO - 'cart', 01:37:23 INFO - 'tsvg_static']}, 01:37:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:37:23 INFO - 'talos_options': ['--disable-e10s'], 01:37:23 INFO - 'tests': ['tp5o']}, 01:37:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:37:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:37:23 INFO - 'talos_options': ['--disable-e10s', 01:37:23 INFO - '--xperf_path', 01:37:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:23 INFO - 'tests': ['tp5n']}, 01:37:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:37:23 INFO - 'talos_options': ['--xperf_path', 01:37:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:23 INFO - 'tests': ['tp5n']}}, 01:37:23 INFO - 'talos.zip': {'path': '', 01:37:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:37:23 INFO - Running post-action listener: _resource_record_post_action 01:37:23 INFO - [mozharness: 2017-04-20 08:37:23.271371Z] Finished populate-webroot step (success) 01:37:23 INFO - [mozharness: 2017-04-20 08:37:23.271458Z] Running create-virtualenv step. 01:37:23 INFO - Running pre-action listener: _resource_record_pre_action 01:37:23 INFO - Running main action method: create_virtualenv 01:37:23 INFO - Creating virtualenv /builds/slave/test/build/venv 01:37:23 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 01:37:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:37:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:37:23 INFO - Using real prefix '/tools/python27' 01:37:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:37:24 INFO - Installing distribute.............................................................................................................................................................................................done. 01:37:27 INFO - Installing pip.................done. 01:37:27 INFO - Return code: 0 01:37:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:37:27 INFO - Reading from file tmpfile_stdout 01:37:27 INFO - Output received: 01:37:27 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) 01:37:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102b32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb33dcb890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102910d30>, '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 0x102837db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102905be8>, '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.YavJEyOMZY/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.qeGVaUMk1k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:37:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:37:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YavJEyOMZY/Render', 01:37:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:27 INFO - 'HOME': '/Users/cltbld', 01:37:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:27 INFO - 'LOGNAME': 'cltbld', 01:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:27 INFO - 'MOZ_NO_REMOTE': '1', 01:37:27 INFO - 'NO_EM_RESTART': '1', 01:37:27 INFO - 'PAGER': '/bin/cat', 01:37:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:27 INFO - 'PWD': '/builds/slave/test', 01:37:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:27 INFO - 'SHELL': '/bin/bash', 01:37:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qeGVaUMk1k/Listeners', 01:37:27 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:37:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:27 INFO - 'USER': 'cltbld', 01:37:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:27 INFO - 'XPC_FLAGS': '0x0', 01:37:27 INFO - 'XPC_SERVICE_NAME': '0', 01:37:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:27 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 01:37:27 INFO - Cleaning up... 01:37:27 INFO - Return code: 0 01:37:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102b32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb33dcb890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102910d30>, '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 0x102837db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102905be8>, '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.YavJEyOMZY/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.qeGVaUMk1k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:37:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:37:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YavJEyOMZY/Render', 01:37:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:27 INFO - 'HOME': '/Users/cltbld', 01:37:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:27 INFO - 'LOGNAME': 'cltbld', 01:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:27 INFO - 'MOZ_NO_REMOTE': '1', 01:37:27 INFO - 'NO_EM_RESTART': '1', 01:37:27 INFO - 'PAGER': '/bin/cat', 01:37:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:27 INFO - 'PWD': '/builds/slave/test', 01:37:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:27 INFO - 'SHELL': '/bin/bash', 01:37:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qeGVaUMk1k/Listeners', 01:37:27 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:37:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:27 INFO - 'USER': 'cltbld', 01:37:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:27 INFO - 'XPC_FLAGS': '0x0', 01:37:27 INFO - 'XPC_SERVICE_NAME': '0', 01:37:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:27 INFO - Downloading/unpacking psutil>=3.1.1 01:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:37:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:31 INFO - Installing collected packages: psutil 01:37:31 INFO - Running setup.py install for psutil 01:37:31 INFO - building 'psutil._psutil_osx' extension 01:37:31 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 01:37:31 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 01:37:31 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 01:37:31 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 01:37:31 INFO - building 'psutil._psutil_posix' extension 01:37:31 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 01:37:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:37:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:37:32 INFO - ^ 01:37:32 INFO - 1 warning generated. 01:37:32 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 01:37:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:32 INFO - Successfully installed psutil 01:37:32 INFO - Cleaning up... 01:37:32 INFO - Return code: 0 01:37:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:37:32 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')]} 01:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:32 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')]} 01:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:32 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 0x102b32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb33dcb890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102910d30>, '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 0x102837db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102905be8>, '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.YavJEyOMZY/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.qeGVaUMk1k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:37:32 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 01:37:32 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 01:37:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YavJEyOMZY/Render', 01:37:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:32 INFO - 'HOME': '/Users/cltbld', 01:37:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:32 INFO - 'LOGNAME': 'cltbld', 01:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:32 INFO - 'MOZ_NO_REMOTE': '1', 01:37:32 INFO - 'NO_EM_RESTART': '1', 01:37:32 INFO - 'PAGER': '/bin/cat', 01:37:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:32 INFO - 'PWD': '/builds/slave/test', 01:37:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:32 INFO - 'SHELL': '/bin/bash', 01:37:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qeGVaUMk1k/Listeners', 01:37:32 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:37:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:32 INFO - 'USER': 'cltbld', 01:37:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:32 INFO - 'XPC_FLAGS': '0x0', 01:37:32 INFO - 'XPC_SERVICE_NAME': '0', 01:37:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:37:32 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 01:37:32 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 01:37:32 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 01:37:32 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 01:37:32 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 01:37:32 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 01:37:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:37:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:37:35 INFO - Installing collected packages: mozsystemmonitor 01:37:35 INFO - Running setup.py install for mozsystemmonitor 01:37:35 INFO - Successfully installed mozsystemmonitor 01:37:35 INFO - Cleaning up... 01:37:35 INFO - Return code: 0 01:37:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:37:35 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')]} 01:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:35 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')]} 01:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:35 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 0x102b32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb33dcb890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102910d30>, '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 0x102837db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102905be8>, '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.YavJEyOMZY/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.qeGVaUMk1k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:37:35 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 01:37:35 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 01:37:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YavJEyOMZY/Render', 01:37:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:35 INFO - 'HOME': '/Users/cltbld', 01:37:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:35 INFO - 'LOGNAME': 'cltbld', 01:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:35 INFO - 'MOZ_NO_REMOTE': '1', 01:37:35 INFO - 'NO_EM_RESTART': '1', 01:37:35 INFO - 'PAGER': '/bin/cat', 01:37:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:35 INFO - 'PWD': '/builds/slave/test', 01:37:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:35 INFO - 'SHELL': '/bin/bash', 01:37:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qeGVaUMk1k/Listeners', 01:37:35 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:37:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:35 INFO - 'USER': 'cltbld', 01:37:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:35 INFO - 'XPC_FLAGS': '0x0', 01:37:35 INFO - 'XPC_SERVICE_NAME': '0', 01:37:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:35 INFO - Downloading/unpacking jsonschema==2.5.1 01:37:35 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 01:37:35 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 01:37:35 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 01:37:35 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 01:37:35 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 01:37:35 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 01:37:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:37:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37:39 INFO - Downloading functools32-3.2.3-2.tar.gz 01:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:37:39 INFO - warning: no files found matching '*.txt' 01:37:39 INFO - no previously-included directories found matching 'build' 01:37:39 INFO - no previously-included directories found matching 'dist' 01:37:39 INFO - no previously-included directories found matching '.git*' 01:37:39 INFO - Installing collected packages: jsonschema, functools32 01:37:39 INFO - Running setup.py install for functools32 01:37:39 INFO - warning: no files found matching '*.txt' 01:37:39 INFO - no previously-included directories found matching 'build' 01:37:39 INFO - no previously-included directories found matching 'dist' 01:37:39 INFO - no previously-included directories found matching '.git*' 01:37:39 INFO - Successfully installed jsonschema functools32 01:37:39 INFO - Cleaning up... 01:37:39 INFO - Return code: 0 01:37:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102b32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb33dcb890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102910d30>, '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 0x102837db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102905be8>, '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.YavJEyOMZY/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.qeGVaUMk1k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:37:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:37:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YavJEyOMZY/Render', 01:37:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:39 INFO - 'HOME': '/Users/cltbld', 01:37:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:39 INFO - 'LOGNAME': 'cltbld', 01:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:39 INFO - 'MOZ_NO_REMOTE': '1', 01:37:39 INFO - 'NO_EM_RESTART': '1', 01:37:39 INFO - 'PAGER': '/bin/cat', 01:37:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:39 INFO - 'PWD': '/builds/slave/test', 01:37:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:39 INFO - 'SHELL': '/bin/bash', 01:37:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qeGVaUMk1k/Listeners', 01:37:39 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:37:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:39 INFO - 'USER': 'cltbld', 01:37:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:39 INFO - 'XPC_FLAGS': '0x0', 01:37:39 INFO - 'XPC_SERVICE_NAME': '0', 01:37:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:37:40 INFO - Cleaning up... 01:37:40 INFO - Return code: 0 01:37:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:40 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 0x102b32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb33dcb890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102910d30>, '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 0x102837db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102905be8>, '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.YavJEyOMZY/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.qeGVaUMk1k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:37:40 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 01:37:40 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 01:37:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YavJEyOMZY/Render', 01:37:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:40 INFO - 'HOME': '/Users/cltbld', 01:37:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:40 INFO - 'LOGNAME': 'cltbld', 01:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:40 INFO - 'MOZ_NO_REMOTE': '1', 01:37:40 INFO - 'NO_EM_RESTART': '1', 01:37:40 INFO - 'PAGER': '/bin/cat', 01:37:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:40 INFO - 'PWD': '/builds/slave/test', 01:37:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:40 INFO - 'SHELL': '/bin/bash', 01:37:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qeGVaUMk1k/Listeners', 01:37:40 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:37:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:40 INFO - 'USER': 'cltbld', 01:37:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:40 INFO - 'XPC_FLAGS': '0x0', 01:37:40 INFO - 'XPC_SERVICE_NAME': '0', 01:37:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:40 INFO - Downloading/unpacking blobuploader==1.2.4 01:37:40 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 01:37:40 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 01:37:40 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 01:37:40 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 01:37:40 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 01:37:40 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 01:37:42 INFO - Downloading blobuploader-1.2.4.tar.gz 01:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:37:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:37:43 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 01:37:43 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 01:37:43 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 01:37:43 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 01:37:43 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 01:37:43 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 01:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:37:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:37:43 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 01:37:43 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 01:37:43 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 01:37:43 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 01:37:43 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 01:37:43 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 01:37:44 INFO - Downloading docopt-0.6.1.tar.gz 01:37:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:37:44 INFO - Installing collected packages: blobuploader, requests, docopt 01:37:44 INFO - Running setup.py install for blobuploader 01:37:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:37:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:37:44 INFO - Running setup.py install for requests 01:37:44 INFO - Running setup.py install for docopt 01:37:45 INFO - Successfully installed blobuploader requests docopt 01:37:45 INFO - Cleaning up... 01:37:45 INFO - Return code: 0 01:37:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:45 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 0x102b32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb33dcb890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102910d30>, '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 0x102837db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102905be8>, '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.YavJEyOMZY/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.qeGVaUMk1k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:37:45 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 01:37:45 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 01:37:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YavJEyOMZY/Render', 01:37:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:45 INFO - 'HOME': '/Users/cltbld', 01:37:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:45 INFO - 'LOGNAME': 'cltbld', 01:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:45 INFO - 'MOZ_NO_REMOTE': '1', 01:37:45 INFO - 'NO_EM_RESTART': '1', 01:37:45 INFO - 'PAGER': '/bin/cat', 01:37:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:45 INFO - 'PWD': '/builds/slave/test', 01:37:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:45 INFO - 'SHELL': '/bin/bash', 01:37:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qeGVaUMk1k/Listeners', 01:37:45 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:37:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:45 INFO - 'USER': 'cltbld', 01:37:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:45 INFO - 'XPC_FLAGS': '0x0', 01:37:45 INFO - 'XPC_SERVICE_NAME': '0', 01:37:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:37:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-NNdak4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:37:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-ReM2AE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:37:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-wmte43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:37:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-D2LcPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:37:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-6U3uW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:37:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-iB4GdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:37:46 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-ahnAHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:37:46 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-SabSVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:37:46 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-4F6zfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:37:46 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-sCUONt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:37:46 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-JanJqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:37:46 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-stx0bV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:37:46 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-ZIIb4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:37:46 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-6C0J2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:37:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:46 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-m72dvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:37:47 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-c16WuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:37:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:37:47 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-kNZSnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:37:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:37:47 INFO - Running setup.py install for manifestparser 01:37:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:37:47 INFO - Running setup.py install for mozcrash 01:37:47 INFO - Running setup.py install for mozdebug 01:37:47 INFO - Running setup.py install for mozdevice 01:37:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:37:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:37:47 INFO - Running setup.py install for mozfile 01:37:47 INFO - Running setup.py install for mozhttpd 01:37:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:37:48 INFO - Running setup.py install for mozinfo 01:37:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:37:48 INFO - Running setup.py install for mozInstall 01:37:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:37:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:37:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:37:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:37:48 INFO - Running setup.py install for mozleak 01:37:48 INFO - Running setup.py install for mozlog 01:37:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:37:48 INFO - Running setup.py install for moznetwork 01:37:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:37:48 INFO - Running setup.py install for mozprocess 01:37:49 INFO - Running setup.py install for mozprofile 01:37:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:37:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:37:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:37:49 INFO - Running setup.py install for mozrunner 01:37:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:37:49 INFO - Running setup.py install for mozscreenshot 01:37:49 INFO - Running setup.py install for moztest 01:37:49 INFO - Running setup.py install for mozversion 01:37:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:37:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:37:49 INFO - Cleaning up... 01:37:49 INFO - Return code: 0 01:37:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:49 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 0x102b32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb33dcb890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102910d30>, '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 0x102837db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102905be8>, '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.YavJEyOMZY/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.qeGVaUMk1k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:37:49 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 01:37:49 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 01:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YavJEyOMZY/Render', 01:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:49 INFO - 'HOME': '/Users/cltbld', 01:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:49 INFO - 'LOGNAME': 'cltbld', 01:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:49 INFO - 'MOZ_NO_REMOTE': '1', 01:37:49 INFO - 'NO_EM_RESTART': '1', 01:37:49 INFO - 'PAGER': '/bin/cat', 01:37:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:49 INFO - 'PWD': '/builds/slave/test', 01:37:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:49 INFO - 'SHELL': '/bin/bash', 01:37:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qeGVaUMk1k/Listeners', 01:37:49 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:37:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:49 INFO - 'USER': 'cltbld', 01:37:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:49 INFO - 'XPC_FLAGS': '0x0', 01:37:49 INFO - 'XPC_SERVICE_NAME': '0', 01:37:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:37:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-bI1Fwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:37:50 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)) 01:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:37:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Emw_Lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:37:50 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)) 01:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:37:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-6RlolO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:37:50 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)) 01:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:37:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-K9aJdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:37:50 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)) 01:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:37:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-LG30px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:37:50 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)) 01:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:37:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-opsORw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:37:50 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)) 01:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:37:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-yk1_Lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:37:50 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)) 01:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:37:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-fPFFwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:37:50 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)) 01:37:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:37:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-_JOJoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:37:51 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)) 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:37:51 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-eggYeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:37:51 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)) 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:37:51 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-y2uOWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:37:51 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)) 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:37:51 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-TAoQxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:37:51 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)) 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:37:51 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-EthLI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:37:51 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)) 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:37:51 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-wzNPPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:37:51 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)) 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:51 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-xkwQlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:51 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)) 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:37:51 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-UGEqwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:37:51 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)) 01:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:37:51 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-3_BMbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:37:51 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)) 01:37:51 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)) 01:37:51 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)) 01:37:51 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)) 01:37:51 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)) 01:37:51 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)) 01:37:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37:54 INFO - Downloading blessings-1.6.tar.gz 01:37:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:37:54 INFO - Installing collected packages: blessings 01:37:54 INFO - Running setup.py install for blessings 01:37:54 INFO - Successfully installed blessings 01:37:54 INFO - Cleaning up... 01:37:54 INFO - Return code: 0 01:37:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:37:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:37:55 INFO - Reading from file tmpfile_stdout 01:37:55 INFO - Current package versions: 01:37:55 INFO - blessings == 1.6 01:37:55 INFO - blobuploader == 1.2.4 01:37:55 INFO - docopt == 0.6.1 01:37:55 INFO - functools32 == 3.2.3-2 01:37:55 INFO - jsonschema == 2.5.1 01:37:55 INFO - manifestparser == 1.1 01:37:55 INFO - mozInstall == 1.12 01:37:55 INFO - mozcrash == 1.0 01:37:55 INFO - mozdebug == 0.1 01:37:55 INFO - mozdevice == 0.49 01:37:55 INFO - mozfile == 1.2 01:37:55 INFO - mozhttpd == 0.7 01:37:55 INFO - mozinfo == 0.9 01:37:55 INFO - mozleak == 0.1 01:37:55 INFO - mozlog == 3.4 01:37:55 INFO - moznetwork == 0.27 01:37:55 INFO - mozprocess == 0.25 01:37:55 INFO - mozprofile == 0.28 01:37:55 INFO - mozrunner == 6.13 01:37:55 INFO - mozscreenshot == 0.1 01:37:55 INFO - mozsystemmonitor == 0.3 01:37:55 INFO - moztest == 0.8 01:37:55 INFO - mozversion == 1.4 01:37:55 INFO - psutil == 3.1.1 01:37:55 INFO - requests == 1.2.3 01:37:55 INFO - wsgiref == 0.1.2 01:37:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:55 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 0x102b32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb33dcb890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102910d30>, '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 0x102837db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102905be8>, '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.YavJEyOMZY/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.qeGVaUMk1k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:37:55 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 01:37:55 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 01:37:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YavJEyOMZY/Render', 01:37:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:55 INFO - 'HOME': '/Users/cltbld', 01:37:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:55 INFO - 'LOGNAME': 'cltbld', 01:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:55 INFO - 'MOZ_NO_REMOTE': '1', 01:37:55 INFO - 'NO_EM_RESTART': '1', 01:37:55 INFO - 'PAGER': '/bin/cat', 01:37:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:55 INFO - 'PWD': '/builds/slave/test', 01:37:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:55 INFO - 'SHELL': '/bin/bash', 01:37:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qeGVaUMk1k/Listeners', 01:37:55 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:37:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:55 INFO - 'USER': 'cltbld', 01:37:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:55 INFO - 'XPC_FLAGS': '0x0', 01:37:55 INFO - 'XPC_SERVICE_NAME': '0', 01:37:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:55 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)) 01:37:55 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)) 01:37:55 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)) 01:37:55 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)) 01:37:55 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)) 01:37:55 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)) 01:37:55 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)) 01:37:55 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)) 01:37:55 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)) 01:37:55 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)) 01:37:55 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)) 01:37:55 INFO - Cleaning up... 01:37:55 INFO - Return code: 0 01:37:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102b32b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b35768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb33dcb890>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102910d30>, '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 0x102837db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102905be8>, '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.YavJEyOMZY/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.qeGVaUMk1k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 01:37:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:37:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YavJEyOMZY/Render', 01:37:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:55 INFO - 'HOME': '/Users/cltbld', 01:37:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:55 INFO - 'LOGNAME': 'cltbld', 01:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:55 INFO - 'MOZ_NO_REMOTE': '1', 01:37:55 INFO - 'NO_EM_RESTART': '1', 01:37:55 INFO - 'PAGER': '/bin/cat', 01:37:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:55 INFO - 'PWD': '/builds/slave/test', 01:37:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:55 INFO - 'SHELL': '/bin/bash', 01:37:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qeGVaUMk1k/Listeners', 01:37:55 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:37:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:55 INFO - 'USER': 'cltbld', 01:37:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:55 INFO - 'XPC_FLAGS': '0x0', 01:37:55 INFO - 'XPC_SERVICE_NAME': '0', 01:37:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:37:55 INFO - Cleaning up... 01:37:55 INFO - Return code: 0 01:37:55 INFO - Running post-action listener: _resource_record_post_action 01:37:55 INFO - Running post-action listener: _start_resource_monitoring 01:37:55 INFO - Starting resource monitoring. 01:37:55 INFO - [mozharness: 2017-04-20 08:37:55.722263Z] Finished create-virtualenv step (success) 01:37:55 INFO - [mozharness: 2017-04-20 08:37:55.723311Z] Running install step. 01:37:55 INFO - Running pre-action listener: _resource_record_pre_action 01:37:55 INFO - Running main action method: install 01:37:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:37:55 INFO - Reading from file tmpfile_stdout 01:37:55 INFO - Detecting whether we're running mozinstall >=1.0... 01:37:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:37:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:37:56 INFO - Reading from file tmpfile_stdout 01:37:56 INFO - Output received: 01:37:56 INFO - Usage: mozinstall [options] installer 01:37:56 INFO - Options: 01:37:56 INFO - -h, --help show this help message and exit 01:37:56 INFO - -d DEST, --destination=DEST 01:37:56 INFO - Directory to install application into. [default: 01:37:56 INFO - "/builds/slave/test"] 01:37:56 INFO - --app=APP Application being installed. [default: firefox] 01:37:56 INFO - mkdir: /builds/slave/test/build/application 01:37:56 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'] 01:37:56 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 01:38:16 INFO - Reading from file tmpfile_stdout 01:38:16 INFO - Output received: 01:38:16 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:38:16 INFO - Running post-action listener: _resource_record_post_action 01:38:16 INFO - [mozharness: 2017-04-20 08:38:16.431879Z] Finished install step (success) 01:38:16 INFO - [mozharness: 2017-04-20 08:38:16.432017Z] Running run-tests step. 01:38:16 INFO - Running pre-action listener: _resource_record_pre_action 01:38:16 INFO - Running main action method: run_tests 01:38:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:38:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:38:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:38:16 INFO - 2017-04-20 01:38:16.446 screenresolution[2367:30243] starting screenresolution argv=screenresolution get 01:38:16 INFO - 2017-04-20 01:38:16.449 screenresolution[2367:30243] Display 0: 1600x1200x32@60 01:38:16 INFO - 2017-04-20 01:38:16.455 screenresolution[2368:30246] starting screenresolution argv=screenresolution list 01:38:16 INFO - Available Modes on Display 0 01:38:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:38:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:38:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:38:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:38:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:38:16 INFO - Intel Iris: 01:38:16 INFO - Chipset Model: Intel Iris 01:38:16 INFO - Type: GPU 01:38:16 INFO - Bus: Built-In 01:38:16 INFO - VRAM (Dynamic, Max): 1536 MB 01:38:16 INFO - Vendor: Intel (0x8086) 01:38:16 INFO - Device ID: 0x0a2e 01:38:16 INFO - Revision ID: 0x0009 01:38:16 INFO - Displays: 01:38:16 INFO - Display: 01:38:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:38:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:38:16 INFO - Display Serial Number: 1600x1200 60 01:38:16 INFO - Main Display: Yes 01:38:16 INFO - Mirror: Off 01:38:16 INFO - Online: Yes 01:38:16 INFO - Rotation: Supported 01:38:16 INFO - Return code: 0 01:38:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:38:16 INFO - Python 2.7.3 01:38:16 INFO - Return code: 0 01:38:16 INFO - grabbing minidump binary from tooltool 01:38:16 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')]} 01:38:16 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 0x102910d30>, '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 0x102837db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102905be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:38:16 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 01:38:16 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 01:38:16 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 01:38:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:38:16 INFO - Return code: 0 01:38:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:38:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:38:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:38:16 INFO - ENV: RUST_BACKTRACE is now 1 01:38:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:38:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:38:16 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/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 01:38:16 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/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0321 --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 01:38:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YavJEyOMZY/Render', 01:38:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:16 INFO - 'HOME': '/Users/cltbld', 01:38:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:16 INFO - 'LOGNAME': 'cltbld', 01:38:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:38:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:16 INFO - 'MOZ_NO_REMOTE': '1', 01:38:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:38:16 INFO - 'NO_EM_RESTART': '1', 01:38:16 INFO - 'PAGER': '/bin/cat', 01:38:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:16 INFO - 'PWD': '/builds/slave/test', 01:38:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:38:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:16 INFO - 'RUST_BACKTRACE': '1', 01:38:16 INFO - 'SHELL': '/bin/bash', 01:38:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qeGVaUMk1k/Listeners', 01:38:16 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 01:38:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:16 INFO - 'USER': 'cltbld', 01:38:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:16 INFO - 'XPC_FLAGS': '0x0', 01:38:16 INFO - 'XPC_SERVICE_NAME': '0', 01:38:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:16 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/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 01:38:17 INFO - mozversion application_buildid: 20170420004021 01:38:17 INFO - mozversion application_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:38:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:38:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:38:17 INFO - mozversion application_name: Firefox 01:38:17 INFO - mozversion application_remotingname: firefox-dev 01:38:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:38:17 INFO - mozversion application_vendor: Mozilla 01:38:17 INFO - mozversion application_version: 54.0a2 01:38:17 INFO - mozversion platform_buildid: 20170420004021 01:38:17 INFO - mozversion platform_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 01:38:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:38:17 INFO - mozversion platform_version: 54.0a2 01:38:17 INFO - using testdate: 1492677497 01:38:17 INFO - actual date: 1492677497 01:38:17 INFO - starting webserver on 'localhost:57697' 01:38:17 INFO - SUITE-START | Running 2 tests 01:38:17 INFO - TEST-START | dromaeo_css 01:38:17 INFO - operating with platform_type : mac_ 01:38:17 INFO - Initialising browser for dromaeo_css test... 01:38:17 INFO - TEST-INFO | started process 2378 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpBnnaVR/profile http://localhost:57697/getInfo.html) 01:38:19 INFO - PROCESS | 2378 | __metrics Screen width/height:1600/1200 01:38:19 INFO - PROCESS | 2378 | colorDepth:24 01:38:19 INFO - PROCESS | 2378 | Browser inner width/height: 1024/689 01:38:19 INFO - PROCESS | 2378 | __metrics 01:38:19 INFO - PROCESS | 2378 | 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" 01:38:19 INFO - PROCESS | 2378 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:38:20 INFO - TEST-INFO | 2378: exit 0 01:38:20 INFO - Browser initialized. 01:38:20 INFO - Running cycle 1/1 for dromaeo_css test... 01:38:20 INFO - TEST-INFO | started process 2381 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpBnnaVR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:38:32 INFO - PROCESS | 2381 | RSS: Main: 215592960 01:38:32 INFO - PROCESS | 2381 | 01:41:37 INFO - PROCESS | 2381 | Cycle 1(1): loaded http://localhost:57697/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57697/tests/dromaeo/cssquery-ext.html) 01:41:39 INFO - PROCESS | 2381 | RSS: Main: 367792128 01:41:39 INFO - PROCESS | 2381 | 01:43:22 INFO - PROCESS | 2381 | ************************* 01:43:22 INFO - PROCESS | 2381 | A coding exception was thrown and uncaught in a Task. 01:43:22 INFO - PROCESS | 2381 | 01:43:22 ERROR - PROCESS | 2381 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:43:22 INFO - PROCESS | 2381 | Full stack: 01:43:22 INFO - PROCESS | 2381 | ************************* 01:43:22 INFO - PROCESS | 2381 | ************************* 01:43:22 INFO - PROCESS | 2381 | A coding exception was thrown and uncaught in a Task. 01:43:22 INFO - PROCESS | 2381 | 01:43:22 ERROR - PROCESS | 2381 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:43:22 INFO - PROCESS | 2381 | Full stack: 01:43:22 INFO - PROCESS | 2381 | ************************* 01:43:22 INFO - PROCESS | 2381 | ************************* 01:43:22 INFO - PROCESS | 2381 | A coding exception was thrown and uncaught in a Task. 01:43:22 INFO - PROCESS | 2381 | 01:43:22 ERROR - PROCESS | 2381 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:43:22 INFO - PROCESS | 2381 | Full stack: 01:43:22 INFO - PROCESS | 2381 | ************************* 01:43:22 INFO - PROCESS | 2381 | ************************* 01:43:22 INFO - PROCESS | 2381 | A coding exception was thrown and uncaught in a Task. 01:43:22 INFO - PROCESS | 2381 | 01:43:22 ERROR - PROCESS | 2381 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:43:22 INFO - PROCESS | 2381 | Full stack: 01:43:22 INFO - PROCESS | 2381 | ************************* 01:44:41 INFO - PROCESS | 2381 | Cycle 1(1): loaded http://localhost:57697/tests/dromaeo/cssquery-ext.html (next: http://localhost:57697/tests/dromaeo/cssquery-jquery.html) 01:44:42 INFO - PROCESS | 2381 | RSS: Main: 351793152 01:44:42 INFO - PROCESS | 2381 | 01:47:44 INFO - PROCESS | 2381 | Cycle 1(1): loaded http://localhost:57697/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57697/tests/dromaeo/cssquery-mootools.html) 01:47:45 INFO - PROCESS | 2381 | RSS: Main: 327667712 01:47:45 INFO - PROCESS | 2381 | 01:50:47 INFO - PROCESS | 2381 | Cycle 1(1): loaded http://localhost:57697/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57697/tests/dromaeo/cssquery-prototype.html) 01:50:48 INFO - PROCESS | 2381 | RSS: Main: 317116416 01:50:48 INFO - PROCESS | 2381 | 01:53:52 INFO - PROCESS | 2381 | Cycle 1(1): loaded http://localhost:57697/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57697/tests/dromaeo/cssquery-yui.html) 01:53:52 INFO - PROCESS | 2381 | RSS: Main: 325132288 01:53:52 INFO - PROCESS | 2381 | 01:56:56 INFO - PROCESS | 2381 | Cycle 1(1): loaded http://localhost:57697/tests/dromaeo/cssquery-yui.html (next: http://localhost:57697/tests/dromaeo/cssquery-dojo.html) 01:56:56 INFO - PROCESS | 2381 | RSS: Main: 481390592 01:56:56 INFO - PROCESS | 2381 | 01:56:56 INFO - PROCESS | 2381 | __start_tp_report 01:56:56 INFO - PROCESS | 2381 | _x_x_mozilla_page_load 01:56:56 INFO - PROCESS | 2381 | _x_x_mozilla_page_load_details 01:56:56 INFO - PROCESS | 2381 | |i|pagename|runs| 01:56:56 INFO - PROCESS | 2381 | |0;dojo.html;3376.2572234108497;3391.050505858359;3391.643877392873;3414.0611331883715;3442.4664177052564;4753.524647535245;5837.795677151301;5872.00175970085;5939.703014849257;5950.583459157855;5859.6777177255235;5931.110333449974;5944.256967879015;5946.5242780577555;5953.732082056307;5305.257263983045;5319.680819150844;5341.145416733323;5389.029974604569;5464.726763661821;5260.210968354758;5261.0267100586325;5450.672959622435;5469.945300547003;5476.507114359707;5276.261323414706;5325.707086110262;5334.413214546396;5342.412334643186;5351.384590772052;4893.314935908976;4918.704877707349;5352.812651557177;5359.5444387227135;5363.892722145574;5172.379314482248;5300.973495132538;5302.469753024705;5320.52115309624;5337.919931201035;5898.085796701518;5898.911516327258;5908.320543137551;5915.645061296336;5916.437938395846;6218.689065546704;6230.158928544633;6249.687515624246;6251.437370636664;6252.343503932113;6251.437370636664;6263.718132683995;6291.245050593912;6308.558400911938;6339.904901426482;6057.200819427583;6062.272527296708;6069.302030266532;6079.848003799941;6080.726367313481;6395.168628078367;6457.128287681103;6460.612363258219;6479.416852483299;6485.578437401554;6106.39999602577;6156.815295541141;6179.227596550431;6220.564560480723;6264.436200741955;6349.365063493614;6365.204349456318;6370.77702280418;6372.235331760218;6375.71309291083;6270.655113968684;6284.968575157095;6290.49676025926;6294.748210071637;6305.4009869062365;6125.295591007002;6197.752089916443;6210.006398976142;6243.719032643542;6277.089821975788;5069.695818250843;5116.795328186831;5131.974340128276;5163.845084647466;5165.870853228699;4529.32060190974;4537.682362234612;4538.909221815546;4547.295169248771;4578.40480737502;5645.774169033275;5720.885582288331;5976.61152025117;5978.880422391528;5992.041273396323;5215.322008138917;6268.62388256697;6293.433590976834;6309.463695585927;6323.557350985387;5953.3451320354725;5985;5989.251343582052;5994.130851026577;6015.909761353583;5632.5212356950115;5635.408282130399;5635.690037048002;5638.323401191801;5645.9717701412055;6212.254529456313;6299.11812346281;6402.295747467681;6442.35576442352;6521.5108866834225;6350.174477317919;6362.840928976812;6363.7772677956045;6369.20384951881;6382.872342553216;6425.261094973951;6505.219373675;6507.837304067436;6525.836854078686;6541.378569035934;6153.538484613761;6201.720922558586;6211.875762484816;6238.220222472191;6329.398707122816;6320.4311611955145;6337.873242535031;6346.714397852015;6362.522810789302;6368.267649220214;6260.123582698517;6266.060090986206;6275.121482992294;6277.027060805583;6281.9948808190475;6066.272047354346;6115.205023346936;6249.50003999688;6255.437010669061;6270.9372906270355;6135.754569817157;6139.631622102688;6174.6912654368;6185.628862268279;6188.071789231652;6245.718942647501;6266.060090986389;6271.090691849565;6280.371962803683;6282.057691346152;5938.406159384027;5962.344142144274;5964.254468191476;5972.34304226526;6106 01:56:56 INFO - PROCESS | 2381 | |1;ext.html;762.4624639629062;792.4571668407142;816.4366587054933;877.1141147441086;890.3278025091055;27844.58233126502;39988.20023599526;40490.58282960097;40609.796951015276;40814;33883.491747623746;41118.58881411185;41941.95145121373;41985.16029679405;42128.36807447891;6286.559940804123;9116.179543841054;9286.907130928672;9287.907120928805;9288.071192880725;7380.77857664271;10820.783584328308;11064.778704425906;11188.888111118866;11191;9989.800203995916;10364.948175259113;10983.725406864813;11052.502637381338;11055.557777688882;7182.533135346186;11005.339679619248;11019.393933333664;11025;11047.95044470778;7272.600006999613;10597.258191926569;10817.459127043696;10960.835587466194;10968.561257549689;39216.80391598052;39378.40932385988;39446.605533944865;39476;39524.80237598823;3458.8097654628987;3489.8255087245534;3506.4564992426212;3508.859645614172;3559.056849934769;21550.461238469165;26593.867030664915;26606.068787592536;27228.047018354264;28144.43711125766;3031.4240294344004;3083.922901927447;3160;3171.3181665941934;3273.3616944695796;340700;340952;341083;341514;341872;51815.48184518182;51825;51902.48097518976;51989.48010519846;51993.48006519886;54379.45620543744;54423.18365224525;54459.18311225335;54586.727066364416;54620.45379546233;14615.634609134644;14704.044237124554;14745.631359215891;14772.852271477363;14804.333804978802;10968.067714244218;11195.888041119648;12657.240565566095;12695.49218031287;12700.237985720887;10911.618093366695;10982.890171098186;10992.670219893416;11004.449777511092;13610.59168224955;4781.453990057721;5005.449400565934;5390.8921821563345;5890.823275301748;5950.702464876739;948.3172116076414;963.9710808675751;965.3628605120728;980.6662938403765;1004.6734811186394;29034.41931161365;29063.709362906102;29400.82396704108;29657.9619713309;29747.40505189884;923.5290002098843;957.200737384278;1036.6734478639205;1043.3009883378154;1079.2013909706918;14096.942729295344;14118.152910825384;14592.402352077883;14773.852261477248;14867.628309292355;466057;470551;471064;471103;472500;45094.549054509036;55889.7205513978;56100.43899560952;56325.7183714087;56425;1294.5792617399384;1348.797680347936;1351.8783309502192;1353.9052266341262;1357.172125003747;27448.313792155357;28236.865849463473;28346.71653283441;28584.428311434072;28751;46375.53624463712;46447.303290451346;46510;46576;46622.53377466182;436997;437961;438059;438306;445783;34406.31187376288;34521.964341069805;35218.295634087684;35274;35316.823415882754;43532.782336088116;43545;43583;44426.11147777091;44495.332570010825;23933.401664958514;29400.55899161557;30228.09315720532;30594.847025764728;30627;29215.415691686474;29733.851330744073;30497.39005219839;30503;30515.694843052173;35637.64362356343;36023.459648105825;36116;36257.63742362543;36387.45418818773;29558;29803.10590682283;30008.24979375533;30020.549691754204;30844.383112338077;22948.885255573616;23931.880340598185;24267.39331516726;24582.50834983326;24613.384665382793 01:56:56 INFO - PROCESS | 2381 | |2;jquery.html;380.7182684813239;426.1306933854936;427.21915302857735;430.74155506695985;439.52311741760167;15432.922835385822;19912.60174796505;21652.566948661017;21682.132714691434;22028.11887524497;21399.67900481494;21909.671354929687;22295.554088918212;22530.746925307503;22545.549089018208;5412.323459567554;6724.999999999988;6767.69545370457;7008.894866577006;7056.647167641623;6818.454523638097;6945.166580010406;6947.513674042819;6949.89575156373;6951.026856240105;6663.866722665568;6886.104806375164;6972.477064220178;6981;6995.475339349544;5784.30588329399;5791.652500849962;6755.121834161528;6838.384545390913;6843.726250949956;6550.6069635822005;6748.257691653914;6751.42612877906;6753.08833307507;6755.49333799967;23985.40036499084;25058.749412505826;26729.930802767867;26943.056993005346;27115.728842711516;3095.4273459409856;3260.2827377976805;3305.1241421023446;3326.5841769778776;3465.9502116648714;15424.614384640474;15836.129012904286;15869.365225390971;15870.285837137357;15930.283137258735;1984.2360691133872;2075.6678931371057;2087.2590230468268;2126.670366093258;2149.871007739541;157675;160458;164690;165004;167024;14763.114213147246;19201.423957281302;19808.801911980983;20012.59974800496;20015.897535881963;28303.009394671088;29142;29171.124866254046;29242.268943276587;29269.707302927123;9648.807023859625;10078.445685487368;10136.493175341204;10149.847752283722;10340.638077667245;6996.790096297119;8480.15198480147;8485.533295668674;8499.447535910145;8655.091215422415;7005.684744186422;8998.280137589109;9059.36584439096;9173.908260917438;9188.90811091894;3258.885938992124;3408.4376077946863;3434.553508043938;3571.7321200910037;3785.6782173515558;740.344794856545;828.0146625515617;891.3715830339595;899.3299991506369;904;20441.977901104885;20672.896635517027;21195.25816596412;21208.787912120682;21275.8936205318;871.242019443076;919.384012711485;921.7695576105973;937.8686983822271;946.7017889364828;10354.068133867837;10671.679849604525;11050.834237486444;11134.49894754738;11141.777164456666;595129;595568;610599;685609;713132;150126.24936875247;150263;150360.74458883126;154372;155964;1253.3169422664669;1261.5836773864603;1286.903482238817;1293.4696774322483;1293.4826069572246;17612.82387176163;18392.080395980414;18637.347692831227;18686.5985051119;18699;40227.59772402239;46213;61801;62717;64249.67875160594;83649;84104;85155.1484485172;86819.56590217008;88031;11315.660530184108;11331.433428328386;11460.713482163013;11592.768144637228;11762;12683.619491415273;12890;13122.212667239995;13188.406521706354;13372.799408009083;11115.666530004113;11222.102231821598;11232.438378081226;11326.603568875049;11549.480273387886;10206.795864082826;10259.384436933808;10393.97317523106;10428.530716117944;10833.67498975032;11500.137489688139;11506.654800356002;11661.416929153338;11734.647960561197;11905.821412678644;11324.660260192208;11373.431328433711;11427.771444571228;11724.472398741906;11800.468978895799;11218.775624487302;11260.549578016788;11305.321680699184;11313.660590182308;11622.0702343814 01:56:56 INFO - PROCESS | 2381 | |3;mootools.html;1458.8395276519584;1483.4881965721836;1528;1550.8139023317203;1554.2073542493329;10444.26890117691;11000.559977600906;11009.229353945217;11011.449427528632;11047.889521104786;10716.624918127867;11089.55641774328;11199.104071674266;11207.047400970907;11244.606438774645;2119.6857948072216;2339.6256598944174;2375;2379.916702915398;2380.321608341623;2245.865248085112;2280.8859557022165;2371.513839662865;2372.4306166519996;2385.964210536835;2307.9307620771406;2344.988275058622;2359.3511784259294;2365.7161140663143;2371.762823717632;2301.8503797253125;2302.1712183613886;2325.732540757809;2326.3021093671914;2333.8482998605036;2331.4637633344255;2332.941676458085;2334.9182778602667;2335.92992210234;2341.028473183627;10999.560017599286;11071.058959988412;11096;11103.278286911325;11106.666799996014;5435.456454354572;5594.300712410949;5604;5611.6352437091455;5618.381977982419;3291.8024918504966;3315.535824984504;3462.3594634992605;3486.8779592714386;3557.6086630470886;1103.1671088328342;1145.6677563506573;1162.7441962768178;1173.23153334566;1173.2608456672326;13462.730745385037;13781.379837907318;14096.224707640973;15214.391424343014;15272.465463708828;4048.2105989332385;4137.441445404892;4154.480689913761;4167.187398457272;4444.244478438609;11479;11502.309861408343;11532.25040372373;11573;11588.36264005471;5536.363318218376;5542;5543.833684989457;5545.7781688732;5548.9722551386985;4941.184704523714;5113.64204505681;5172.327597412387;5187.507186817246;5194.818181363634;3631.1103779573646;3753.249350129985;3777.6033516480925;3825.407061905409;3853.2100919311474;955.5795450001976;966.4925913895261;973.4500007495742;975.6341371985505;993.9353941993747;953.3374304858057;972.4262685015875;978.7602037500858;979.8285300072458;991.8660980767648;6371;6587.703553340111;6675.9332406676285;6748.561343512754;6898.206706228848;917.6283605139929;994.4282037828277;1018.8471729240525;1033.8266068012708;1056.8995945385177;4162.7502349859105;4249.40508328828;4249.851255206053;4315.611594956469;4395.164918665443;12779.616611501484;13215.66960825987;13233.536826211037;13279.800802987962;13298.867011329763;13170.60488185356;13218.272994985367;13239.338033098307;13242;13260.801087983687;9775.462349570842;9893.65372211969;9928.305018648625;10071.34536255141;10071.992800720016;5790.218320526675;6385.936140638534;6448.193975753031;6607.00894865774;6611.966940165461;11807.114466414881;12161.087918405978;12170.75658486843;12218.877811221773;12227.816582751087;11301.26541774782;11399.316041037564;12267.447964841782;12488.313142776871;12508.499660013498;8348.33213342919;9262.44425334482;9395.248380129437;9405.905940940504;9412.764680883032;10299.021592948659;10307.381557106597;10414.583416663248;10466.005729455994;10494.108000820015;8482.533460659723;8589.914100858912;8658.350623703122;8682.43564168327;8933.330000249878;8338.541380224146;8494.53280069602;8538.487690738575;8557.358198135289;8705.042445331135;7638.770836874903;7796.4932279401655;7860.960695196487;7915.722949696733;7920.960395197987;5767.394423585631;5891.263592050994;5954.940450595439;5957.791477298274;6059.484943779828;5657.60396772222;5967.224260846236;6044.607100538451;6083.847903802441;6158.969205153946 01:56:56 INFO - PROCESS | 2381 | |4;prototype.html;350.17533708117384;378.3397970541404;383.24691980258785;384.34852924293324;389.33423845224667;4776.641751868607;5035.848924532265;5053.570446512042;5053.823116190934;5054.090348604436;4114.897127571812;4363.821768122605;4555.52167022462;4984.451710311862;4998.325226094476;4113.4858142732155;4174.8121334539865;4179.561146079664;4193.454850869382;4204.096119334343;3646.6171052039554;3832.7351973848563;3994.660453861425;4258.765767882765;4261.403403523509;3600.8837260449213;3936.409538569223;4172.645325147351;4218.261804184255;4242.554531774165;3848.3073046851555;4033.9596604033877;4109.034376921421;4127.5666055064385;4147.398627199054;3813.31360355136;3823.801314244293;3838.7312888097845;3839.520059992501;3864.285107255139;4340.52254252032;4389.275769498029;4900.534449227318;4912.985675872875;4943.802247910079;4132.855350062733;4553.908921821545;4808.3989501312335;4861.8784530386665;4900.387451568554;5380.650257733235;5405.864853378657;5448;5467.343918729738;5478.616496845222;3882.650561449455;4315.395844581761;4356.409910382719;4374.1033088217155;4395.494518130392;5246.45229657252;5611.373654739696;5629.173805111731;5682.971585142089;5698.002849501362;3534.628863969246;3747.5315585551807;4120.166525895947;4319.941614304453;4336.869893903188;4393.714408563433;4421.425214722066;4423.225935461282;4452.799624016927;4540.661559296965;4028.8187031583648;4507.3689683444345;4550.317452382103;4824.855254342376;4834.912144767399;4884.511548845087;5160.845174644766;5394.811181608703;5416.10634245353;5446.836594902159;1325.2843464529046;1416.3484796993498;1541.4450797712814;1545.698588775178;1551.9767203491956;956.5599824080862;1074.462768615692;1151.3897634253858;1159.2001518951897;1175.8300491011498;4618.376519169869;4628.583427491474;4920.729359885169;4933.629977751683;5076.720780357042;5231.790728370898;5348.545373643206;5599.0761524348845;5637.915431268534;5671.17767923657;4347.934780978288;4861.732604706775;5040.2691609716385;5080.822171223989;5084.339035925306;2727.863606819651;2783.5685468752376;2910.57796619489;2916.912492625182;2924.7806414518996;5263.868403289872;5529.281193444826;5831.2127862738835;5863.560232982458;5877.265341832271;5083.796648134107;5372.200312895224;5388.892222155535;5647.7176141193595;5750.683712395775;5656.295126692024;5721.742521586539;5780.364159942403;5840.722118373753;5877.94122058774;5026.623003274696;5642.830715078554;5660.499967508531;5680.40355762639;5683.2895888014;4476.239039363381;4915.778789954532;4949.406071271471;5440.591955603425;5553.0004599172535;4586.449626044896;5441.700706461183;5777.595568310346;5814.970925145347;5876.941230587639;4082.652974497201;4243.917800960735;4405.735655860659;4456.777161141995;4523.864284071483;5311.814086506954;5365.229474273402;5537.7784888604;5607.859803504945;5666.291713535808;4199.622034016953;5181.948180518147;5399.7300134993875;5435.755391007493;5437.564994800486;4933.77797999098;4965.776540055634;4974.776135073858;5425.21334406501;5447.536959358499;4785.59322457581;5319.946800531945;5320.733963301896;5345.1714984177515;5383.892322153457;4465.615659145676;4679.766011699469;4861.51384861511;5435.483629055233;5470.835874923759;4140.730852494578;5144.356955380577;5257.608842296773;5265.341832270966;5363.264734985263 01:56:56 INFO - PROCESS | 2381 | |5;yui.html;710.4032612605411;745.0984308986126;757.8294883651179;814.9674013039479;825.9710910118147;15373.615659608515;15678;15894.602634934132;15921.363145474166;17441.04074275914;16366.427175048875;16662.83337166628;16690;16766.74849877253;17859.10704464775;924.7549399409162;959.3045042344314;961.9855702164473;962.6101428921298;963.8072385522923;931.6925414613162;949.2311227905384;950.8668786369914;952.2477242978039;952.642758965388;996.5565323431076;1009.1573536097368;1009.6112996496365;1017.8167929772638;1019.1642852860657;1012.0840639221443;1013.8580598716186;1014.2747935226312;1015.6343716262139;1017.2218253036433;745.5489428895548;750.2759836757555;751.3275618321626;751.9586422746747;755.0524092264228;15907.60230994223;16208;16343;16412.75380869288;16630.417935372203;13652.453901843914;13909.059216096359;14017.64955876101;14084.084534505328;14118.717625647532;11331.830022549668;11734.295942243492;11815.94092029543;11943.462544185533;11943.820842687366;3152.2592190835367;3613.927721445583;3780.9432858507143;3840.8463661453507;3846.576876543578;95957.5202123985;100226.9909203631;102337.48831255871;103174;105098.47450762773;10360.274780765425;10551.26141170126;10688.25182237236;10882;10924.235303528836;20579.69130463014;22114.668279975813;22155.889220554116;22163;22248.332550023526;7580.658870350848;7676.923230767732;7795.14253432122;7884.842303153905;7954.84090318202;4292.656587472995;4296.119295544406;4314.80583373749;4319.740815551077;4405.713628614129;3446.5347178130633;3493.63316851732;3509.8069606171907;3534.752567320263;3542.8937131886087;638.1289539778262;639.3191251317332;643.7392855893371;649.4577028181427;653.3172834388076;661.355178700763;669.7990602819232;681.9386255237052;690.9619970901649;729.6461216310086;9567.282453815853;10175.236857235737;10180.949095254624;10258.58965641381;10399.636012739518;695.1553862057624;704.3484776581641;723.0925188887912;724.1599744296695;735.7755884455186;3914.1772997661487;4077.1641813428178;4933.4819843915875;4966.478519755446;5286.784039670821;103088.96911030794;103659.40851478773;104360.47819761005;105499;106368;73095.63452182812;73205.53588928192;85292.29415411656;92208;92615.44307341447;81217.59391203006;81898;83138;84340;84868;10825.782219056244;10893.727656808644;10928.289661171999;10943.616973405893;11162.274452160584;43099.56900430955;43788.56211437845;52290.47709522856;53583.46416535785;54408.727956361545;58637.4136258632;59965;60067;62479;62574;12362.38188090574;12454.25274483534;12488.75022499563;12835.101542892282;12881.549145779853;14040.719185616026;14228.928855355656;14250.572482825532;14833.33250003774;14976.400943962119;12906.612801615967;13150.671233219246;13446.93276533611;13502.122362046435;13569.592912212649;12480.68798280014;12999.740005199654;13231.3384330785;13371.465141394236;13733.45066197341;13201.27392993356;13469.932650337078;13520.459181632625;13675.316234188449;13750.722097169124;9106.726798196065;9314.813703726024;9799.608015679292;10034.297599167989;10102.848457273294;9895.356801808148;11148.729626078308;11300.49147788335;11325.377104259016;11329.886701132884 01:56:56 INFO - PROCESS | 2381 | __end_tp_report 01:56:56 INFO - PROCESS | 2381 | __start_cc_report 01:56:56 INFO - PROCESS | 2381 | _x_x_mozilla_cycle_collect,1429 01:56:56 INFO - PROCESS | 2381 | __end_cc_report 01:56:56 INFO - PROCESS | 2381 | __startTimestamp1492678616461__endTimestamp 01:56:56 INFO - PROCESS | 2381 | 01:56:56 INFO - PROCESS | 2381 | ------- Summary: start ------- 01:56:56 INFO - PROCESS | 2381 | Number of tests: 6 01:56:56 INFO - PROCESS | 2381 | 01:56:56 INFO - PROCESS | 2381 | [#0] dojo.html Cycles:165 Average:5863.76 Median:6106.40 stddev:648.51 (10.6%) stddev-sans-first:620.45 01:56:56 INFO - PROCESS | 2381 | Values: 3376.3 3391.1 3391.6 3414.1 3442.5 4753.5 5837.8 5872.0 5939.7 5950.6 5859.7 5931.1 5944.3 5946.5 5953.7 5305.3 5319.7 5341.1 5389.0 5464.7 5260.2 5261.0 5450.7 5469.9 5476.5 5276.3 5325.7 5334.4 5342.4 5351.4 4893.3 4918.7 5352.8 5359.5 5363.9 5172.4 5301.0 5302.5 5320.5 5337.9 5898.1 5898.9 5908.3 5915.6 5916.4 6218.7 6230.2 6249.7 6251.4 6252.3 6251.4 6263.7 6291.2 6308.6 6339.9 6057.2 6062.3 6069.3 6079.8 6080.7 6395.2 6457.1 6460.6 6479.4 6485.6 6106.4 6156.8 6179.2 6220.6 6264.4 6349.4 6365.2 6370.8 6372.2 6375.7 6270.7 6285.0 6290.5 6294.7 6305.4 6125.3 6197.8 6210.0 6243.7 6277.1 5069.7 5116.8 5132.0 5163.8 5165.9 4529.3 4537.7 4538.9 4547.3 4578.4 5645.8 5720.9 5976.6 5978.9 5992.0 5215.3 6268.6 6293.4 6309.5 6323.6 5953.3 5985.0 5989.3 5994.1 6015.9 5632.5 5635.4 5635.7 5638.3 5646.0 6212.3 6299.1 6402.3 6442.4 6521.5 6350.2 6362.8 6363.8 6369.2 6382.9 6425.3 6505.2 6507.8 6525.8 6541.4 6153.5 6201.7 6211.9 6238.2 6329.4 6320.4 6337.9 6346.7 6362.5 6368.3 6260.1 6266.1 6275.1 6277.0 6282.0 6066.3 6115.2 6249.5 6255.4 6270.9 6135.8 6139.6 6174.7 6185.6 6188.1 6245.7 6266.1 6271.1 6280.4 6282.1 5938.4 5962.3 5964.3 5972.3 6106.0 01:56:56 INFO - PROCESS | 2381 | 01:56:56 INFO - PROCESS | 2381 | [#1] ext.html Cycles:180 Average:55726.40 Median:341693.00 stddev:111565.11 (32.7%) stddev-sans-first:111801.75 01:56:56 INFO - PROCESS | 2381 | Values: 762.5 792.5 816.4 877.1 890.3 27844.6 39988.2 40490.6 40609.8 40814.0 33883.5 41118.6 41942.0 41985.2 42128.4 6286.6 9116.2 9286.9 9287.9 9288.1 7380.8 10820.8 11064.8 11188.9 11191.0 9989.8 10364.9 10983.7 11052.5 11055.6 7182.5 11005.3 11019.4 11025.0 11048.0 7272.6 10597.3 10817.5 10960.8 10968.6 39216.8 39378.4 39446.6 39476.0 39524.8 3458.8 3489.8 3506.5 3508.9 3559.1 21550.5 26593.9 26606.1 27228.0 28144.4 3031.4 3083.9 3160.0 3171.3 3273.4 340700.0 340952.0 341083.0 341514.0 341872.0 51815.5 51825.0 51902.5 51989.5 51993.5 54379.5 54423.2 54459.2 54586.7 54620.5 14615.6 14704.0 14745.6 14772.9 14804.3 10968.1 11195.9 12657.2 12695.5 12700.2 10911.6 10982.9 10992.7 11004.4 13610.6 4781.5 5005.4 5390.9 5890.8 5950.7 948.3 964.0 965.4 980.7 1004.7 29034.4 29063.7 29400.8 29658.0 29747.4 923.5 957.2 1036.7 1043.3 1079.2 14096.9 14118.2 14592.4 14773.9 14867.6 466057.0 470551.0 471064.0 471103.0 472500.0 45094.5 55889.7 56100.4 56325.7 56425.0 1294.6 1348.8 1351.9 1353.9 1357.2 27448.3 28236.9 28346.7 28584.4 28751.0 46375.5 46447.3 46510.0 46576.0 46622.5 436997.0 437961.0 438059.0 438306.0 445783.0 34406.3 34522.0 35218.3 35274.0 35316.8 43532.8 43545.0 43583.0 44426.1 44495.3 23933.4 29400.6 30228.1 30594.8 30627.0 29215.4 29733.9 30497.4 30503.0 30515.7 35637.6 36023.5 36116.0 36257.6 36387.5 29558.0 29803.1 30008.2 30020.5 30844.4 22948.9 23931.9 24267.4 24582.5 24613.4 01:56:56 INFO - PROCESS | 2381 | 01:56:56 INFO - PROCESS | 2381 | [#2] jquery.html Cycles:180 Average:39763.38 Median:22161.84 stddev:108404.06 (489.1%) stddev-sans-first:108667.83 01:56:56 INFO - PROCESS | 2381 | Values: 380.7 426.1 427.2 430.7 439.5 15432.9 19912.6 21652.6 21682.1 22028.1 21399.7 21909.7 22295.6 22530.7 22545.5 5412.3 6725.0 6767.7 7008.9 7056.6 6818.5 6945.2 6947.5 6949.9 6951.0 6663.9 6886.1 6972.5 6981.0 6995.5 5784.3 5791.7 6755.1 6838.4 6843.7 6550.6 6748.3 6751.4 6753.1 6755.5 23985.4 25058.7 26729.9 26943.1 27115.7 3095.4 3260.3 3305.1 3326.6 3466.0 15424.6 15836.1 15869.4 15870.3 15930.3 1984.2 2075.7 2087.3 2126.7 2149.9 157675.0 160458.0 164690.0 165004.0 167024.0 14763.1 19201.4 19808.8 20012.6 20015.9 28303.0 29142.0 29171.1 29242.3 29269.7 9648.8 10078.4 10136.5 10149.8 10340.6 6996.8 8480.2 8485.5 8499.4 8655.1 7005.7 8998.3 9059.4 9173.9 9188.9 3258.9 3408.4 3434.6 3571.7 3785.7 740.3 828.0 891.4 899.3 904.0 20442.0 20672.9 21195.3 21208.8 21275.9 871.2 919.4 921.8 937.9 946.7 10354.1 10671.7 11050.8 11134.5 11141.8 595129.0 595568.0 610599.0 685609.0 713132.0 150126.2 150263.0 150360.7 154372.0 155964.0 1253.3 1261.6 1286.9 1293.5 1293.5 17612.8 18392.1 18637.3 18686.6 18699.0 40227.6 46213.0 61801.0 62717.0 64249.7 83649.0 84104.0 85155.1 86819.6 88031.0 11315.7 11331.4 11460.7 11592.8 11762.0 12683.6 12890.0 13122.2 13188.4 13372.8 11115.7 11222.1 11232.4 11326.6 11549.5 10206.8 10259.4 10394.0 10428.5 10833.7 11500.1 11506.7 11661.4 11734.6 11905.8 11324.7 11373.4 11427.8 11724.5 11800.5 11218.8 11260.5 11305.3 11313.7 11622.1 01:56:56 INFO - PROCESS | 2381 | 01:56:56 INFO - PROCESS | 2381 | [#3] mootools.html Cycles:180 Average:6613.88 Median:3303.67 stddev:4124.04 (124.8%) stddev-sans-first:4117.42 01:56:56 INFO - PROCESS | 2381 | Values: 1458.8 1483.5 1528.0 1550.8 1554.2 10444.3 11000.6 11009.2 11011.4 11047.9 10716.6 11089.6 11199.1 11207.0 11244.6 2119.7 2339.6 2375.0 2379.9 2380.3 2245.9 2280.9 2371.5 2372.4 2386.0 2307.9 2345.0 2359.4 2365.7 2371.8 2301.9 2302.2 2325.7 2326.3 2333.8 2331.5 2332.9 2334.9 2335.9 2341.0 10999.6 11071.1 11096.0 11103.3 11106.7 5435.5 5594.3 5604.0 5611.6 5618.4 3291.8 3315.5 3462.4 3486.9 3557.6 1103.2 1145.7 1162.7 1173.2 1173.3 13462.7 13781.4 14096.2 15214.4 15272.5 4048.2 4137.4 4154.5 4167.2 4444.2 11479.0 11502.3 11532.3 11573.0 11588.4 5536.4 5542.0 5543.8 5545.8 5549.0 4941.2 5113.6 5172.3 5187.5 5194.8 3631.1 3753.2 3777.6 3825.4 3853.2 955.6 966.5 973.5 975.6 993.9 953.3 972.4 978.8 979.8 991.9 6371.0 6587.7 6675.9 6748.6 6898.2 917.6 994.4 1018.8 1033.8 1056.9 4162.8 4249.4 4249.9 4315.6 4395.2 12779.6 13215.7 13233.5 13279.8 13298.9 13170.6 13218.3 13239.3 13242.0 13260.8 9775.5 9893.7 9928.3 10071.3 10072.0 5790.2 6385.9 6448.2 6607.0 6612.0 11807.1 12161.1 12170.8 12218.9 12227.8 11301.3 11399.3 12267.4 12488.3 12508.5 8348.3 9262.4 9395.2 9405.9 9412.8 10299.0 10307.4 10414.6 10466.0 10494.1 8482.5 8589.9 8658.4 8682.4 8933.3 8338.5 8494.5 8538.5 8557.4 8705.0 7638.8 7796.5 7861.0 7915.7 7921.0 5767.4 5891.3 5954.9 5957.8 6059.5 5657.6 5967.2 6044.6 6083.8 6159.0 01:56:56 INFO - PROCESS | 2381 | 01:56:56 INFO - PROCESS | 2381 | [#4] prototype.html Cycles:180 Average:4499.49 Median:4873.20 stddev:1267.08 (26.0%) stddev-sans-first:1231.77 01:56:56 INFO - PROCESS | 2381 | Values: 350.2 378.3 383.2 384.3 389.3 4776.6 5035.8 5053.6 5053.8 5054.1 4114.9 4363.8 4555.5 4984.5 4998.3 4113.5 4174.8 4179.6 4193.5 4204.1 3646.6 3832.7 3994.7 4258.8 4261.4 3600.9 3936.4 4172.6 4218.3 4242.6 3848.3 4034.0 4109.0 4127.6 4147.4 3813.3 3823.8 3838.7 3839.5 3864.3 4340.5 4389.3 4900.5 4913.0 4943.8 4132.9 4553.9 4808.4 4861.9 4900.4 5380.7 5405.9 5448.0 5467.3 5478.6 3882.7 4315.4 4356.4 4374.1 4395.5 5246.5 5611.4 5629.2 5683.0 5698.0 3534.6 3747.5 4120.2 4319.9 4336.9 4393.7 4421.4 4423.2 4452.8 4540.7 4028.8 4507.4 4550.3 4824.9 4834.9 4884.5 5160.8 5394.8 5416.1 5446.8 1325.3 1416.3 1541.4 1545.7 1552.0 956.6 1074.5 1151.4 1159.2 1175.8 4618.4 4628.6 4920.7 4933.6 5076.7 5231.8 5348.5 5599.1 5637.9 5671.2 4347.9 4861.7 5040.3 5080.8 5084.3 2727.9 2783.6 2910.6 2916.9 2924.8 5263.9 5529.3 5831.2 5863.6 5877.3 5083.8 5372.2 5388.9 5647.7 5750.7 5656.3 5721.7 5780.4 5840.7 5877.9 5026.6 5642.8 5660.5 5680.4 5683.3 4476.2 4915.8 4949.4 5440.6 5553.0 4586.4 5441.7 5777.6 5815.0 5876.9 4082.7 4243.9 4405.7 4456.8 4523.9 5311.8 5365.2 5537.8 5607.9 5666.3 4199.6 5181.9 5399.7 5435.8 5437.6 4933.8 4965.8 4974.8 5425.2 5447.5 4785.6 5319.9 5320.7 5345.2 5383.9 4465.6 4679.8 4861.5 5435.5 5470.8 4140.7 5144.4 5257.6 5265.3 5363.3 01:56:56 INFO - PROCESS | 2381 | 01:56:56 INFO - PROCESS | 2381 | [#5] yui.html Cycles:180 Average:20282.87 Median:22159.44 stddev:28802.65 (130.0%) stddev-sans-first:28845.95 01:56:56 INFO - PROCESS | 2381 | Values: 710.4 745.1 757.8 815.0 826.0 15373.6 15678.0 15894.6 15921.4 17441.0 16366.4 16662.8 16690.0 16766.7 17859.1 924.8 959.3 962.0 962.6 963.8 931.7 949.2 950.9 952.2 952.6 996.6 1009.2 1009.6 1017.8 1019.2 1012.1 1013.9 1014.3 1015.6 1017.2 745.5 750.3 751.3 752.0 755.1 15907.6 16208.0 16343.0 16412.8 16630.4 13652.5 13909.1 14017.6 14084.1 14118.7 11331.8 11734.3 11815.9 11943.5 11943.8 3152.3 3613.9 3780.9 3840.8 3846.6 95957.5 100227.0 102337.5 103174.0 105098.5 10360.3 10551.3 10688.3 10882.0 10924.2 20579.7 22114.7 22155.9 22163.0 22248.3 7580.7 7676.9 7795.1 7884.8 7954.8 4292.7 4296.1 4314.8 4319.7 4405.7 3446.5 3493.6 3509.8 3534.8 3542.9 638.1 639.3 643.7 649.5 653.3 661.4 669.8 681.9 691.0 729.6 9567.3 10175.2 10180.9 10258.6 10399.6 695.2 704.3 723.1 724.2 735.8 3914.2 4077.2 4933.5 4966.5 5286.8 103089.0 103659.4 104360.5 105499.0 106368.0 73095.6 73205.5 85292.3 92208.0 92615.4 81217.6 81898.0 83138.0 84340.0 84868.0 10825.8 10893.7 10928.3 10943.6 11162.3 43099.6 43788.6 52290.5 53583.5 54408.7 58637.4 59965.0 60067.0 62479.0 62574.0 12362.4 12454.3 12488.8 12835.1 12881.5 14040.7 14228.9 14250.6 14833.3 14976.4 12906.6 13150.7 13446.9 13502.1 13569.6 12480.7 12999.7 13231.3 13371.5 13733.5 13201.3 13469.9 13520.5 13675.3 13750.7 9106.7 9314.8 9799.6 10034.3 10102.8 9895.4 11148.7 11300.5 11325.4 11329.9 01:56:56 INFO - PROCESS | 2381 | -------- Summary: end -------- 01:56:56 INFO - PROCESS | 2381 | 01:56:57 INFO - TEST-INFO | 2381: exit 0 01:56:57 INFO - TEST-OK | dromaeo_css | took 1120118ms 01:56:57 INFO - TEST-START | kraken 01:56:57 INFO - operating with platform_type : mac_ 01:56:57 INFO - Initialising browser for kraken test... 01:56:57 INFO - TEST-INFO | started process 2384 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpSCdsVq/profile http://localhost:57697/getInfo.html) 01:56:59 INFO - PROCESS | 2384 | __metrics Screen width/height:1600/1200 01:56:59 INFO - PROCESS | 2384 | colorDepth:24 01:56:59 INFO - PROCESS | 2384 | Browser inner width/height: 1024/689 01:56:59 INFO - PROCESS | 2384 | __metrics 01:56:59 INFO - PROCESS | 2384 | 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" 01:56:59 INFO - PROCESS | 2384 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:57:00 INFO - TEST-INFO | 2384: exit 0 01:57:00 INFO - Browser initialized. 01:57:00 INFO - Running cycle 1/1 for kraken test... 01:57:00 INFO - TEST-INFO | started process 2386 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpSCdsVq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:57:12 INFO - PROCESS | 2386 | RSS: Main: 211308544 01:57:12 INFO - PROCESS | 2386 | 01:57:15 INFO - PROCESS | 2386 | Cycle 1(1): loaded http://localhost:57697/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57697/tests/kraken/driver.html?testName=audio-beat-detection) 01:57:16 INFO - PROCESS | 2386 | RSS: Main: 264404992 01:57:16 INFO - PROCESS | 2386 | 01:57:18 INFO - PROCESS | 2386 | Cycle 1(1): loaded http://localhost:57697/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57697/tests/kraken/driver.html?testName=audio-dft) 01:57:19 INFO - PROCESS | 2386 | RSS: Main: 278028288 01:57:19 INFO - PROCESS | 2386 | 01:57:22 INFO - PROCESS | 2386 | Cycle 1(1): loaded http://localhost:57697/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57697/tests/kraken/driver.html?testName=audio-fft) 01:57:23 INFO - PROCESS | 2386 | RSS: Main: 374464512 01:57:23 INFO - PROCESS | 2386 | 01:57:25 INFO - PROCESS | 2386 | Cycle 1(1): loaded http://localhost:57697/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57697/tests/kraken/driver.html?testName=audio-oscillator) 01:57:25 INFO - PROCESS | 2386 | RSS: Main: 278118400 01:57:25 INFO - PROCESS | 2386 | 01:57:27 INFO - PROCESS | 2386 | Cycle 1(1): loaded http://localhost:57697/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57697/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:57:28 INFO - PROCESS | 2386 | RSS: Main: 280846336 01:57:28 INFO - PROCESS | 2386 | 01:57:31 INFO - PROCESS | 2386 | Cycle 1(1): loaded http://localhost:57697/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57697/tests/kraken/driver.html?testName=imaging-darkroom) 01:57:32 INFO - PROCESS | 2386 | RSS: Main: 320024576 01:57:32 INFO - PROCESS | 2386 | 01:57:35 INFO - PROCESS | 2386 | Cycle 1(1): loaded http://localhost:57697/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57697/tests/kraken/driver.html?testName=imaging-desaturate) 01:57:35 INFO - PROCESS | 2386 | RSS: Main: 321343488 01:57:35 INFO - PROCESS | 2386 | 01:57:38 INFO - PROCESS | 2386 | Cycle 1(1): loaded http://localhost:57697/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57697/tests/kraken/driver.html?testName=json-parse-financial) 01:57:39 INFO - PROCESS | 2386 | RSS: Main: 318509056 01:57:39 INFO - PROCESS | 2386 | 01:57:40 INFO - PROCESS | 2386 | Cycle 1(1): loaded http://localhost:57697/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57697/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:57:41 INFO - PROCESS | 2386 | RSS: Main: 297504768 01:57:41 INFO - PROCESS | 2386 | 01:57:43 INFO - PROCESS | 2386 | Cycle 1(1): loaded http://localhost:57697/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57697/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:57:44 INFO - PROCESS | 2386 | RSS: Main: 300666880 01:57:44 INFO - PROCESS | 2386 | 01:57:46 INFO - PROCESS | 2386 | Cycle 1(1): loaded http://localhost:57697/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57697/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:57:47 INFO - PROCESS | 2386 | RSS: Main: 303693824 01:57:47 INFO - PROCESS | 2386 | 01:57:50 INFO - PROCESS | 2386 | Cycle 1(1): loaded http://localhost:57697/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:57:50 INFO - PROCESS | 2386 | RSS: Main: 318496768 01:57:50 INFO - PROCESS | 2386 | 01:57:53 INFO - PROCESS | 2386 | Cycle 1(1): loaded http://localhost:57697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:57:54 INFO - PROCESS | 2386 | RSS: Main: 312508416 01:57:54 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | Cycle 1(1): loaded http://localhost:57697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57697/tests/kraken/driver.html?testName=ai-astar) 01:57:56 INFO - PROCESS | 2386 | RSS: Main: 356597760 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | __start_tp_report 01:57:56 INFO - PROCESS | 2386 | _x_x_mozilla_page_load 01:57:56 INFO - PROCESS | 2386 | _x_x_mozilla_page_load_details 01:57:56 INFO - PROCESS | 2386 | |i|pagename|runs| 01:57:56 INFO - PROCESS | 2386 | |0;ai-astar;106;115;112;114;115;115;115;113;112;114 01:57:56 INFO - PROCESS | 2386 | |1;audio-beat-detection;132;107;106;142;108;117;135;138;128;109 01:57:56 INFO - PROCESS | 2386 | |2;audio-dft;183;182;183;183;181;182;186;180;188;183 01:57:56 INFO - PROCESS | 2386 | |3;audio-fft;81;62;61;98;82;73;86;84;102;62 01:57:56 INFO - PROCESS | 2386 | |4;audio-oscillator;91;72;88;69;69;60;78;69;70;83 01:57:56 INFO - PROCESS | 2386 | |5;imaging-gaussian-blur;91;85;80;119;136;115;87;87;87;87 01:57:56 INFO - PROCESS | 2386 | |6;imaging-darkroom;93;95;94;96;94;99;95;96;96;95 01:57:56 INFO - PROCESS | 2386 | |7;imaging-desaturate;81;83;84;83;84;86;84;83;83;85 01:57:56 INFO - PROCESS | 2386 | |8;json-parse-financial;59;59;61;62;65;64;64;64;64;65 01:57:56 INFO - PROCESS | 2386 | |9;json-stringify-tinderbox;60;58;56;65;60;58;57;59;63;84 01:57:56 INFO - PROCESS | 2386 | |10;stanford-crypto-aes;96;102;100;73;95;99;103;100;101;82 01:57:56 INFO - PROCESS | 2386 | |11;stanford-crypto-ccm;137;138;142;160;136;142;148;146;178;148 01:57:56 INFO - PROCESS | 2386 | |12;stanford-crypto-pbkdf2;166;166;164;166;166;165;163;164;165;164 01:57:56 INFO - PROCESS | 2386 | |13;stanford-crypto-sha256-iterative;66;66;66;64;65;64;65;64;63;64 01:57:56 INFO - PROCESS | 2386 | __end_tp_report 01:57:56 INFO - PROCESS | 2386 | __start_cc_report 01:57:56 INFO - PROCESS | 2386 | _x_x_mozilla_cycle_collect,2140 01:57:56 INFO - PROCESS | 2386 | __end_cc_report 01:57:56 INFO - PROCESS | 2386 | __startTimestamp1492678676313__endTimestamp 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | ------- Summary: start ------- 01:57:56 INFO - PROCESS | 2386 | Number of tests: 14 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.50 stddev:2.77 (2.4%) stddev-sans-first:1.27 01:57:56 INFO - PROCESS | 2386 | Values: 106.0 115.0 112.0 114.0 115.0 115.0 115.0 113.0 112.0 114.0 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | [#1] audio-beat-detection Cycles:10 Average:122.20 Median:130.00 stddev:14.27 (11.0%) stddev-sans-first:14.68 01:57:56 INFO - PROCESS | 2386 | Values: 132.0 107.0 106.0 142.0 108.0 117.0 135.0 138.0 128.0 109.0 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.00 stddev:2.33 (1.3%) stddev-sans-first:2.47 01:57:56 INFO - PROCESS | 2386 | Values: 183.0 182.0 183.0 183.0 181.0 182.0 186.0 180.0 188.0 183.0 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | [#3] audio-fft Cycles:10 Average:79.10 Median:81.50 stddev:14.59 (17.9%) stddev-sans-first:15.46 01:57:56 INFO - PROCESS | 2386 | Values: 81.0 62.0 61.0 98.0 82.0 73.0 86.0 84.0 102.0 62.0 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | [#4] audio-oscillator Cycles:10 Average:74.90 Median:75.00 stddev:9.80 (13.1%) stddev-sans-first:8.49 01:57:56 INFO - PROCESS | 2386 | Values: 91.0 72.0 88.0 69.0 69.0 60.0 78.0 69.0 70.0 83.0 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | [#5] imaging-gaussian-blur Cycles:10 Average:97.40 Median:87.00 stddev:18.85 (21.7%) stddev-sans-first:19.85 01:57:56 INFO - PROCESS | 2386 | Values: 91.0 85.0 80.0 119.0 136.0 115.0 87.0 87.0 87.0 87.0 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.50 stddev:1.64 (1.7%) stddev-sans-first:1.51 01:57:56 INFO - PROCESS | 2386 | Values: 93.0 95.0 94.0 96.0 94.0 99.0 95.0 96.0 96.0 95.0 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | [#7] imaging-desaturate Cycles:10 Average:83.60 Median:84.00 stddev:1.35 (1.6%) stddev-sans-first:1.05 01:57:56 INFO - PROCESS | 2386 | Values: 81.0 83.0 84.0 83.0 84.0 86.0 84.0 83.0 83.0 85.0 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:64.00 stddev:2.31 (3.6%) stddev-sans-first:2.03 01:57:56 INFO - PROCESS | 2386 | Values: 59.0 59.0 61.0 62.0 65.0 64.0 64.0 64.0 64.0 65.0 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:60.00 stddev:8.19 (13.7%) stddev-sans-first:8.66 01:57:56 INFO - PROCESS | 2386 | Values: 60.0 58.0 56.0 65.0 60.0 58.0 57.0 59.0 63.0 84.0 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | [#10] stanford-crypto-aes Cycles:10 Average:95.10 Median:77.50 stddev:9.83 (12.7%) stddev-sans-first:10.42 01:57:56 INFO - PROCESS | 2386 | Values: 96.0 102.0 100.0 73.0 95.0 99.0 103.0 100.0 101.0 82.0 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | [#11] stanford-crypto-ccm Cycles:10 Average:147.50 Median:147.00 stddev:12.83 (8.7%) stddev-sans-first:13.04 01:57:56 INFO - PROCESS | 2386 | Values: 137.0 138.0 142.0 160.0 136.0 142.0 148.0 146.0 178.0 148.0 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:165.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 01:57:56 INFO - PROCESS | 2386 | Values: 166.0 166.0 164.0 166.0 166.0 165.0 163.0 164.0 165.0 164.0 01:57:56 INFO - PROCESS | 2386 | 01:57:56 INFO - PROCESS | 2386 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:1.01 01:57:56 INFO - PROCESS | 2386 | Values: 66.0 66.0 66.0 64.0 65.0 64.0 65.0 64.0 63.0 64.0 01:57:56 INFO - PROCESS | 2386 | -------- Summary: end -------- 01:57:56 INFO - PROCESS | 2386 | 01:57:57 INFO - TEST-INFO | 2386: exit 0 01:57:57 INFO - TEST-OK | kraken | took 60083ms 01:57:57 INFO - SUITE-END | took 1180s 01:57:57 INFO - Completed test suite (00:19:40) 01:57:57 INFO - javascript benchmark 01:57:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7610.116620539447, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3376.2572234108497, 3391.050505858359, 3391.643877392873, 3414.0611331883715, 3442.4664177052564, 4753.524647535245, 5837.795677151301, 5872.00175970085, 5939.703014849257, 5950.583459157855, 5859.6777177255235, 5931.110333449974, 5944.256967879015, 5946.5242780577555, 5953.732082056307, 5305.257263983045, 5319.680819150844, 5341.145416733323, 5389.029974604569, 5464.726763661821, 5260.210968354758, 5261.0267100586325, 5450.672959622435, 5469.945300547003, 5476.507114359707, 5276.261323414706, 5325.707086110262, 5334.413214546396, 5342.412334643186, 5351.384590772052, 4893.314935908976, 4918.704877707349, 5352.812651557177, 5359.5444387227135, 5363.892722145574, 5172.379314482248, 5300.973495132538, 5302.469753024705, 5320.52115309624, 5337.919931201035, 5898.085796701518, 5898.911516327258, 5908.320543137551, 5915.645061296336, 5916.437938395846, 6218.689065546704, 6230.158928544633, 6249.687515624246, 6251.437370636664, 6252.343503932113, 6251.437370636664, 6263.718132683995, 6291.245050593912, 6308.558400911938, 6339.904901426482, 6057.200819427583, 6062.272527296708, 6069.302030266532, 6079.848003799941, 6080.726367313481, 6395.168628078367, 6457.128287681103, 6460.612363258219, 6479.416852483299, 6485.578437401554, 6106.39999602577, 6156.815295541141, 6179.227596550431, 6220.564560480723, 6264.436200741955, 6349.365063493614, 6365.204349456318, 6370.77702280418, 6372.235331760218, 6375.71309291083, 6270.655113968684, 6284.968575157095, 6290.49676025926, 6294.748210071637, 6305.4009869062365, 6125.295591007002, 6197.752089916443, 6210.006398976142, 6243.719032643542, 6277.089821975788, 5069.695818250843, 5116.795328186831, 5131.974340128276, 5163.845084647466, 5165.870853228699, 4529.32060190974, 4537.682362234612, 4538.909221815546, 4547.295169248771, 4578.40480737502, 5645.774169033275, 5720.885582288331, 5976.61152025117, 5978.880422391528, 5992.041273396323, 5215.322008138917, 6268.62388256697, 6293.433590976834, 6309.463695585927, 6323.557350985387, 5953.3451320354725, 5985.0, 5989.251343582052, 5994.130851026577, 6015.909761353583, 5632.5212356950115, 5635.408282130399, 5635.690037048002, 5638.323401191801, 5645.9717701412055, 6212.254529456313, 6299.11812346281, 6402.295747467681, 6442.35576442352, 6521.5108866834225, 6350.174477317919, 6362.840928976812, 6363.7772677956045, 6369.20384951881, 6382.872342553216, 6425.261094973951, 6505.219373675, 6507.837304067436, 6525.836854078686, 6541.378569035934, 6153.538484613761, 6201.720922558586, 6211.875762484816, 6238.220222472191, 6329.398707122816, 6320.4311611955145, 6337.873242535031, 6346.714397852015, 6362.522810789302, 6368.267649220214, 6260.123582698517, 6266.060090986206, 6275.121482992294, 6277.027060805583, 6281.9948808190475, 6066.272047354346, 6115.205023346936, 6249.50003999688, 6255.437010669061, 6270.9372906270355, 6135.754569817157, 6139.631622102688, 6174.6912654368, 6185.628862268279, 6188.071789231652, 6245.718942647501, 6266.060090986389, 6271.090691849565, 6280.371962803683, 6282.057691346152, 5938.406159384027, 5962.344142144274, 5964.254468191476, 5972.34304226526, 6106.0], "value": 5822.357755193828, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.4624639629062, 792.4571668407142, 816.4366587054933, 877.1141147441086, 890.3278025091055, 27844.58233126502, 39988.20023599526, 40490.58282960097, 40609.796951015276, 40814.0, 33883.491747623746, 41118.58881411185, 41941.95145121373, 41985.16029679405, 42128.36807447891, 6286.559940804123, 9116.179543841054, 9286.907130928672, 9287.907120928805, 9288.071192880725, 7380.77857664271, 10820.783584328308, 11064.778704425906, 11188.888111118866, 11191.0, 9989.800203995916, 10364.948175259113, 10983.725406864813, 11052.502637381338, 11055.557777688882, 7182.533135346186, 11005.339679619248, 11019.393933333664, 11025.0, 11047.95044470778, 7272.600006999613, 10597.258191926569, 10817.459127043696, 10960.835587466194, 10968.561257549689, 39216.80391598052, 39378.40932385988, 39446.605533944865, 39476.0, 39524.80237598823, 3458.8097654628987, 3489.8255087245534, 3506.4564992426212, 3508.859645614172, 3559.056849934769, 21550.461238469165, 26593.867030664915, 26606.068787592536, 27228.047018354264, 28144.43711125766, 3031.4240294344004, 3083.922901927447, 3160.0, 3171.3181665941934, 3273.3616944695796, 340700.0, 340952.0, 341083.0, 341514.0, 341872.0, 51815.48184518182, 51825.0, 51902.48097518976, 51989.48010519846, 51993.48006519886, 54379.45620543744, 54423.18365224525, 54459.18311225335, 54586.727066364416, 54620.45379546233, 14615.634609134644, 14704.044237124554, 14745.631359215891, 14772.852271477363, 14804.333804978802, 10968.067714244218, 11195.888041119648, 12657.240565566095, 12695.49218031287, 12700.237985720887, 10911.618093366695, 10982.890171098186, 10992.670219893416, 11004.449777511092, 13610.59168224955, 4781.453990057721, 5005.449400565934, 5390.8921821563345, 5890.823275301748, 5950.702464876739, 948.3172116076414, 963.9710808675751, 965.3628605120728, 980.6662938403765, 1004.6734811186394, 29034.41931161365, 29063.709362906102, 29400.82396704108, 29657.9619713309, 29747.40505189884, 923.5290002098843, 957.200737384278, 1036.6734478639205, 1043.3009883378154, 1079.2013909706918, 14096.942729295344, 14118.152910825384, 14592.402352077883, 14773.852261477248, 14867.628309292355, 466057.0, 470551.0, 471064.0, 471103.0, 472500.0, 45094.549054509036, 55889.7205513978, 56100.43899560952, 56325.7183714087, 56425.0, 1294.5792617399384, 1348.797680347936, 1351.8783309502192, 1353.9052266341262, 1357.172125003747, 27448.313792155357, 28236.865849463473, 28346.71653283441, 28584.428311434072, 28751.0, 46375.53624463712, 46447.303290451346, 46510.0, 46576.0, 46622.53377466182, 436997.0, 437961.0, 438059.0, 438306.0, 445783.0, 34406.31187376288, 34521.964341069805, 35218.295634087684, 35274.0, 35316.823415882754, 43532.782336088116, 43545.0, 43583.0, 44426.11147777091, 44495.332570010825, 23933.401664958514, 29400.55899161557, 30228.09315720532, 30594.847025764728, 30627.0, 29215.415691686474, 29733.851330744073, 30497.39005219839, 30503.0, 30515.694843052173, 35637.64362356343, 36023.459648105825, 36116.0, 36257.63742362543, 36387.45418818773, 29558.0, 29803.10590682283, 30008.24979375533, 30020.549691754204, 30844.383112338077, 22948.885255573616, 23931.880340598185, 24267.39331516726, 24582.50834983326, 24613.384665382793], "value": 18522.11117412982, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.7182684813239, 426.1306933854936, 427.21915302857735, 430.74155506695985, 439.52311741760167, 15432.922835385822, 19912.60174796505, 21652.566948661017, 21682.132714691434, 22028.11887524497, 21399.67900481494, 21909.671354929687, 22295.554088918212, 22530.746925307503, 22545.549089018208, 5412.323459567554, 6724.999999999988, 6767.69545370457, 7008.894866577006, 7056.647167641623, 6818.454523638097, 6945.166580010406, 6947.513674042819, 6949.89575156373, 6951.026856240105, 6663.866722665568, 6886.104806375164, 6972.477064220178, 6981.0, 6995.475339349544, 5784.30588329399, 5791.652500849962, 6755.121834161528, 6838.384545390913, 6843.726250949956, 6550.6069635822005, 6748.257691653914, 6751.42612877906, 6753.08833307507, 6755.49333799967, 23985.40036499084, 25058.749412505826, 26729.930802767867, 26943.056993005346, 27115.728842711516, 3095.4273459409856, 3260.2827377976805, 3305.1241421023446, 3326.5841769778776, 3465.9502116648714, 15424.614384640474, 15836.129012904286, 15869.365225390971, 15870.285837137357, 15930.283137258735, 1984.2360691133872, 2075.6678931371057, 2087.2590230468268, 2126.670366093258, 2149.871007739541, 157675.0, 160458.0, 164690.0, 165004.0, 167024.0, 14763.114213147246, 19201.423957281302, 19808.801911980983, 20012.59974800496, 20015.897535881963, 28303.009394671088, 29142.0, 29171.124866254046, 29242.268943276587, 29269.707302927123, 9648.807023859625, 10078.445685487368, 10136.493175341204, 10149.847752283722, 10340.638077667245, 6996.790096297119, 8480.15198480147, 8485.533295668674, 8499.447535910145, 8655.091215422415, 7005.684744186422, 8998.280137589109, 9059.36584439096, 9173.908260917438, 9188.90811091894, 3258.885938992124, 3408.4376077946863, 3434.553508043938, 3571.7321200910037, 3785.6782173515558, 740.344794856545, 828.0146625515617, 891.3715830339595, 899.3299991506369, 904.0, 20441.977901104885, 20672.896635517027, 21195.25816596412, 21208.787912120682, 21275.8936205318, 871.242019443076, 919.384012711485, 921.7695576105973, 937.8686983822271, 946.7017889364828, 10354.068133867837, 10671.679849604525, 11050.834237486444, 11134.49894754738, 11141.777164456666, 595129.0, 595568.0, 610599.0, 685609.0, 713132.0, 150126.24936875247, 150263.0, 150360.74458883126, 154372.0, 155964.0, 1253.3169422664669, 1261.5836773864603, 1286.903482238817, 1293.4696774322483, 1293.4826069572246, 17612.82387176163, 18392.080395980414, 18637.347692831227, 18686.5985051119, 18699.0, 40227.59772402239, 46213.0, 61801.0, 62717.0, 64249.67875160594, 83649.0, 84104.0, 85155.1484485172, 86819.56590217008, 88031.0, 11315.660530184108, 11331.433428328386, 11460.713482163013, 11592.768144637228, 11762.0, 12683.619491415273, 12890.0, 13122.212667239995, 13188.406521706354, 13372.799408009083, 11115.666530004113, 11222.102231821598, 11232.438378081226, 11326.603568875049, 11549.480273387886, 10206.795864082826, 10259.384436933808, 10393.97317523106, 10428.530716117944, 10833.67498975032, 11500.137489688139, 11506.654800356002, 11661.416929153338, 11734.647960561197, 11905.821412678644, 11324.660260192208, 11373.431328433711, 11427.771444571228, 11724.472398741906, 11800.468978895799, 11218.775624487302, 11260.549578016788, 11305.321680699184, 11313.660590182308, 11622.0702343814], "value": 11306.12567303762, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.8395276519584, 1483.4881965721836, 1528.0, 1550.8139023317203, 1554.2073542493329, 10444.26890117691, 11000.559977600906, 11009.229353945217, 11011.449427528632, 11047.889521104786, 10716.624918127867, 11089.55641774328, 11199.104071674266, 11207.047400970907, 11244.606438774645, 2119.6857948072216, 2339.6256598944174, 2375.0, 2379.916702915398, 2380.321608341623, 2245.865248085112, 2280.8859557022165, 2371.513839662865, 2372.4306166519996, 2385.964210536835, 2307.9307620771406, 2344.988275058622, 2359.3511784259294, 2365.7161140663143, 2371.762823717632, 2301.8503797253125, 2302.1712183613886, 2325.732540757809, 2326.3021093671914, 2333.8482998605036, 2331.4637633344255, 2332.941676458085, 2334.9182778602667, 2335.92992210234, 2341.028473183627, 10999.560017599286, 11071.058959988412, 11096.0, 11103.278286911325, 11106.666799996014, 5435.456454354572, 5594.300712410949, 5604.0, 5611.6352437091455, 5618.381977982419, 3291.8024918504966, 3315.535824984504, 3462.3594634992605, 3486.8779592714386, 3557.6086630470886, 1103.1671088328342, 1145.6677563506573, 1162.7441962768178, 1173.23153334566, 1173.2608456672326, 13462.730745385037, 13781.379837907318, 14096.224707640973, 15214.391424343014, 15272.465463708828, 4048.2105989332385, 4137.441445404892, 4154.480689913761, 4167.187398457272, 4444.244478438609, 11479.0, 11502.309861408343, 11532.25040372373, 11573.0, 11588.36264005471, 5536.363318218376, 5542.0, 5543.833684989457, 5545.7781688732, 5548.9722551386985, 4941.184704523714, 5113.64204505681, 5172.327597412387, 5187.507186817246, 5194.818181363634, 3631.1103779573646, 3753.249350129985, 3777.6033516480925, 3825.407061905409, 3853.2100919311474, 955.5795450001976, 966.4925913895261, 973.4500007495742, 975.6341371985505, 993.9353941993747, 953.3374304858057, 972.4262685015875, 978.7602037500858, 979.8285300072458, 991.8660980767648, 6371.0, 6587.703553340111, 6675.9332406676285, 6748.561343512754, 6898.206706228848, 917.6283605139929, 994.4282037828277, 1018.8471729240525, 1033.8266068012708, 1056.8995945385177, 4162.7502349859105, 4249.40508328828, 4249.851255206053, 4315.611594956469, 4395.164918665443, 12779.616611501484, 13215.66960825987, 13233.536826211037, 13279.800802987962, 13298.867011329763, 13170.60488185356, 13218.272994985367, 13239.338033098307, 13242.0, 13260.801087983687, 9775.462349570842, 9893.65372211969, 9928.305018648625, 10071.34536255141, 10071.992800720016, 5790.218320526675, 6385.936140638534, 6448.193975753031, 6607.00894865774, 6611.966940165461, 11807.114466414881, 12161.087918405978, 12170.75658486843, 12218.877811221773, 12227.816582751087, 11301.26541774782, 11399.316041037564, 12267.447964841782, 12488.313142776871, 12508.499660013498, 8348.33213342919, 9262.44425334482, 9395.248380129437, 9405.905940940504, 9412.764680883032, 10299.021592948659, 10307.381557106597, 10414.583416663248, 10466.005729455994, 10494.108000820015, 8482.533460659723, 8589.914100858912, 8658.350623703122, 8682.43564168327, 8933.330000249878, 8338.541380224146, 8494.53280069602, 8538.487690738575, 8557.358198135289, 8705.042445331135, 7638.770836874903, 7796.4932279401655, 7860.960695196487, 7915.722949696733, 7920.960395197987, 5767.394423585631, 5891.263592050994, 5954.940450595439, 5957.791477298274, 6059.484943779828, 5657.60396772222, 5967.224260846236, 6044.607100538451, 6083.847903802441, 6158.969205153946], "value": 5040.11721821911, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.17533708117384, 378.3397970541404, 383.24691980258785, 384.34852924293324, 389.33423845224667, 4776.641751868607, 5035.848924532265, 5053.570446512042, 5053.823116190934, 5054.090348604436, 4114.897127571812, 4363.821768122605, 4555.52167022462, 4984.451710311862, 4998.325226094476, 4113.4858142732155, 4174.8121334539865, 4179.561146079664, 4193.454850869382, 4204.096119334343, 3646.6171052039554, 3832.7351973848563, 3994.660453861425, 4258.765767882765, 4261.403403523509, 3600.8837260449213, 3936.409538569223, 4172.645325147351, 4218.261804184255, 4242.554531774165, 3848.3073046851555, 4033.9596604033877, 4109.034376921421, 4127.5666055064385, 4147.398627199054, 3813.31360355136, 3823.801314244293, 3838.7312888097845, 3839.520059992501, 3864.285107255139, 4340.52254252032, 4389.275769498029, 4900.534449227318, 4912.985675872875, 4943.802247910079, 4132.855350062733, 4553.908921821545, 4808.3989501312335, 4861.8784530386665, 4900.387451568554, 5380.650257733235, 5405.864853378657, 5448.0, 5467.343918729738, 5478.616496845222, 3882.650561449455, 4315.395844581761, 4356.409910382719, 4374.1033088217155, 4395.494518130392, 5246.45229657252, 5611.373654739696, 5629.173805111731, 5682.971585142089, 5698.002849501362, 3534.628863969246, 3747.5315585551807, 4120.166525895947, 4319.941614304453, 4336.869893903188, 4393.714408563433, 4421.425214722066, 4423.225935461282, 4452.799624016927, 4540.661559296965, 4028.8187031583648, 4507.3689683444345, 4550.317452382103, 4824.855254342376, 4834.912144767399, 4884.511548845087, 5160.845174644766, 5394.811181608703, 5416.10634245353, 5446.836594902159, 1325.2843464529046, 1416.3484796993498, 1541.4450797712814, 1545.698588775178, 1551.9767203491956, 956.5599824080862, 1074.462768615692, 1151.3897634253858, 1159.2001518951897, 1175.8300491011498, 4618.376519169869, 4628.583427491474, 4920.729359885169, 4933.629977751683, 5076.720780357042, 5231.790728370898, 5348.545373643206, 5599.0761524348845, 5637.915431268534, 5671.17767923657, 4347.934780978288, 4861.732604706775, 5040.2691609716385, 5080.822171223989, 5084.339035925306, 2727.863606819651, 2783.5685468752376, 2910.57796619489, 2916.912492625182, 2924.7806414518996, 5263.868403289872, 5529.281193444826, 5831.2127862738835, 5863.560232982458, 5877.265341832271, 5083.796648134107, 5372.200312895224, 5388.892222155535, 5647.7176141193595, 5750.683712395775, 5656.295126692024, 5721.742521586539, 5780.364159942403, 5840.722118373753, 5877.94122058774, 5026.623003274696, 5642.830715078554, 5660.499967508531, 5680.40355762639, 5683.2895888014, 4476.239039363381, 4915.778789954532, 4949.406071271471, 5440.591955603425, 5553.0004599172535, 4586.449626044896, 5441.700706461183, 5777.595568310346, 5814.970925145347, 5876.941230587639, 4082.652974497201, 4243.917800960735, 4405.735655860659, 4456.777161141995, 4523.864284071483, 5311.814086506954, 5365.229474273402, 5537.7784888604, 5607.859803504945, 5666.291713535808, 4199.622034016953, 5181.948180518147, 5399.7300134993875, 5435.755391007493, 5437.564994800486, 4933.77797999098, 4965.776540055634, 4974.776135073858, 5425.21334406501, 5447.536959358499, 4785.59322457581, 5319.946800531945, 5320.733963301896, 5345.1714984177515, 5383.892322153457, 4465.615659145676, 4679.766011699469, 4861.51384861511, 5435.483629055233, 5470.835874923759, 4140.730852494578, 5144.356955380577, 5257.608842296773, 5265.341832270966, 5363.264734985263], "value": 4131.157527944389, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.4032612605411, 745.0984308986126, 757.8294883651179, 814.9674013039479, 825.9710910118147, 15373.615659608515, 15678.0, 15894.602634934132, 15921.363145474166, 17441.04074275914, 16366.427175048875, 16662.83337166628, 16690.0, 16766.74849877253, 17859.10704464775, 924.7549399409162, 959.3045042344314, 961.9855702164473, 962.6101428921298, 963.8072385522923, 931.6925414613162, 949.2311227905384, 950.8668786369914, 952.2477242978039, 952.642758965388, 996.5565323431076, 1009.1573536097368, 1009.6112996496365, 1017.8167929772638, 1019.1642852860657, 1012.0840639221443, 1013.8580598716186, 1014.2747935226312, 1015.6343716262139, 1017.2218253036433, 745.5489428895548, 750.2759836757555, 751.3275618321626, 751.9586422746747, 755.0524092264228, 15907.60230994223, 16208.0, 16343.0, 16412.75380869288, 16630.417935372203, 13652.453901843914, 13909.059216096359, 14017.64955876101, 14084.084534505328, 14118.717625647532, 11331.830022549668, 11734.295942243492, 11815.94092029543, 11943.462544185533, 11943.820842687366, 3152.2592190835367, 3613.927721445583, 3780.9432858507143, 3840.8463661453507, 3846.576876543578, 95957.5202123985, 100226.9909203631, 102337.48831255871, 103174.0, 105098.47450762773, 10360.274780765425, 10551.26141170126, 10688.25182237236, 10882.0, 10924.235303528836, 20579.69130463014, 22114.668279975813, 22155.889220554116, 22163.0, 22248.332550023526, 7580.658870350848, 7676.923230767732, 7795.14253432122, 7884.842303153905, 7954.84090318202, 4292.656587472995, 4296.119295544406, 4314.80583373749, 4319.740815551077, 4405.713628614129, 3446.5347178130633, 3493.63316851732, 3509.8069606171907, 3534.752567320263, 3542.8937131886087, 638.1289539778262, 639.3191251317332, 643.7392855893371, 649.4577028181427, 653.3172834388076, 661.355178700763, 669.7990602819232, 681.9386255237052, 690.9619970901649, 729.6461216310086, 9567.282453815853, 10175.236857235737, 10180.949095254624, 10258.58965641381, 10399.636012739518, 695.1553862057624, 704.3484776581641, 723.0925188887912, 724.1599744296695, 735.7755884455186, 3914.1772997661487, 4077.1641813428178, 4933.4819843915875, 4966.478519755446, 5286.784039670821, 103088.96911030794, 103659.40851478773, 104360.47819761005, 105499.0, 106368.0, 73095.63452182812, 73205.53588928192, 85292.29415411656, 92208.0, 92615.44307341447, 81217.59391203006, 81898.0, 83138.0, 84340.0, 84868.0, 10825.782219056244, 10893.727656808644, 10928.289661171999, 10943.616973405893, 11162.274452160584, 43099.56900430955, 43788.56211437845, 52290.47709522856, 53583.46416535785, 54408.727956361545, 58637.4136258632, 59965.0, 60067.0, 62479.0, 62574.0, 12362.38188090574, 12454.25274483534, 12488.75022499563, 12835.101542892282, 12881.549145779853, 14040.719185616026, 14228.928855355656, 14250.572482825532, 14833.33250003774, 14976.400943962119, 12906.612801615967, 13150.671233219246, 13446.93276533611, 13502.122362046435, 13569.592912212649, 12480.68798280014, 12999.740005199654, 13231.3384330785, 13371.465141394236, 13733.45066197341, 13201.27392993356, 13469.932650337078, 13520.459181632625, 13675.316234188449, 13750.722097169124, 9106.726798196065, 9314.813703726024, 9799.608015679292, 10034.297599167989, 10102.848457273294, 9895.356801808148, 11148.729626078308, 11300.49147788335, 11325.377104259016, 11329.886701132884], "value": 7650.506807254098, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1445.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 112.0, 114.0, 115.0, 115.0, 115.0, 113.0, 112.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 107.0, 106.0, 142.0, 108.0, 117.0, 135.0, 138.0, 128.0, 109.0], "value": 122.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 183.0, 183.0, 181.0, 182.0, 186.0, 180.0, 188.0, 183.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 62.0, 61.0, 98.0, 82.0, 73.0, 86.0, 84.0, 102.0, 62.0], "value": 79.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 72.0, 88.0, 69.0, 69.0, 60.0, 78.0, 69.0, 70.0, 83.0], "value": 74.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 85.0, 80.0, 119.0, 136.0, 115.0, 87.0, 87.0, 87.0, 87.0], "value": 97.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 96.0, 94.0, 99.0, 95.0, 96.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 84.0, 83.0, 84.0, 86.0, 84.0, 83.0, 83.0, 85.0], "value": 83.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 61.0, 62.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 56.0, 65.0, 60.0, 58.0, 57.0, 59.0, 63.0, 84.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 102.0, 100.0, 73.0, 95.0, 99.0, 103.0, 100.0, 101.0, 82.0], "value": 95.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 142.0, 160.0, 136.0, 142.0, 148.0, 146.0, 178.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 164.0, 166.0, 166.0, 165.0, 163.0, 164.0, 165.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 64.0, 65.0, 64.0, 65.0, 64.0, 63.0, 64.0], "value": 64.7, "unit": "score"}]}]} 01:57:57 INFO - Return code: 0 01:57:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:57:57 ERROR - # TBPL SUCCESS # 01:57:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:57:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:57:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:57:57 INFO - 2017-04-20 01:57:57.627 screenresolution[2390:32275] starting screenresolution argv=screenresolution get 01:57:57 INFO - 2017-04-20 01:57:57.629 screenresolution[2390:32275] Display 0: 1600x1200x32@60 01:57:57 INFO - 2017-04-20 01:57:57.635 screenresolution[2391:32278] starting screenresolution argv=screenresolution list 01:57:57 INFO - Available Modes on Display 0 01:57:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:57:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:57:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:57:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:57:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:57:57 INFO - Intel Iris: 01:57:57 INFO - Chipset Model: Intel Iris 01:57:57 INFO - Type: GPU 01:57:57 INFO - Bus: Built-In 01:57:57 INFO - VRAM (Dynamic, Max): 1536 MB 01:57:57 INFO - Vendor: Intel (0x8086) 01:57:57 INFO - Device ID: 0x0a2e 01:57:57 INFO - Revision ID: 0x0009 01:57:57 INFO - Displays: 01:57:57 INFO - Display: 01:57:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:57:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:57:57 INFO - Display Serial Number: 1600x1200 60 01:57:57 INFO - Main Display: Yes 01:57:57 INFO - Mirror: Off 01:57:57 INFO - Online: Yes 01:57:57 INFO - Rotation: Supported 01:57:57 INFO - Return code: 0 01:57:57 INFO - Running post-action listener: _resource_record_post_action 01:57:57 INFO - [mozharness: 2017-04-20 08:57:57.881426Z] Finished run-tests step (success) 01:57:57 INFO - Running post-run listener: _resource_record_post_run 01:57:57 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 1503232; Write bytes: 508288000; Read time: 8; Write time: 1588 01:57:57 INFO - TinderboxPrint: CPU usage
53.8% 01:57:57 INFO - TinderboxPrint: I/O read bytes / time
1,503,232 / 8 01:57:57 INFO - TinderboxPrint: I/O write bytes / time
508,288,000 / 1,588 01:57:57 INFO - TinderboxPrint: CPU idle
2,221.2 (46.2%) 01:57:57 INFO - TinderboxPrint: CPU system
955.4 (19.9%) 01:57:57 INFO - TinderboxPrint: CPU user
1,629.2 (33.9%) 01:57:57 INFO - TinderboxPrint: Swap in / out
209,350,656 / 0 01:57:57 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201531904; Write bytes: 201223680; Read time: 15589; Write time: 446 01:57:57 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 1503232; Write bytes: 297139712; Read time: 8; Write time: 1107 01:57:58 INFO - Running post-run listener: _upload_blobber_files 01:57:58 INFO - Blob upload gear active. 01:57:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:57:58 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 01:57:58 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'] 01:57:58 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 01:57:58 INFO - (blobuploader) - INFO - Open directory for files ... 01:57:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:57:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:57:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:58:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:00 INFO - (blobuploader) - INFO - Done attempting. 01:58:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:58:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:58:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:01 INFO - (blobuploader) - INFO - Done attempting. 01:58:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:58:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:58:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:02 INFO - (blobuploader) - INFO - Done attempting. 01:58:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:58:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:58:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:06 INFO - (blobuploader) - INFO - Done attempting. 01:58:06 INFO - (blobuploader) - INFO - Iteration through files over. 01:58:06 INFO - Return code: 0 01:58:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:58:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:58:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a073ff9e0c1319574448a5be597305e946587f509bd6cde97b991ffefbc2e150f574348c781578dee7503e27c9e75ea58ea3d7bc247d3c2fde5466a3d83a080d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44ab79ce23a012163bc366f1c44b21a22c9b246a6363337ca94617e7ae6eedb28eceec9062000873e74e3f3d5281cb8bcd4fa7141c3070c6f2eb30513f6e4cd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fd492e1a47dc4abbd1ff5196adcc9ee44a68ef8beea6e95991541aa5e39083919f1381be8460e09dcf8d9bcb83dc5bcd473153d35520614d27ab5cdf06e245d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/982ed505d608a478c0a0d00e3a34ccda878ee5223a8ff58f53b29ef40c95a3fe78eace58b524097a4b87144a67c0ecc0c1427c96b5cec0330258b8797779518a"} 01:58:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:58:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:58:06 INFO - Contents: 01:58:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a073ff9e0c1319574448a5be597305e946587f509bd6cde97b991ffefbc2e150f574348c781578dee7503e27c9e75ea58ea3d7bc247d3c2fde5466a3d83a080d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44ab79ce23a012163bc366f1c44b21a22c9b246a6363337ca94617e7ae6eedb28eceec9062000873e74e3f3d5281cb8bcd4fa7141c3070c6f2eb30513f6e4cd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fd492e1a47dc4abbd1ff5196adcc9ee44a68ef8beea6e95991541aa5e39083919f1381be8460e09dcf8d9bcb83dc5bcd473153d35520614d27ab5cdf06e245d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/982ed505d608a478c0a0d00e3a34ccda878ee5223a8ff58f53b29ef40c95a3fe78eace58b524097a4b87144a67c0ecc0c1427c96b5cec0330258b8797779518a"} 01:58:06 INFO - Running post-run listener: copy_logs_to_upload_dir 01:58:06 INFO - Copying logs to upload dir... 01:58:06 INFO - mkdir: /builds/slave/test/build/upload/logs 01:58:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.969746 ========= master_lag: 1.55 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-20 01:58:08.010646) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-04-20 01:58:08.014702) ========= 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.YavJEyOMZY/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.qeGVaUMk1k/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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/a073ff9e0c1319574448a5be597305e946587f509bd6cde97b991ffefbc2e150f574348c781578dee7503e27c9e75ea58ea3d7bc247d3c2fde5466a3d83a080d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44ab79ce23a012163bc366f1c44b21a22c9b246a6363337ca94617e7ae6eedb28eceec9062000873e74e3f3d5281cb8bcd4fa7141c3070c6f2eb30513f6e4cd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fd492e1a47dc4abbd1ff5196adcc9ee44a68ef8beea6e95991541aa5e39083919f1381be8460e09dcf8d9bcb83dc5bcd473153d35520614d27ab5cdf06e245d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/982ed505d608a478c0a0d00e3a34ccda878ee5223a8ff58f53b29ef40c95a3fe78eace58b524097a4b87144a67c0ecc0c1427c96b5cec0330258b8797779518a"} build_url:https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/JyCmPckfSP-5QjyPWPWcMA/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/a073ff9e0c1319574448a5be597305e946587f509bd6cde97b991ffefbc2e150f574348c781578dee7503e27c9e75ea58ea3d7bc247d3c2fde5466a3d83a080d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/44ab79ce23a012163bc366f1c44b21a22c9b246a6363337ca94617e7ae6eedb28eceec9062000873e74e3f3d5281cb8bcd4fa7141c3070c6f2eb30513f6e4cd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4fd492e1a47dc4abbd1ff5196adcc9ee44a68ef8beea6e95991541aa5e39083919f1381be8460e09dcf8d9bcb83dc5bcd473153d35520614d27ab5cdf06e245d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/982ed505d608a478c0a0d00e3a34ccda878ee5223a8ff58f53b29ef40c95a3fe78eace58b524097a4b87144a67c0ecc0c1427c96b5cec0330258b8797779518a"}' ========= master_lag: 1.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2017-04-20 01:58:09.055489) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:58:09.055867) ========= 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.YavJEyOMZY/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.qeGVaUMk1k/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.005301 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 01:58:09.083159) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 01:58:09.083583) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 01:58:09.083895) ========= ========= Total master_lag: 2.68 =========