builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0145 starttime: 1479135104.01 results: success (0) buildid: 20161114021920 builduid: 34a00fa3aee34299865356c4ee83715c revision: 2d9b6132e7d75327e063a15d8e5e279077adf987 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:44.010793) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:44.011142) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:44.011405) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:44.055359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:44.055605) ========= 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.ddTC5b9yHW/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.b4SnNv5TuW/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-14 06:51:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 155M=0s 2016-11-14 06:51:44 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.495120 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:44.575562) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:44.575857) ========= 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.ddTC5b9yHW/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.b4SnNv5TuW/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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.025606 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:44.624601) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:44.624977) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2d9b6132e7d75327e063a15d8e5e279077adf987 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2d9b6132e7d75327e063a15d8e5e279077adf987 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ddTC5b9yHW/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.b4SnNv5TuW/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-14 06:51:44,704 truncating revision to first 12 chars 2016-11-14 06:51:44,704 Setting DEBUG logging. 2016-11-14 06:51:44,704 attempt 1/10 2016-11-14 06:51:44,705 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2d9b6132e7d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 06:51:45,372 unpacking tar archive at: mozilla-aurora-2d9b6132e7d7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.913990 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:45.590061) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:45.590548) ========= script_repo_revision: 2d9b6132e7d75327e063a15d8e5e279077adf987 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:45.591109) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:45.591479) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:45.610695) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-14 06:51:45.611069) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ddTC5b9yHW/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.b4SnNv5TuW/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 06:51:45 INFO - MultiFileLogger online at 20161114 06:51:45 in /builds/slave/test 06:51:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 06:51:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:51:45 INFO - {'append_to_log': False, 06:51:45 INFO - 'base_work_dir': '/builds/slave/test', 06:51:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:51:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:51:45 INFO - 'branch': 'Mozilla-Aurora', 06:51:45 INFO - 'buildbot_json_path': 'buildprops.json', 06:51:45 INFO - 'config_files': ('talos/mac_config.py',), 06:51:45 INFO - 'default_actions': ('clobber', 06:51:45 INFO - 'read-buildbot-config', 06:51:45 INFO - 'download-and-extract', 06:51:45 INFO - 'populate-webroot', 06:51:45 INFO - 'create-virtualenv', 06:51:45 INFO - 'install', 06:51:45 INFO - 'run-tests'), 06:51:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:51:45 INFO - 'download_minidump_stackwalk': True, 06:51:45 INFO - 'download_symbols': 'ondemand', 06:51:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:51:45 INFO - 'tooltool.py': '/tools/tooltool.py', 06:51:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:51:45 INFO - '/tools/misc-python/virtualenv.py')}, 06:51:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:51:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:51:45 INFO - 'installer_path': 'installer.exe', 06:51:45 INFO - 'log_level': 'info', 06:51:45 INFO - 'log_name': 'talos', 06:51:45 INFO - 'log_to_console': True, 06:51:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:51:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:51:45 INFO - 'opt_config_files': (), 06:51:45 INFO - 'pip_index': False, 06:51:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:51:45 INFO - 'cmd': ('bash', 06:51:45 INFO - '-c', 06:51:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:51:45 INFO - 'enabled': True, 06:51:45 INFO - 'halt_on_failure': False, 06:51:45 INFO - 'name': 'check_screen_resolution'},), 06:51:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:51:45 INFO - 'cmd': ('bash', 06:51:45 INFO - '-c', 06:51:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:51:45 INFO - 'enabled': True, 06:51:45 INFO - 'halt_on_failure': False, 06:51:45 INFO - 'name': 'check_screen_resolution'},), 06:51:45 INFO - 'run_cmd_checks_enabled': True, 06:51:45 INFO - 'sps_profile': False, 06:51:45 INFO - 'sps_profile_interval': 0, 06:51:45 INFO - 'suite': 'dromaeojs', 06:51:45 INFO - 'system_bits': '32', 06:51:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:51:45 INFO - 'title': 't-yosemite-r7-0145', 06:51:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:51:45 INFO - 'use_talos_json': True, 06:51:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:51:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:51:45 INFO - 'work_dir': 'build'} 06:51:45 INFO - [mozharness: 2016-11-14 14:51:45.806949Z] Running clobber step. 06:51:45 INFO - Running pre-action listener: _resource_record_pre_action 06:51:45 INFO - Running main action method: clobber 06:51:45 INFO - rmtree: /builds/slave/test/build 06:51:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:51:48 INFO - Running post-action listener: _resource_record_post_action 06:51:48 INFO - [mozharness: 2016-11-14 14:51:48.234974Z] Finished clobber step (success) 06:51:48 INFO - [mozharness: 2016-11-14 14:51:48.235112Z] Running read-buildbot-config step. 06:51:48 INFO - Running pre-action listener: _resource_record_pre_action 06:51:48 INFO - Running main action method: read_buildbot_config 06:51:48 INFO - Using buildbot properties: 06:51:48 INFO - { 06:51:48 INFO - "project": "", 06:51:48 INFO - "product": "firefox", 06:51:48 INFO - "script_repo_revision": "production", 06:51:48 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 06:51:48 INFO - "repository": "", 06:51:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 06:51:48 INFO - "buildid": "20161114021920", 06:51:48 INFO - "pgo_build": "False", 06:51:48 INFO - "basedir": "/builds/slave/test", 06:51:48 INFO - "buildnumber": 18, 06:51:48 INFO - "slavename": "t-yosemite-r7-0145", 06:51:48 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:51:48 INFO - "platform": "yosemite_r7", 06:51:48 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 06:51:48 INFO - "branch": "mozilla-aurora", 06:51:48 INFO - "repo_path": "releases/mozilla-aurora", 06:51:48 INFO - "revision": "2d9b6132e7d75327e063a15d8e5e279077adf987", 06:51:48 INFO - "stage_platform": "macosx64", 06:51:48 INFO - "builduid": "34a00fa3aee34299865356c4ee83715c", 06:51:48 INFO - "slavebuilddir": "test" 06:51:48 INFO - } 06:51:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 06:51:48 INFO - Running post-action listener: _resource_record_post_action 06:51:48 INFO - [mozharness: 2016-11-14 14:51:48.239060Z] Finished read-buildbot-config step (success) 06:51:48 INFO - [mozharness: 2016-11-14 14:51:48.239191Z] Running download-and-extract step. 06:51:48 INFO - Running pre-action listener: _resource_record_pre_action 06:51:48 INFO - Running main action method: download_and_extract 06:51:48 INFO - mkdir: /builds/slave/test/build/tests 06:51:48 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')]} 06:51:48 INFO - trying https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 06:51:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 06:51:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 06:51:49 INFO - Downloaded 1199 bytes. 06:51:49 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 06:51:49 INFO - Using the following test package requirements: 06:51:49 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 06:51:49 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:51:49 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 06:51:49 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:51:49 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 06:51:49 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:51:49 INFO - u'jsshell-mac.zip'], 06:51:49 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:51:49 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 06:51:49 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 06:51:49 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:51:49 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 06:51:49 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:51:49 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 06:51:49 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:51:49 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 06:51:49 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 06:51:49 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 06:51:49 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 06:51:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 06:51:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:51:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 06:51:50 INFO - Expected file size: 16423851 06:51:57 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 06:51:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 06:51:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 06:51:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 06:51:57 INFO - Expected file size: 16423851 06:52:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 06:52:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 06:52:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 06:52:04 INFO - Expected file size: 14414089 06:52: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')]} 06:52:05 INFO - trying https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 06:52:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 06:52:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 06:52:09 INFO - Downloaded 115554865 bytes. 06:52:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 06:52:09 INFO - mkdir: /builds/slave/test/properties 06:52:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:52:09 INFO - Writing to file /builds/slave/test/properties/build_url 06:52:09 INFO - Contents: 06:52:09 INFO - build_url:https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 06:52:09 INFO - Running post-action listener: _resource_record_post_action 06:52:09 INFO - Running post-action listener: set_extra_try_arguments 06:52:09 INFO - [mozharness: 2016-11-14 14:52:09.819646Z] Finished download-and-extract step (success) 06:52:09 INFO - [mozharness: 2016-11-14 14:52:09.819791Z] Running populate-webroot step. 06:52:09 INFO - Running pre-action listener: _resource_record_pre_action 06:52:09 INFO - Running main action method: populate_webroot 06:52:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:52:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:52:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:52:09 INFO - '--tppagecycles', 06:52:09 INFO - '7'], 06:52:09 INFO - 'tests': ['tsvgm']}}, 06:52:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:52:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:52:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:52:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:52:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:52:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:52:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:09 INFO - 'talos_options': ['--disable-e10s'], 06:52:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:52:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:52:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:09 INFO - 'talos_options': ['--disable-e10s'], 06:52:09 INFO - 'tests': ['damp', 'tps']}, 06:52:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:09 INFO - 'tests': ['damp', 'tps']}, 06:52:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:52:09 INFO - 'tests': ['dromaeo_dom']}, 06:52:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:52:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:52:09 INFO - 'tests': ['basic_compositor_video']}, 06:52:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:52:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:52:09 INFO - 'tests': ['a11yr', 06:52:09 INFO - 'ts_paint', 06:52:09 INFO - 'tpaint', 06:52:09 INFO - 'sessionrestore', 06:52:09 INFO - 'sessionrestore_no_auto_restore', 06:52:09 INFO - 'tabpaint']}, 06:52:09 INFO - 'other-e10s': {'tests': ['a11yr', 06:52:09 INFO - 'ts_paint', 06:52:09 INFO - 'tpaint', 06:52:09 INFO - 'sessionrestore', 06:52:09 INFO - 'sessionrestore_no_auto_restore', 06:52:09 INFO - 'tabpaint']}, 06:52:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:52:09 INFO - 'ts_paint', 06:52:09 INFO - 'tpaint', 06:52:09 INFO - 'sessionrestore', 06:52:09 INFO - 'sessionrestore_no_auto_restore', 06:52:09 INFO - 'tabpaint']}, 06:52:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:52:09 INFO - 'ts_paint', 06:52:09 INFO - 'tpaint', 06:52:09 INFO - 'sessionrestore', 06:52:09 INFO - 'sessionrestore_no_auto_restore', 06:52:09 INFO - 'tabpaint']}, 06:52:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:52:09 INFO - 'tests': ['a11yr', 06:52:09 INFO - 'ts_paint', 06:52:09 INFO - 'tpaint', 06:52:09 INFO - 'sessionrestore', 06:52:09 INFO - 'sessionrestore_no_auto_restore', 06:52:09 INFO - 'tabpaint']}, 06:52:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:52:09 INFO - 'tests': ['a11yr', 06:52:09 INFO - 'ts_paint', 06:52:09 INFO - 'tpaint', 06:52:09 INFO - 'sessionrestore', 06:52:09 INFO - 'sessionrestore_no_auto_restore', 06:52:09 INFO - 'tabpaint']}, 06:52:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:52:09 INFO - 'tests': ['tsvgx', 06:52:09 INFO - 'tsvgr_opacity', 06:52:09 INFO - 'tart', 06:52:09 INFO - 'tscrollx', 06:52:09 INFO - 'cart']}, 06:52:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:52:09 INFO - 'tsvgr_opacity', 06:52:09 INFO - 'tart', 06:52:09 INFO - 'tscrollx', 06:52:09 INFO - 'cart']}, 06:52:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:09 INFO - 'talos_options': ['--disable-e10s'], 06:52:09 INFO - 'tests': ['tp5o']}, 06:52:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:09 INFO - 'tests': ['tp5o']}, 06:52:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:09 INFO - 'talos_options': ['--disable-e10s', 06:52:09 INFO - '--xperf_path', 06:52:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:52:09 INFO - 'tests': ['tp5n']}, 06:52:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:52:09 INFO - 'talos_options': ['--xperf_path', 06:52:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:52:09 INFO - 'tests': ['tp5n']}}, 06:52:09 INFO - 'talos.zip': {'path': '', 06:52:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:52:09 INFO - Running post-action listener: _resource_record_post_action 06:52:09 INFO - [mozharness: 2016-11-14 14:52:09.838094Z] Finished populate-webroot step (success) 06:52:09 INFO - [mozharness: 2016-11-14 14:52:09.838227Z] Running create-virtualenv step. 06:52:09 INFO - Running pre-action listener: _resource_record_pre_action 06:52:09 INFO - Running main action method: create_virtualenv 06:52:09 INFO - Creating virtualenv /builds/slave/test/build/venv 06:52:09 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 06:52:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:52:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:52:09 INFO - Using real prefix '/tools/python27' 06:52:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:52:10 INFO - Installing distribute.............................................................................................................................................................................................done. 06:52:13 INFO - Installing pip.................done. 06:52:13 INFO - Return code: 0 06:52:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:52:13 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')]} 06:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:13 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')]} 06:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:13 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90faca32a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.ddTC5b9yHW/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.b4SnNv5TuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 06:52:13 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 06:52:13 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 06:52:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddTC5b9yHW/Render', 06:52:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:13 INFO - 'HOME': '/Users/cltbld', 06:52:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:13 INFO - 'LOGNAME': 'cltbld', 06:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:13 INFO - 'MOZ_NO_REMOTE': '1', 06:52:13 INFO - 'NO_EM_RESTART': '1', 06:52:13 INFO - 'PAGER': '/bin/cat', 06:52:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:13 INFO - 'PWD': '/builds/slave/test', 06:52:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:13 INFO - 'SHELL': '/bin/bash', 06:52:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b4SnNv5TuW/Listeners', 06:52:13 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 06:52:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:13 INFO - 'USER': 'cltbld', 06:52:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:13 INFO - 'XPC_FLAGS': '0x0', 06:52:13 INFO - 'XPC_SERVICE_NAME': '0', 06:52:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:13 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 06:52:13 INFO - Cleaning up... 06:52:13 INFO - Return code: 0 06:52:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:52:13 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')]} 06:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:13 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')]} 06:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:13 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90faca32a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.ddTC5b9yHW/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.b4SnNv5TuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 06:52:13 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 06:52:13 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 06:52:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddTC5b9yHW/Render', 06:52:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:13 INFO - 'HOME': '/Users/cltbld', 06:52:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:13 INFO - 'LOGNAME': 'cltbld', 06:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:13 INFO - 'MOZ_NO_REMOTE': '1', 06:52:13 INFO - 'NO_EM_RESTART': '1', 06:52:13 INFO - 'PAGER': '/bin/cat', 06:52:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:13 INFO - 'PWD': '/builds/slave/test', 06:52:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:13 INFO - 'SHELL': '/bin/bash', 06:52:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b4SnNv5TuW/Listeners', 06:52:13 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 06:52:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:13 INFO - 'USER': 'cltbld', 06:52:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:13 INFO - 'XPC_FLAGS': '0x0', 06:52:13 INFO - 'XPC_SERVICE_NAME': '0', 06:52:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:14 INFO - Downloading/unpacking psutil>=3.1.1 06:52:14 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 06:52:14 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 06:52:14 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 06:52:14 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 06:52:14 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 06:52:14 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 06:52:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:52:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:52:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:52:17 INFO - Installing collected packages: psutil 06:52:17 INFO - Running setup.py install for psutil 06:52:17 INFO - building 'psutil._psutil_osx' extension 06:52:17 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 06:52:18 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 06:52:18 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 06:52:18 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 06:52:18 INFO - building 'psutil._psutil_posix' extension 06:52:18 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 06:52:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:52:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:52:18 INFO - ^ 06:52:18 INFO - 1 warning generated. 06:52:18 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 06:52:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:52:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:52:18 INFO - Successfully installed psutil 06:52:18 INFO - Cleaning up... 06:52:18 INFO - Return code: 0 06:52:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:18 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90faca32a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.ddTC5b9yHW/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.b4SnNv5TuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 06:52:18 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 06:52:18 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 06:52:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddTC5b9yHW/Render', 06:52:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:18 INFO - 'HOME': '/Users/cltbld', 06:52:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:18 INFO - 'LOGNAME': 'cltbld', 06:52:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:18 INFO - 'MOZ_NO_REMOTE': '1', 06:52:18 INFO - 'NO_EM_RESTART': '1', 06:52:18 INFO - 'PAGER': '/bin/cat', 06:52:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:18 INFO - 'PWD': '/builds/slave/test', 06:52:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:18 INFO - 'SHELL': '/bin/bash', 06:52:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b4SnNv5TuW/Listeners', 06:52:18 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 06:52:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:18 INFO - 'USER': 'cltbld', 06:52:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:18 INFO - 'XPC_FLAGS': '0x0', 06:52:18 INFO - 'XPC_SERVICE_NAME': '0', 06:52:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:52:18 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 06:52:18 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 06:52:18 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 06:52:18 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 06:52:18 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 06:52:18 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 06:52:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:52:21 INFO - Installing collected packages: mozsystemmonitor 06:52:21 INFO - Running setup.py install for mozsystemmonitor 06:52:21 INFO - Successfully installed mozsystemmonitor 06:52:21 INFO - Cleaning up... 06:52:21 INFO - Return code: 0 06:52:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:52:21 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')]} 06:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:21 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')]} 06:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:21 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90faca32a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.ddTC5b9yHW/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.b4SnNv5TuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 06:52:21 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 06:52:21 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 06:52:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddTC5b9yHW/Render', 06:52:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:21 INFO - 'HOME': '/Users/cltbld', 06:52:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:21 INFO - 'LOGNAME': 'cltbld', 06:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:21 INFO - 'MOZ_NO_REMOTE': '1', 06:52:21 INFO - 'NO_EM_RESTART': '1', 06:52:21 INFO - 'PAGER': '/bin/cat', 06:52:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:21 INFO - 'PWD': '/builds/slave/test', 06:52:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:21 INFO - 'SHELL': '/bin/bash', 06:52:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b4SnNv5TuW/Listeners', 06:52:21 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 06:52:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:21 INFO - 'USER': 'cltbld', 06:52:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:21 INFO - 'XPC_FLAGS': '0x0', 06:52:21 INFO - 'XPC_SERVICE_NAME': '0', 06:52:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:22 INFO - Downloading/unpacking jsonschema==2.5.1 06:52:22 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 06:52:22 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 06:52:22 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 06:52:22 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 06:52:22 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 06:52:22 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 06:52:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:52:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:24 INFO - Downloading functools32-3.2.3-2.tar.gz 06:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:52:25 INFO - warning: no files found matching '*.txt' 06:52:25 INFO - no previously-included directories found matching 'build' 06:52:25 INFO - no previously-included directories found matching 'dist' 06:52:25 INFO - no previously-included directories found matching '.git*' 06:52:25 INFO - Installing collected packages: jsonschema, functools32 06:52:25 INFO - Running setup.py install for functools32 06:52:25 INFO - warning: no files found matching '*.txt' 06:52:25 INFO - no previously-included directories found matching 'build' 06:52:25 INFO - no previously-included directories found matching 'dist' 06:52:25 INFO - no previously-included directories found matching '.git*' 06:52:25 INFO - Successfully installed jsonschema functools32 06:52:25 INFO - Cleaning up... 06:52:25 INFO - Return code: 0 06:52:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:52:25 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')]} 06:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:25 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')]} 06:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:25 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90faca32a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.ddTC5b9yHW/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.b4SnNv5TuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 06:52:25 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 06:52:25 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 06:52:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddTC5b9yHW/Render', 06:52:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:25 INFO - 'HOME': '/Users/cltbld', 06:52:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:25 INFO - 'LOGNAME': 'cltbld', 06:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:25 INFO - 'MOZ_NO_REMOTE': '1', 06:52:25 INFO - 'NO_EM_RESTART': '1', 06:52:25 INFO - 'PAGER': '/bin/cat', 06:52:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:25 INFO - 'PWD': '/builds/slave/test', 06:52:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:25 INFO - 'SHELL': '/bin/bash', 06:52:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b4SnNv5TuW/Listeners', 06:52:25 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 06:52:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:25 INFO - 'USER': 'cltbld', 06:52:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:25 INFO - 'XPC_FLAGS': '0x0', 06:52:25 INFO - 'XPC_SERVICE_NAME': '0', 06:52:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:52:25 INFO - Cleaning up... 06:52:25 INFO - Return code: 0 06:52:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:52:25 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')]} 06:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:25 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')]} 06:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:25 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90faca32a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.ddTC5b9yHW/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.b4SnNv5TuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 06:52:25 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 06:52:25 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 06:52:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddTC5b9yHW/Render', 06:52:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:25 INFO - 'HOME': '/Users/cltbld', 06:52:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:25 INFO - 'LOGNAME': 'cltbld', 06:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:25 INFO - 'MOZ_NO_REMOTE': '1', 06:52:25 INFO - 'NO_EM_RESTART': '1', 06:52:25 INFO - 'PAGER': '/bin/cat', 06:52:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:25 INFO - 'PWD': '/builds/slave/test', 06:52:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:25 INFO - 'SHELL': '/bin/bash', 06:52:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b4SnNv5TuW/Listeners', 06:52:25 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 06:52:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:25 INFO - 'USER': 'cltbld', 06:52:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:25 INFO - 'XPC_FLAGS': '0x0', 06:52:25 INFO - 'XPC_SERVICE_NAME': '0', 06:52:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:25 INFO - Downloading/unpacking blobuploader==1.2.4 06:52:25 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 06:52:25 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 06:52:25 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 06:52:25 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 06:52:25 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 06:52:25 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 06:52:28 INFO - Downloading blobuploader-1.2.4.tar.gz 06:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:52:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:52:28 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 06:52:28 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 06:52:28 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 06:52:28 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 06:52:28 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 06:52:28 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 06:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:52:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:52:29 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 06:52:29 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 06:52:29 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 06:52:29 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 06:52:29 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 06:52:29 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 06:52:29 INFO - Downloading docopt-0.6.1.tar.gz 06:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:52:29 INFO - Installing collected packages: blobuploader, requests, docopt 06:52:29 INFO - Running setup.py install for blobuploader 06:52:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:52:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:52:29 INFO - Running setup.py install for requests 06:52:30 INFO - Running setup.py install for docopt 06:52:30 INFO - Successfully installed blobuploader requests docopt 06:52:30 INFO - Cleaning up... 06:52:30 INFO - Return code: 0 06:52:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:30 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90faca32a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.ddTC5b9yHW/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.b4SnNv5TuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 06:52:30 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 06:52:30 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 06:52:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddTC5b9yHW/Render', 06:52:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:30 INFO - 'HOME': '/Users/cltbld', 06:52:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:30 INFO - 'LOGNAME': 'cltbld', 06:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:30 INFO - 'MOZ_NO_REMOTE': '1', 06:52:30 INFO - 'NO_EM_RESTART': '1', 06:52:30 INFO - 'PAGER': '/bin/cat', 06:52:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:30 INFO - 'PWD': '/builds/slave/test', 06:52:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:30 INFO - 'SHELL': '/bin/bash', 06:52:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b4SnNv5TuW/Listeners', 06:52:30 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 06:52:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:30 INFO - 'USER': 'cltbld', 06:52:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:30 INFO - 'XPC_FLAGS': '0x0', 06:52:30 INFO - 'XPC_SERVICE_NAME': '0', 06:52:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:52:30 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-d_Vure-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:52:30 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-EPfk6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:52:31 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-CR38NC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:52:31 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-GpCs8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:52:31 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-nFBcUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:52:31 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-dg1eRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:52:31 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-qccus6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:52:31 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-xjpyH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:52:31 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-Acet92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:52:31 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-vuvu67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:52:31 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-wijnel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:52:31 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-q3CKc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:52:32 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-s2uhfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:52:32 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-NcG9S7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:32 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-NUlJr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:52:32 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-N821ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:52:32 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-zIakYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:52:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:52:32 INFO - Running setup.py install for manifestparser 06:52:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:52:32 INFO - Running setup.py install for mozcrash 06:52:32 INFO - Running setup.py install for mozdebug 06:52:32 INFO - Running setup.py install for mozdevice 06:52:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:52:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:52:33 INFO - Running setup.py install for mozfile 06:52:33 INFO - Running setup.py install for mozhttpd 06:52:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:52:33 INFO - Running setup.py install for mozinfo 06:52:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:52:33 INFO - Running setup.py install for mozInstall 06:52:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:52:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:52:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:52:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:52:33 INFO - Running setup.py install for mozleak 06:52:33 INFO - Running setup.py install for mozlog 06:52:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:52:34 INFO - Running setup.py install for moznetwork 06:52:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:52:34 INFO - Running setup.py install for mozprocess 06:52:34 INFO - Running setup.py install for mozprofile 06:52:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:52:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:52:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:52:34 INFO - Running setup.py install for mozrunner 06:52:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:52:34 INFO - Running setup.py install for mozscreenshot 06:52:34 INFO - Running setup.py install for moztest 06:52:34 INFO - Running setup.py install for mozversion 06:52:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:52:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:52:35 INFO - Cleaning up... 06:52:35 INFO - Return code: 0 06:52:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:35 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90faca32a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.ddTC5b9yHW/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.b4SnNv5TuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 06:52:35 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 06:52:35 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 06:52:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddTC5b9yHW/Render', 06:52:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:35 INFO - 'HOME': '/Users/cltbld', 06:52:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:35 INFO - 'LOGNAME': 'cltbld', 06:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:35 INFO - 'MOZ_NO_REMOTE': '1', 06:52:35 INFO - 'NO_EM_RESTART': '1', 06:52:35 INFO - 'PAGER': '/bin/cat', 06:52:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:35 INFO - 'PWD': '/builds/slave/test', 06:52:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:35 INFO - 'SHELL': '/bin/bash', 06:52:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b4SnNv5TuW/Listeners', 06:52:35 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 06:52:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:35 INFO - 'USER': 'cltbld', 06:52:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:35 INFO - 'XPC_FLAGS': '0x0', 06:52:35 INFO - 'XPC_SERVICE_NAME': '0', 06:52:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:52:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-_a8LAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:52:35 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)) 06:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:52:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-ttwwtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:52:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-cJNfud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:52:35 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)) 06:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:52:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-OUmqna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:52:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:52:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-SX41C6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:52:35 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)) 06:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:52:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-IsvNN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:52:36 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)) 06:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:52:36 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-f6Ke86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:52:36 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)) 06:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:52:36 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-JurDf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:52:36 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)) 06:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:52:36 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-8cd_Iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:52:36 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)) 06:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:52:36 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-1JDN43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:52:36 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)) 06:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:52:36 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-Lh6TUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:52:36 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)) 06:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:52:36 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-T2BrRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:52:36 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-ixsh3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:52:36 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)) 06:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:52:36 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-W3mpVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:36 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-gGUbsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:37 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)) 06:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:52:37 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-2T1siv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:52:37 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-H7g6YC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:52:37 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)) 06:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:52:37 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)) 06:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:52:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:52:37 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 06:52:37 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 06:52:37 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 06:52:37 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 06:52:37 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 06:52:37 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 06:52:39 INFO - Downloading blessings-1.6.tar.gz 06:52:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:52:39 INFO - Installing collected packages: blessings 06:52:39 INFO - Running setup.py install for blessings 06:52:40 INFO - Successfully installed blessings 06:52:40 INFO - Cleaning up... 06:52:40 INFO - Return code: 0 06:52:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:52:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:52:40 INFO - Reading from file tmpfile_stdout 06:52:40 INFO - Current package versions: 06:52:40 INFO - blessings == 1.6 06:52:40 INFO - blobuploader == 1.2.4 06:52:40 INFO - docopt == 0.6.1 06:52:40 INFO - functools32 == 3.2.3-2 06:52:40 INFO - jsonschema == 2.5.1 06:52:40 INFO - manifestparser == 1.1 06:52:40 INFO - mozInstall == 1.12 06:52:40 INFO - mozcrash == 0.17 06:52:40 INFO - mozdebug == 0.1 06:52:40 INFO - mozdevice == 0.48 06:52:40 INFO - mozfile == 1.2 06:52:40 INFO - mozhttpd == 0.7 06:52:40 INFO - mozinfo == 0.9 06:52:40 INFO - mozleak == 0.1 06:52:40 INFO - mozlog == 3.4 06:52:40 INFO - moznetwork == 0.27 06:52:40 INFO - mozprocess == 0.23 06:52:40 INFO - mozprofile == 0.28 06:52:40 INFO - mozrunner == 6.12 06:52:40 INFO - mozscreenshot == 0.1 06:52:40 INFO - mozsystemmonitor == 0.3 06:52:40 INFO - moztest == 0.7 06:52:40 INFO - mozversion == 1.4 06:52:40 INFO - psutil == 3.1.1 06:52:40 INFO - requests == 1.2.3 06:52:40 INFO - wsgiref == 0.1.2 06:52:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:40 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90faca32a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.ddTC5b9yHW/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.b4SnNv5TuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 06:52:40 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 06:52:40 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 06:52:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddTC5b9yHW/Render', 06:52:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:40 INFO - 'HOME': '/Users/cltbld', 06:52:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:40 INFO - 'LOGNAME': 'cltbld', 06:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:40 INFO - 'MOZ_NO_REMOTE': '1', 06:52:40 INFO - 'NO_EM_RESTART': '1', 06:52:40 INFO - 'PAGER': '/bin/cat', 06:52:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:40 INFO - 'PWD': '/builds/slave/test', 06:52:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:40 INFO - 'SHELL': '/bin/bash', 06:52:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b4SnNv5TuW/Listeners', 06:52:40 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 06:52:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:40 INFO - 'USER': 'cltbld', 06:52:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:40 INFO - 'XPC_FLAGS': '0x0', 06:52:40 INFO - 'XPC_SERVICE_NAME': '0', 06:52:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:40 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)) 06:52:40 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)) 06:52:40 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)) 06:52:40 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)) 06:52:40 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)) 06:52:40 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)) 06:52:40 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)) 06:52:40 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)) 06:52:40 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)) 06:52:40 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)) 06:52:40 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)) 06:52:40 INFO - Cleaning up... 06:52:40 INFO - Return code: 0 06:52:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90faca32a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.ddTC5b9yHW/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.b4SnNv5TuW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 06:52:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:52:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddTC5b9yHW/Render', 06:52:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:40 INFO - 'HOME': '/Users/cltbld', 06:52:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:40 INFO - 'LOGNAME': 'cltbld', 06:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:40 INFO - 'MOZ_NO_REMOTE': '1', 06:52:40 INFO - 'NO_EM_RESTART': '1', 06:52:40 INFO - 'PAGER': '/bin/cat', 06:52:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:40 INFO - 'PWD': '/builds/slave/test', 06:52:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:40 INFO - 'SHELL': '/bin/bash', 06:52:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b4SnNv5TuW/Listeners', 06:52:40 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 06:52:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:40 INFO - 'USER': 'cltbld', 06:52:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:40 INFO - 'XPC_FLAGS': '0x0', 06:52:40 INFO - 'XPC_SERVICE_NAME': '0', 06:52:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:52:40 INFO - Cleaning up... 06:52:40 INFO - Return code: 0 06:52:40 INFO - Running post-action listener: _resource_record_post_action 06:52:40 INFO - Running post-action listener: _start_resource_monitoring 06:52:40 INFO - Starting resource monitoring. 06:52:40 INFO - [mozharness: 2016-11-14 14:52:40.962468Z] Finished create-virtualenv step (success) 06:52:40 INFO - [mozharness: 2016-11-14 14:52:40.963445Z] Running install step. 06:52:40 INFO - Running pre-action listener: _resource_record_pre_action 06:52:40 INFO - Running main action method: install 06:52:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:52:41 INFO - Reading from file tmpfile_stdout 06:52:41 INFO - Detecting whether we're running mozinstall >=1.0... 06:52:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:52:41 INFO - Reading from file tmpfile_stdout 06:52:41 INFO - Output received: 06:52:41 INFO - Usage: mozinstall [options] installer 06:52:41 INFO - Options: 06:52:41 INFO - -h, --help show this help message and exit 06:52:41 INFO - -d DEST, --destination=DEST 06:52:41 INFO - Directory to install application into. [default: 06:52:41 INFO - "/builds/slave/test"] 06:52:41 INFO - --app=APP Application being installed. [default: firefox] 06:52:41 INFO - mkdir: /builds/slave/test/build/application 06:52:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 06:53:13 INFO - Reading from file tmpfile_stdout 06:53:13 INFO - Output received: 06:53:13 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:53:13 INFO - Running post-action listener: _resource_record_post_action 06:53:13 INFO - [mozharness: 2016-11-14 14:53:13.857280Z] Finished install step (success) 06:53:13 INFO - [mozharness: 2016-11-14 14:53:13.857407Z] Running run-tests step. 06:53:13 INFO - Running pre-action listener: _resource_record_pre_action 06:53:13 INFO - Running main action method: run_tests 06:53:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:53:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:53:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:53:13 INFO - 2016-11-14 06:53:13.870 screenresolution[1651:8764] starting screenresolution argv=screenresolution get 06:53:13 INFO - 2016-11-14 06:53:13.872 screenresolution[1651:8764] Display 0: 1600x1200x32@60 06:53:13 INFO - 2016-11-14 06:53:13.878 screenresolution[1652:8769] starting screenresolution argv=screenresolution list 06:53:13 INFO - Available Modes on Display 0 06:53:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:53:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:53:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:53:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:53:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:53:14 INFO - Intel Iris: 06:53:14 INFO - Chipset Model: Intel Iris 06:53:14 INFO - Type: GPU 06:53:14 INFO - Bus: Built-In 06:53:14 INFO - VRAM (Dynamic, Max): 1536 MB 06:53:14 INFO - Vendor: Intel (0x8086) 06:53:14 INFO - Device ID: 0x0a2e 06:53:14 INFO - Revision ID: 0x0009 06:53:14 INFO - Displays: 06:53:14 INFO - Display: 06:53:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:53:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:53:14 INFO - Display Serial Number: 1600x1200 60 06:53:14 INFO - Main Display: Yes 06:53:14 INFO - Mirror: Off 06:53:14 INFO - Online: Yes 06:53:14 INFO - Rotation: Supported 06:53:14 INFO - Return code: 0 06:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:53:14 INFO - Python 2.7.3 06:53:14 INFO - Return code: 0 06:53:14 INFO - grabbing minidump binary from tooltool 06:53: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')]} 06:53:14 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 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:53:14 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 06:53:14 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 06:53:14 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 06:53:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:53:14 INFO - Return code: 0 06:53:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:53:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:53:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:53:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:53:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0145', '--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 06:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0145 --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 06:53:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ddTC5b9yHW/Render', 06:53:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:14 INFO - 'HOME': '/Users/cltbld', 06:53:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:14 INFO - 'LOGNAME': 'cltbld', 06:53:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:53:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:14 INFO - 'MOZ_NO_REMOTE': '1', 06:53:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:53:14 INFO - 'NO_EM_RESTART': '1', 06:53:14 INFO - 'PAGER': '/bin/cat', 06:53:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:14 INFO - 'PWD': '/builds/slave/test', 06:53:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:53:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:14 INFO - 'SHELL': '/bin/bash', 06:53:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.b4SnNv5TuW/Listeners', 06:53:14 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 06:53:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:14 INFO - 'USER': 'cltbld', 06:53:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:14 INFO - 'XPC_FLAGS': '0x0', 06:53:14 INFO - 'XPC_SERVICE_NAME': '0', 06:53:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0145', '--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 06:53:14 INFO - mozversion application_buildid: 20161114021920 06:53:14 INFO - mozversion application_changeset: 2d9b6132e7d75327e063a15d8e5e279077adf987 06:53:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:53:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:53:14 INFO - mozversion application_name: Firefox 06:53:14 INFO - mozversion application_remotingname: firefox-dev 06:53:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:53:14 INFO - mozversion application_vendor: Mozilla 06:53:14 INFO - mozversion application_version: 51.0a2 06:53:14 INFO - mozversion platform_buildid: 20161114021920 06:53:14 INFO - mozversion platform_changeset: 2d9b6132e7d75327e063a15d8e5e279077adf987 06:53:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:53:14 INFO - mozversion platform_version: 51.0a2 06:53:14 INFO - using testdate: 1479135194 06:53:14 INFO - actual date: 1479135194 06:53:14 INFO - starting webserver on 'localhost:49277' 06:53:14 INFO - SUITE-START | Running 2 tests 06:53:14 INFO - TEST-START | dromaeo_css 06:53:14 INFO - operating with platform_type : mac_ 06:53:14 INFO - Initialising browser for dromaeo_css test... 06:53:14 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpLOsVQ4/profile http://localhost:49277/getInfo.html) 06:53:16 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 06:53:16 INFO - PROCESS | 1662 | colorDepth:24 06:53:16 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 06:53:16 INFO - PROCESS | 1662 | __metrics 06:53:17 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:53:17 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:53:17 INFO - TEST-INFO | 1662: exit 0 06:53:17 INFO - Browser initialized. 06:53:17 INFO - Running cycle 1/1 for dromaeo_css test... 06:53:17 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpLOsVQ4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:53:29 INFO - PROCESS | 1665 | RSS: Main: 219824128 06:53:29 INFO - PROCESS | 1665 | 06:54:20 INFO - PROCESS | 1665 | 1479135260809 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:56:32 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 06:56:34 INFO - PROCESS | 1665 | RSS: Main: 369201152 06:56:34 INFO - PROCESS | 1665 | 06:59:37 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 06:59:38 INFO - PROCESS | 1665 | RSS: Main: 353497088 06:59:38 INFO - PROCESS | 1665 | 07:02:40 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 07:02:40 INFO - PROCESS | 1665 | RSS: Main: 331108352 07:02:40 INFO - PROCESS | 1665 | 07:05:43 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 07:05:43 INFO - PROCESS | 1665 | RSS: Main: 325541888 07:05:43 INFO - PROCESS | 1665 | 07:08:47 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 07:08:47 INFO - PROCESS | 1665 | RSS: Main: 313516032 07:08:47 INFO - PROCESS | 1665 | 07:11:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 07:11:51 INFO - PROCESS | 1665 | RSS: Main: 365981696 07:11:51 INFO - PROCESS | 1665 | 07:11:51 INFO - PROCESS | 1665 | __start_tp_report 07:11:51 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 07:11:51 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 07:11:51 INFO - PROCESS | 1665 | |i|pagename|runs| 07:11:51 INFO - PROCESS | 1665 | |0;dojo.html;2918.7810914181437;3304.7356211503075;3344.7993120412793;3374.325134973003;3379.79721216727;5656.57575681824;5734.111212762024;5747.166660834177;5747.626404283718;5765.942340576587;5628.831135065944;5658.830235092953;5687.090065589507;5692.37383887773;5707.714614269291;5156.716380599066;5203.765830537635;5207.765650545734;5216.139337009407;5274.208868669711;5154.433012368637;5163.1480805667015;5174.042802081608;5273.736313184345;5340.332458442695;5204.29741984831;5215.817446389377;5259.237410575464;5260.789568417259;5271.947280527184;5246.50158234969;5275.076861549252;5294.682319060868;5297.894042119175;5311.256424100629;5120.257562653432;5126.282320475137;5228.5555727763185;5230.21546767984;5231.424543300234;4698.553637404441;5601.411851755588;5650.406707295757;5666.263385759866;5726.656400615935;6127.5710700251;6179.5674302798825;6192.28788689302;6251.4061164189325;6268.905966410507;6212.9068063979075;6249.937500624981;6287.905681414737;6295.937040629581;6306.747730090791;5670.3479099903625;5718.714064296769;5730.656160630376;5753;5805.796797112081;5283.709395983258;6234.9688251558455;6264.843378915563;6272.843178920563;6276.592021518587;6175.722092505848;6176.104464852571;6180.47465965389;6207.906881396782;6225.408586184305;5602.215689803431;5841.707914604338;6091.573589848668;6129.48104857405;6250.218722659668;6136.693165341715;6172.197614310201;6183.721732522047;6256.280527739277;6259.78090766821;6236.812895613139;6264.59280146789;6276.874462510816;6279.215098112736;6281.780137695158;4855.490173531728;4913.434954980152;4968.875778105504;4977.527134922177;4996.875078123076;4378.299472084451;4406.1187762447635;4450.821967121279;4477.28363461851;4477.619402350771;5826.941730582725;5827.125931110368;5839.591228613956;5846.8538286542325;5852.7658893643775;6289.905651415233;6295.811125666238;6307.432331090224;6315.210598675166;6326.841828954313;5640.379558248589;5680.375158732536;5705.001624715741;5784.248047753849;5825.825225243249;5357.116075847442;5370.865728356823;5436.320459942507;5444.373897001896;5491.258680078138;6297;6319.557630965788;6324.494040476843;6327.829351569974;6341.270753863365;6118.314626315779;6223.253209614875;6279.272329094502;6297;6304.432601065926;6201.6899155041165;6226.40849119333;6241.3134555197985;6244.2819075806865;6321.462675672619;6147.784827531015;6178.042403427476;6195.4424101831055;6212.689365531615;6233.563650544418;6171.7531298749345;6210.3168651449205;6266.060090986389;6269.843253918689;6275.905861412174;5034.421041580119;5888.146218798336;5909.586328957103;5984.551158663205;6086;6118.174046503665;6123.785667501616;6129.417705318166;6136.2636483622255;6141.692915354304;5964.224650795542;5966.015607424726;5975.521958243417;5980.312264089685;6008.1588577598295;5897.115432685132;6018.578699490994;6031.306399763907;6081.361457046946;6114.724837382418;5936.762529498772;5940.3168635605725;5952.017917043812;5952.821415357546;5967.492763115184 07:11:51 INFO - PROCESS | 1665 | |1;ext.html;490.5879061588265;523.549747217393;530.5834919588124;537.1807992810963;540.9829520501456;27732.86133569332;41176.38235426467;42207.522736704224;42446.57553424465;44745.32882006765;43629;44007;44034.11931761371;44102;44139.77930110353;8649.913500865005;9825.50872456376;10014.799704005916;10021.699349019542;10054.396736195851;8845.20393164615;9075.455472671627;11881.881181188164;12249;12293.754124917541;12316.507339706446;12386.442610082568;12412.75174496514;12413.317267550281;12413.379331033457;12317.568885089024;12400.56598019074;12406.875931240662;12434.253944763297;12435.626931192079;10198.388096714147;12147.210431321935;12172.878271217263;12176.330301833395;12181.756364872741;40938.18123637541;41168.97077573085;41188.79405602983;41196.38205426891;41257.587424125675;3327.3012667339644;3465.4455287154187;3850.2876967761053;3859.4982652255308;3961.2869683456966;24434.755652443426;30392.93624723146;31956.20109497258;32252.516212256836;32743;3224.871005159791;3240.4329242382723;3266.4936934775146;3296.2748195396975;3378.189234583707;516983;518735.2189717157;518901.6219675585;519569;521782.3910880459;33783.66216337854;34193.97418077462;34405.82797085999;62302.68848655728;62486.75026499444;35802.28395432077;35968.28063438716;35973;36067;36089;14759;14831.258437078102;15218.239088045553;15332.616684582974;15345.769813452807;11708.414579271002;11928.284302941851;12936.288504132175;13068.346582670829;13077.607671769862;7419.109706835215;7658.081030276291;7832.216778322122;7839.25527074927;7884.093329267093;3140.4661207594763;3165.7467402607735;3186.1875221818286;3208.5508028875975;3230.935381292361;972.2513664478312;1061.1192710050639;1062.1555863088709;1078.5254488025244;1104.3600253623363;30421.23946901301;30517.542236866466;30618.38763224723;31264.531032034538;31291.374172516877;966.7534778631403;1065.472591067411;1124.7581769919507;1127.7857207130783;1181.7695549367963;15456.84543154554;15486;15838.12890291022;15951.44169954046;15957.601059973362;695630;702659;703180;703592;704614.4769276121;59163;59669.701651491465;59756.70121649364;59809.10286345621;59940.40059599435;1237.9257244565356;1270.0791925853866;1304.1327517200955;1358.7146699193281;1394;25585.744142558335;31344.373112537167;31522.684773151974;31815.979420066174;32048.839755801073;50907.72730681763;51500.742496287276;51544.96910061853;51589.742051289504;51593.48406515887;549814;551344;551694;551718;551793.2410337923;26885.596716049666;27172.864135679196;27565.448691025667;27566.5865012021;28504.714952851034;47698.52301476941;47786.76106619445;47861.76069119632;47880;48660.75669621629;39664.2067158661;40156.59451919169;40530.39204411995;41006.58993410028;42033;36107;39418.60581394264;40228.79313620596;40618.55259092413;41563.168736624495;37500.624993750804;38954;39128.804355978034;39264.41103383509;39269.6073039266;33932.151696207795;34940;35105.29789404249;35803.46294805632;35982.4602630966;23530.176443824384;25575.48849022972;25811.88153327469;26119;26486.602700959887 07:11:51 INFO - PROCESS | 1665 | |2;jquery.html;353.2422952766318;369.3554746966543;378.3397970541407;383.28517315207137;401.62046865711915;14988.700225995473;15077.849221507782;16454.532351932583;21199.68200476994;21255;16720.331186752544;20184.89907550464;21032.05355758991;21057.57884842302;21167.470813229676;4628.773375055613;5957.255343082125;6207.162033125515;6209.658468784215;6226.3462336454695;5755.45323194298;6098.32918378978;6143;6191.226096737908;6209.130721698965;5811.6803575803315;6014.5188384929315;6073.544484163684;6154.076888466743;6163.845903852395;6059.121427393025;6081.087836824468;6115.510759139258;6123.755049798003;6127;5076.390833100052;5275.419703832576;5315.7873685052555;5327.733613319358;5343.225232341328;26117.82469788845;26240.21279361622;26256;26354.341141471425;26694;2373.0982226753895;2411.7588241175918;2797.104926423525;3180.3957248122783;3216.8713251469912;15860;15939.521814345588;16057.875948683597;16539.66920661592;16716.41492547767;1891.7635295588052;1893.1196993397998;1899.9145038473303;1908.9574155653456;1910.6560819052565;103077;117118.41440792827;123274.76725232722;124722;127784;8026.719064832703;9709.504578351787;11179.552817887194;11187;11376.089912806956;11652.883471165349;13820.239886806323;13828.516001939885;13847.099938503965;13911.30443477822;8562.871556926651;8829.646814127364;8898;8985.326100542485;8997.730068097837;9018.59416326267;9019.32355073359;9054.366194366463;9208.677696280598;9220.631174752934;5581.274434323512;6609.107770450928;6734.696938637773;6739.865202695919;6758.493113016543;1623.4399132299575;1812.4109664359137;1843.787964384113;1850.3986204483597;1878;899.3929097858919;913.4473643445752;943.6838659049158;972.1639390124487;1015.746063484129;21145;22617.660735088986;22647.773522264895;22664.320070397913;22682.43293917665;919.7194855569115;947.6967370441392;972.5769290358717;987.5161171026289;988.2242439684813;11310.773784524263;11635;12006.099542534344;12023.398830058462;12034.157608967464;594750;603637;616255;629650;631520;74537;97197;100329;116291.41854290674;122450;999.7600575861741;1026.958921643126;1078.7680648660576;1082.4804094034907;1086.8098082835472;19948;20032.399028029184;20587.691184632542;20654.586908262052;20692;50704;50969.23546146737;51127.48872511227;51449;52590;70245.64877175582;71783.64108179425;74062;75057.62471187828;76729.61635191788;7947.245011723877;7955.24425179607;8170.264676179172;8231.917680823115;8472.915270847212;12999.740005200032;13431.395587198404;13517.932410337886;13829.239391833546;13919.512817051354;5321.973390133025;9422.340436169403;11463.656090317303;11711.180217385043;11943.880561194277;10745.817960024235;11152.330860148417;11160.051395631137;11641.359725215194;11742.88257117418;5724.4561766632105;6273.749050037947;10863.098957682216;11241.325520468798;11585.594504192313;7920.881186782318;8019;8089.393295502979;8189.653033783797;8274.255317021256;10965.232433729563;11268.475052145937;11417.429128543707;11563.537458501565;11631.59289424866 07:11:51 INFO - PROCESS | 1665 | |3;mootools.html;1492.0972811449074;1511.9168445735484;1678.5467923660613;1837.7059670452722;1844.0871768474608;8568.100349463302;9084.09159084092;9087.727368178965;9087.954560227206;9089.59096840642;7866.763997080083;8153.8776918346275;8154.6330415131315;8194.91805081949;8200;1824.9726254106165;2351.6007975254697;2433.0754313360985;2446.0460420436043;2452.2765784093735;2400.6399040143942;2412.5416170927556;2428.0651948999584;2432.586460301753;2438.195395519483;2430.8419952703016;2432.1122790181544;2434.2332165367943;2437.524682686877;2437.549053425122;2393.652920326552;2422.9636555451684;2426.308502076917;2427.526632306692;2433.1362366359863;2079.334612923865;2318.721753389604;2397.568437681217;2398.82008849337;2399.784019438259;8923.643054277822;8963.014068452465;9038.412503187272;9038.683646072423;9042.728718138467;5294.841154765363;5470.124780035215;5476.096444086721;5480.314960629921;5487.341519017704;3387.8475468603974;3623.800690961996;3715.9628403715888;3777.452269420946;3784.7161462890394;1035.6116456328878;1104.618906477264;1108.3793075877534;1125.1055410948316;1127.949242284091;11538;11680.123990700646;11690.41547922609;11723.237989530739;11742.47158877844;4622.375979242759;4671;4728.219843725747;4735.479097299294;4914.5822605078965;10162.03460671235;10168.135708464863;10172.491375431198;10173.54219060144;10175.44035078063;5455.099908515051;5457.481539253765;5457.6452530586175;5457.727113644302;5461.290032295776;4881.633877459205;4935.185231296348;4957.380327459067;4984.950150498448;4986.55121039101;4025.3358195897936;4039.4748682671066;4077.103037331782;4134.069834287321;4145.108801607669;1293.236990175782;1298.6558561981083;1305.4973835073565;1318.156379916854;1323.3184909771476;820.0774129104757;835.5655059369094;842.614193124784;878.8925953298761;890.9976276688725;5530.640508366943;5542.63972841764;5566.942280966603;5586.86032849182;5757.165211044375;422.75902735441116;434.82172309353643;438.8485972339538;438.8551777913281;442.09591385616494;3115.3146307812244;3709.2025214578994;3856.8457261709777;3873.7288389812443;3889.8444062237195;10494.212934029825;10752.892471075345;10958.068564172134;10964.177686673373;11040.558377664964;10875.401852898167;10893.727656808485;10895.945520272347;10931.726706832393;10980.066694331072;7617.847643047219;8047.718329858427;8179.345652347798;8223.21879421454;8373.539455329894;5540.833774986757;5603.7758489659955;5698.6580805151825;5768.480836724715;5795.478406943395;9884.703458896245;9956.452395118338;10086.29395942277;10122.392656440637;10236.33463824849;8798.736037918872;10029.29794914349;10239.385636861813;10457.372557646566;10625.415602141957;7105.680244389118;7339.376153027052;7348.191698913222;7601.12587052496;7748.496347737379;8649.091845356146;8655.740327790176;8740.868886966573;8744.912550874664;8772.166644168794;7729.149793522595;7746.186650401627;7758.495697779626;7796.259355361231;7833.882491762742;7537;7621.657025433758;7654.502457340255;7665.808354791175;7721.92278077212;7085.964570177116;7132.964335178291;7199.532030418006;7239.095113110861;7263.854722905407;4654.185517534485;4800.1119792838435;4814.721327216012;4836.443808962014;5041.571466425395;4204.264253755519;4869.951300487091;4874.073925954058;4965.726885021359;5062.164742817394 07:11:51 INFO - PROCESS | 1665 | |4;prototype.html;294.6949906846413;297.1101550855189;298.87297898393206;305.0908293286008;311.2902582112782;4818.939833236686;4870.41555013398;5362;5403.378611459683;5414.945850541493;5002.549770520653;5139.640225184229;5188.688678679282;5208.5051920067535;5312.495312945273;3884.9223015539674;4001.239764444746;4014.4781178446833;4015.4177644241568;4045.110075783323;3352.2457447074335;3569.982150089246;4071.4707088078508;4078.021274894019;4101.9179616407655;3346.5482159908343;3898.4737060496896;3990.361542153256;4039.333509970866;4056.249593825152;4052.2098190852794;4061.7969101544804;4071.5928407159345;4081.551069358376;4098.360655737699;3404.3021180657906;3492.0746002309406;3538.221591249921;3558.395072837598;3570.589382221052;4000;5183.559397451221;5226.97386513065;5228.372595288552;5231.476852314776;3941.6452519273116;4431.756253406062;4636.53634636537;4679.672422930396;4681.485036645966;4515.774211289422;5424.83725488232;5568.415316391802;5622.634528755618;5624.831255062355;3781.735278530504;3951.6245956634075;3956.0703234739813;3963.960360396388;3989.5412027616903;5536.861578460531;5571.637843540157;5803.65178089316;5884.6763428011445;5914.408559144094;3090.90727278182;3516.331896939573;3812.8093595320124;3966.5835087315995;4008.118213992917;3425.4861770734587;3432.5366075579977;4050.0887300357185;4061.248668996245;4070.61329173728;4296.742195468282;4614.261718125151;4663.626909847272;4692.155412025868;4709.905801883943;4885.60915126789;5695.515881150066;5699.629524080921;5702.771889124471;5752.568557358215;1066.4987455895716;1154.9595764148214;1237.6472705278952;1327.057788969823;1364.4269406849148;840.9369297302604;862.4049405910027;864.4942708515463;867.3538214030588;895.9596818143199;4436.711613745097;4906.950930490721;5094.923576146361;5208.583313334924;5234.586661601346;5711.543076553866;5725.227094342294;5743.4543718346695;5758.395368486249;5783.132530120515;4958.603311735053;5138.794448222104;5222.67590922036;5260.526552610283;5267.604929630216;2762.7513523782955;2772.50094982905;2996.9700302997126;3017.336186039068;3039.2098054505545;5654.915176272277;5910.320313163955;5915.438033386821;5931.258592675916;5942.58401911862;5596.468335508121;5902.321233058167;6034.366391528826;6034.818955431344;6044.667543285073;6049.697515124226;6059.878802423927;6102.298235702951;6206.355315841396;6215.098810672517;4887.3890763654545;5547.531348549856;5805.187273781589;5922.7927022554;5975.671338076448;5771.422857714195;5781.219535362672;5803.129530570448;5832.94167058324;5839.416058394297;5881.647221139247;6119.755209791559;6136.325004249618;6191.566590338633;6191.690415479298;3838.2323535292494;3901.8439262429183;3913.941290880696;3913.9804300978312;3928.2339943711845;5856.355800861987;5894.587378883437;5904.498117660047;5934.762609495745;5947.821565353046;5425.159100339453;5477.534409575231;5707.315122185364;5748.6550806950045;5753.424657534213;5641.461342395856;5653;5657.632253903483;5662.122371032497;5683.465464324692;5183.792648294177;5324.9733751331;5512.003797246964;5587.55299576041;5659.320881494247;5024.196128619404;5026.547610715053;5634.605577609528;5650.406707295675;5709.286339207599;4483.977580112079;5527.397054854047;5553.805616803393;5563.304586926634;5606.859828504157 07:11:51 INFO - PROCESS | 1665 | |5;yui.html;706.480736658556;794.5884241327572;803.774943015955;806.1011971651607;807.571986846971;14917.104973701573;15544.378224870992;15590.220488975534;16359;16375.508734737961;14948;14982.475613353508;15190.924045379757;15199.316030778615;15200.619984500394;659.1826135591856;674.8549061951679;809.5142914251446;831.42631584207;833.2251006563923;673.6093066021721;818.7420962396856;837.530982649715;847.2501835875264;850.2135524639715;849.7238397520799;862.0517430826072;880.7621942075635;884.1600479544427;886.3839631456141;685.9828504287433;879.0681877210146;879.8680197970356;879.8812160358366;881.6737807011383;518.7224834713448;629.5939119268093;645.33852800879;649.6264647827518;651.7490766055056;14872.70254594902;14902.776458353133;14931.552053438305;14946.177960212184;14946.177960212184;13793.655158621015;14047.367868445945;14074.2962851857;14106.294685265799;14450;10636.521356538897;12182.573609923611;12430.440630171664;12961.546345877943;12963.935180324132;4525.637948964075;4534.6372290216705;4540.500544940054;4720.976395118037;4733.0533893221145;121678.39160804139;122653;123235;124702.75297247001;129359;9811.705648830546;10058.497075146213;10232.846507302396;10243.436610986319;10436.73908152287;19083.522911927033;19150.521236968907;19246.326378576683;19300.90349548243;19302.4209273722;7783.494072885244;7856.921430785734;7888.6450109744055;7904.762857114296;8017;4272.46594175728;4348.913021739548;4350.651947844165;4354.521002689701;4355.15074560464;3530.099824544776;3571.5357003589365;3591.066322756102;3596.6762991330384;3636.945445818315;658.8418779492887;711.9394851437582;735.5182355557118;757.1293013035054;759.673340463606;491.6509278412296;620.9875802484015;637.6684124255454;682.5085938124543;683.4225079807554;7664.271894170045;9779.168770654433;9795.118439340351;9825.901740982641;9978.900210997797;635.1425575473074;638.8275165705327;659.4954859532462;671.5265737654942;677.5392732941647;4446.866594002185;4676.298555216745;4676.579107880307;4682.789274482657;4800.3279540864305;104452.43321350186;147310.2634486842;150177;154808.71147731174;156055;123166;140260;145791.5420845799;146601;147598.26200868926;123910.38044809719;125563;127444;128305;128768.06847897288;8746.69386571467;9084.137006984325;9113.179813816789;9172.6789562365;9210.355275130676;61756;66103.66948165228;66384;68568.6571567139;69199.61600768057;88207;99117.51323730005;99763;104599;109878;11854.881451185378;11946.76106477883;11989.34058626784;12093.637190884288;12522.561710340095;12354.876451235372;12696.04779641549;13107.279099649611;13491.392887319898;13674.658133546742;12428.875711242772;12462.439190236642;12467.87532124667;12494.812577811159;13030.08789384734;12255.387230638611;12353;12380.62858114258;12539.24764514132;12958;11788.479961679857;12135.271883687006;12261.570845020382;12401.565945191875;12835.101542892282;9557.856632150384;10160.542775575264;10588.788224235626;10746.601270450838;10779.785659836058;10001.749956251151;10712.8928710715;10732.409717465302;10743.08683761889;10759.623413180501 07:11:51 INFO - PROCESS | 1665 | __end_tp_report 07:11:51 INFO - PROCESS | 1665 | __start_cc_report 07:11:51 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1462 07:11:51 INFO - PROCESS | 1665 | __end_cc_report 07:11:51 INFO - PROCESS | 1665 | __startTimestamp1479136311012__endTimestamp 07:11:51 INFO - PROCESS | 1665 | 07:11:51 INFO - PROCESS | 1665 | ------- Summary: start ------- 07:11:51 INFO - PROCESS | 1665 | Number of tests: 6 07:11:51 INFO - PROCESS | 1665 | 07:11:51 INFO - PROCESS | 1665 | [#0] dojo.html Cycles:165 Average:5727.14 Median:5936.76 stddev:649.97 (10.9%) stddev-sans-first:613.50 07:11:51 INFO - PROCESS | 1665 | Values: 2918.8 3304.7 3344.8 3374.3 3379.8 5656.6 5734.1 5747.2 5747.6 5765.9 5628.8 5658.8 5687.1 5692.4 5707.7 5156.7 5203.8 5207.8 5216.1 5274.2 5154.4 5163.1 5174.0 5273.7 5340.3 5204.3 5215.8 5259.2 5260.8 5271.9 5246.5 5275.1 5294.7 5297.9 5311.3 5120.3 5126.3 5228.6 5230.2 5231.4 4698.6 5601.4 5650.4 5666.3 5726.7 6127.6 6179.6 6192.3 6251.4 6268.9 6212.9 6249.9 6287.9 6295.9 6306.7 5670.3 5718.7 5730.7 5753.0 5805.8 5283.7 6235.0 6264.8 6272.8 6276.6 6175.7 6176.1 6180.5 6207.9 6225.4 5602.2 5841.7 6091.6 6129.5 6250.2 6136.7 6172.2 6183.7 6256.3 6259.8 6236.8 6264.6 6276.9 6279.2 6281.8 4855.5 4913.4 4968.9 4977.5 4996.9 4378.3 4406.1 4450.8 4477.3 4477.6 5826.9 5827.1 5839.6 5846.9 5852.8 6289.9 6295.8 6307.4 6315.2 6326.8 5640.4 5680.4 5705.0 5784.2 5825.8 5357.1 5370.9 5436.3 5444.4 5491.3 6297.0 6319.6 6324.5 6327.8 6341.3 6118.3 6223.3 6279.3 6297.0 6304.4 6201.7 6226.4 6241.3 6244.3 6321.5 6147.8 6178.0 6195.4 6212.7 6233.6 6171.8 6210.3 6266.1 6269.8 6275.9 5034.4 5888.1 5909.6 5984.6 6086.0 6118.2 6123.8 6129.4 6136.3 6141.7 5964.2 5966.0 5975.5 5980.3 6008.2 5897.1 6018.6 6031.3 6081.4 6114.7 5936.8 5940.3 5952.0 5952.8 5967.5 07:11:51 INFO - PROCESS | 1665 | 07:11:51 INFO - PROCESS | 1665 | [#1] ext.html Cycles:180 Average:71083.56 Median:19202.72 stddev:159710.95 (831.7%) stddev-sans-first:160071.04 07:11:51 INFO - PROCESS | 1665 | Values: 490.6 523.5 530.6 537.2 541.0 27732.9 41176.4 42207.5 42446.6 44745.3 43629.0 44007.0 44034.1 44102.0 44139.8 8649.9 9825.5 10014.8 10021.7 10054.4 8845.2 9075.5 11881.9 12249.0 12293.8 12316.5 12386.4 12412.8 12413.3 12413.4 12317.6 12400.6 12406.9 12434.3 12435.6 10198.4 12147.2 12172.9 12176.3 12181.8 40938.2 41169.0 41188.8 41196.4 41257.6 3327.3 3465.4 3850.3 3859.5 3961.3 24434.8 30392.9 31956.2 32252.5 32743.0 3224.9 3240.4 3266.5 3296.3 3378.2 516983.0 518735.2 518901.6 519569.0 521782.4 33783.7 34194.0 34405.8 62302.7 62486.8 35802.3 35968.3 35973.0 36067.0 36089.0 14759.0 14831.3 15218.2 15332.6 15345.8 11708.4 11928.3 12936.3 13068.3 13077.6 7419.1 7658.1 7832.2 7839.3 7884.1 3140.5 3165.7 3186.2 3208.6 3230.9 972.3 1061.1 1062.2 1078.5 1104.4 30421.2 30517.5 30618.4 31264.5 31291.4 966.8 1065.5 1124.8 1127.8 1181.8 15456.8 15486.0 15838.1 15951.4 15957.6 695630.0 702659.0 703180.0 703592.0 704614.5 59163.0 59669.7 59756.7 59809.1 59940.4 1237.9 1270.1 1304.1 1358.7 1394.0 25585.7 31344.4 31522.7 31816.0 32048.8 50907.7 51500.7 51545.0 51589.7 51593.5 549814.0 551344.0 551694.0 551718.0 551793.2 26885.6 27172.9 27565.4 27566.6 28504.7 47698.5 47786.8 47861.8 47880.0 48660.8 39664.2 40156.6 40530.4 41006.6 42033.0 36107.0 39418.6 40228.8 40618.6 41563.2 37500.6 38954.0 39128.8 39264.4 39269.6 33932.2 34940.0 35105.3 35803.5 35982.5 23530.2 25575.5 25811.9 26119.0 26486.6 07:11:51 INFO - PROCESS | 1665 | 07:11:51 INFO - PROCESS | 1665 | [#2] jquery.html Cycles:180 Average:34868.74 Median:3198.63 stddev:101951.89 (3187.4%) stddev-sans-first:102204.95 07:11:51 INFO - PROCESS | 1665 | Values: 353.2 369.4 378.3 383.3 401.6 14988.7 15077.8 16454.5 21199.7 21255.0 16720.3 20184.9 21032.1 21057.6 21167.5 4628.8 5957.3 6207.2 6209.7 6226.3 5755.5 6098.3 6143.0 6191.2 6209.1 5811.7 6014.5 6073.5 6154.1 6163.8 6059.1 6081.1 6115.5 6123.8 6127.0 5076.4 5275.4 5315.8 5327.7 5343.2 26117.8 26240.2 26256.0 26354.3 26694.0 2373.1 2411.8 2797.1 3180.4 3216.9 15860.0 15939.5 16057.9 16539.7 16716.4 1891.8 1893.1 1899.9 1909.0 1910.7 103077.0 117118.4 123274.8 124722.0 127784.0 8026.7 9709.5 11179.6 11187.0 11376.1 11652.9 13820.2 13828.5 13847.1 13911.3 8562.9 8829.6 8898.0 8985.3 8997.7 9018.6 9019.3 9054.4 9208.7 9220.6 5581.3 6609.1 6734.7 6739.9 6758.5 1623.4 1812.4 1843.8 1850.4 1878.0 899.4 913.4 943.7 972.2 1015.7 21145.0 22617.7 22647.8 22664.3 22682.4 919.7 947.7 972.6 987.5 988.2 11310.8 11635.0 12006.1 12023.4 12034.2 594750.0 603637.0 616255.0 629650.0 631520.0 74537.0 97197.0 100329.0 116291.4 122450.0 999.8 1027.0 1078.8 1082.5 1086.8 19948.0 20032.4 20587.7 20654.6 20692.0 50704.0 50969.2 51127.5 51449.0 52590.0 70245.6 71783.6 74062.0 75057.6 76729.6 7947.2 7955.2 8170.3 8231.9 8472.9 12999.7 13431.4 13517.9 13829.2 13919.5 5322.0 9422.3 11463.7 11711.2 11943.9 10745.8 11152.3 11160.1 11641.4 11742.9 5724.5 6273.7 10863.1 11241.3 11585.6 7920.9 8019.0 8089.4 8189.7 8274.3 10965.2 11268.5 11417.4 11563.5 11631.6 07:11:51 INFO - PROCESS | 1665 | 07:11:51 INFO - PROCESS | 1665 | [#3] mootools.html Cycles:180 Average:5744.46 Median:4699.61 stddev:3260.52 (69.4%) stddev-sans-first:3254.01 07:11:51 INFO - PROCESS | 1665 | Values: 1492.1 1511.9 1678.5 1837.7 1844.1 8568.1 9084.1 9087.7 9088.0 9089.6 7866.8 8153.9 8154.6 8194.9 8200.0 1825.0 2351.6 2433.1 2446.0 2452.3 2400.6 2412.5 2428.1 2432.6 2438.2 2430.8 2432.1 2434.2 2437.5 2437.5 2393.7 2423.0 2426.3 2427.5 2433.1 2079.3 2318.7 2397.6 2398.8 2399.8 8923.6 8963.0 9038.4 9038.7 9042.7 5294.8 5470.1 5476.1 5480.3 5487.3 3387.8 3623.8 3716.0 3777.5 3784.7 1035.6 1104.6 1108.4 1125.1 1127.9 11538.0 11680.1 11690.4 11723.2 11742.5 4622.4 4671.0 4728.2 4735.5 4914.6 10162.0 10168.1 10172.5 10173.5 10175.4 5455.1 5457.5 5457.6 5457.7 5461.3 4881.6 4935.2 4957.4 4985.0 4986.6 4025.3 4039.5 4077.1 4134.1 4145.1 1293.2 1298.7 1305.5 1318.2 1323.3 820.1 835.6 842.6 878.9 891.0 5530.6 5542.6 5566.9 5586.9 5757.2 422.8 434.8 438.8 438.9 442.1 3115.3 3709.2 3856.8 3873.7 3889.8 10494.2 10752.9 10958.1 10964.2 11040.6 10875.4 10893.7 10895.9 10931.7 10980.1 7617.8 8047.7 8179.3 8223.2 8373.5 5540.8 5603.8 5698.7 5768.5 5795.5 9884.7 9956.5 10086.3 10122.4 10236.3 8798.7 10029.3 10239.4 10457.4 10625.4 7105.7 7339.4 7348.2 7601.1 7748.5 8649.1 8655.7 8740.9 8744.9 8772.2 7729.1 7746.2 7758.5 7796.3 7833.9 7537.0 7621.7 7654.5 7665.8 7721.9 7086.0 7133.0 7199.5 7239.1 7263.9 4654.2 4800.1 4814.7 4836.4 5041.6 4204.3 4870.0 4874.1 4965.7 5062.2 07:11:51 INFO - PROCESS | 1665 | 07:11:51 INFO - PROCESS | 1665 | [#4] prototype.html Cycles:180 Average:4602.36 Median:5215.63 stddev:1451.55 (27.8%) stddev-sans-first:1419.15 07:11:51 INFO - PROCESS | 1665 | Values: 294.7 297.1 298.9 305.1 311.3 4818.9 4870.4 5362.0 5403.4 5414.9 5002.5 5139.6 5188.7 5208.5 5312.5 3884.9 4001.2 4014.5 4015.4 4045.1 3352.2 3570.0 4071.5 4078.0 4101.9 3346.5 3898.5 3990.4 4039.3 4056.2 4052.2 4061.8 4071.6 4081.6 4098.4 3404.3 3492.1 3538.2 3558.4 3570.6 4000.0 5183.6 5227.0 5228.4 5231.5 3941.6 4431.8 4636.5 4679.7 4681.5 4515.8 5424.8 5568.4 5622.6 5624.8 3781.7 3951.6 3956.1 3964.0 3989.5 5536.9 5571.6 5803.7 5884.7 5914.4 3090.9 3516.3 3812.8 3966.6 4008.1 3425.5 3432.5 4050.1 4061.2 4070.6 4296.7 4614.3 4663.6 4692.2 4709.9 4885.6 5695.5 5699.6 5702.8 5752.6 1066.5 1155.0 1237.6 1327.1 1364.4 840.9 862.4 864.5 867.4 896.0 4436.7 4907.0 5094.9 5208.6 5234.6 5711.5 5725.2 5743.5 5758.4 5783.1 4958.6 5138.8 5222.7 5260.5 5267.6 2762.8 2772.5 2997.0 3017.3 3039.2 5654.9 5910.3 5915.4 5931.3 5942.6 5596.5 5902.3 6034.4 6034.8 6044.7 6049.7 6059.9 6102.3 6206.4 6215.1 4887.4 5547.5 5805.2 5922.8 5975.7 5771.4 5781.2 5803.1 5832.9 5839.4 5881.6 6119.8 6136.3 6191.6 6191.7 3838.2 3901.8 3913.9 3914.0 3928.2 5856.4 5894.6 5904.5 5934.8 5947.8 5425.2 5477.5 5707.3 5748.7 5753.4 5641.5 5653.0 5657.6 5662.1 5683.5 5183.8 5325.0 5512.0 5587.6 5659.3 5024.2 5026.5 5634.6 5650.4 5709.3 4484.0 5527.4 5553.8 5563.3 5606.9 07:11:51 INFO - PROCESS | 1665 | 07:11:51 INFO - PROCESS | 1665 | [#5] yui.html Cycles:180 Average:26007.50 Median:3550.82 stddev:42654.22 (1201.3%) stddev-sans-first:42731.57 07:11:51 INFO - PROCESS | 1665 | Values: 706.5 794.6 803.8 806.1 807.6 14917.1 15544.4 15590.2 16359.0 16375.5 14948.0 14982.5 15190.9 15199.3 15200.6 659.2 674.9 809.5 831.4 833.2 673.6 818.7 837.5 847.3 850.2 849.7 862.1 880.8 884.2 886.4 686.0 879.1 879.9 879.9 881.7 518.7 629.6 645.3 649.6 651.7 14872.7 14902.8 14931.6 14946.2 14946.2 13793.7 14047.4 14074.3 14106.3 14450.0 10636.5 12182.6 12430.4 12961.5 12963.9 4525.6 4534.6 4540.5 4721.0 4733.1 121678.4 122653.0 123235.0 124702.8 129359.0 9811.7 10058.5 10232.8 10243.4 10436.7 19083.5 19150.5 19246.3 19300.9 19302.4 7783.5 7856.9 7888.6 7904.8 8017.0 4272.5 4348.9 4350.7 4354.5 4355.2 3530.1 3571.5 3591.1 3596.7 3636.9 658.8 711.9 735.5 757.1 759.7 491.7 621.0 637.7 682.5 683.4 7664.3 9779.2 9795.1 9825.9 9978.9 635.1 638.8 659.5 671.5 677.5 4446.9 4676.3 4676.6 4682.8 4800.3 104452.4 147310.3 150177.0 154808.7 156055.0 123166.0 140260.0 145791.5 146601.0 147598.3 123910.4 125563.0 127444.0 128305.0 128768.1 8746.7 9084.1 9113.2 9172.7 9210.4 61756.0 66103.7 66384.0 68568.7 69199.6 88207.0 99117.5 99763.0 104599.0 109878.0 11854.9 11946.8 11989.3 12093.6 12522.6 12354.9 12696.0 13107.3 13491.4 13674.7 12428.9 12462.4 12467.9 12494.8 13030.1 12255.4 12353.0 12380.6 12539.2 12958.0 11788.5 12135.3 12261.6 12401.6 12835.1 9557.9 10160.5 10588.8 10746.6 10779.8 10001.7 10712.9 10732.4 10743.1 10759.6 07:11:51 INFO - PROCESS | 1665 | -------- Summary: end -------- 07:11:51 INFO - PROCESS | 1665 | 07:11:51 INFO - TEST-INFO | 1665: exit 0 07:11:51 INFO - TEST-OK | dromaeo_css | took 1117159ms 07:11:51 INFO - TEST-START | kraken 07:11:51 INFO - operating with platform_type : mac_ 07:11:51 INFO - Initialising browser for kraken test... 07:11:51 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpEADDdB/profile http://localhost:49277/getInfo.html) 07:11:53 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 07:11:53 INFO - PROCESS | 1673 | colorDepth:24 07:11:53 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 07:11:53 INFO - PROCESS | 1673 | __metrics 07:11:53 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:11:53 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:11:54 INFO - TEST-INFO | 1673: exit 0 07:11:54 INFO - Browser initialized. 07:11:54 INFO - Running cycle 1/1 for kraken test... 07:11:54 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmpEADDdB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:12:06 INFO - PROCESS | 1674 | RSS: Main: 219832320 07:12:06 INFO - PROCESS | 1674 | 07:12:09 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 07:12:10 INFO - PROCESS | 1674 | RSS: Main: 269991936 07:12:10 INFO - PROCESS | 1674 | 07:12:12 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 07:12:13 INFO - PROCESS | 1674 | RSS: Main: 281219072 07:12:13 INFO - PROCESS | 1674 | 07:12:16 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 07:12:17 INFO - PROCESS | 1674 | RSS: Main: 376512512 07:12:17 INFO - PROCESS | 1674 | 07:12:19 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 07:12:19 INFO - PROCESS | 1674 | RSS: Main: 280903680 07:12:19 INFO - PROCESS | 1674 | 07:12:21 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:12:22 INFO - PROCESS | 1674 | RSS: Main: 281751552 07:12:22 INFO - PROCESS | 1674 | 07:12:25 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 07:12:25 INFO - PROCESS | 1674 | RSS: Main: 317976576 07:12:25 INFO - PROCESS | 1674 | 07:12:28 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 07:12:29 INFO - PROCESS | 1674 | RSS: Main: 319565824 07:12:29 INFO - PROCESS | 1674 | 07:12:32 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 07:12:32 INFO - PROCESS | 1674 | RSS: Main: 318488576 07:12:32 INFO - PROCESS | 1674 | 07:12:34 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:12:35 INFO - PROCESS | 1674 | RSS: Main: 291966976 07:12:35 INFO - PROCESS | 1674 | 07:12:36 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:12:37 INFO - PROCESS | 1674 | RSS: Main: 299024384 07:12:37 INFO - PROCESS | 1674 | 07:12:39 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:12:40 INFO - PROCESS | 1674 | RSS: Main: 302911488 07:12:40 INFO - PROCESS | 1674 | 07:12:43 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:12:44 INFO - PROCESS | 1674 | RSS: Main: 310788096 07:12:44 INFO - PROCESS | 1674 | 07:12:47 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:12:47 INFO - PROCESS | 1674 | RSS: Main: 310558720 07:12:47 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 07:12:49 INFO - PROCESS | 1674 | RSS: Main: 355086336 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | __start_tp_report 07:12:49 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 07:12:49 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 07:12:49 INFO - PROCESS | 1674 | |i|pagename|runs| 07:12:49 INFO - PROCESS | 1674 | |0;ai-astar;116;115;115;113;115;115;114;113;114;114 07:12:49 INFO - PROCESS | 1674 | |1;audio-beat-detection;143;110;112;139;128;135;138;108;140;111 07:12:49 INFO - PROCESS | 1674 | |2;audio-dft;180;184;185;183;185;182;183;184;187;182 07:12:49 INFO - PROCESS | 1674 | |3;audio-fft;82;59;59;89;59;60;73;81;105;78 07:12:49 INFO - PROCESS | 1674 | |4;audio-oscillator;87;70;93;70;67;71;116;94;96;98 07:12:49 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;118;126;102;85;89;85;90;88;88;85 07:12:49 INFO - PROCESS | 1674 | |6;imaging-darkroom;95;93;95;95;94;95;95;95;93;96 07:12:49 INFO - PROCESS | 1674 | |7;imaging-desaturate;94;97;85;86;87;86;84;84;86;103 07:12:49 INFO - PROCESS | 1674 | |8;json-parse-financial;56;53;53;53;56;56;56;57;56;56 07:12:49 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;65;76;66;83;76;74;70;70;70;71 07:12:49 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;84;85;82;85;83;79;80;80;86;82 07:12:49 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;132;142;120;151;150;150;159;143;204;153 07:12:49 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;159;218;226;171;165;167;180;207;165;164 07:12:49 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;66;66;68;67;67;68;66;67;66;67 07:12:49 INFO - PROCESS | 1674 | __end_tp_report 07:12:49 INFO - PROCESS | 1674 | __start_cc_report 07:12:49 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,2009 07:12:49 INFO - PROCESS | 1674 | __end_cc_report 07:12:49 INFO - PROCESS | 1674 | __startTimestamp1479136369629__endTimestamp 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | ------- Summary: start ------- 07:12:49 INFO - PROCESS | 1674 | Number of tests: 14 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:0.97 (0.8%) stddev-sans-first:0.83 07:12:49 INFO - PROCESS | 1674 | Values: 116.0 115.0 115.0 113.0 115.0 115.0 114.0 113.0 114.0 114.0 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:126.40 Median:136.50 stddev:14.46 (10.6%) stddev-sans-first:14.04 07:12:49 INFO - PROCESS | 1674 | Values: 143.0 110.0 112.0 139.0 128.0 135.0 138.0 108.0 140.0 111.0 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.96 (1.1%) stddev-sans-first:1.62 07:12:49 INFO - PROCESS | 1674 | Values: 180.0 184.0 185.0 183.0 185.0 182.0 183.0 184.0 187.0 182.0 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:74.50 Median:75.50 stddev:15.58 (20.6%) stddev-sans-first:16.29 07:12:49 INFO - PROCESS | 1674 | Values: 82.0 59.0 59.0 89.0 59.0 60.0 73.0 81.0 105.0 78.0 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:86.20 Median:90.00 stddev:16.18 (18.0%) stddev-sans-first:17.16 07:12:49 INFO - PROCESS | 1674 | Values: 87.0 70.0 93.0 70.0 67.0 71.0 116.0 94.0 96.0 98.0 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:95.60 Median:86.50 stddev:14.89 (17.2%) stddev-sans-first:13.40 07:12:49 INFO - PROCESS | 1674 | Values: 118.0 126.0 102.0 85.0 89.0 85.0 90.0 88.0 88.0 85.0 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 07:12:49 INFO - PROCESS | 1674 | Values: 95.0 93.0 95.0 95.0 94.0 95.0 95.0 95.0 93.0 96.0 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:89.20 Median:86.00 stddev:6.51 (7.6%) stddev-sans-first:6.67 07:12:49 INFO - PROCESS | 1674 | Values: 94.0 97.0 85.0 86.0 87.0 86.0 84.0 84.0 86.0 103.0 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:1.55 (2.8%) stddev-sans-first:1.62 07:12:49 INFO - PROCESS | 1674 | Values: 56.0 53.0 53.0 53.0 56.0 56.0 56.0 57.0 56.0 56.0 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:72.50 stddev:5.32 (7.3%) stddev-sans-first:4.99 07:12:49 INFO - PROCESS | 1674 | Values: 65.0 76.0 66.0 83.0 76.0 74.0 70.0 70.0 70.0 71.0 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.50 stddev:2.41 (2.9%) stddev-sans-first:2.51 07:12:49 INFO - PROCESS | 1674 | Values: 84.0 85.0 82.0 85.0 83.0 79.0 80.0 80.0 86.0 82.0 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:150.40 Median:150.50 stddev:21.97 (14.6%) stddev-sans-first:22.27 07:12:49 INFO - PROCESS | 1674 | Values: 132.0 142.0 120.0 151.0 150.0 150.0 159.0 143.0 204.0 153.0 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:175.50 stddev:25.03 (14.3%) stddev-sans-first:25.10 07:12:49 INFO - PROCESS | 1674 | Values: 159.0 218.0 226.0 171.0 165.0 167.0 180.0 207.0 165.0 164.0 07:12:49 INFO - PROCESS | 1674 | 07:12:49 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 07:12:49 INFO - PROCESS | 1674 | Values: 66.0 66.0 68.0 67.0 67.0 68.0 66.0 67.0 66.0 67.0 07:12:49 INFO - PROCESS | 1674 | -------- Summary: end -------- 07:12:49 INFO - PROCESS | 1674 | 07:12:50 INFO - TEST-INFO | 1674: exit 0 07:12:50 INFO - TEST-OK | kraken | took 58932ms 07:12:50 INFO - SUITE-END | took 1176s 07:12:50 INFO - Completed test suite (00:19:36) 07:12:50 INFO - javascript benchmark 07:12:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2918.7810914181437, 3304.7356211503075, 3344.7993120412793, 3374.325134973003, 3379.79721216727, 5656.57575681824, 5734.111212762024, 5747.166660834177, 5747.626404283718, 5765.942340576587, 5628.831135065944, 5658.830235092953, 5687.090065589507, 5692.37383887773, 5707.714614269291, 5156.716380599066, 5203.765830537635, 5207.765650545734, 5216.139337009407, 5274.208868669711, 5154.433012368637, 5163.1480805667015, 5174.042802081608, 5273.736313184345, 5340.332458442695, 5204.29741984831, 5215.817446389377, 5259.237410575464, 5260.789568417259, 5271.947280527184, 5246.50158234969, 5275.076861549252, 5294.682319060868, 5297.894042119175, 5311.256424100629, 5120.257562653432, 5126.282320475137, 5228.5555727763185, 5230.21546767984, 5231.424543300234, 4698.553637404441, 5601.411851755588, 5650.406707295757, 5666.263385759866, 5726.656400615935, 6127.5710700251, 6179.5674302798825, 6192.28788689302, 6251.4061164189325, 6268.905966410507, 6212.9068063979075, 6249.937500624981, 6287.905681414737, 6295.937040629581, 6306.747730090791, 5670.3479099903625, 5718.714064296769, 5730.656160630376, 5753.0, 5805.796797112081, 5283.709395983258, 6234.9688251558455, 6264.843378915563, 6272.843178920563, 6276.592021518587, 6175.722092505848, 6176.104464852571, 6180.47465965389, 6207.906881396782, 6225.408586184305, 5602.215689803431, 5841.707914604338, 6091.573589848668, 6129.48104857405, 6250.218722659668, 6136.693165341715, 6172.197614310201, 6183.721732522047, 6256.280527739277, 6259.78090766821, 6236.812895613139, 6264.59280146789, 6276.874462510816, 6279.215098112736, 6281.780137695158, 4855.490173531728, 4913.434954980152, 4968.875778105504, 4977.527134922177, 4996.875078123076, 4378.299472084451, 4406.1187762447635, 4450.821967121279, 4477.28363461851, 4477.619402350771, 5826.941730582725, 5827.125931110368, 5839.591228613956, 5846.8538286542325, 5852.7658893643775, 6289.905651415233, 6295.811125666238, 6307.432331090224, 6315.210598675166, 6326.841828954313, 5640.379558248589, 5680.375158732536, 5705.001624715741, 5784.248047753849, 5825.825225243249, 5357.116075847442, 5370.865728356823, 5436.320459942507, 5444.373897001896, 5491.258680078138, 6297.0, 6319.557630965788, 6324.494040476843, 6327.829351569974, 6341.270753863365, 6118.314626315779, 6223.253209614875, 6279.272329094502, 6297.0, 6304.432601065926, 6201.6899155041165, 6226.40849119333, 6241.3134555197985, 6244.2819075806865, 6321.462675672619, 6147.784827531015, 6178.042403427476, 6195.4424101831055, 6212.689365531615, 6233.563650544418, 6171.7531298749345, 6210.3168651449205, 6266.060090986389, 6269.843253918689, 6275.905861412174, 5034.421041580119, 5888.146218798336, 5909.586328957103, 5984.551158663205, 6086.0, 6118.174046503665, 6123.785667501616, 6129.417705318166, 6136.2636483622255, 6141.692915354304, 5964.224650795542, 5966.015607424726, 5975.521958243417, 5980.312264089685, 6008.1588577598295, 5897.115432685132, 6018.578699490994, 6031.306399763907, 6081.361457046946, 6114.724837382418, 5936.762529498772, 5940.3168635605725, 5952.017917043812, 5952.821415357546, 5967.492763115184], "value": 5684.6185955716555, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.5879061588265, 523.549747217393, 530.5834919588124, 537.1807992810963, 540.9829520501456, 27732.86133569332, 41176.38235426467, 42207.522736704224, 42446.57553424465, 44745.32882006765, 43629.0, 44007.0, 44034.11931761371, 44102.0, 44139.77930110353, 8649.913500865005, 9825.50872456376, 10014.799704005916, 10021.699349019542, 10054.396736195851, 8845.20393164615, 9075.455472671627, 11881.881181188164, 12249.0, 12293.754124917541, 12316.507339706446, 12386.442610082568, 12412.75174496514, 12413.317267550281, 12413.379331033457, 12317.568885089024, 12400.56598019074, 12406.875931240662, 12434.253944763297, 12435.626931192079, 10198.388096714147, 12147.210431321935, 12172.878271217263, 12176.330301833395, 12181.756364872741, 40938.18123637541, 41168.97077573085, 41188.79405602983, 41196.38205426891, 41257.587424125675, 3327.3012667339644, 3465.4455287154187, 3850.2876967761053, 3859.4982652255308, 3961.2869683456966, 24434.755652443426, 30392.93624723146, 31956.20109497258, 32252.516212256836, 32743.0, 3224.871005159791, 3240.4329242382723, 3266.4936934775146, 3296.2748195396975, 3378.189234583707, 516983.0, 518735.2189717157, 518901.6219675585, 519569.0, 521782.3910880459, 33783.66216337854, 34193.97418077462, 34405.82797085999, 62302.68848655728, 62486.75026499444, 35802.28395432077, 35968.28063438716, 35973.0, 36067.0, 36089.0, 14759.0, 14831.258437078102, 15218.239088045553, 15332.616684582974, 15345.769813452807, 11708.414579271002, 11928.284302941851, 12936.288504132175, 13068.346582670829, 13077.607671769862, 7419.109706835215, 7658.081030276291, 7832.216778322122, 7839.25527074927, 7884.093329267093, 3140.4661207594763, 3165.7467402607735, 3186.1875221818286, 3208.5508028875975, 3230.935381292361, 972.2513664478312, 1061.1192710050639, 1062.1555863088709, 1078.5254488025244, 1104.3600253623363, 30421.23946901301, 30517.542236866466, 30618.38763224723, 31264.531032034538, 31291.374172516877, 966.7534778631403, 1065.472591067411, 1124.7581769919507, 1127.7857207130783, 1181.7695549367963, 15456.84543154554, 15486.0, 15838.12890291022, 15951.44169954046, 15957.601059973362, 695630.0, 702659.0, 703180.0, 703592.0, 704614.4769276121, 59163.0, 59669.701651491465, 59756.70121649364, 59809.10286345621, 59940.40059599435, 1237.9257244565356, 1270.0791925853866, 1304.1327517200955, 1358.7146699193281, 1394.0, 25585.744142558335, 31344.373112537167, 31522.684773151974, 31815.979420066174, 32048.839755801073, 50907.72730681763, 51500.742496287276, 51544.96910061853, 51589.742051289504, 51593.48406515887, 549814.0, 551344.0, 551694.0, 551718.0, 551793.2410337923, 26885.596716049666, 27172.864135679196, 27565.448691025667, 27566.5865012021, 28504.714952851034, 47698.52301476941, 47786.76106619445, 47861.76069119632, 47880.0, 48660.75669621629, 39664.2067158661, 40156.59451919169, 40530.39204411995, 41006.58993410028, 42033.0, 36107.0, 39418.60581394264, 40228.79313620596, 40618.55259092413, 41563.168736624495, 37500.624993750804, 38954.0, 39128.804355978034, 39264.41103383509, 39269.6073039266, 33932.151696207795, 34940.0, 35105.29789404249, 35803.46294805632, 35982.4602630966, 23530.176443824384, 25575.48849022972, 25811.88153327469, 26119.0, 26486.602700959887], "value": 19344.626336545884, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.2422952766318, 369.3554746966543, 378.3397970541407, 383.28517315207137, 401.62046865711915, 14988.700225995473, 15077.849221507782, 16454.532351932583, 21199.68200476994, 21255.0, 16720.331186752544, 20184.89907550464, 21032.05355758991, 21057.57884842302, 21167.470813229676, 4628.773375055613, 5957.255343082125, 6207.162033125515, 6209.658468784215, 6226.3462336454695, 5755.45323194298, 6098.32918378978, 6143.0, 6191.226096737908, 6209.130721698965, 5811.6803575803315, 6014.5188384929315, 6073.544484163684, 6154.076888466743, 6163.845903852395, 6059.121427393025, 6081.087836824468, 6115.510759139258, 6123.755049798003, 6127.0, 5076.390833100052, 5275.419703832576, 5315.7873685052555, 5327.733613319358, 5343.225232341328, 26117.82469788845, 26240.21279361622, 26256.0, 26354.341141471425, 26694.0, 2373.0982226753895, 2411.7588241175918, 2797.104926423525, 3180.3957248122783, 3216.8713251469912, 15860.0, 15939.521814345588, 16057.875948683597, 16539.66920661592, 16716.41492547767, 1891.7635295588052, 1893.1196993397998, 1899.9145038473303, 1908.9574155653456, 1910.6560819052565, 103077.0, 117118.41440792827, 123274.76725232722, 124722.0, 127784.0, 8026.719064832703, 9709.504578351787, 11179.552817887194, 11187.0, 11376.089912806956, 11652.883471165349, 13820.239886806323, 13828.516001939885, 13847.099938503965, 13911.30443477822, 8562.871556926651, 8829.646814127364, 8898.0, 8985.326100542485, 8997.730068097837, 9018.59416326267, 9019.32355073359, 9054.366194366463, 9208.677696280598, 9220.631174752934, 5581.274434323512, 6609.107770450928, 6734.696938637773, 6739.865202695919, 6758.493113016543, 1623.4399132299575, 1812.4109664359137, 1843.787964384113, 1850.3986204483597, 1878.0, 899.3929097858919, 913.4473643445752, 943.6838659049158, 972.1639390124487, 1015.746063484129, 21145.0, 22617.660735088986, 22647.773522264895, 22664.320070397913, 22682.43293917665, 919.7194855569115, 947.6967370441392, 972.5769290358717, 987.5161171026289, 988.2242439684813, 11310.773784524263, 11635.0, 12006.099542534344, 12023.398830058462, 12034.157608967464, 594750.0, 603637.0, 616255.0, 629650.0, 631520.0, 74537.0, 97197.0, 100329.0, 116291.41854290674, 122450.0, 999.7600575861741, 1026.958921643126, 1078.7680648660576, 1082.4804094034907, 1086.8098082835472, 19948.0, 20032.399028029184, 20587.691184632542, 20654.586908262052, 20692.0, 50704.0, 50969.23546146737, 51127.48872511227, 51449.0, 52590.0, 70245.64877175582, 71783.64108179425, 74062.0, 75057.62471187828, 76729.61635191788, 7947.245011723877, 7955.24425179607, 8170.264676179172, 8231.917680823115, 8472.915270847212, 12999.740005200032, 13431.395587198404, 13517.932410337886, 13829.239391833546, 13919.512817051354, 5321.973390133025, 9422.340436169403, 11463.656090317303, 11711.180217385043, 11943.880561194277, 10745.817960024235, 11152.330860148417, 11160.051395631137, 11641.359725215194, 11742.88257117418, 5724.4561766632105, 6273.749050037947, 10863.098957682216, 11241.325520468798, 11585.594504192313, 7920.881186782318, 8019.0, 8089.393295502979, 8189.653033783797, 8274.255317021256, 10965.232433729563, 11268.475052145937, 11417.429128543707, 11563.537458501565, 11631.59289424866], "value": 9763.95381865214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.0972811449074, 1511.9168445735484, 1678.5467923660613, 1837.7059670452722, 1844.0871768474608, 8568.100349463302, 9084.09159084092, 9087.727368178965, 9087.954560227206, 9089.59096840642, 7866.763997080083, 8153.8776918346275, 8154.6330415131315, 8194.91805081949, 8200.0, 1824.9726254106165, 2351.6007975254697, 2433.0754313360985, 2446.0460420436043, 2452.2765784093735, 2400.6399040143942, 2412.5416170927556, 2428.0651948999584, 2432.586460301753, 2438.195395519483, 2430.8419952703016, 2432.1122790181544, 2434.2332165367943, 2437.524682686877, 2437.549053425122, 2393.652920326552, 2422.9636555451684, 2426.308502076917, 2427.526632306692, 2433.1362366359863, 2079.334612923865, 2318.721753389604, 2397.568437681217, 2398.82008849337, 2399.784019438259, 8923.643054277822, 8963.014068452465, 9038.412503187272, 9038.683646072423, 9042.728718138467, 5294.841154765363, 5470.124780035215, 5476.096444086721, 5480.314960629921, 5487.341519017704, 3387.8475468603974, 3623.800690961996, 3715.9628403715888, 3777.452269420946, 3784.7161462890394, 1035.6116456328878, 1104.618906477264, 1108.3793075877534, 1125.1055410948316, 1127.949242284091, 11538.0, 11680.123990700646, 11690.41547922609, 11723.237989530739, 11742.47158877844, 4622.375979242759, 4671.0, 4728.219843725747, 4735.479097299294, 4914.5822605078965, 10162.03460671235, 10168.135708464863, 10172.491375431198, 10173.54219060144, 10175.44035078063, 5455.099908515051, 5457.481539253765, 5457.6452530586175, 5457.727113644302, 5461.290032295776, 4881.633877459205, 4935.185231296348, 4957.380327459067, 4984.950150498448, 4986.55121039101, 4025.3358195897936, 4039.4748682671066, 4077.103037331782, 4134.069834287321, 4145.108801607669, 1293.236990175782, 1298.6558561981083, 1305.4973835073565, 1318.156379916854, 1323.3184909771476, 820.0774129104757, 835.5655059369094, 842.614193124784, 878.8925953298761, 890.9976276688725, 5530.640508366943, 5542.63972841764, 5566.942280966603, 5586.86032849182, 5757.165211044375, 422.75902735441116, 434.82172309353643, 438.8485972339538, 438.8551777913281, 442.09591385616494, 3115.3146307812244, 3709.2025214578994, 3856.8457261709777, 3873.7288389812443, 3889.8444062237195, 10494.212934029825, 10752.892471075345, 10958.068564172134, 10964.177686673373, 11040.558377664964, 10875.401852898167, 10893.727656808485, 10895.945520272347, 10931.726706832393, 10980.066694331072, 7617.847643047219, 8047.718329858427, 8179.345652347798, 8223.21879421454, 8373.539455329894, 5540.833774986757, 5603.7758489659955, 5698.6580805151825, 5768.480836724715, 5795.478406943395, 9884.703458896245, 9956.452395118338, 10086.29395942277, 10122.392656440637, 10236.33463824849, 8798.736037918872, 10029.29794914349, 10239.385636861813, 10457.372557646566, 10625.415602141957, 7105.680244389118, 7339.376153027052, 7348.191698913222, 7601.12587052496, 7748.496347737379, 8649.091845356146, 8655.740327790176, 8740.868886966573, 8744.912550874664, 8772.166644168794, 7729.149793522595, 7746.186650401627, 7758.495697779626, 7796.259355361231, 7833.882491762742, 7537.0, 7621.657025433758, 7654.502457340255, 7665.808354791175, 7721.92278077212, 7085.964570177116, 7132.964335178291, 7199.532030418006, 7239.095113110861, 7263.854722905407, 4654.185517534485, 4800.1119792838435, 4814.721327216012, 4836.443808962014, 5041.571466425395, 4204.264253755519, 4869.951300487091, 4874.073925954058, 4965.726885021359, 5062.164742817394], "value": 4525.422116348759, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.6949906846413, 297.1101550855189, 298.87297898393206, 305.0908293286008, 311.2902582112782, 4818.939833236686, 4870.41555013398, 5362.0, 5403.378611459683, 5414.945850541493, 5002.549770520653, 5139.640225184229, 5188.688678679282, 5208.5051920067535, 5312.495312945273, 3884.9223015539674, 4001.239764444746, 4014.4781178446833, 4015.4177644241568, 4045.110075783323, 3352.2457447074335, 3569.982150089246, 4071.4707088078508, 4078.021274894019, 4101.9179616407655, 3346.5482159908343, 3898.4737060496896, 3990.361542153256, 4039.333509970866, 4056.249593825152, 4052.2098190852794, 4061.7969101544804, 4071.5928407159345, 4081.551069358376, 4098.360655737699, 3404.3021180657906, 3492.0746002309406, 3538.221591249921, 3558.395072837598, 3570.589382221052, 4000.0, 5183.559397451221, 5226.97386513065, 5228.372595288552, 5231.476852314776, 3941.6452519273116, 4431.756253406062, 4636.53634636537, 4679.672422930396, 4681.485036645966, 4515.774211289422, 5424.83725488232, 5568.415316391802, 5622.634528755618, 5624.831255062355, 3781.735278530504, 3951.6245956634075, 3956.0703234739813, 3963.960360396388, 3989.5412027616903, 5536.861578460531, 5571.637843540157, 5803.65178089316, 5884.6763428011445, 5914.408559144094, 3090.90727278182, 3516.331896939573, 3812.8093595320124, 3966.5835087315995, 4008.118213992917, 3425.4861770734587, 3432.5366075579977, 4050.0887300357185, 4061.248668996245, 4070.61329173728, 4296.742195468282, 4614.261718125151, 4663.626909847272, 4692.155412025868, 4709.905801883943, 4885.60915126789, 5695.515881150066, 5699.629524080921, 5702.771889124471, 5752.568557358215, 1066.4987455895716, 1154.9595764148214, 1237.6472705278952, 1327.057788969823, 1364.4269406849148, 840.9369297302604, 862.4049405910027, 864.4942708515463, 867.3538214030588, 895.9596818143199, 4436.711613745097, 4906.950930490721, 5094.923576146361, 5208.583313334924, 5234.586661601346, 5711.543076553866, 5725.227094342294, 5743.4543718346695, 5758.395368486249, 5783.132530120515, 4958.603311735053, 5138.794448222104, 5222.67590922036, 5260.526552610283, 5267.604929630216, 2762.7513523782955, 2772.50094982905, 2996.9700302997126, 3017.336186039068, 3039.2098054505545, 5654.915176272277, 5910.320313163955, 5915.438033386821, 5931.258592675916, 5942.58401911862, 5596.468335508121, 5902.321233058167, 6034.366391528826, 6034.818955431344, 6044.667543285073, 6049.697515124226, 6059.878802423927, 6102.298235702951, 6206.355315841396, 6215.098810672517, 4887.3890763654545, 5547.531348549856, 5805.187273781589, 5922.7927022554, 5975.671338076448, 5771.422857714195, 5781.219535362672, 5803.129530570448, 5832.94167058324, 5839.416058394297, 5881.647221139247, 6119.755209791559, 6136.325004249618, 6191.566590338633, 6191.690415479298, 3838.2323535292494, 3901.8439262429183, 3913.941290880696, 3913.9804300978312, 3928.2339943711845, 5856.355800861987, 5894.587378883437, 5904.498117660047, 5934.762609495745, 5947.821565353046, 5425.159100339453, 5477.534409575231, 5707.315122185364, 5748.6550806950045, 5753.424657534213, 5641.461342395856, 5653.0, 5657.632253903483, 5662.122371032497, 5683.465464324692, 5183.792648294177, 5324.9733751331, 5512.003797246964, 5587.55299576041, 5659.320881494247, 5024.196128619404, 5026.547610715053, 5634.605577609528, 5650.406707295675, 5709.286339207599, 4483.977580112079, 5527.397054854047, 5553.805616803393, 5563.304586926634, 5606.859828504157], "value": 4129.242114791847, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.480736658556, 794.5884241327572, 803.774943015955, 806.1011971651607, 807.571986846971, 14917.104973701573, 15544.378224870992, 15590.220488975534, 16359.0, 16375.508734737961, 14948.0, 14982.475613353508, 15190.924045379757, 15199.316030778615, 15200.619984500394, 659.1826135591856, 674.8549061951679, 809.5142914251446, 831.42631584207, 833.2251006563923, 673.6093066021721, 818.7420962396856, 837.530982649715, 847.2501835875264, 850.2135524639715, 849.7238397520799, 862.0517430826072, 880.7621942075635, 884.1600479544427, 886.3839631456141, 685.9828504287433, 879.0681877210146, 879.8680197970356, 879.8812160358366, 881.6737807011383, 518.7224834713448, 629.5939119268093, 645.33852800879, 649.6264647827518, 651.7490766055056, 14872.70254594902, 14902.776458353133, 14931.552053438305, 14946.177960212184, 14946.177960212184, 13793.655158621015, 14047.367868445945, 14074.2962851857, 14106.294685265799, 14450.0, 10636.521356538897, 12182.573609923611, 12430.440630171664, 12961.546345877943, 12963.935180324132, 4525.637948964075, 4534.6372290216705, 4540.500544940054, 4720.976395118037, 4733.0533893221145, 121678.39160804139, 122653.0, 123235.0, 124702.75297247001, 129359.0, 9811.705648830546, 10058.497075146213, 10232.846507302396, 10243.436610986319, 10436.73908152287, 19083.522911927033, 19150.521236968907, 19246.326378576683, 19300.90349548243, 19302.4209273722, 7783.494072885244, 7856.921430785734, 7888.6450109744055, 7904.762857114296, 8017.0, 4272.46594175728, 4348.913021739548, 4350.651947844165, 4354.521002689701, 4355.15074560464, 3530.099824544776, 3571.5357003589365, 3591.066322756102, 3596.6762991330384, 3636.945445818315, 658.8418779492887, 711.9394851437582, 735.5182355557118, 757.1293013035054, 759.673340463606, 491.6509278412296, 620.9875802484015, 637.6684124255454, 682.5085938124543, 683.4225079807554, 7664.271894170045, 9779.168770654433, 9795.118439340351, 9825.901740982641, 9978.900210997797, 635.1425575473074, 638.8275165705327, 659.4954859532462, 671.5265737654942, 677.5392732941647, 4446.866594002185, 4676.298555216745, 4676.579107880307, 4682.789274482657, 4800.3279540864305, 104452.43321350186, 147310.2634486842, 150177.0, 154808.71147731174, 156055.0, 123166.0, 140260.0, 145791.5420845799, 146601.0, 147598.26200868926, 123910.38044809719, 125563.0, 127444.0, 128305.0, 128768.06847897288, 8746.69386571467, 9084.137006984325, 9113.179813816789, 9172.6789562365, 9210.355275130676, 61756.0, 66103.66948165228, 66384.0, 68568.6571567139, 69199.61600768057, 88207.0, 99117.51323730005, 99763.0, 104599.0, 109878.0, 11854.881451185378, 11946.76106477883, 11989.34058626784, 12093.637190884288, 12522.561710340095, 12354.876451235372, 12696.04779641549, 13107.279099649611, 13491.392887319898, 13674.658133546742, 12428.875711242772, 12462.439190236642, 12467.87532124667, 12494.812577811159, 13030.08789384734, 12255.387230638611, 12353.0, 12380.62858114258, 12539.24764514132, 12958.0, 11788.479961679857, 12135.271883687006, 12261.570845020382, 12401.565945191875, 12835.101542892282, 9557.856632150384, 10160.542775575264, 10588.788224235626, 10746.601270450838, 10779.785659836058, 10001.749956251151, 10712.8928710715, 10732.409717465302, 10743.08683761889, 10759.623413180501], "value": 7788.67559438711, "unit": "score"}], "name": "dromaeo_css", "value": 7339.293763381931, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 113.0, 115.0, 115.0, 114.0, 113.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 112.0, 139.0, 128.0, 135.0, 138.0, 108.0, 140.0, 111.0], "value": 126.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 184.0, 185.0, 183.0, 185.0, 182.0, 183.0, 184.0, 187.0, 182.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 59.0, 89.0, 59.0, 60.0, 73.0, 81.0, 105.0, 78.0], "value": 74.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 93.0, 70.0, 67.0, 71.0, 116.0, 94.0, 96.0, 98.0], "value": 86.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 126.0, 102.0, 85.0, 89.0, 85.0, 90.0, 88.0, 88.0, 85.0], "value": 95.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 93.0, 96.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 85.0, 86.0, 87.0, 86.0, 84.0, 84.0, 86.0, 103.0], "value": 89.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 53.0, 53.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 76.0, 66.0, 83.0, 76.0, 74.0, 70.0, 70.0, 70.0, 71.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 82.0, 85.0, 83.0, 79.0, 80.0, 80.0, 86.0, 82.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 142.0, 120.0, 151.0, 150.0, 150.0, 159.0, 143.0, 204.0, 153.0], "value": 150.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 218.0, 226.0, 171.0, 165.0, 167.0, 180.0, 207.0, 165.0, 164.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 67.0, 67.0, 68.0, 66.0, 67.0, 66.0, 67.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1473.7000000000003, "alertThreshold": 2.0}]} 07:12:50 INFO - Return code: 0 07:12:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:12:50 INFO - # TBPL SUCCESS # 07:12:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:12:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:12:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:12:50 INFO - 2016-11-14 07:12:50.954 screenresolution[1678:11165] starting screenresolution argv=screenresolution get 07:12:50 INFO - 2016-11-14 07:12:50.958 screenresolution[1678:11165] Display 0: 1600x1200x32@60 07:12:50 INFO - 2016-11-14 07:12:50.964 screenresolution[1679:11168] starting screenresolution argv=screenresolution list 07:12:50 INFO - Available Modes on Display 0 07:12:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:12:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:12:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:12:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:12:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:12:51 INFO - Intel Iris: 07:12:51 INFO - Chipset Model: Intel Iris 07:12:51 INFO - Type: GPU 07:12:51 INFO - Bus: Built-In 07:12:51 INFO - VRAM (Dynamic, Max): 1536 MB 07:12:51 INFO - Vendor: Intel (0x8086) 07:12:51 INFO - Device ID: 0x0a2e 07:12:51 INFO - Revision ID: 0x0009 07:12:51 INFO - Displays: 07:12:51 INFO - Display: 07:12:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:12:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:12:51 INFO - Display Serial Number: 1600x1200 60 07:12:51 INFO - Main Display: Yes 07:12:51 INFO - Mirror: Off 07:12:51 INFO - Online: Yes 07:12:51 INFO - Rotation: Supported 07:12:51 INFO - Return code: 0 07:12:51 INFO - Running post-action listener: _resource_record_post_action 07:12:51 INFO - [mozharness: 2016-11-14 15:12:51.210412Z] Finished run-tests step (success) 07:12:51 INFO - Running post-run listener: _resource_record_post_run 07:12:51 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 33356800; Write bytes: 666108416; Read time: 313; Write time: 2084 07:12:51 INFO - TinderboxPrint: CPU usage
53.3% 07:12:51 INFO - TinderboxPrint: I/O read bytes / time
33,356,800 / 313 07:12:51 INFO - TinderboxPrint: I/O write bytes / time
666,108,416 / 2,084 07:12:51 INFO - TinderboxPrint: CPU idle
2,258.8 (46.7%) 07:12:51 INFO - TinderboxPrint: CPU system
968.2 (20.0%) 07:12:51 INFO - TinderboxPrint: CPU user
1,610.7 (33.3%) 07:12:51 INFO - TinderboxPrint: Swap in / out
393,424,896 / 0 07:12:51 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355123712; Write bytes: 357842944; Read time: 27633; Write time: 707 07:12:51 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 32418816; Write bytes: 298103296; Read time: 299; Write time: 1343 07:12:51 INFO - Running post-run listener: _upload_blobber_files 07:12:51 INFO - Blob upload gear active. 07:12:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:12:51 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 07:12:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:12:52 INFO - (blobuploader) - INFO - Open directory for files ... 07:12:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:12:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:12:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:53 INFO - (blobuploader) - INFO - Done attempting. 07:12:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:12:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:12:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:54 INFO - (blobuploader) - INFO - Done attempting. 07:12:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:12:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:12:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:56 INFO - (blobuploader) - INFO - Done attempting. 07:12:56 INFO - (blobuploader) - INFO - Iteration through files over. 07:12:56 INFO - Return code: 0 07:12:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:12:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:12:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19d4fbcdc05ef883b17d2a752246fe5e261bba327409d9f61e711edb0fb3147b56a4bb5aa344b724bf6ea24fdbfa705eb4bf71b1916d8299347f12ff9a5e7e23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fac95c71bc420d05bc66823cd6ea957cccc11d27edbecef8855a1cf196ad52ba7402d43e0a7ab0c0ba0ea6633c5925053c8605ec44e499e94086dc376600b661", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24040a03fda224ada4e6ad3292f976b6c81b8506822539fbcf3bde45d196715d4e4d65c6297decc20ea3d27f75fe80da391453cd3d2fceddcdaf3b26a96983d6"} 07:12:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:12:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:12:56 INFO - Contents: 07:12:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19d4fbcdc05ef883b17d2a752246fe5e261bba327409d9f61e711edb0fb3147b56a4bb5aa344b724bf6ea24fdbfa705eb4bf71b1916d8299347f12ff9a5e7e23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fac95c71bc420d05bc66823cd6ea957cccc11d27edbecef8855a1cf196ad52ba7402d43e0a7ab0c0ba0ea6633c5925053c8605ec44e499e94086dc376600b661", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24040a03fda224ada4e6ad3292f976b6c81b8506822539fbcf3bde45d196715d4e4d65c6297decc20ea3d27f75fe80da391453cd3d2fceddcdaf3b26a96983d6"} 07:12:56 INFO - Running post-run listener: copy_logs_to_upload_dir 07:12:56 INFO - Copying logs to upload dir... 07:12:56 INFO - mkdir: /builds/slave/test/build/upload/logs 07:12:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.172810 ========= master_lag: 2.62 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-14 07:12:59.406310) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:12:59.412164) ========= 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.ddTC5b9yHW/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.b4SnNv5TuW/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19d4fbcdc05ef883b17d2a752246fe5e261bba327409d9f61e711edb0fb3147b56a4bb5aa344b724bf6ea24fdbfa705eb4bf71b1916d8299347f12ff9a5e7e23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fac95c71bc420d05bc66823cd6ea957cccc11d27edbecef8855a1cf196ad52ba7402d43e0a7ab0c0ba0ea6633c5925053c8605ec44e499e94086dc376600b661", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24040a03fda224ada4e6ad3292f976b6c81b8506822539fbcf3bde45d196715d4e4d65c6297decc20ea3d27f75fe80da391453cd3d2fceddcdaf3b26a96983d6"} build_url:https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010613 build_url: 'https://queue.taskcluster.net/v1/task/Ueyvb9olRhS7NG9v_mKbCQ/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/19d4fbcdc05ef883b17d2a752246fe5e261bba327409d9f61e711edb0fb3147b56a4bb5aa344b724bf6ea24fdbfa705eb4bf71b1916d8299347f12ff9a5e7e23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fac95c71bc420d05bc66823cd6ea957cccc11d27edbecef8855a1cf196ad52ba7402d43e0a7ab0c0ba0ea6633c5925053c8605ec44e499e94086dc376600b661", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/24040a03fda224ada4e6ad3292f976b6c81b8506822539fbcf3bde45d196715d4e4d65c6297decc20ea3d27f75fe80da391453cd3d2fceddcdaf3b26a96983d6"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:12:59.456494) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-11-14 07:12:59.456775) ========= 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.ddTC5b9yHW/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.b4SnNv5TuW/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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.005213 ========= master_lag: 3.82 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-11-14 07:13:03.279973) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-11-14 07:13:03.280247) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-11-14 07:13:07.414904) ========= ========= Total master_lag: 6.57 =========