builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0109 starttime: 1494503170.06 results: success (0) buildid: 20170511031632 builduid: e2b763176e5346deaac6b2262b3d2c7b revision: f0f049c1962b4b509fb944f848b29adc74bcd496 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 04:46:10.064024) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 04:46:10.064515) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 04:46:10.064806) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 04:46:10.091714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:46:10.092126) ========= 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.H5MKKn11EB/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.BtslZ3Koxi/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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-05-11 04:46:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 151M=0s 2017-05-11 04:46:10 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092723 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:46:10.209259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:46:10.209568) ========= 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.H5MKKn11EB/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.BtslZ3Koxi/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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.029027 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:46:10.259894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 04:46:10.260498) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f0f049c1962b4b509fb944f848b29adc74bcd496 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f0f049c1962b4b509fb944f848b29adc74bcd496 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H5MKKn11EB/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.BtslZ3Koxi/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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-05-11 04:46:10,375 truncating revision to first 12 chars 2017-05-11 04:46:10,375 Setting DEBUG logging. 2017-05-11 04:46:10,375 attempt 1/10 2017-05-11 04:46:10,375 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f0f049c1962b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-11 04:46:11,132 unpacking tar archive at: mozilla-beta-f0f049c1962b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.026879 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-11 04:46:11.311135) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 04:46:11.311478) ========= script_repo_revision: f0f049c1962b4b509fb944f848b29adc74bcd496 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 04:46:11.311908) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 04:46:11.312228) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 04:46:11.331877) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-05-11 04:46:11.332358) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H5MKKn11EB/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.BtslZ3Koxi/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 04:46:11 INFO - MultiFileLogger online at 20170511 04:46:11 in /builds/slave/test 04:46:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:46:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:46:11 INFO - {'append_to_log': False, 04:46:11 INFO - 'base_work_dir': '/builds/slave/test', 04:46:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:46:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:46:11 INFO - 'branch': 'Mozilla-Beta', 04:46:11 INFO - 'buildbot_json_path': 'buildprops.json', 04:46:11 INFO - 'config_files': ('talos/mac_config.py',), 04:46:11 INFO - 'default_actions': ('clobber', 04:46:11 INFO - 'read-buildbot-config', 04:46:11 INFO - 'download-and-extract', 04:46:11 INFO - 'populate-webroot', 04:46:11 INFO - 'create-virtualenv', 04:46:11 INFO - 'install', 04:46:11 INFO - 'run-tests'), 04:46:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:46:11 INFO - 'download_minidump_stackwalk': True, 04:46:11 INFO - 'download_symbols': 'ondemand', 04:46:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:46:11 INFO - 'tooltool.py': '/tools/tooltool.py', 04:46:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:46:11 INFO - '/tools/misc-python/virtualenv.py')}, 04:46:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:46:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:46:11 INFO - 'gecko_profile': False, 04:46:11 INFO - 'gecko_profile_interval': 0, 04:46:11 INFO - 'installer_path': 'installer.exe', 04:46:11 INFO - 'log_level': 'info', 04:46:11 INFO - 'log_name': 'talos', 04:46:11 INFO - 'log_to_console': True, 04:46:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:46:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:46:11 INFO - 'opt_config_files': (), 04:46:11 INFO - 'pip_index': False, 04:46:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:46:11 INFO - 'cmd': ('bash', 04:46:11 INFO - '-c', 04:46:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:46:11 INFO - 'enabled': True, 04:46:11 INFO - 'halt_on_failure': False, 04:46:11 INFO - 'name': 'check_screen_resolution'},), 04:46:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:46:11 INFO - 'cmd': ('bash', 04:46:11 INFO - '-c', 04:46:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:46:11 INFO - 'enabled': True, 04:46:11 INFO - 'halt_on_failure': False, 04:46:11 INFO - 'name': 'check_screen_resolution'},), 04:46:11 INFO - 'run_cmd_checks_enabled': True, 04:46:11 INFO - 'suite': 'dromaeojs', 04:46:11 INFO - 'system_bits': '32', 04:46:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:46:11 INFO - 'title': 't-yosemite-r7-0109', 04:46:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:46:11 INFO - 'use_talos_json': True, 04:46:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:46:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:46:11 INFO - 'work_dir': 'build'} 04:46:11 INFO - [mozharness: 2017-05-11 11:46:11.559755Z] Running clobber step. 04:46:11 INFO - Running pre-action listener: _resource_record_pre_action 04:46:11 INFO - Running main action method: clobber 04:46:11 INFO - rmtree: /builds/slave/test/build 04:46:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:46:14 INFO - Running post-action listener: _resource_record_post_action 04:46:14 INFO - [mozharness: 2017-05-11 11:46:14.328699Z] Finished clobber step (success) 04:46:14 INFO - [mozharness: 2017-05-11 11:46:14.328832Z] Running read-buildbot-config step. 04:46:14 INFO - Running pre-action listener: _resource_record_pre_action 04:46:14 INFO - Running main action method: read_buildbot_config 04:46:14 INFO - Using buildbot properties: 04:46:14 INFO - { 04:46:14 INFO - "project": "", 04:46:14 INFO - "product": "firefox", 04:46:14 INFO - "script_repo_revision": "production", 04:46:14 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 04:46:14 INFO - "repository": "", 04:46:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 04:46:14 INFO - "buildid": "20170511031632", 04:46:14 INFO - "pgo_build": "False", 04:46:14 INFO - "basedir": "/builds/slave/test", 04:46:14 INFO - "buildnumber": 27, 04:46:14 INFO - "slavename": "t-yosemite-r7-0109", 04:46:14 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:46:14 INFO - "platform": "yosemite_r7", 04:46:14 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:46:14 INFO - "branch": "mozilla-beta", 04:46:14 INFO - "repo_path": "releases/mozilla-beta", 04:46:14 INFO - "revision": "f0f049c1962b4b509fb944f848b29adc74bcd496", 04:46:14 INFO - "stage_platform": "macosx64", 04:46:14 INFO - "builduid": "e2b763176e5346deaac6b2262b3d2c7b", 04:46:14 INFO - "slavebuilddir": "test" 04:46:14 INFO - } 04:46:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 04:46:14 INFO - Running post-action listener: _resource_record_post_action 04:46:14 INFO - [mozharness: 2017-05-11 11:46:14.332245Z] Finished read-buildbot-config step (success) 04:46:14 INFO - [mozharness: 2017-05-11 11:46:14.332378Z] Running download-and-extract step. 04:46:14 INFO - Running pre-action listener: _resource_record_pre_action 04:46:14 INFO - Running main action method: download_and_extract 04:46:14 INFO - mkdir: /builds/slave/test/build/tests 04:46:14 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')]} 04:46:14 INFO - trying https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 04:46:14 INFO - Downloading https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 04:46:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 04:46:15 INFO - Downloaded 1287 bytes. 04:46:15 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 04:46:15 INFO - Using the following test package requirements: 04:46:15 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:46:15 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 04:46:15 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 04:46:15 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:46:15 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 04:46:15 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:46:15 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 04:46:15 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:46:15 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:46:15 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 04:46:15 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 04:46:15 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:46:15 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 04:46:15 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:46:15 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 04:46:15 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:46:15 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 04:46:15 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 04:46:15 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 04:46:15 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 04:46:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 04:46:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 04:46:15 INFO - Fetch https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 04:46:17 INFO - Expected file size: 51223566 04:46:17 INFO - Obtained file size: 51223566 04:46:33 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:46:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 04:46:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 04:46:33 INFO - Fetch https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 04:46:35 INFO - Expected file size: 51223566 04:46:35 INFO - Obtained file size: 51223566 04:46:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 04:46:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 04:46:50 INFO - Fetch https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 04:46:52 INFO - Expected file size: 14404449 04:46:52 INFO - Obtained file size: 14404449 04:46:52 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')]} 04:46:52 INFO - trying https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 04:46:52 INFO - Downloading https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 04:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 04:46:56 INFO - Downloaded 59571455 bytes. 04:46:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 04:46:56 INFO - mkdir: /builds/slave/test/properties 04:46:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:46:56 INFO - Writing to file /builds/slave/test/properties/build_url 04:46:56 INFO - Contents: 04:46:56 INFO - build_url:https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 04:46:57 INFO - Running post-action listener: _resource_record_post_action 04:46:57 INFO - Running post-action listener: set_extra_try_arguments 04:46:57 INFO - [mozharness: 2017-05-11 11:46:57.144909Z] Finished download-and-extract step (success) 04:46:57 INFO - [mozharness: 2017-05-11 11:46:57.145060Z] Running populate-webroot step. 04:46:57 INFO - Running pre-action listener: _resource_record_pre_action 04:46:57 INFO - Running main action method: populate_webroot 04:46:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:46:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:46:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:46:57 INFO - '--tppagecycles', 04:46:57 INFO - '7'], 04:46:57 INFO - 'tests': ['tsvgm']}}, 04:46:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:46:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:46:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:46:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:46:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:46:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:46:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:46:57 INFO - 'talos_options': ['--disable-e10s'], 04:46:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:46:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:46:57 INFO - 'talos_options': ['--disable-e10s'], 04:46:57 INFO - 'tests': ['damp', 'tps']}, 04:46:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:46:57 INFO - 'tests': ['damp', 'tps']}, 04:46:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:46:57 INFO - 'tests': ['dromaeo_dom']}, 04:46:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:46:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:46:57 INFO - 'tests': ['basic_compositor_video']}, 04:46:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:46:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:46:57 INFO - 'tests': ['a11yr', 04:46:57 INFO - 'ts_paint', 04:46:57 INFO - 'tpaint', 04:46:57 INFO - 'sessionrestore', 04:46:57 INFO - 'sessionrestore_no_auto_restore', 04:46:57 INFO - 'tabpaint']}, 04:46:57 INFO - 'other-e10s': {'tests': ['a11yr', 04:46:57 INFO - 'ts_paint', 04:46:57 INFO - 'tpaint', 04:46:57 INFO - 'sessionrestore', 04:46:57 INFO - 'sessionrestore_no_auto_restore', 04:46:57 INFO - 'tabpaint']}, 04:46:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:46:57 INFO - 'ts_paint', 04:46:57 INFO - 'tpaint', 04:46:57 INFO - 'sessionrestore', 04:46:57 INFO - 'sessionrestore_no_auto_restore', 04:46:57 INFO - 'tabpaint']}, 04:46:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:46:57 INFO - 'ts_paint', 04:46:57 INFO - 'tpaint', 04:46:57 INFO - 'sessionrestore', 04:46:57 INFO - 'sessionrestore_no_auto_restore', 04:46:57 INFO - 'tabpaint']}, 04:46:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:46:57 INFO - 'tests': ['a11yr', 04:46:57 INFO - 'ts_paint', 04:46:57 INFO - 'tpaint', 04:46:57 INFO - 'sessionrestore', 04:46:57 INFO - 'sessionrestore_no_auto_restore', 04:46:57 INFO - 'tabpaint']}, 04:46:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:46:57 INFO - 'tests': ['a11yr', 04:46:57 INFO - 'ts_paint', 04:46:57 INFO - 'tpaint', 04:46:57 INFO - 'sessionrestore', 04:46:57 INFO - 'sessionrestore_no_auto_restore', 04:46:57 INFO - 'tabpaint']}, 04:46:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:46:57 INFO - 'tests': ['tsvgx', 04:46:57 INFO - 'tsvgr_opacity', 04:46:57 INFO - 'tart', 04:46:57 INFO - 'tscrollx', 04:46:57 INFO - 'cart', 04:46:57 INFO - 'tsvg_static']}, 04:46:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:46:57 INFO - 'tsvgr_opacity', 04:46:57 INFO - 'tart', 04:46:57 INFO - 'tscrollx', 04:46:57 INFO - 'cart', 04:46:57 INFO - 'tsvg_static']}, 04:46:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:46:57 INFO - 'talos_options': ['--disable-e10s'], 04:46:57 INFO - 'tests': ['tp5o']}, 04:46:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:46:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:46:57 INFO - 'talos_options': ['--disable-e10s', 04:46:57 INFO - '--xperf_path', 04:46:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:57 INFO - 'tests': ['tp5n']}, 04:46:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:46:57 INFO - 'talos_options': ['--xperf_path', 04:46:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:57 INFO - 'tests': ['tp5n']}}, 04:46:57 INFO - 'talos.zip': {'path': '', 04:46:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:46:57 INFO - Running post-action listener: _resource_record_post_action 04:46:57 INFO - [mozharness: 2017-05-11 11:46:57.164045Z] Finished populate-webroot step (success) 04:46:57 INFO - [mozharness: 2017-05-11 11:46:57.164177Z] Running create-virtualenv step. 04:46:57 INFO - Running pre-action listener: _resource_record_pre_action 04:46:57 INFO - Running main action method: create_virtualenv 04:46:57 INFO - Creating virtualenv /builds/slave/test/build/venv 04:46:57 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 04:46:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:46:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:46:57 INFO - Using real prefix '/tools/python27' 04:46:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:46:58 INFO - Installing distribute.............................................................................................................................................................................................done. 04:47:00 INFO - Installing pip.................done. 04:47:00 INFO - Return code: 0 04:47:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:47:01 INFO - Reading from file tmpfile_stdout 04:47:01 INFO - Output received: 04:47:01 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) 04:47:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:47:01 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')]} 04:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:01 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')]} 04:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:01 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 0x1043afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1cbca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418dd30>, '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 0x1040b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104182be8>, '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.H5MKKn11EB/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.BtslZ3Koxi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 04:47:01 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 04:47:01 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 04:47:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MKKn11EB/Render', 04:47:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:01 INFO - 'HOME': '/Users/cltbld', 04:47:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:01 INFO - 'LOGNAME': 'cltbld', 04:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:01 INFO - 'MOZ_NO_REMOTE': '1', 04:47:01 INFO - 'NO_EM_RESTART': '1', 04:47:01 INFO - 'PAGER': '/bin/cat', 04:47:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:01 INFO - 'PWD': '/builds/slave/test', 04:47:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:01 INFO - 'SHELL': '/bin/bash', 04:47:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BtslZ3Koxi/Listeners', 04:47:01 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 04:47:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:01 INFO - 'USER': 'cltbld', 04:47:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:01 INFO - 'XPC_FLAGS': '0x0', 04:47:01 INFO - 'XPC_SERVICE_NAME': '0', 04:47:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:01 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 04:47:01 INFO - Cleaning up... 04:47:01 INFO - Return code: 0 04:47:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:47:01 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')]} 04:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:01 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')]} 04:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:01 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 0x1043afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1cbca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418dd30>, '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 0x1040b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104182be8>, '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.H5MKKn11EB/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.BtslZ3Koxi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 04:47:01 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 04:47:01 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 04:47:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MKKn11EB/Render', 04:47:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:01 INFO - 'HOME': '/Users/cltbld', 04:47:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:01 INFO - 'LOGNAME': 'cltbld', 04:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:01 INFO - 'MOZ_NO_REMOTE': '1', 04:47:01 INFO - 'NO_EM_RESTART': '1', 04:47:01 INFO - 'PAGER': '/bin/cat', 04:47:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:01 INFO - 'PWD': '/builds/slave/test', 04:47:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:01 INFO - 'SHELL': '/bin/bash', 04:47:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BtslZ3Koxi/Listeners', 04:47:01 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 04:47:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:01 INFO - 'USER': 'cltbld', 04:47:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:01 INFO - 'XPC_FLAGS': '0x0', 04:47:01 INFO - 'XPC_SERVICE_NAME': '0', 04:47:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:01 INFO - Downloading/unpacking psutil>=3.1.1 04:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:47:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:04 INFO - Installing collected packages: psutil 04:47:04 INFO - Running setup.py install for psutil 04:47:04 INFO - building 'psutil._psutil_osx' extension 04:47:04 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 04:47:04 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 04:47:04 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 04:47:04 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 04:47:04 INFO - building 'psutil._psutil_posix' extension 04:47:04 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 04:47:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:47:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:47:05 INFO - ^ 04:47:05 INFO - 1 warning generated. 04:47:05 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 04:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:05 INFO - Successfully installed psutil 04:47:05 INFO - Cleaning up... 04:47:05 INFO - Return code: 0 04:47:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1cbca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418dd30>, '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 0x1040b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104182be8>, '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.H5MKKn11EB/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.BtslZ3Koxi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 04:47:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:47:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MKKn11EB/Render', 04:47:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:06 INFO - 'HOME': '/Users/cltbld', 04:47:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:06 INFO - 'LOGNAME': 'cltbld', 04:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:06 INFO - 'MOZ_NO_REMOTE': '1', 04:47:06 INFO - 'NO_EM_RESTART': '1', 04:47:06 INFO - 'PAGER': '/bin/cat', 04:47:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:06 INFO - 'PWD': '/builds/slave/test', 04:47:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:06 INFO - 'SHELL': '/bin/bash', 04:47:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BtslZ3Koxi/Listeners', 04:47:06 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 04:47:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:06 INFO - 'USER': 'cltbld', 04:47:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:06 INFO - 'XPC_FLAGS': '0x0', 04:47:06 INFO - 'XPC_SERVICE_NAME': '0', 04:47:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:47:06 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 04:47:06 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 04:47:06 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 04:47:06 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 04:47:06 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 04:47:06 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 04:47:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:47:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:47:08 INFO - Installing collected packages: mozsystemmonitor 04:47:08 INFO - Running setup.py install for mozsystemmonitor 04:47:08 INFO - Successfully installed mozsystemmonitor 04:47:08 INFO - Cleaning up... 04:47:08 INFO - Return code: 0 04:47:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:47:08 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')]} 04:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:08 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')]} 04:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:08 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 0x1043afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1cbca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418dd30>, '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 0x1040b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104182be8>, '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.H5MKKn11EB/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.BtslZ3Koxi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 04:47:08 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 04:47:08 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 04:47:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MKKn11EB/Render', 04:47:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:08 INFO - 'HOME': '/Users/cltbld', 04:47:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:08 INFO - 'LOGNAME': 'cltbld', 04:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:08 INFO - 'MOZ_NO_REMOTE': '1', 04:47:08 INFO - 'NO_EM_RESTART': '1', 04:47:08 INFO - 'PAGER': '/bin/cat', 04:47:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:08 INFO - 'PWD': '/builds/slave/test', 04:47:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:08 INFO - 'SHELL': '/bin/bash', 04:47:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BtslZ3Koxi/Listeners', 04:47:08 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 04:47:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:08 INFO - 'USER': 'cltbld', 04:47:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:08 INFO - 'XPC_FLAGS': '0x0', 04:47:08 INFO - 'XPC_SERVICE_NAME': '0', 04:47:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:08 INFO - Downloading/unpacking jsonschema==2.5.1 04:47:08 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 04:47:08 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 04:47:08 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 04:47:08 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 04:47:08 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 04:47:08 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 04:47:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:47:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:10 INFO - Downloading functools32-3.2.3-2.tar.gz 04:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:47:10 INFO - warning: no files found matching '*.txt' 04:47:10 INFO - no previously-included directories found matching 'build' 04:47:10 INFO - no previously-included directories found matching 'dist' 04:47:10 INFO - no previously-included directories found matching '.git*' 04:47:10 INFO - Installing collected packages: jsonschema, functools32 04:47:10 INFO - Running setup.py install for functools32 04:47:10 INFO - warning: no files found matching '*.txt' 04:47:10 INFO - no previously-included directories found matching 'build' 04:47:10 INFO - no previously-included directories found matching 'dist' 04:47:10 INFO - no previously-included directories found matching '.git*' 04:47:10 INFO - Successfully installed jsonschema functools32 04:47:10 INFO - Cleaning up... 04:47:10 INFO - Return code: 0 04:47:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:10 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 0x1043afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1cbca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418dd30>, '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 0x1040b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104182be8>, '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.H5MKKn11EB/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.BtslZ3Koxi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 04:47:10 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 04:47:10 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 04:47:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MKKn11EB/Render', 04:47:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:10 INFO - 'HOME': '/Users/cltbld', 04:47:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:10 INFO - 'LOGNAME': 'cltbld', 04:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:10 INFO - 'MOZ_NO_REMOTE': '1', 04:47:10 INFO - 'NO_EM_RESTART': '1', 04:47:10 INFO - 'PAGER': '/bin/cat', 04:47:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:10 INFO - 'PWD': '/builds/slave/test', 04:47:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:10 INFO - 'SHELL': '/bin/bash', 04:47:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BtslZ3Koxi/Listeners', 04:47:10 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 04:47:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:10 INFO - 'USER': 'cltbld', 04:47:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:10 INFO - 'XPC_FLAGS': '0x0', 04:47:10 INFO - 'XPC_SERVICE_NAME': '0', 04:47:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:47:10 INFO - Cleaning up... 04:47:11 INFO - Return code: 0 04:47:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:11 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 0x1043afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1cbca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418dd30>, '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 0x1040b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104182be8>, '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.H5MKKn11EB/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.BtslZ3Koxi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 04:47:11 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 04:47:11 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 04:47:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MKKn11EB/Render', 04:47:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:11 INFO - 'HOME': '/Users/cltbld', 04:47:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:11 INFO - 'LOGNAME': 'cltbld', 04:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:11 INFO - 'MOZ_NO_REMOTE': '1', 04:47:11 INFO - 'NO_EM_RESTART': '1', 04:47:11 INFO - 'PAGER': '/bin/cat', 04:47:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:11 INFO - 'PWD': '/builds/slave/test', 04:47:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:11 INFO - 'SHELL': '/bin/bash', 04:47:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BtslZ3Koxi/Listeners', 04:47:11 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 04:47:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:11 INFO - 'USER': 'cltbld', 04:47:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:11 INFO - 'XPC_FLAGS': '0x0', 04:47:11 INFO - 'XPC_SERVICE_NAME': '0', 04:47:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:11 INFO - Downloading/unpacking blobuploader==1.2.4 04:47:11 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 04:47:11 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 04:47:11 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 04:47:11 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 04:47:11 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 04:47:11 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 04:47:12 INFO - Downloading blobuploader-1.2.4.tar.gz 04:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:47:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:47:12 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 04:47:12 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 04:47:12 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 04:47:12 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 04:47:12 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 04:47:12 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 04:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:47:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:47:13 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 04:47:13 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 04:47:13 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 04:47:13 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 04:47:13 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 04:47:13 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 04:47:13 INFO - Downloading docopt-0.6.1.tar.gz 04:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:47:13 INFO - Installing collected packages: blobuploader, requests, docopt 04:47:13 INFO - Running setup.py install for blobuploader 04:47:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:47:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:47:13 INFO - Running setup.py install for requests 04:47:14 INFO - Running setup.py install for docopt 04:47:14 INFO - Successfully installed blobuploader requests docopt 04:47:14 INFO - Cleaning up... 04:47:14 INFO - Return code: 0 04:47:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:14 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')]} 04:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:14 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')]} 04:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:14 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 0x1043afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1cbca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418dd30>, '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 0x1040b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104182be8>, '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.H5MKKn11EB/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.BtslZ3Koxi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 04:47:14 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 04:47:14 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 04:47:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MKKn11EB/Render', 04:47:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:14 INFO - 'HOME': '/Users/cltbld', 04:47:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:14 INFO - 'LOGNAME': 'cltbld', 04:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:14 INFO - 'MOZ_NO_REMOTE': '1', 04:47:14 INFO - 'NO_EM_RESTART': '1', 04:47:14 INFO - 'PAGER': '/bin/cat', 04:47:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:14 INFO - 'PWD': '/builds/slave/test', 04:47:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:14 INFO - 'SHELL': '/bin/bash', 04:47:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BtslZ3Koxi/Listeners', 04:47:14 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 04:47:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:14 INFO - 'USER': 'cltbld', 04:47:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:14 INFO - 'XPC_FLAGS': '0x0', 04:47:14 INFO - 'XPC_SERVICE_NAME': '0', 04:47:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:14 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-vSdB_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:14 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-vpIJSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:14 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-UfcRzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:15 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-DtdYRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:15 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-mYeL7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:15 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-_uuyT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:15 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-5AI7gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:15 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-liUBAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:15 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-ClZLDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:15 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-GnPkxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:15 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-rwOoou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:15 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-tQGycE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:16 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-qsL_5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:16 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-HIWxn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:16 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-IcZaAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:16 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-qYpfwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:16 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-Fym9Uz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:47:16 INFO - Running setup.py install for manifestparser 04:47:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:47:16 INFO - Running setup.py install for mozcrash 04:47:16 INFO - Running setup.py install for mozdebug 04:47:16 INFO - Running setup.py install for mozdevice 04:47:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:47:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:47:17 INFO - Running setup.py install for mozfile 04:47:17 INFO - Running setup.py install for mozhttpd 04:47:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:47:17 INFO - Running setup.py install for mozinfo 04:47:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:47:17 INFO - Running setup.py install for mozInstall 04:47:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:47:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:47:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:47:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:47:17 INFO - Running setup.py install for mozleak 04:47:17 INFO - Running setup.py install for mozlog 04:47:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:47:18 INFO - Running setup.py install for moznetwork 04:47:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:47:18 INFO - Running setup.py install for mozprocess 04:47:18 INFO - Running setup.py install for mozprofile 04:47:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:47:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:47:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:47:18 INFO - Running setup.py install for mozrunner 04:47:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:47:18 INFO - Running setup.py install for mozscreenshot 04:47:18 INFO - Running setup.py install for moztest 04:47:18 INFO - Running setup.py install for mozversion 04:47:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:47:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:47:19 INFO - Cleaning up... 04:47:19 INFO - Return code: 0 04:47:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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')]} 04:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:19 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 0x1043afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1cbca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418dd30>, '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 0x1040b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104182be8>, '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.H5MKKn11EB/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.BtslZ3Koxi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 04:47:19 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 04:47:19 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 04:47:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MKKn11EB/Render', 04:47:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:19 INFO - 'HOME': '/Users/cltbld', 04:47:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:19 INFO - 'LOGNAME': 'cltbld', 04:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:19 INFO - 'MOZ_NO_REMOTE': '1', 04:47:19 INFO - 'NO_EM_RESTART': '1', 04:47:19 INFO - 'PAGER': '/bin/cat', 04:47:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:19 INFO - 'PWD': '/builds/slave/test', 04:47:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:19 INFO - 'SHELL': '/bin/bash', 04:47:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BtslZ3Koxi/Listeners', 04:47:19 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 04:47:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:19 INFO - 'USER': 'cltbld', 04:47:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:19 INFO - 'XPC_FLAGS': '0x0', 04:47:19 INFO - 'XPC_SERVICE_NAME': '0', 04:47:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:19 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-hGclFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:19 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)) 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:19 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-7ICCyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:19 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)) 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:19 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-xE39cB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:19 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)) 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:19 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-yZ9vut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:19 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)) 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:19 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-HFGklc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:19 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)) 04:47:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:19 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-O39tXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:20 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)) 04:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:20 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-8oU_3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:20 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)) 04:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:20 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-SJoYbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:20 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)) 04:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:20 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-4jt9u0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:20 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)) 04:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:20 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-72Yflz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:20 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)) 04:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:20 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-zkhWu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:20 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)) 04:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:20 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-dlZUma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:20 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)) 04:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:20 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-6ll_IU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:20 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)) 04:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:20 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-lpPtuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:20 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)) 04:47:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:20 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-k4LMKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:21 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)) 04:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:21 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-vvvT54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:21 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)) 04:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:21 INFO - Running setup.py (path:/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/pip-RevlNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:21 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)) 04:47:21 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)) 04:47:21 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)) 04:47:21 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)) 04:47:21 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)) 04:47:21 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)) 04:47:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:47:21 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 04:47:21 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 04:47:21 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 04:47:21 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 04:47:21 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 04:47:21 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 04:47:22 INFO - Downloading blessings-1.6.tar.gz 04:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:47:22 INFO - Installing collected packages: blessings 04:47:22 INFO - Running setup.py install for blessings 04:47:22 INFO - Successfully installed blessings 04:47:22 INFO - Cleaning up... 04:47:22 INFO - Return code: 0 04:47:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:47:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:23 INFO - Reading from file tmpfile_stdout 04:47:23 INFO - Current package versions: 04:47:23 INFO - blessings == 1.6 04:47:23 INFO - blobuploader == 1.2.4 04:47:23 INFO - docopt == 0.6.1 04:47:23 INFO - functools32 == 3.2.3-2 04:47:23 INFO - jsonschema == 2.5.1 04:47:23 INFO - manifestparser == 1.1 04:47:23 INFO - mozInstall == 1.12 04:47:23 INFO - mozcrash == 1.0 04:47:23 INFO - mozdebug == 0.1 04:47:23 INFO - mozdevice == 0.49 04:47:23 INFO - mozfile == 1.2 04:47:23 INFO - mozhttpd == 0.7 04:47:23 INFO - mozinfo == 0.9 04:47:23 INFO - mozleak == 0.1 04:47:23 INFO - mozlog == 3.4 04:47:23 INFO - moznetwork == 0.27 04:47:23 INFO - mozprocess == 0.25 04:47:23 INFO - mozprofile == 0.28 04:47:23 INFO - mozrunner == 6.13 04:47:23 INFO - mozscreenshot == 0.1 04:47:23 INFO - mozsystemmonitor == 0.3 04:47:23 INFO - moztest == 0.8 04:47:23 INFO - mozversion == 1.4 04:47:23 INFO - psutil == 3.1.1 04:47:23 INFO - requests == 1.2.3 04:47:23 INFO - wsgiref == 0.1.2 04:47:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:23 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 0x1043afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1cbca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418dd30>, '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 0x1040b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104182be8>, '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.H5MKKn11EB/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.BtslZ3Koxi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 04:47:23 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 04:47:23 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 04:47:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MKKn11EB/Render', 04:47:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:23 INFO - 'HOME': '/Users/cltbld', 04:47:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:23 INFO - 'LOGNAME': 'cltbld', 04:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:23 INFO - 'MOZ_NO_REMOTE': '1', 04:47:23 INFO - 'NO_EM_RESTART': '1', 04:47:23 INFO - 'PAGER': '/bin/cat', 04:47:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:23 INFO - 'PWD': '/builds/slave/test', 04:47:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:23 INFO - 'SHELL': '/bin/bash', 04:47:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BtslZ3Koxi/Listeners', 04:47:23 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 04:47:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:23 INFO - 'USER': 'cltbld', 04:47:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:23 INFO - 'XPC_FLAGS': '0x0', 04:47:23 INFO - 'XPC_SERVICE_NAME': '0', 04:47:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 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)) 04:47:23 INFO - Cleaning up... 04:47:23 INFO - Return code: 0 04:47:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:23 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 0x1043afb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043b2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecc1cbca90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10418dd30>, '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 0x1040b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104182be8>, '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.H5MKKn11EB/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.BtslZ3Koxi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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 04:47:23 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 04:47:23 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 04:47:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MKKn11EB/Render', 04:47:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:23 INFO - 'HOME': '/Users/cltbld', 04:47:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:23 INFO - 'LOGNAME': 'cltbld', 04:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:23 INFO - 'MOZ_NO_REMOTE': '1', 04:47:23 INFO - 'NO_EM_RESTART': '1', 04:47:23 INFO - 'PAGER': '/bin/cat', 04:47:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:23 INFO - 'PWD': '/builds/slave/test', 04:47:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:23 INFO - 'SHELL': '/bin/bash', 04:47:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BtslZ3Koxi/Listeners', 04:47:23 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 04:47:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:23 INFO - 'USER': 'cltbld', 04:47:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:23 INFO - 'XPC_FLAGS': '0x0', 04:47:23 INFO - 'XPC_SERVICE_NAME': '0', 04:47:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:47:23 INFO - Cleaning up... 04:47:23 INFO - Return code: 0 04:47:23 INFO - Running post-action listener: _resource_record_post_action 04:47:23 INFO - Running post-action listener: _start_resource_monitoring 04:47:23 INFO - Starting resource monitoring. 04:47:23 INFO - [mozharness: 2017-05-11 11:47:23.801341Z] Finished create-virtualenv step (success) 04:47:23 INFO - [mozharness: 2017-05-11 11:47:23.802321Z] Running install step. 04:47:23 INFO - Running pre-action listener: _resource_record_pre_action 04:47:23 INFO - Running main action method: install 04:47:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:24 INFO - Reading from file tmpfile_stdout 04:47:24 INFO - Detecting whether we're running mozinstall >=1.0... 04:47:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:47:24 INFO - Reading from file tmpfile_stdout 04:47:24 INFO - Output received: 04:47:24 INFO - Usage: mozinstall [options] installer 04:47:24 INFO - Options: 04:47:24 INFO - -h, --help show this help message and exit 04:47:24 INFO - -d DEST, --destination=DEST 04:47:24 INFO - Directory to install application into. [default: 04:47:24 INFO - "/builds/slave/test"] 04:47:24 INFO - --app=APP Application being installed. [default: firefox] 04:47:24 INFO - mkdir: /builds/slave/test/build/application 04:47:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:47:38 INFO - Reading from file tmpfile_stdout 04:47:38 INFO - Output received: 04:47:38 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:47:38 INFO - Running post-action listener: _resource_record_post_action 04:47:38 INFO - [mozharness: 2017-05-11 11:47:38.709097Z] Finished install step (success) 04:47:38 INFO - [mozharness: 2017-05-11 11:47:38.709257Z] Running run-tests step. 04:47:38 INFO - Running pre-action listener: _resource_record_pre_action 04:47:38 INFO - Running main action method: run_tests 04:47:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:47:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:47:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:47:38 INFO - 2017-05-11 04:47:38.723 screenresolution[1622:7325] starting screenresolution argv=screenresolution get 04:47:38 INFO - 2017-05-11 04:47:38.726 screenresolution[1622:7325] Display 0: 1600x1200x32@60 04:47:38 INFO - 2017-05-11 04:47:38.732 screenresolution[1623:7327] starting screenresolution argv=screenresolution list 04:47:38 INFO - Available Modes on Display 0 04:47:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:47:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:47:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:47:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:47:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:47:38 INFO - Intel Iris: 04:47:38 INFO - Chipset Model: Intel Iris 04:47:38 INFO - Type: GPU 04:47:38 INFO - Bus: Built-In 04:47:38 INFO - VRAM (Dynamic, Max): 1536 MB 04:47:38 INFO - Vendor: Intel (0x8086) 04:47:38 INFO - Device ID: 0x0a2e 04:47:38 INFO - Revision ID: 0x0009 04:47:38 INFO - Displays: 04:47:38 INFO - Display: 04:47:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:47:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:47:38 INFO - Display Serial Number: 1600x1200 60 04:47:38 INFO - Main Display: Yes 04:47:38 INFO - Mirror: Off 04:47:38 INFO - Online: Yes 04:47:38 INFO - Rotation: Supported 04:47:38 INFO - Return code: 0 04:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:38 INFO - Python 2.7.3 04:47:38 INFO - Return code: 0 04:47:38 INFO - grabbing minidump binary from tooltool 04:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:47:38 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 0x10418dd30>, '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 0x1040b4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104182be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47:38 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 04:47:38 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 04:47:38 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 04:47:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:39 INFO - Return code: 0 04:47:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:47:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:39 INFO - ENV: RUST_BACKTRACE is now 1 04:47:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:47:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0109', '--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 04:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0109 --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 04:47:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H5MKKn11EB/Render', 04:47:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:47:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:47:39 INFO - 'HOME': '/Users/cltbld', 04:47:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:47:39 INFO - 'LOGNAME': 'cltbld', 04:47:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:39 INFO - 'MOZ_NO_REMOTE': '1', 04:47:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:39 INFO - 'NO_EM_RESTART': '1', 04:47:39 INFO - 'PAGER': '/bin/cat', 04:47:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:39 INFO - 'PWD': '/builds/slave/test', 04:47:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:47:39 INFO - 'RUST_BACKTRACE': '1', 04:47:39 INFO - 'SHELL': '/bin/bash', 04:47:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BtslZ3Koxi/Listeners', 04:47:39 INFO - 'TMPDIR': '/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/', 04:47:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:47:39 INFO - 'USER': 'cltbld', 04:47:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:47:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:39 INFO - 'XPC_FLAGS': '0x0', 04:47:39 INFO - 'XPC_SERVICE_NAME': '0', 04:47:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:47:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0109', '--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 04:47:39 INFO - mozversion application_buildid: 20170511031632 04:47:39 INFO - mozversion application_changeset: f0f049c1962b4b509fb944f848b29adc74bcd496 04:47:39 INFO - mozversion application_display_name: Firefox 04:47:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:39 INFO - mozversion application_name: Firefox 04:47:39 INFO - mozversion application_remotingname: firefox 04:47:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:47:39 INFO - mozversion application_vendor: Mozilla 04:47:39 INFO - mozversion application_version: 54.0 04:47:39 INFO - mozversion platform_buildid: 20170511031632 04:47:39 INFO - mozversion platform_changeset: f0f049c1962b4b509fb944f848b29adc74bcd496 04:47:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:47:39 INFO - mozversion platform_version: 54.0 04:47:39 INFO - using testdate: 1494503259 04:47:39 INFO - actual date: 1494503259 04:47:39 INFO - starting webserver on 'localhost:49240' 04:47:39 INFO - SUITE-START | Running 2 tests 04:47:39 INFO - TEST-START | dromaeo_css 04:47:39 INFO - operating with platform_type : mac_ 04:47:39 INFO - Initialising browser for dromaeo_css test... 04:47:39 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpVNs2U7/profile http://localhost:49240/getInfo.html) 04:47:41 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 04:47:41 INFO - PROCESS | 1633 | colorDepth:24 04:47:41 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 04:47:41 INFO - PROCESS | 1633 | __metrics 04:47:42 INFO - PROCESS | 1633 | 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" 04:47:42 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:47:42 INFO - TEST-INFO | 1633: exit 0 04:47:42 INFO - Browser initialized. 04:47:42 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:42 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmpVNs2U7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:54 INFO - PROCESS | 1637 | RSS: Main: 165212160 04:47:54 INFO - PROCESS | 1637 | 04:50:58 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 04:51:00 INFO - PROCESS | 1637 | RSS: Main: 310243328 04:51:00 INFO - PROCESS | 1637 | 04:54:03 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 04:54:03 INFO - PROCESS | 1637 | RSS: Main: 300593152 04:54:03 INFO - PROCESS | 1637 | 04:57:06 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 04:57:07 INFO - PROCESS | 1637 | RSS: Main: 286363648 04:57:07 INFO - PROCESS | 1637 | 05:00:09 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 05:00:10 INFO - PROCESS | 1637 | RSS: Main: 267698176 05:00:10 INFO - PROCESS | 1637 | 05:03:13 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 05:03:14 INFO - PROCESS | 1637 | RSS: Main: 268152832 05:03:14 INFO - PROCESS | 1637 | 05:06:17 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 05:06:17 INFO - PROCESS | 1637 | RSS: Main: 316440576 05:06:17 INFO - PROCESS | 1637 | 05:06:17 INFO - PROCESS | 1637 | __start_tp_report 05:06:17 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 05:06:17 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 05:06:17 INFO - PROCESS | 1637 | |i|pagename|runs| 05:06:17 INFO - PROCESS | 1637 | |0;dojo.html;3471.409860323745;3541.0970202598332;3548.3435564420583;3570.428731402976;3624.930645459589;6163.845903852406;6176.598521096125;6215.223097112861;6232.252129744431;6271.1847459830215;6225.2529696436495;6269.686515674221;6299.433051025407;6299.77950771723;6307.3692630736905;5499.780008799643;5521.668699878021;5556.527695145917;5584.944150558504;5660.60375773696;5419.376771671269;5454.836354909359;5512.33851937768;5524.392316845144;5646.971765141189;5517.089680202782;5520.254765606652;5528.834134975958;5530.391656917735;5546.833594992157;4583;5538.556915446755;5540.279763630742;5541.501264886179;5543.944560554383;4530.932036019462;5385.3268341457315;5488.259085023511;5497.780088796443;5506.119020956668;6183.690815459254;6185.783497577563;6186;6188.628682279078;6202.81391558254;6529.151210342672;6556.770513032021;6565.113709649184;6569.67151642416;6569.770058047993;6661.233958094833;6661.733530658767;6667.899981500282;6675.432588230006;6690.83272918176;6110.619513019656;6134.283518479682;6255.655938923357;6304.369563043705;6344.619322840645;6562.967185164043;6659.134312539339;6700.162479690039;6744.156980377453;6761.188657361148;6453.967730161413;6466.159399278158;6466.967665161644;6499.545031847725;6503.967480162569;6610.272869984298;6617.007448882609;6626.86746265072;6633;6637.037629543785;5573.442655734394;6301.590396624297;6452.870942581122;6469.708863101172;6482.546221764431;6578.506612004119;6584.308647591934;6584.76953306632;6588.96705516479;6598.505112116611;5275.973620131875;5317.654352467077;5344.118220493653;5356.330458692663;5364.114921037985;4642.210824159901;4663.370444989951;4665.206914824488;4686.554777296152;4753.643476739258;6306.054091886253;6309.526785491014;6316.715747791361;6329.113924050636;6331.3352098029045;6625.933740662628;6640.833979150463;6647.268800431949;6647.966760166265;6650.201975762842;6122.520135281246;6301.7164227609865;6321.1782468278825;6359.936400635935;6364.331745166784;5729.828105156852;5736.13957906309;5800.100984347433;5865.325487568899;5928.851778705481;6837.487188460886;6871.931280687129;6873.037774711444;6877.312268773083;6877.449804015567;6528.575642583217;6645.468362530889;6663.100481434944;6680.5991640501725;6682.164729408824;6545.116409284686;6624;6640.701168447528;6799.252082271045;6834.419074378733;6368.554201205871;6374.394432528902;6375.74497020114;6383.872322553616;6389.9680501597195;6544.705488253136;6560.803175904731;6596.8350791230605;6654.700538475877;6654.933450665431;6460.580062295936;6472.5145614080075;6477.4170324671;6480.773172938924;6490.448311893542;5953.821385358447;6298.708764703133;6456.38664326907;6466.773662921775;6485.156929599122;4770;6197.628142311476;6243.469305108935;6251.3123556407845;6265.874682506415;6451.1290975717675;6459.935400645933;6462.192225971754;6470.547061705635;6471.25580558223;6330.303666596763;6331.018692102732;6335.2714437838395;6344.1118243445035;6348.968255158695 05:06:17 INFO - PROCESS | 1637 | |1;ext.html;775.7284950267403;811.500926929938;828.1345993436857;895.3061377432493;915.4873270968254;29206;40923.79538102309;41296.793516032456;41398;41417.79291103544;34737.65262347376;43480;43710;43726.78136609321;43754.562454375446;8002.639881205359;9604.423734575912;9751.073648003428;9765.169960553361;9770.951145244264;7932.603369831514;11656.125790565698;11794.646160615152;11799.705007374798;11812.881871181307;11921;11944.343061131634;11957.402129893513;11963.342016189106;11975.101867359983;11877.28736275822;11908.523659053628;11920.986716129139;11923.224990375598;11925.344106074206;11556.768864622745;11608.071354291636;11618.244814087057;11621.535138594447;11632.941835290769;40598.594014059774;40838.774836754645;40882.77351679454;40888.36446542135;40934;3981.840726370942;4034.435179074932;4051.1290072634524;4053.837846486137;4062.6749860011128;28429.715702842914;28883.56674649882;29901.252468688457;30640;30791.38417231643;3267.8856240031723;3279.540864279003;3298.835058247102;3409.6760807723226;3426.7258619310396;367610;371313;371831;372852;373206;42431.36352954708;53126.734366327924;53166.46833531615;53233.467665323624;53240.733796331544;54571;54592;54640.45359546433;54644;54722.72638636861;14884.255787210595;15294.770578441332;15314;15319.923400382926;15329.386824526893;11994.980426663657;12037.037037037016;13109.41007654658;13121;13123.54067607629;9697.6605818796;11600.88399115998;11921.86742259484;11937.164398492023;11943.641690749291;5344.327836081959;5365.1147560652835;5368.91946620801;5370.31484257871;5423.078076726966;838.8657814749732;966.9323147379616;973.6592192732487;984.3995162950595;994.8905620381752;25472.745272547407;27639.86180069087;28551.57172642412;28752.568711469346;29040;1073.4257172412879;1086.3047649504324;1089.8910108989196;1100.114407901647;1120.8654961404684;14516.346764395628;14702.044367116103;14757.335919883417;14881.181535015461;15007.849921500645;412099;412397;412683;412755;413123;57645.423545764;57647;57692.134617980766;57750.42249577535;57769.84460310854;1470.8235011798652;1489.0693316677077;1529.0978322789608;1530.3572499550216;1532.1343440955825;26558.203253902415;26648.7335126654;27613.171604851887;28156.155315340573;28368;46879.76560117178;46975.590732278084;47025.2946205814;47035.29447058228;47054.76472617615;353763;354489;354748.2262588671;357796;358867;29333.85333073321;29799.55300670535;30856.691433085383;34612;34795.304093917475;32396.83801580977;32458.837705812264;32658.183545411553;33709.66290337163;41871.90640468025;25137.74862251354;27702.168934931986;27776.16671499858;29394.559081613366;29491.557626636048;26473.867630661724;28289.434211315245;29263;29311.974080907064;29428.558571621015;33186.5022024665;33476.83261583676;34489;34513.96458106261;34580.481292780125;20746;20908.327333812955;23501.41246468852;28542.714572854005;29507.967221147155;22560.435989100402;23173.188938387077;23208.4197895054;23556.9399377025;23641.40896477602 05:06:17 INFO - PROCESS | 1637 | |2;jquery.html;397.9383006139619;433.39974135821876;442.9379886815846;446.9731816091035;450.08632476073564;19694.90152549237;21340.679889801646;21929.671054934188;22103.44741381466;22144.446388840286;22266.332010039725;22285.44286392837;22413.21553745619;22785.54428911425;23535;6941.861162776741;7247.565146091225;7253.274672532757;7262.055932728738;7690.461667683265;6633.767818126366;8022;8027.076886158079;8028.879566806502;8032.076311224226;7766;8000.4799688020385;8060.3954703397185;8098.838023239561;8144;7764.30121289081;7971.043474783063;8013.398995075364;8051.959740201261;8064.475809072421;6798.966005169992;7197.856042879165;7802.492837965571;7805.336546393563;7825.726099586487;24417.877910610332;24799.256022319358;24987.50024999508;26475.33811654705;27094.32264193391;2973.895913643012;3017.6571425715565;3024.3195281061585;3065.172403451078;3070.6929307069336;15438.911768376389;15524.689506209812;16151.91924040384;16168.434104806276;16452.670946581;2084.781097984705;2103.116690989788;2106.5260316428835;2113.820325272354;2125.0543508138885;118159.63680726338;119361.40319298347;134186;146225.26887365602;151878;15250.847491525165;18316.63366732658;20147.697784533244;20498.077586508643;20625.48436289105;32115;32256.709731610943;32339.191520211712;32385.51421728676;32399.676003240136;10709.839352409721;10747.623833165802;10818;10873.891261087447;11060.834087488694;7793.142754297136;8718;9072.727818165466;9078;9196.908030919605;9022;9227.3079519035;9376.390534615228;9376.5311734413;9393.436393816393;3379.9493007604906;3614.644508309384;3987.8404863805704;3996.9600303997167;4007.599240075969;896.6323807239131;982.5234761140841;1040.9167266618651;1045.4511381524608;1054.509653011338;21427.46431339229;21508.677369839465;21629.459263518536;21786.257099432325;21799.564008719735;918.8300164469595;1012.00823193271;1033.5297439664935;1060.9628662996759;1074.8763892152347;8222.259996600334;9016.684416045407;11227.382493962747;11375.715607109889;11621.07031437483;682893;685037.5748121327;685478;691667.2499825014;698443;131282;155985.22007390118;159625.2018739899;162805;163673;1250.2685928731612;1378.9379477923317;1396.8812650924785;1432.2194404049817;1436.8203974503188;19357;20448.284310049075;20501.58996820085;20565.89717051405;20625.58748824985;62160.68919655373;62331.37668623437;62965.37034629779;63703.3629663716;64554.67722661357;85162.57418713115;86279.56860215659;86738;87589;88750.55624721835;9700.369475984038;11299.265547739371;11407.942960285478;11496.54013839437;11833.82249266279;11244.831327530257;12401.697821728589;12981.480740770263;12991.155574887602;13280.937524997784;11161;11264.436778161224;11339.092872570009;11463.484143213409;11684.591039313924;10087.193024557871;10120.139788117798;10229.948850255701;10412.947935260276;10585.89414105849;10004.649837255953;10855.968682975104;11313.490892909675;11491.48288327044;11741.941290293495;11178.708364785361;11441;11565.306081635128;11570.363630000431;11775.941120294343;11148.609798657008;11406.885931140583;11415.086793056702;11507.884921150682;11604.361760103275 05:06:17 INFO - PROCESS | 1637 | |3;mootools.html;1409.2671810658464;1536.4238410596026;1642.096846734296;1657.4613250693524;1665.8417450342222;9335.206507446866;10622.893771062287;10845;11115.333080015205;11119.1660625453;10694.946525267364;10793.352398856074;10793.974572415627;10798.136149108072;10824.67525974222;2430.100862680806;2476.6532685424054;2477.1082410332265;2477.2815883393796;2485.652008718781;2081.573277478121;2151.8708877467325;2454.214651311581;2533.5692932201478;2539.149384956033;2478.9752102478924;2504.6368276599974;2510.2845688978646;2510.8242423030397;2511.61070034145;2455.4229756007326;2479.764422379871;2484.0560586977012;2487.614419764939;2491.140556508011;2431.9270421887372;2445.6942882139733;2446.449548851494;2454.361865914857;2459.594166962449;11434.714132146679;11553.653390398302;11562.30626162433;11564.248323858923;11589.130815188895;6034.487068599175;6158.8152355428965;6171.012637977902;6176.320604733476;6184.659843708594;3348.5312056312137;3543.6102028776813;3599.3521166190076;3600.207954250061;3606.2787442511603;1203.5125774061432;1247.8440194975628;1252.843394575678;1298.2210673595862;1299.1750238598559;15663.843361566353;15864.286107125206;15864.60338491547;15878.206089695468;15894.28475718607;4778.37881075458;5083.517065878736;5087.97456012725;5105.310783044316;5138.07514647367;13268.668283292995;13293.268870212038;13309.334533273297;13310;13340.266285354399;6166.691665416712;6174.320824709278;6175.228096487939;6180.381961803783;6181.196444462191;4689.742064186435;5437.700926449004;5442.863928401822;5527.751251193706;5532.197831314437;3324.6841550052704;3731.7201209909367;3867.207222519377;3918.275119102975;3924;1092.8306112552566;1108.9889101109047;1171.1977295552574;1192.4991503568522;1199.7060720123452;941.8963913969458;948.8624149498285;982.6069572171045;993.2203220471895;1018.7198520406947;6603;6632.043547153601;6711.63086030273;6816.591004539743;6875.759348422881;934.5887809363858;1069.1820757120654;1072.5066469423996;1084.430673896195;1088.8747794003632;4425.867223983286;4473.776311184428;4518.073794872109;4645.372874661945;4656.767161641905;13266.734665306833;13304.13523120994;13685.863141368658;13735.587932362045;13864.098833575785;13412.195268283935;13892.861071389158;13896.861031389759;13910.095843770123;13928.930355348159;10096.040876116756;10433.843492347622;10443.164546836235;10454.425006624557;10462.68611941643;6867;6918.515703900679;7057.364837164474;7101;7188.460865435218;12224.511019559119;12419.503219871465;12468.5012599495;12630.305333206761;12641.620751377106;12467.189632673848;12741.17182383142;12912.935435322763;12930.741385172432;13001.479940802263;7468.626568671436;9037.954810225907;9471.147596716328;9481.857772133562;9486.573104210465;10140.594376224868;10151.086402223835;10183.949080254552;10258.846117308098;10275;7047.506674532939;7342.265773422615;8705.260052895575;8890.110988901059;8929.642814287356;8567.914320856711;8682.826343472969;8728.956355218183;8733.257673097858;8850.955745221232;8110.837783244184;8164.346852251924;8191.180881911761;8269.4624849387;8286.792830179294;5936.22829032223;5986.9401305986385;6155.6614386209185;6182.783602573888;6229.034499652561;5967.373425790403;6062.454379105901;6064.211652485149;6113.083037544404;6154.076888466766 05:06:17 INFO - PROCESS | 1637 | |4;prototype.html;334.50994293360225;394.66256350820044;400.3074680802212;402.2116651363328;404.70658772390004;5038.178619972813;5088.745562721868;5098.566621837139;5104.617153713472;5138.871528211796;5060.822871199509;5094.847154585359;5121.923171152435;5133.435322114565;5156.793728250875;3429.4684323929705;3673.485712000329;4052.1085361220485;4071.4503542021894;4090.425186303265;3294.670532946698;4067.2068946555432;4082.5713300103507;4109.6506796922295;4110.938335924963;4027.8388864445387;4049.3723472861607;4103.466549348581;4105.527864295615;4135.421041054255;3383.0189245118886;3973.9403908941244;3987.441758153861;3997.860074897379;4046.9275641954905;2960.3635218427926;3225.3226822367333;3625.7280703947044;3640.672339489459;3655.738770124303;4541.931871021938;4763.78562964664;5016.724080175589;5088;5092.388913330387;4050.675945924319;4129.834806607732;4603.424571928509;4647.3958385410015;4736.881577960544;4730.59789917854;5031.345925029759;5239.685618862881;5473.67157970519;5477.452254774531;3473.9131521711906;3924.135381171732;3996.0009997500624;4081.69387295954;4091.85678501251;4926.433460152092;5018.655351525335;5148.897022059537;5488.81990372072;5656.830295091154;4151.584841515824;4781.521847815191;4804.543568361;4809.927851082237;4834.129856625841;4303.548127446636;4514;4871.124617022401;4982.277569752366;5055.393352797688;4238.788060596958;4552.635789136861;5087.669301495391;5101.704233095122;5196.92204616931;4965.90068198634;5374;5405.8107966221;5419.268398766195;5452.890942181134;1337.6923307639297;1485.9405623775144;1497.7304085264757;1572.316042521507;1582.889197756146;1095.7041598768446;1159.9420028998686;1161.7502237019082;1167.8073117935446;1181.8286348479594;4471.754053527087;5085.974570127126;5107.591392688576;5119.257707632372;5159.871003224949;4872.6832755870755;5341.439148889311;5616.550675945915;5635.590467766942;5711.6858572778065;4582.816687332536;4754.381930349033;4769.833055843029;4867.269909513601;5010.271456347555;2533.645289659449;2792.9581056284173;2917.0665387076356;2937.897173598914;2962.2298202467514;4918.5573298403315;5721.5136713379825;5735.812856614694;5845.9707701462075;5889.734961926723;5234.581233501311;5370.91943620846;5416;5425.26758887553;5609.354924183689;4511.616512596466;5405.108157154104;5514.503694667499;5651.943480565224;5713.714314284269;4696.976515117539;5385.784568617211;5445.564354851682;5541.695206763506;5547.446714919829;5161.793528258978;5337.893242135058;5438;5458;5557.916631250615;5049.419316778617;5242.9475705243985;5542.3903370630005;5784.7107644618445;5839.7372118255635;4157.355609880473;4290.4636920384955;4372.6939114261695;4375.868723938287;4412.448443944507;4893.877653058702;5258.474152584711;5290.418054013979;5488.9725551371985;5617.354004289559;4938.037082768826;5075.213341932006;5164.018836421068;5194.714290713896;5373.7850485980125;4622.329762184397;4828.2998965150555;5032.370953630796;5391.86520336979;5422.783088676409;4363.672724545735;5196;5247.583152548867;5311.41574426805;5313.698143954756;4617.215073437456;5022.171341728574;5357.794496238315;5450.484437537845;5470.288862447856;4279;4614.81577711378;5226.451222621722;5250.711210883285;5260.552853007537 05:06:17 INFO - PROCESS | 1637 | |5;yui.html;791.4815795653849;798.2735710503443;813.6704634622976;813.7802793245824;909.4679612426733;15308.38766449342;18072.27710891566;18083.819161808377;18132.546686332833;18180.454586362415;16602.335906563752;16765.832341676578;16798.32806687731;16807.82345235834;16814;993.538004827755;999.2705325112672;1000.6697789729408;1003.1473247739436;1004.6232662751469;991.6281394477071;992.7567745902264;994.3437331361303;995.2833959549113;995.9352642078242;1038.3717850700332;1075.9408232547207;1082.588616325795;1085.1644233939862;1086.413336798128;1061.936283822973;1074.623881641427;1074.6829685242872;1074.8602681651334;1076.4994277660885;788.562347896917;789.0334340432981;789.6801795272924;790.2018960849526;791.8812178173263;16928.40750573724;17393.304267829273;17468.039257840814;18012.54968625782;18319.54201144969;14479.131252124906;14826.925865370711;14973.326200321011;15022.549323520312;15287.089113860768;11822.822657660143;12100.152989290753;12318.322492262922;12476.563320283747;12806.32726836959;3877.903052423712;3881.4565960765517;3992.8203230854683;4007.1184339445276;4119.546849846514;128033.35983320118;128223;129457.35271323583;129909;129933;10993.230473866912;11103.278286911325;11156.219064665396;11198.328100314007;11244.662660120046;19134.71297930532;21920.561588768454;22396.55206895853;23364.532709345716;23426;7639.350655194259;8350.582470876432;8388.32893368529;8399.748007559661;8544.31645468361;4506.932396014063;4566.337881007235;4664.743439110814;4692.389989301369;4787.0904528139545;3710.888673339804;3814.4469051987307;3816.46569480273;3824.6366595173413;3828.8851334459455;652.8335274504971;660.0561197487639;681.9318068193141;684.8356394465293;697.5361384679131;690.989635155473;730.4120183252533;734.4968696442953;752.5259086775296;759.7075126076501;10272.435016074038;10844.837327440095;10887.67925782644;11003;11392.145589080852;667.8330417395651;668.4677883946848;725.6444342272249;732.1319623219897;762.9280860391159;5152.227165925066;5166.521576918294;5186.377634683862;5205.323307970016;5223.3209682741;81343;103727;105952;107478;107567;56720.71639641775;87110.56444717736;88499;89455.55272223597;92095;81820;81897.18102819014;81940.36119277582;83824.90437738983;84750.15249847423;8425.915740842513;9467.431954082776;10165.390076595428;10305.330153539995;10313.639022634172;52371;52629.21056184084;52759;54360.72819635877;54807;57953.840923180454;59251;65794.67102664456;66506;67304.32695673176;11903.702407439883;11927.761444770882;11979.221350612183;12191.451384687887;12360.938195308965;13190.406431710788;13331.466741330627;13449;13900.16599004063;14405.279736013366;12189.390530473618;12973.545925892926;13083.149595276276;13291.335433228493;13294.468221271041;12238;12499.00007999376;12870.16343937641;12885.871141288468;13218.669533261746;11345.829812552653;12491.063170262449;12492.562760303346;12504.437300321326;12857.292848893401;8285.239312209913;9019.20849806305;9375.437473751597;9666.420014799134;9794.75513112178;9194.586243619187;10603.681889543326;10608.045275925204;10608.363498190134;10609.89390106089 05:06:17 INFO - PROCESS | 1637 | __end_tp_report 05:06:17 INFO - PROCESS | 1637 | __start_cc_report 05:06:17 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1414 05:06:17 INFO - PROCESS | 1637 | __end_cc_report 05:06:17 INFO - PROCESS | 1637 | __startTimestamp1494504377803__endTimestamp 05:06:17 INFO - PROCESS | 1637 | 05:06:17 INFO - PROCESS | 1637 | ------- Summary: start ------- 05:06:17 INFO - PROCESS | 1637 | Number of tests: 6 05:06:17 INFO - PROCESS | 1637 | 05:06:17 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:6102.21 Median:6331.34 stddev:702.89 (11.1%) stddev-sans-first:674.07 05:06:17 INFO - PROCESS | 1637 | Values: 3471.4 3541.1 3548.3 3570.4 3624.9 6163.8 6176.6 6215.2 6232.3 6271.2 6225.3 6269.7 6299.4 6299.8 6307.4 5499.8 5521.7 5556.5 5584.9 5660.6 5419.4 5454.8 5512.3 5524.4 5647.0 5517.1 5520.3 5528.8 5530.4 5546.8 4583.0 5538.6 5540.3 5541.5 5543.9 4530.9 5385.3 5488.3 5497.8 5506.1 6183.7 6185.8 6186.0 6188.6 6202.8 6529.2 6556.8 6565.1 6569.7 6569.8 6661.2 6661.7 6667.9 6675.4 6690.8 6110.6 6134.3 6255.7 6304.4 6344.6 6563.0 6659.1 6700.2 6744.2 6761.2 6454.0 6466.2 6467.0 6499.5 6504.0 6610.3 6617.0 6626.9 6633.0 6637.0 5573.4 6301.6 6452.9 6469.7 6482.5 6578.5 6584.3 6584.8 6589.0 6598.5 5276.0 5317.7 5344.1 5356.3 5364.1 4642.2 4663.4 4665.2 4686.6 4753.6 6306.1 6309.5 6316.7 6329.1 6331.3 6625.9 6640.8 6647.3 6648.0 6650.2 6122.5 6301.7 6321.2 6359.9 6364.3 5729.8 5736.1 5800.1 5865.3 5928.9 6837.5 6871.9 6873.0 6877.3 6877.4 6528.6 6645.5 6663.1 6680.6 6682.2 6545.1 6624.0 6640.7 6799.3 6834.4 6368.6 6374.4 6375.7 6383.9 6390.0 6544.7 6560.8 6596.8 6654.7 6654.9 6460.6 6472.5 6477.4 6480.8 6490.4 5953.8 6298.7 6456.4 6466.8 6485.2 4770.0 6197.6 6243.5 6251.3 6265.9 6451.1 6459.9 6462.2 6470.5 6471.3 6330.3 6331.0 6335.3 6344.1 6349.0 05:06:17 INFO - PROCESS | 1637 | 05:06:17 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:52469.21 Median:3273.71 stddev:100538.29 (3071.1%) stddev-sans-first:100745.41 05:06:17 INFO - PROCESS | 1637 | Values: 775.7 811.5 828.1 895.3 915.5 29206.0 40923.8 41296.8 41398.0 41417.8 34737.7 43480.0 43710.0 43726.8 43754.6 8002.6 9604.4 9751.1 9765.2 9771.0 7932.6 11656.1 11794.6 11799.7 11812.9 11921.0 11944.3 11957.4 11963.3 11975.1 11877.3 11908.5 11921.0 11923.2 11925.3 11556.8 11608.1 11618.2 11621.5 11632.9 40598.6 40838.8 40882.8 40888.4 40934.0 3981.8 4034.4 4051.1 4053.8 4062.7 28429.7 28883.6 29901.3 30640.0 30791.4 3267.9 3279.5 3298.8 3409.7 3426.7 367610.0 371313.0 371831.0 372852.0 373206.0 42431.4 53126.7 53166.5 53233.5 53240.7 54571.0 54592.0 54640.5 54644.0 54722.7 14884.3 15294.8 15314.0 15319.9 15329.4 11995.0 12037.0 13109.4 13121.0 13123.5 9697.7 11600.9 11921.9 11937.2 11943.6 5344.3 5365.1 5368.9 5370.3 5423.1 838.9 966.9 973.7 984.4 994.9 25472.7 27639.9 28551.6 28752.6 29040.0 1073.4 1086.3 1089.9 1100.1 1120.9 14516.3 14702.0 14757.3 14881.2 15007.8 412099.0 412397.0 412683.0 412755.0 413123.0 57645.4 57647.0 57692.1 57750.4 57769.8 1470.8 1489.1 1529.1 1530.4 1532.1 26558.2 26648.7 27613.2 28156.2 28368.0 46879.8 46975.6 47025.3 47035.3 47054.8 353763.0 354489.0 354748.2 357796.0 358867.0 29333.9 29799.6 30856.7 34612.0 34795.3 32396.8 32458.8 32658.2 33709.7 41871.9 25137.7 27702.2 27776.2 29394.6 29491.6 26473.9 28289.4 29263.0 29312.0 29428.6 33186.5 33476.8 34489.0 34514.0 34580.5 20746.0 20908.3 23501.4 28542.7 29508.0 22560.4 23173.2 23208.4 23556.9 23641.4 05:06:17 INFO - PROCESS | 1637 | 05:06:17 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:41001.27 Median:21864.62 stddev:114988.65 (525.9%) stddev-sans-first:115270.81 05:06:17 INFO - PROCESS | 1637 | Values: 397.9 433.4 442.9 447.0 450.1 19694.9 21340.7 21929.7 22103.4 22144.4 22266.3 22285.4 22413.2 22785.5 23535.0 6941.9 7247.6 7253.3 7262.1 7690.5 6633.8 8022.0 8027.1 8028.9 8032.1 7766.0 8000.5 8060.4 8098.8 8144.0 7764.3 7971.0 8013.4 8052.0 8064.5 6799.0 7197.9 7802.5 7805.3 7825.7 24417.9 24799.3 24987.5 26475.3 27094.3 2973.9 3017.7 3024.3 3065.2 3070.7 15438.9 15524.7 16151.9 16168.4 16452.7 2084.8 2103.1 2106.5 2113.8 2125.1 118159.6 119361.4 134186.0 146225.3 151878.0 15250.8 18316.6 20147.7 20498.1 20625.5 32115.0 32256.7 32339.2 32385.5 32399.7 10709.8 10747.6 10818.0 10873.9 11060.8 7793.1 8718.0 9072.7 9078.0 9196.9 9022.0 9227.3 9376.4 9376.5 9393.4 3379.9 3614.6 3987.8 3997.0 4007.6 896.6 982.5 1040.9 1045.5 1054.5 21427.5 21508.7 21629.5 21786.3 21799.6 918.8 1012.0 1033.5 1061.0 1074.9 8222.3 9016.7 11227.4 11375.7 11621.1 682893.0 685037.6 685478.0 691667.2 698443.0 131282.0 155985.2 159625.2 162805.0 163673.0 1250.3 1378.9 1396.9 1432.2 1436.8 19357.0 20448.3 20501.6 20565.9 20625.6 62160.7 62331.4 62965.4 63703.4 64554.7 85162.6 86279.6 86738.0 87589.0 88750.6 9700.4 11299.3 11407.9 11496.5 11833.8 11244.8 12401.7 12981.5 12991.2 13280.9 11161.0 11264.4 11339.1 11463.5 11684.6 10087.2 10120.1 10229.9 10412.9 10585.9 10004.6 10856.0 11313.5 11491.5 11741.9 11178.7 11441.0 11565.3 11570.4 11775.9 11148.6 11406.9 11415.1 11507.9 11604.4 05:06:17 INFO - PROCESS | 1637 | 05:06:17 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:6892.34 Median:2486.63 stddev:4300.88 (173.0%) stddev-sans-first:4293.21 05:06:17 INFO - PROCESS | 1637 | Values: 1409.3 1536.4 1642.1 1657.5 1665.8 9335.2 10622.9 10845.0 11115.3 11119.2 10694.9 10793.4 10794.0 10798.1 10824.7 2430.1 2476.7 2477.1 2477.3 2485.7 2081.6 2151.9 2454.2 2533.6 2539.1 2479.0 2504.6 2510.3 2510.8 2511.6 2455.4 2479.8 2484.1 2487.6 2491.1 2431.9 2445.7 2446.4 2454.4 2459.6 11434.7 11553.7 11562.3 11564.2 11589.1 6034.5 6158.8 6171.0 6176.3 6184.7 3348.5 3543.6 3599.4 3600.2 3606.3 1203.5 1247.8 1252.8 1298.2 1299.2 15663.8 15864.3 15864.6 15878.2 15894.3 4778.4 5083.5 5088.0 5105.3 5138.1 13268.7 13293.3 13309.3 13310.0 13340.3 6166.7 6174.3 6175.2 6180.4 6181.2 4689.7 5437.7 5442.9 5527.8 5532.2 3324.7 3731.7 3867.2 3918.3 3924.0 1092.8 1109.0 1171.2 1192.5 1199.7 941.9 948.9 982.6 993.2 1018.7 6603.0 6632.0 6711.6 6816.6 6875.8 934.6 1069.2 1072.5 1084.4 1088.9 4425.9 4473.8 4518.1 4645.4 4656.8 13266.7 13304.1 13685.9 13735.6 13864.1 13412.2 13892.9 13896.9 13910.1 13928.9 10096.0 10433.8 10443.2 10454.4 10462.7 6867.0 6918.5 7057.4 7101.0 7188.5 12224.5 12419.5 12468.5 12630.3 12641.6 12467.2 12741.2 12912.9 12930.7 13001.5 7468.6 9038.0 9471.1 9481.9 9486.6 10140.6 10151.1 10183.9 10258.8 10275.0 7047.5 7342.3 8705.3 8890.1 8929.6 8567.9 8682.8 8729.0 8733.3 8851.0 8110.8 8164.3 8191.2 8269.5 8286.8 5936.2 5986.9 6155.7 6182.8 6229.0 5967.4 6062.5 6064.2 6113.1 6154.1 05:06:17 INFO - PROCESS | 1637 | 05:06:17 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4482.67 Median:4951.97 stddev:1259.23 (25.4%) stddev-sans-first:1223.67 05:06:17 INFO - PROCESS | 1637 | Values: 334.5 394.7 400.3 402.2 404.7 5038.2 5088.7 5098.6 5104.6 5138.9 5060.8 5094.8 5121.9 5133.4 5156.8 3429.5 3673.5 4052.1 4071.5 4090.4 3294.7 4067.2 4082.6 4109.7 4110.9 4027.8 4049.4 4103.5 4105.5 4135.4 3383.0 3973.9 3987.4 3997.9 4046.9 2960.4 3225.3 3625.7 3640.7 3655.7 4541.9 4763.8 5016.7 5088.0 5092.4 4050.7 4129.8 4603.4 4647.4 4736.9 4730.6 5031.3 5239.7 5473.7 5477.5 3473.9 3924.1 3996.0 4081.7 4091.9 4926.4 5018.7 5148.9 5488.8 5656.8 4151.6 4781.5 4804.5 4809.9 4834.1 4303.5 4514.0 4871.1 4982.3 5055.4 4238.8 4552.6 5087.7 5101.7 5196.9 4965.9 5374.0 5405.8 5419.3 5452.9 1337.7 1485.9 1497.7 1572.3 1582.9 1095.7 1159.9 1161.8 1167.8 1181.8 4471.8 5086.0 5107.6 5119.3 5159.9 4872.7 5341.4 5616.6 5635.6 5711.7 4582.8 4754.4 4769.8 4867.3 5010.3 2533.6 2793.0 2917.1 2937.9 2962.2 4918.6 5721.5 5735.8 5846.0 5889.7 5234.6 5370.9 5416.0 5425.3 5609.4 4511.6 5405.1 5514.5 5651.9 5713.7 4697.0 5385.8 5445.6 5541.7 5547.4 5161.8 5337.9 5438.0 5458.0 5557.9 5049.4 5242.9 5542.4 5784.7 5839.7 4157.4 4290.5 4372.7 4375.9 4412.4 4893.9 5258.5 5290.4 5489.0 5617.4 4938.0 5075.2 5164.0 5194.7 5373.8 4622.3 4828.3 5032.4 5391.9 5422.8 4363.7 5196.0 5247.6 5311.4 5313.7 4617.2 5022.2 5357.8 5450.5 5470.3 4279.0 4614.8 5226.5 5250.7 5260.6 05:06:17 INFO - PROCESS | 1637 | 05:06:17 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:21186.99 Median:22158.56 stddev:31218.18 (140.9%) stddev-sans-first:31268.19 05:06:17 INFO - PROCESS | 1637 | Values: 791.5 798.3 813.7 813.8 909.5 15308.4 18072.3 18083.8 18132.5 18180.5 16602.3 16765.8 16798.3 16807.8 16814.0 993.5 999.3 1000.7 1003.1 1004.6 991.6 992.8 994.3 995.3 995.9 1038.4 1075.9 1082.6 1085.2 1086.4 1061.9 1074.6 1074.7 1074.9 1076.5 788.6 789.0 789.7 790.2 791.9 16928.4 17393.3 17468.0 18012.5 18319.5 14479.1 14826.9 14973.3 15022.5 15287.1 11822.8 12100.2 12318.3 12476.6 12806.3 3877.9 3881.5 3992.8 4007.1 4119.5 128033.4 128223.0 129457.4 129909.0 129933.0 10993.2 11103.3 11156.2 11198.3 11244.7 19134.7 21920.6 22396.6 23364.5 23426.0 7639.4 8350.6 8388.3 8399.7 8544.3 4506.9 4566.3 4664.7 4692.4 4787.1 3710.9 3814.4 3816.5 3824.6 3828.9 652.8 660.1 681.9 684.8 697.5 691.0 730.4 734.5 752.5 759.7 10272.4 10844.8 10887.7 11003.0 11392.1 667.8 668.5 725.6 732.1 762.9 5152.2 5166.5 5186.4 5205.3 5223.3 81343.0 103727.0 105952.0 107478.0 107567.0 56720.7 87110.6 88499.0 89455.6 92095.0 81820.0 81897.2 81940.4 83824.9 84750.2 8425.9 9467.4 10165.4 10305.3 10313.6 52371.0 52629.2 52759.0 54360.7 54807.0 57953.8 59251.0 65794.7 66506.0 67304.3 11903.7 11927.8 11979.2 12191.5 12360.9 13190.4 13331.5 13449.0 13900.2 14405.3 12189.4 12973.5 13083.1 13291.3 13294.5 12238.0 12499.0 12870.2 12885.9 13218.7 11345.8 12491.1 12492.6 12504.4 12857.3 8285.2 9019.2 9375.4 9666.4 9794.8 9194.6 10603.7 10608.0 10608.4 10609.9 05:06:17 INFO - PROCESS | 1637 | -------- Summary: end -------- 05:06:17 INFO - PROCESS | 1637 | 05:06:18 INFO - TEST-INFO | 1637: exit 0 05:06:18 INFO - TEST-OK | dromaeo_css | took 1119121ms 05:06:18 INFO - TEST-START | kraken 05:06:18 INFO - operating with platform_type : mac_ 05:06:18 INFO - Initialising browser for kraken test... 05:06:18 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmphw_tqc/profile http://localhost:49240/getInfo.html) 05:06:20 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 05:06:20 INFO - PROCESS | 1647 | colorDepth:24 05:06:20 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 05:06:20 INFO - PROCESS | 1647 | __metrics 05:06:20 INFO - PROCESS | 1647 | 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" 05:06:20 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:06:21 INFO - TEST-INFO | 1647: exit 0 05:06:21 INFO - Browser initialized. 05:06:21 INFO - Running cycle 1/1 for kraken test... 05:06:21 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/T/tmphw_tqc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:33 INFO - PROCESS | 1649 | RSS: Main: 165089280 05:06:33 INFO - PROCESS | 1649 | 05:06:36 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:36 INFO - PROCESS | 1649 | RSS: Main: 215715840 05:06:36 INFO - PROCESS | 1649 | 05:06:39 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 05:06:40 INFO - PROCESS | 1649 | RSS: Main: 231469056 05:06:40 INFO - PROCESS | 1649 | 05:06:43 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 05:06:43 INFO - PROCESS | 1649 | RSS: Main: 327577600 05:06:43 INFO - PROCESS | 1649 | 05:06:45 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 05:06:46 INFO - PROCESS | 1649 | RSS: Main: 229515264 05:06:46 INFO - PROCESS | 1649 | 05:06:48 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:06:49 INFO - PROCESS | 1649 | RSS: Main: 231952384 05:06:49 INFO - PROCESS | 1649 | 05:06:51 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 05:06:52 INFO - PROCESS | 1649 | RSS: Main: 272060416 05:06:52 INFO - PROCESS | 1649 | 05:06:55 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 05:06:56 INFO - PROCESS | 1649 | RSS: Main: 273776640 05:06:56 INFO - PROCESS | 1649 | 05:06:59 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 05:06:59 INFO - PROCESS | 1649 | RSS: Main: 271024128 05:06:59 INFO - PROCESS | 1649 | 05:07:01 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:07:01 INFO - PROCESS | 1649 | RSS: Main: 247377920 05:07:01 INFO - PROCESS | 1649 | 05:07:03 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:07:04 INFO - PROCESS | 1649 | RSS: Main: 252022784 05:07:04 INFO - PROCESS | 1649 | 05:07:06 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:07:07 INFO - PROCESS | 1649 | RSS: Main: 257859584 05:07:07 INFO - PROCESS | 1649 | 05:07:10 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:07:10 INFO - PROCESS | 1649 | RSS: Main: 272543744 05:07:10 INFO - PROCESS | 1649 | 05:07:13 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:07:14 INFO - PROCESS | 1649 | RSS: Main: 266317824 05:07:14 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 05:07:16 INFO - PROCESS | 1649 | RSS: Main: 310657024 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | __start_tp_report 05:07:16 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 05:07:16 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 05:07:16 INFO - PROCESS | 1649 | |i|pagename|runs| 05:07:16 INFO - PROCESS | 1649 | |0;ai-astar;104;117;114;116;115;115;115;114;115;115 05:07:16 INFO - PROCESS | 1649 | |1;audio-beat-detection;141;108;108;162;140;108;106;105;123;108 05:07:16 INFO - PROCESS | 1649 | |2;audio-dft;184;182;186;184;184;183;180;181;183;183 05:07:16 INFO - PROCESS | 1649 | |3;audio-fft;80;57;60;90;61;59;59;59;74;59 05:07:16 INFO - PROCESS | 1649 | |4;audio-oscillator;91;70;87;69;69;68;81;69;68;82 05:07:16 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;86;87;86;86;87;86;86;86;86;86 05:07:16 INFO - PROCESS | 1649 | |6;imaging-darkroom;93;94;94;93;93;94;93;94;94;94 05:07:16 INFO - PROCESS | 1649 | |7;imaging-desaturate;95;128;128;83;84;83;83;83;84;84 05:07:16 INFO - PROCESS | 1649 | |8;json-parse-financial;62;62;62;59;62;63;63;62;63;65 05:07:16 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;58;70;99;90;86;57;57;56;57;58 05:07:16 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;80;79;81;82;83;81;82;89;98;87 05:07:16 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;137;142;132;133;132;141;146;137;180;146 05:07:16 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;158;175;215;203;159;161;161;160;160;186 05:07:16 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;65;64;65;62;65;63;64;62;60;62 05:07:16 INFO - PROCESS | 1649 | __end_tp_report 05:07:16 INFO - PROCESS | 1649 | __start_cc_report 05:07:16 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2003 05:07:16 INFO - PROCESS | 1649 | __end_cc_report 05:07:16 INFO - PROCESS | 1649 | __startTimestamp1494504436295__endTimestamp 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | ------- Summary: start ------- 05:07:16 INFO - PROCESS | 1649 | Number of tests: 14 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:3.62 (3.1%) stddev-sans-first:0.93 05:07:16 INFO - PROCESS | 1649 | Values: 104.0 117.0 114.0 116.0 115.0 115.0 115.0 114.0 115.0 115.0 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:120.90 Median:115.50 stddev:20.01 (17.3%) stddev-sans-first:19.86 05:07:16 INFO - PROCESS | 1649 | Values: 141.0 108.0 108.0 162.0 140.0 108.0 106.0 105.0 123.0 108.0 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.50 stddev:1.70 (0.9%) stddev-sans-first:1.76 05:07:16 INFO - PROCESS | 1649 | Values: 184.0 182.0 186.0 184.0 184.0 183.0 180.0 181.0 183.0 183.0 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:65.80 Median:60.50 stddev:11.42 (18.9%) stddev-sans-first:10.89 05:07:16 INFO - PROCESS | 1649 | Values: 80.0 57.0 60.0 90.0 61.0 59.0 59.0 59.0 74.0 59.0 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:75.50 stddev:8.91 (11.8%) stddev-sans-first:7.45 05:07:16 INFO - PROCESS | 1649 | Values: 91.0 70.0 87.0 69.0 69.0 68.0 81.0 69.0 68.0 82.0 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:86.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 05:07:16 INFO - PROCESS | 1649 | Values: 86.0 87.0 86.0 86.0 87.0 86.0 86.0 86.0 86.0 86.0 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 05:07:16 INFO - PROCESS | 1649 | Values: 93.0 94.0 94.0 93.0 93.0 94.0 93.0 94.0 94.0 94.0 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:83.50 stddev:18.54 (22.2%) stddev-sans-first:19.66 05:07:16 INFO - PROCESS | 1649 | Values: 95.0 128.0 128.0 83.0 84.0 83.0 83.0 83.0 84.0 84.0 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:62.30 Median:62.50 stddev:1.49 (2.4%) stddev-sans-first:1.58 05:07:16 INFO - PROCESS | 1649 | Values: 62.0 62.0 62.0 59.0 62.0 63.0 63.0 62.0 63.0 65.0 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:64.00 stddev:16.58 (25.9%) stddev-sans-first:17.12 05:07:16 INFO - PROCESS | 1649 | Values: 58.0 70.0 99.0 90.0 86.0 57.0 57.0 56.0 57.0 58.0 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:82.50 stddev:5.75 (7.0%) stddev-sans-first:5.89 05:07:16 INFO - PROCESS | 1649 | Values: 80.0 79.0 81.0 82.0 83.0 81.0 82.0 89.0 98.0 87.0 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:141.50 stddev:14.16 (10.0%) stddev-sans-first:14.87 05:07:16 INFO - PROCESS | 1649 | Values: 137.0 142.0 132.0 133.0 132.0 141.0 146.0 137.0 180.0 146.0 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:168.00 stddev:20.76 (12.4%) stddev-sans-first:21.21 05:07:16 INFO - PROCESS | 1649 | Values: 158.0 175.0 215.0 203.0 159.0 161.0 161.0 160.0 160.0 186.0 05:07:16 INFO - PROCESS | 1649 | 05:07:16 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:64.00 stddev:1.69 (2.6%) stddev-sans-first:1.66 05:07:16 INFO - PROCESS | 1649 | Values: 65.0 64.0 65.0 62.0 65.0 63.0 64.0 62.0 60.0 62.0 05:07:16 INFO - PROCESS | 1649 | -------- Summary: end -------- 05:07:16 INFO - PROCESS | 1649 | 05:07:17 INFO - TEST-INFO | 1649: exit 0 05:07:17 INFO - TEST-OK | kraken | took 58697ms 05:07:17 INFO - SUITE-END | took 1177s 05:07:17 INFO - Completed test suite (00:19:38) 05:07:17 INFO - javascript benchmark 05:07:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7819.574266852901, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3471.409860323745, 3541.0970202598332, 3548.3435564420583, 3570.428731402976, 3624.930645459589, 6163.845903852406, 6176.598521096125, 6215.223097112861, 6232.252129744431, 6271.1847459830215, 6225.2529696436495, 6269.686515674221, 6299.433051025407, 6299.77950771723, 6307.3692630736905, 5499.780008799643, 5521.668699878021, 5556.527695145917, 5584.944150558504, 5660.60375773696, 5419.376771671269, 5454.836354909359, 5512.33851937768, 5524.392316845144, 5646.971765141189, 5517.089680202782, 5520.254765606652, 5528.834134975958, 5530.391656917735, 5546.833594992157, 4583.0, 5538.556915446755, 5540.279763630742, 5541.501264886179, 5543.944560554383, 4530.932036019462, 5385.3268341457315, 5488.259085023511, 5497.780088796443, 5506.119020956668, 6183.690815459254, 6185.783497577563, 6186.0, 6188.628682279078, 6202.81391558254, 6529.151210342672, 6556.770513032021, 6565.113709649184, 6569.67151642416, 6569.770058047993, 6661.233958094833, 6661.733530658767, 6667.899981500282, 6675.432588230006, 6690.83272918176, 6110.619513019656, 6134.283518479682, 6255.655938923357, 6304.369563043705, 6344.619322840645, 6562.967185164043, 6659.134312539339, 6700.162479690039, 6744.156980377453, 6761.188657361148, 6453.967730161413, 6466.159399278158, 6466.967665161644, 6499.545031847725, 6503.967480162569, 6610.272869984298, 6617.007448882609, 6626.86746265072, 6633.0, 6637.037629543785, 5573.442655734394, 6301.590396624297, 6452.870942581122, 6469.708863101172, 6482.546221764431, 6578.506612004119, 6584.308647591934, 6584.76953306632, 6588.96705516479, 6598.505112116611, 5275.973620131875, 5317.654352467077, 5344.118220493653, 5356.330458692663, 5364.114921037985, 4642.210824159901, 4663.370444989951, 4665.206914824488, 4686.554777296152, 4753.643476739258, 6306.054091886253, 6309.526785491014, 6316.715747791361, 6329.113924050636, 6331.3352098029045, 6625.933740662628, 6640.833979150463, 6647.268800431949, 6647.966760166265, 6650.201975762842, 6122.520135281246, 6301.7164227609865, 6321.1782468278825, 6359.936400635935, 6364.331745166784, 5729.828105156852, 5736.13957906309, 5800.100984347433, 5865.325487568899, 5928.851778705481, 6837.487188460886, 6871.931280687129, 6873.037774711444, 6877.312268773083, 6877.449804015567, 6528.575642583217, 6645.468362530889, 6663.100481434944, 6680.5991640501725, 6682.164729408824, 6545.116409284686, 6624.0, 6640.701168447528, 6799.252082271045, 6834.419074378733, 6368.554201205871, 6374.394432528902, 6375.74497020114, 6383.872322553616, 6389.9680501597195, 6544.705488253136, 6560.803175904731, 6596.8350791230605, 6654.700538475877, 6654.933450665431, 6460.580062295936, 6472.5145614080075, 6477.4170324671, 6480.773172938924, 6490.448311893542, 5953.821385358447, 6298.708764703133, 6456.38664326907, 6466.773662921775, 6485.156929599122, 4770.0, 6197.628142311476, 6243.469305108935, 6251.3123556407845, 6265.874682506415, 6451.1290975717675, 6459.935400645933, 6462.192225971754, 6470.547061705635, 6471.25580558223, 6330.303666596763, 6331.018692102732, 6335.2714437838395, 6344.1118243445035, 6348.968255158695], "value": 6056.616603500969, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.7284950267403, 811.500926929938, 828.1345993436857, 895.3061377432493, 915.4873270968254, 29206.0, 40923.79538102309, 41296.793516032456, 41398.0, 41417.79291103544, 34737.65262347376, 43480.0, 43710.0, 43726.78136609321, 43754.562454375446, 8002.639881205359, 9604.423734575912, 9751.073648003428, 9765.169960553361, 9770.951145244264, 7932.603369831514, 11656.125790565698, 11794.646160615152, 11799.705007374798, 11812.881871181307, 11921.0, 11944.343061131634, 11957.402129893513, 11963.342016189106, 11975.101867359983, 11877.28736275822, 11908.523659053628, 11920.986716129139, 11923.224990375598, 11925.344106074206, 11556.768864622745, 11608.071354291636, 11618.244814087057, 11621.535138594447, 11632.941835290769, 40598.594014059774, 40838.774836754645, 40882.77351679454, 40888.36446542135, 40934.0, 3981.840726370942, 4034.435179074932, 4051.1290072634524, 4053.837846486137, 4062.6749860011128, 28429.715702842914, 28883.56674649882, 29901.252468688457, 30640.0, 30791.38417231643, 3267.8856240031723, 3279.540864279003, 3298.835058247102, 3409.6760807723226, 3426.7258619310396, 367610.0, 371313.0, 371831.0, 372852.0, 373206.0, 42431.36352954708, 53126.734366327924, 53166.46833531615, 53233.467665323624, 53240.733796331544, 54571.0, 54592.0, 54640.45359546433, 54644.0, 54722.72638636861, 14884.255787210595, 15294.770578441332, 15314.0, 15319.923400382926, 15329.386824526893, 11994.980426663657, 12037.037037037016, 13109.41007654658, 13121.0, 13123.54067607629, 9697.6605818796, 11600.88399115998, 11921.86742259484, 11937.164398492023, 11943.641690749291, 5344.327836081959, 5365.1147560652835, 5368.91946620801, 5370.31484257871, 5423.078076726966, 838.8657814749732, 966.9323147379616, 973.6592192732487, 984.3995162950595, 994.8905620381752, 25472.745272547407, 27639.86180069087, 28551.57172642412, 28752.568711469346, 29040.0, 1073.4257172412879, 1086.3047649504324, 1089.8910108989196, 1100.114407901647, 1120.8654961404684, 14516.346764395628, 14702.044367116103, 14757.335919883417, 14881.181535015461, 15007.849921500645, 412099.0, 412397.0, 412683.0, 412755.0, 413123.0, 57645.423545764, 57647.0, 57692.134617980766, 57750.42249577535, 57769.84460310854, 1470.8235011798652, 1489.0693316677077, 1529.0978322789608, 1530.3572499550216, 1532.1343440955825, 26558.203253902415, 26648.7335126654, 27613.171604851887, 28156.155315340573, 28368.0, 46879.76560117178, 46975.590732278084, 47025.2946205814, 47035.29447058228, 47054.76472617615, 353763.0, 354489.0, 354748.2262588671, 357796.0, 358867.0, 29333.85333073321, 29799.55300670535, 30856.691433085383, 34612.0, 34795.304093917475, 32396.83801580977, 32458.837705812264, 32658.183545411553, 33709.66290337163, 41871.90640468025, 25137.74862251354, 27702.168934931986, 27776.16671499858, 29394.559081613366, 29491.557626636048, 26473.867630661724, 28289.434211315245, 29263.0, 29311.974080907064, 29428.558571621015, 33186.5022024665, 33476.83261583676, 34489.0, 34513.96458106261, 34580.481292780125, 20746.0, 20908.327333812955, 23501.41246468852, 28542.714572854005, 29507.967221147155, 22560.435989100402, 23173.188938387077, 23208.4197895054, 23556.9399377025, 23641.40896477602], "value": 18666.755463431215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.9383006139619, 433.39974135821876, 442.9379886815846, 446.9731816091035, 450.08632476073564, 19694.90152549237, 21340.679889801646, 21929.671054934188, 22103.44741381466, 22144.446388840286, 22266.332010039725, 22285.44286392837, 22413.21553745619, 22785.54428911425, 23535.0, 6941.861162776741, 7247.565146091225, 7253.274672532757, 7262.055932728738, 7690.461667683265, 6633.767818126366, 8022.0, 8027.076886158079, 8028.879566806502, 8032.076311224226, 7766.0, 8000.4799688020385, 8060.3954703397185, 8098.838023239561, 8144.0, 7764.30121289081, 7971.043474783063, 8013.398995075364, 8051.959740201261, 8064.475809072421, 6798.966005169992, 7197.856042879165, 7802.492837965571, 7805.336546393563, 7825.726099586487, 24417.877910610332, 24799.256022319358, 24987.50024999508, 26475.33811654705, 27094.32264193391, 2973.895913643012, 3017.6571425715565, 3024.3195281061585, 3065.172403451078, 3070.6929307069336, 15438.911768376389, 15524.689506209812, 16151.91924040384, 16168.434104806276, 16452.670946581, 2084.781097984705, 2103.116690989788, 2106.5260316428835, 2113.820325272354, 2125.0543508138885, 118159.63680726338, 119361.40319298347, 134186.0, 146225.26887365602, 151878.0, 15250.847491525165, 18316.63366732658, 20147.697784533244, 20498.077586508643, 20625.48436289105, 32115.0, 32256.709731610943, 32339.191520211712, 32385.51421728676, 32399.676003240136, 10709.839352409721, 10747.623833165802, 10818.0, 10873.891261087447, 11060.834087488694, 7793.142754297136, 8718.0, 9072.727818165466, 9078.0, 9196.908030919605, 9022.0, 9227.3079519035, 9376.390534615228, 9376.5311734413, 9393.436393816393, 3379.9493007604906, 3614.644508309384, 3987.8404863805704, 3996.9600303997167, 4007.599240075969, 896.6323807239131, 982.5234761140841, 1040.9167266618651, 1045.4511381524608, 1054.509653011338, 21427.46431339229, 21508.677369839465, 21629.459263518536, 21786.257099432325, 21799.564008719735, 918.8300164469595, 1012.00823193271, 1033.5297439664935, 1060.9628662996759, 1074.8763892152347, 8222.259996600334, 9016.684416045407, 11227.382493962747, 11375.715607109889, 11621.07031437483, 682893.0, 685037.5748121327, 685478.0, 691667.2499825014, 698443.0, 131282.0, 155985.22007390118, 159625.2018739899, 162805.0, 163673.0, 1250.2685928731612, 1378.9379477923317, 1396.8812650924785, 1432.2194404049817, 1436.8203974503188, 19357.0, 20448.284310049075, 20501.58996820085, 20565.89717051405, 20625.58748824985, 62160.68919655373, 62331.37668623437, 62965.37034629779, 63703.3629663716, 64554.67722661357, 85162.57418713115, 86279.56860215659, 86738.0, 87589.0, 88750.55624721835, 9700.369475984038, 11299.265547739371, 11407.942960285478, 11496.54013839437, 11833.82249266279, 11244.831327530257, 12401.697821728589, 12981.480740770263, 12991.155574887602, 13280.937524997784, 11161.0, 11264.436778161224, 11339.092872570009, 11463.484143213409, 11684.591039313924, 10087.193024557871, 10120.139788117798, 10229.948850255701, 10412.947935260276, 10585.89414105849, 10004.649837255953, 10855.968682975104, 11313.490892909675, 11491.48288327044, 11741.941290293495, 11178.708364785361, 11441.0, 11565.306081635128, 11570.363630000431, 11775.941120294343, 11148.609798657008, 11406.885931140583, 11415.086793056702, 11507.884921150682, 11604.361760103275], "value": 11780.884224545809, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.2671810658464, 1536.4238410596026, 1642.096846734296, 1657.4613250693524, 1665.8417450342222, 9335.206507446866, 10622.893771062287, 10845.0, 11115.333080015205, 11119.1660625453, 10694.946525267364, 10793.352398856074, 10793.974572415627, 10798.136149108072, 10824.67525974222, 2430.100862680806, 2476.6532685424054, 2477.1082410332265, 2477.2815883393796, 2485.652008718781, 2081.573277478121, 2151.8708877467325, 2454.214651311581, 2533.5692932201478, 2539.149384956033, 2478.9752102478924, 2504.6368276599974, 2510.2845688978646, 2510.8242423030397, 2511.61070034145, 2455.4229756007326, 2479.764422379871, 2484.0560586977012, 2487.614419764939, 2491.140556508011, 2431.9270421887372, 2445.6942882139733, 2446.449548851494, 2454.361865914857, 2459.594166962449, 11434.714132146679, 11553.653390398302, 11562.30626162433, 11564.248323858923, 11589.130815188895, 6034.487068599175, 6158.8152355428965, 6171.012637977902, 6176.320604733476, 6184.659843708594, 3348.5312056312137, 3543.6102028776813, 3599.3521166190076, 3600.207954250061, 3606.2787442511603, 1203.5125774061432, 1247.8440194975628, 1252.843394575678, 1298.2210673595862, 1299.1750238598559, 15663.843361566353, 15864.286107125206, 15864.60338491547, 15878.206089695468, 15894.28475718607, 4778.37881075458, 5083.517065878736, 5087.97456012725, 5105.310783044316, 5138.07514647367, 13268.668283292995, 13293.268870212038, 13309.334533273297, 13310.0, 13340.266285354399, 6166.691665416712, 6174.320824709278, 6175.228096487939, 6180.381961803783, 6181.196444462191, 4689.742064186435, 5437.700926449004, 5442.863928401822, 5527.751251193706, 5532.197831314437, 3324.6841550052704, 3731.7201209909367, 3867.207222519377, 3918.275119102975, 3924.0, 1092.8306112552566, 1108.9889101109047, 1171.1977295552574, 1192.4991503568522, 1199.7060720123452, 941.8963913969458, 948.8624149498285, 982.6069572171045, 993.2203220471895, 1018.7198520406947, 6603.0, 6632.043547153601, 6711.63086030273, 6816.591004539743, 6875.759348422881, 934.5887809363858, 1069.1820757120654, 1072.5066469423996, 1084.430673896195, 1088.8747794003632, 4425.867223983286, 4473.776311184428, 4518.073794872109, 4645.372874661945, 4656.767161641905, 13266.734665306833, 13304.13523120994, 13685.863141368658, 13735.587932362045, 13864.098833575785, 13412.195268283935, 13892.861071389158, 13896.861031389759, 13910.095843770123, 13928.930355348159, 10096.040876116756, 10433.843492347622, 10443.164546836235, 10454.425006624557, 10462.68611941643, 6867.0, 6918.515703900679, 7057.364837164474, 7101.0, 7188.460865435218, 12224.511019559119, 12419.503219871465, 12468.5012599495, 12630.305333206761, 12641.620751377106, 12467.189632673848, 12741.17182383142, 12912.935435322763, 12930.741385172432, 13001.479940802263, 7468.626568671436, 9037.954810225907, 9471.147596716328, 9481.857772133562, 9486.573104210465, 10140.594376224868, 10151.086402223835, 10183.949080254552, 10258.846117308098, 10275.0, 7047.506674532939, 7342.265773422615, 8705.260052895575, 8890.110988901059, 8929.642814287356, 8567.914320856711, 8682.826343472969, 8728.956355218183, 8733.257673097858, 8850.955745221232, 8110.837783244184, 8164.346852251924, 8191.180881911761, 8269.4624849387, 8286.792830179294, 5936.22829032223, 5986.9401305986385, 6155.6614386209185, 6182.783602573888, 6229.034499652561, 5967.373425790403, 6062.454379105901, 6064.211652485149, 6113.083037544404, 6154.076888466766], "value": 5280.95031211367, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.50994293360225, 394.66256350820044, 400.3074680802212, 402.2116651363328, 404.70658772390004, 5038.178619972813, 5088.745562721868, 5098.566621837139, 5104.617153713472, 5138.871528211796, 5060.822871199509, 5094.847154585359, 5121.923171152435, 5133.435322114565, 5156.793728250875, 3429.4684323929705, 3673.485712000329, 4052.1085361220485, 4071.4503542021894, 4090.425186303265, 3294.670532946698, 4067.2068946555432, 4082.5713300103507, 4109.6506796922295, 4110.938335924963, 4027.8388864445387, 4049.3723472861607, 4103.466549348581, 4105.527864295615, 4135.421041054255, 3383.0189245118886, 3973.9403908941244, 3987.441758153861, 3997.860074897379, 4046.9275641954905, 2960.3635218427926, 3225.3226822367333, 3625.7280703947044, 3640.672339489459, 3655.738770124303, 4541.931871021938, 4763.78562964664, 5016.724080175589, 5088.0, 5092.388913330387, 4050.675945924319, 4129.834806607732, 4603.424571928509, 4647.3958385410015, 4736.881577960544, 4730.59789917854, 5031.345925029759, 5239.685618862881, 5473.67157970519, 5477.452254774531, 3473.9131521711906, 3924.135381171732, 3996.0009997500624, 4081.69387295954, 4091.85678501251, 4926.433460152092, 5018.655351525335, 5148.897022059537, 5488.81990372072, 5656.830295091154, 4151.584841515824, 4781.521847815191, 4804.543568361, 4809.927851082237, 4834.129856625841, 4303.548127446636, 4514.0, 4871.124617022401, 4982.277569752366, 5055.393352797688, 4238.788060596958, 4552.635789136861, 5087.669301495391, 5101.704233095122, 5196.92204616931, 4965.90068198634, 5374.0, 5405.8107966221, 5419.268398766195, 5452.890942181134, 1337.6923307639297, 1485.9405623775144, 1497.7304085264757, 1572.316042521507, 1582.889197756146, 1095.7041598768446, 1159.9420028998686, 1161.7502237019082, 1167.8073117935446, 1181.8286348479594, 4471.754053527087, 5085.974570127126, 5107.591392688576, 5119.257707632372, 5159.871003224949, 4872.6832755870755, 5341.439148889311, 5616.550675945915, 5635.590467766942, 5711.6858572778065, 4582.816687332536, 4754.381930349033, 4769.833055843029, 4867.269909513601, 5010.271456347555, 2533.645289659449, 2792.9581056284173, 2917.0665387076356, 2937.897173598914, 2962.2298202467514, 4918.5573298403315, 5721.5136713379825, 5735.812856614694, 5845.9707701462075, 5889.734961926723, 5234.581233501311, 5370.91943620846, 5416.0, 5425.26758887553, 5609.354924183689, 4511.616512596466, 5405.108157154104, 5514.503694667499, 5651.943480565224, 5713.714314284269, 4696.976515117539, 5385.784568617211, 5445.564354851682, 5541.695206763506, 5547.446714919829, 5161.793528258978, 5337.893242135058, 5438.0, 5458.0, 5557.916631250615, 5049.419316778617, 5242.9475705243985, 5542.3903370630005, 5784.7107644618445, 5839.7372118255635, 4157.355609880473, 4290.4636920384955, 4372.6939114261695, 4375.868723938287, 4412.448443944507, 4893.877653058702, 5258.474152584711, 5290.418054013979, 5488.9725551371985, 5617.354004289559, 4938.037082768826, 5075.213341932006, 5164.018836421068, 5194.714290713896, 5373.7850485980125, 4622.329762184397, 4828.2998965150555, 5032.370953630796, 5391.86520336979, 5422.783088676409, 4363.672724545735, 5196.0, 5247.583152548867, 5311.41574426805, 5313.698143954756, 4617.215073437456, 5022.171341728574, 5357.794496238315, 5450.484437537845, 5470.288862447856, 4279.0, 4614.81577711378, 5226.451222621722, 5250.711210883285, 5260.552853007537], "value": 4122.195173448567, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.4815795653849, 798.2735710503443, 813.6704634622976, 813.7802793245824, 909.4679612426733, 15308.38766449342, 18072.27710891566, 18083.819161808377, 18132.546686332833, 18180.454586362415, 16602.335906563752, 16765.832341676578, 16798.32806687731, 16807.82345235834, 16814.0, 993.538004827755, 999.2705325112672, 1000.6697789729408, 1003.1473247739436, 1004.6232662751469, 991.6281394477071, 992.7567745902264, 994.3437331361303, 995.2833959549113, 995.9352642078242, 1038.3717850700332, 1075.9408232547207, 1082.588616325795, 1085.1644233939862, 1086.413336798128, 1061.936283822973, 1074.623881641427, 1074.6829685242872, 1074.8602681651334, 1076.4994277660885, 788.562347896917, 789.0334340432981, 789.6801795272924, 790.2018960849526, 791.8812178173263, 16928.40750573724, 17393.304267829273, 17468.039257840814, 18012.54968625782, 18319.54201144969, 14479.131252124906, 14826.925865370711, 14973.326200321011, 15022.549323520312, 15287.089113860768, 11822.822657660143, 12100.152989290753, 12318.322492262922, 12476.563320283747, 12806.32726836959, 3877.903052423712, 3881.4565960765517, 3992.8203230854683, 4007.1184339445276, 4119.546849846514, 128033.35983320118, 128223.0, 129457.35271323583, 129909.0, 129933.0, 10993.230473866912, 11103.278286911325, 11156.219064665396, 11198.328100314007, 11244.662660120046, 19134.71297930532, 21920.561588768454, 22396.55206895853, 23364.532709345716, 23426.0, 7639.350655194259, 8350.582470876432, 8388.32893368529, 8399.748007559661, 8544.31645468361, 4506.932396014063, 4566.337881007235, 4664.743439110814, 4692.389989301369, 4787.0904528139545, 3710.888673339804, 3814.4469051987307, 3816.46569480273, 3824.6366595173413, 3828.8851334459455, 652.8335274504971, 660.0561197487639, 681.9318068193141, 684.8356394465293, 697.5361384679131, 690.989635155473, 730.4120183252533, 734.4968696442953, 752.5259086775296, 759.7075126076501, 10272.435016074038, 10844.837327440095, 10887.67925782644, 11003.0, 11392.145589080852, 667.8330417395651, 668.4677883946848, 725.6444342272249, 732.1319623219897, 762.9280860391159, 5152.227165925066, 5166.521576918294, 5186.377634683862, 5205.323307970016, 5223.3209682741, 81343.0, 103727.0, 105952.0, 107478.0, 107567.0, 56720.71639641775, 87110.56444717736, 88499.0, 89455.55272223597, 92095.0, 81820.0, 81897.18102819014, 81940.36119277582, 83824.90437738983, 84750.15249847423, 8425.915740842513, 9467.431954082776, 10165.390076595428, 10305.330153539995, 10313.639022634172, 52371.0, 52629.21056184084, 52759.0, 54360.72819635877, 54807.0, 57953.840923180454, 59251.0, 65794.67102664456, 66506.0, 67304.32695673176, 11903.702407439883, 11927.761444770882, 11979.221350612183, 12191.451384687887, 12360.938195308965, 13190.406431710788, 13331.466741330627, 13449.0, 13900.16599004063, 14405.279736013366, 12189.390530473618, 12973.545925892926, 13083.149595276276, 13291.335433228493, 13294.468221271041, 12238.0, 12499.00007999376, 12870.16343937641, 12885.871141288468, 13218.669533261746, 11345.829812552653, 12491.063170262449, 12492.562760303346, 12504.437300321326, 12857.292848893401, 8285.239312209913, 9019.20849806305, 9375.437473751597, 9666.420014799134, 9794.75513112178, 9194.586243619187, 10603.681889543326, 10608.045275925204, 10608.363498190134, 10609.89390106089], "value": 7883.87888142133, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 114.0, 116.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 108.0, 162.0, 140.0, 108.0, 106.0, 105.0, 123.0, 108.0], "value": 120.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 186.0, 184.0, 184.0, 183.0, 180.0, 181.0, 183.0, 183.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 60.0, 90.0, 61.0, 59.0, 59.0, 59.0, 74.0, 59.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 87.0, 69.0, 69.0, 68.0, 81.0, 69.0, 68.0, 82.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 86.0, 86.0, 87.0, 86.0, 86.0, 86.0, 86.0, 86.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 93.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 128.0, 128.0, 83.0, 84.0, 83.0, 83.0, 83.0, 84.0, 84.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 59.0, 62.0, 63.0, 63.0, 62.0, 63.0, 65.0], "value": 62.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 70.0, 99.0, 90.0, 86.0, 57.0, 57.0, 56.0, 57.0, 58.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 81.0, 82.0, 83.0, 81.0, 82.0, 89.0, 98.0, 87.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 142.0, 132.0, 133.0, 132.0, 141.0, 146.0, 137.0, 180.0, 146.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 175.0, 215.0, 203.0, 159.0, 161.0, 161.0, 160.0, 160.0, 186.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 62.0, 65.0, 63.0, 64.0, 62.0, 60.0, 62.0], "value": 63.2, "unit": "score"}]}]} 05:07:17 INFO - Return code: 0 05:07:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:07:17 INFO - # TBPL SUCCESS # 05:07:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:07:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:07:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:07:17 INFO - 2017-05-11 05:07:17.616 screenresolution[1653:9789] starting screenresolution argv=screenresolution get 05:07:17 INFO - 2017-05-11 05:07:17.618 screenresolution[1653:9789] Display 0: 1600x1200x32@60 05:07:17 INFO - 2017-05-11 05:07:17.624 screenresolution[1654:9792] starting screenresolution argv=screenresolution list 05:07:17 INFO - Available Modes on Display 0 05:07:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:07:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:07:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:07:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:07:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:07:17 INFO - Intel Iris: 05:07:17 INFO - Chipset Model: Intel Iris 05:07:17 INFO - Type: GPU 05:07:17 INFO - Bus: Built-In 05:07:17 INFO - VRAM (Dynamic, Max): 1536 MB 05:07:17 INFO - Vendor: Intel (0x8086) 05:07:17 INFO - Device ID: 0x0a2e 05:07:17 INFO - Revision ID: 0x0009 05:07:17 INFO - Displays: 05:07:17 INFO - Display: 05:07:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:07:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:07:17 INFO - Display Serial Number: 1600x1200 60 05:07:17 INFO - Main Display: Yes 05:07:17 INFO - Mirror: Off 05:07:17 INFO - Online: Yes 05:07:17 INFO - Rotation: Supported 05:07:17 INFO - Return code: 0 05:07:17 INFO - Running post-action listener: _resource_record_post_action 05:07:17 INFO - [mozharness: 2017-05-11 12:07:17.860656Z] Finished run-tests step (success) 05:07:17 INFO - Running post-run listener: _resource_record_post_run 05:07:17 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 39801856; Write bytes: 425137152; Read time: 386; Write time: 1551 05:07:17 INFO - TinderboxPrint: CPU usage
53.8% 05:07:17 INFO - TinderboxPrint: I/O read bytes / time
39,801,856 / 386 05:07:17 INFO - TinderboxPrint: I/O write bytes / time
425,137,152 / 1,551 05:07:17 INFO - TinderboxPrint: CPU idle
2,203.3 (46.2%) 05:07:17 INFO - TinderboxPrint: CPU system
951.9 (19.9%) 05:07:17 INFO - TinderboxPrint: CPU user
1,618.5 (33.9%) 05:07:17 INFO - TinderboxPrint: Swap in / out
161,726,464 / 0 05:07:17 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 110731776; Write bytes: 106551296; Read time: 9933; Write time: 274 05:07:17 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 38839296; Write bytes: 298748928; Read time: 372; Write time: 1220 05:07:18 INFO - Running post-run listener: _upload_blobber_files 05:07:18 INFO - Blob upload gear active. 05:07:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07:18 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 05:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:07:18 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:07:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:07:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:20 INFO - (blobuploader) - INFO - Done attempting. 05:07:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:07:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:07:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:21 INFO - (blobuploader) - INFO - Done attempting. 05:07:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:07:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:07:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:22 INFO - (blobuploader) - INFO - Done attempting. 05:07:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:07:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:07:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:24 INFO - (blobuploader) - INFO - Done attempting. 05:07:24 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:24 INFO - Return code: 0 05:07:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d1b0571709ab83bd46fef26667a26e17f9fd332337f8726d35d334a787901082f4b62d86747677884ffe809a360fc2b4998d38f240a502ef3298ac12548279f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96add850c38256b11268c261f1aa808f57024184134f3305fc694dadde59ef91e96728d0197bb30b4222c55a92790f348f382f9bd148c0c4f45e30081d268c27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3da6fa4e0251d3757ccde6a51ce6ab0735f32f6d3227bb93eb11fda79b4db06eab201bc882e61876a812f4fbcb23084c52d2f9b58dc49874e6e6510a259908a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96067d552e5f7492fc3930655f70cd54c944d6239285469cf11c9bfebdf65ea379078f2b0d9db0ef2bbaeba0406243260b3722f2a59a28557f22516cf65a7ed4"} 05:07:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:24 INFO - Contents: 05:07:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d1b0571709ab83bd46fef26667a26e17f9fd332337f8726d35d334a787901082f4b62d86747677884ffe809a360fc2b4998d38f240a502ef3298ac12548279f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96add850c38256b11268c261f1aa808f57024184134f3305fc694dadde59ef91e96728d0197bb30b4222c55a92790f348f382f9bd148c0c4f45e30081d268c27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3da6fa4e0251d3757ccde6a51ce6ab0735f32f6d3227bb93eb11fda79b4db06eab201bc882e61876a812f4fbcb23084c52d2f9b58dc49874e6e6510a259908a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96067d552e5f7492fc3930655f70cd54c944d6239285469cf11c9bfebdf65ea379078f2b0d9db0ef2bbaeba0406243260b3722f2a59a28557f22516cf65a7ed4"} 05:07:24 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:24 INFO - Copying logs to upload dir... 05:07:24 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.989655 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-05-11 05:07:24.361186) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 05:07:24.364464) ========= 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.H5MKKn11EB/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.BtslZ3Koxi/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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-Beta/sha512/6d1b0571709ab83bd46fef26667a26e17f9fd332337f8726d35d334a787901082f4b62d86747677884ffe809a360fc2b4998d38f240a502ef3298ac12548279f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96add850c38256b11268c261f1aa808f57024184134f3305fc694dadde59ef91e96728d0197bb30b4222c55a92790f348f382f9bd148c0c4f45e30081d268c27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3da6fa4e0251d3757ccde6a51ce6ab0735f32f6d3227bb93eb11fda79b4db06eab201bc882e61876a812f4fbcb23084c52d2f9b58dc49874e6e6510a259908a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96067d552e5f7492fc3930655f70cd54c944d6239285469cf11c9bfebdf65ea379078f2b0d9db0ef2bbaeba0406243260b3722f2a59a28557f22516cf65a7ed4"} build_url:https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/ejew3sQaSVGw7cMK1C0LDw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d1b0571709ab83bd46fef26667a26e17f9fd332337f8726d35d334a787901082f4b62d86747677884ffe809a360fc2b4998d38f240a502ef3298ac12548279f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96add850c38256b11268c261f1aa808f57024184134f3305fc694dadde59ef91e96728d0197bb30b4222c55a92790f348f382f9bd148c0c4f45e30081d268c27", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3da6fa4e0251d3757ccde6a51ce6ab0735f32f6d3227bb93eb11fda79b4db06eab201bc882e61876a812f4fbcb23084c52d2f9b58dc49874e6e6510a259908a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96067d552e5f7492fc3930655f70cd54c944d6239285469cf11c9bfebdf65ea379078f2b0d9db0ef2bbaeba0406243260b3722f2a59a28557f22516cf65a7ed4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 05:07:24.399248) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 05:07:24.399582) ========= 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.H5MKKn11EB/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.BtslZ3Koxi/Listeners TMPDIR=/var/folders/29/m_1c7lhj4kb13s_f9szps0wr00000w/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.005118 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 05:07:24.448008) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 05:07:24.448324) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 05:07:24.448701) ========= ========= Total master_lag: 0.18 =========