builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0071 starttime: 1479135103.99 results: success (0) buildid: 20161114021920 builduid: 34a00fa3aee34299865356c4ee83715c revision: 2d9b6132e7d75327e063a15d8e5e279077adf987 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:43.990364) ========= 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:43.990785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:43.991080) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:44.049427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:44.049869) ========= 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.QgkwKnHybB/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.H6bXBrpGxr/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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% 11.2M=0.001s 2016-11-14 06:51:44 (11.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.475969 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:44.549380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:44.549737) ========= 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.QgkwKnHybB/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.H6bXBrpGxr/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.019448 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:44.598324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 06:51:44.598711) ========= 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.QgkwKnHybB/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.H6bXBrpGxr/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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,676 truncating revision to first 12 chars 2016-11-14 06:51:44,677 Setting DEBUG logging. 2016-11-14 06:51:44,677 attempt 1/10 2016-11-14 06:51:44,677 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,943 unpacking tar archive at: mozilla-aurora-2d9b6132e7d7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.542168 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 06:51:46.166655) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:46.166932) ========= script_repo_revision: 2d9b6132e7d75327e063a15d8e5e279077adf987 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:46.167292) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:46.167549) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 06:51:46.185656) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-14 06:51:46.185970) ========= /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.QgkwKnHybB/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.H6bXBrpGxr/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:46 INFO - MultiFileLogger online at 20161114 06:51:46 in /builds/slave/test 06:51:46 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:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:51:46 INFO - {'append_to_log': False, 06:51:46 INFO - 'base_work_dir': '/builds/slave/test', 06:51:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:51:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:51:46 INFO - 'branch': 'Mozilla-Aurora', 06:51:46 INFO - 'buildbot_json_path': 'buildprops.json', 06:51:46 INFO - 'config_files': ('talos/mac_config.py',), 06:51:46 INFO - 'default_actions': ('clobber', 06:51:46 INFO - 'read-buildbot-config', 06:51:46 INFO - 'download-and-extract', 06:51:46 INFO - 'populate-webroot', 06:51:46 INFO - 'create-virtualenv', 06:51:46 INFO - 'install', 06:51:46 INFO - 'run-tests'), 06:51:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:51:46 INFO - 'download_minidump_stackwalk': True, 06:51:46 INFO - 'download_symbols': 'ondemand', 06:51:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:51:46 INFO - 'tooltool.py': '/tools/tooltool.py', 06:51:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:51:46 INFO - '/tools/misc-python/virtualenv.py')}, 06:51:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:51:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:51:46 INFO - 'installer_path': 'installer.exe', 06:51:46 INFO - 'log_level': 'info', 06:51:46 INFO - 'log_name': 'talos', 06:51:46 INFO - 'log_to_console': True, 06:51:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:51:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:51:46 INFO - 'opt_config_files': (), 06:51:46 INFO - 'pip_index': False, 06:51:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:51:46 INFO - 'cmd': ('bash', 06:51:46 INFO - '-c', 06:51:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:51:46 INFO - 'enabled': True, 06:51:46 INFO - 'halt_on_failure': False, 06:51:46 INFO - 'name': 'check_screen_resolution'},), 06:51:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:51:46 INFO - 'cmd': ('bash', 06:51:46 INFO - '-c', 06:51:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:51:46 INFO - 'enabled': True, 06:51:46 INFO - 'halt_on_failure': False, 06:51:46 INFO - 'name': 'check_screen_resolution'},), 06:51:46 INFO - 'run_cmd_checks_enabled': True, 06:51:46 INFO - 'sps_profile': False, 06:51:46 INFO - 'sps_profile_interval': 0, 06:51:46 INFO - 'suite': 'dromaeojs', 06:51:46 INFO - 'system_bits': '32', 06:51:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:51:46 INFO - 'title': 't-yosemite-r7-0071', 06:51:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:51:46 INFO - 'use_talos_json': True, 06:51:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:51:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:51:46 INFO - 'work_dir': 'build'} 06:51:46 INFO - [mozharness: 2016-11-14 14:51:46.384933Z] Running clobber step. 06:51:46 INFO - Running pre-action listener: _resource_record_pre_action 06:51:46 INFO - Running main action method: clobber 06:51:46 INFO - rmtree: /builds/slave/test/build 06:51:46 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.030094Z] Finished clobber step (success) 06:51:48 INFO - [mozharness: 2016-11-14 14:51:48.030226Z] 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": 15, 06:51:48 INFO - "slavename": "t-yosemite-r7-0071", 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.033283Z] Finished read-buildbot-config step (success) 06:51:48 INFO - [mozharness: 2016-11-14 14:51:48.033408Z] 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:56 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:56 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:56 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:56 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:08 INFO - Downloaded 115554865 bytes. 06:52:08 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:08 INFO - mkdir: /builds/slave/test/properties 06:52:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:52:08 INFO - Writing to file /builds/slave/test/properties/build_url 06:52:08 INFO - Contents: 06:52:08 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.091006Z] Finished download-and-extract step (success) 06:52:09 INFO - [mozharness: 2016-11-14 14:52:09.091121Z] 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.109998Z] Finished populate-webroot step (success) 06:52:09 INFO - [mozharness: 2016-11-14 14:52:09.110135Z] 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:09 INFO - Installing distribute.............................................................................................................................................................................................done. 06:52:12 INFO - Installing pip.................done. 06:52:12 INFO - Return code: 0 06:52:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:52:12 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:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:12 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:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:12 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 0x102e24490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9332565a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c38d30>, '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 0x102a9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c30b20>, '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.QgkwKnHybB/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.H6bXBrpGxr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:12 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:12 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:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QgkwKnHybB/Render', 06:52:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:12 INFO - 'HOME': '/Users/cltbld', 06:52:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:12 INFO - 'LOGNAME': 'cltbld', 06:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:12 INFO - 'MOZ_NO_REMOTE': '1', 06:52:12 INFO - 'NO_EM_RESTART': '1', 06:52:12 INFO - 'PAGER': '/bin/cat', 06:52:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:12 INFO - 'PWD': '/builds/slave/test', 06:52:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:12 INFO - 'SHELL': '/bin/bash', 06:52:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6bXBrpGxr/Listeners', 06:52:12 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:52:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:12 INFO - 'USER': 'cltbld', 06:52:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:12 INFO - 'XPC_FLAGS': '0x0', 06:52:12 INFO - 'XPC_SERVICE_NAME': '0', 06:52:12 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 0x102e24490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9332565a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c38d30>, '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 0x102a9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c30b20>, '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.QgkwKnHybB/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.H6bXBrpGxr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.QgkwKnHybB/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.H6bXBrpGxr/Listeners', 06:52:13 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 - Downloading/unpacking psutil>=3.1.1 06:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:52:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:52:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:52:16 INFO - Installing collected packages: psutil 06:52:16 INFO - Running setup.py install for psutil 06:52:16 INFO - building 'psutil._psutil_osx' extension 06:52:16 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: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:52:17 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:17 INFO - building 'psutil._psutil_posix' extension 06:52:17 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:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:52:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:52:17 INFO - ^ 06:52:17 INFO - 1 warning generated. 06:52:17 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: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 - Successfully installed psutil 06:52:17 INFO - Cleaning up... 06:52:17 INFO - Return code: 0 06:52:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:52:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:17 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 0x102e24490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9332565a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c38d30>, '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 0x102a9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c30b20>, '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.QgkwKnHybB/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.H6bXBrpGxr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:17 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:17 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:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QgkwKnHybB/Render', 06:52:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:17 INFO - 'HOME': '/Users/cltbld', 06:52:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:17 INFO - 'LOGNAME': 'cltbld', 06:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:17 INFO - 'MOZ_NO_REMOTE': '1', 06:52:17 INFO - 'NO_EM_RESTART': '1', 06:52:17 INFO - 'PAGER': '/bin/cat', 06:52:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:17 INFO - 'PWD': '/builds/slave/test', 06:52:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:17 INFO - 'SHELL': '/bin/bash', 06:52:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6bXBrpGxr/Listeners', 06:52:17 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:52:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:17 INFO - 'USER': 'cltbld', 06:52:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:17 INFO - 'XPC_FLAGS': '0x0', 06:52:17 INFO - 'XPC_SERVICE_NAME': '0', 06:52:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:52:17 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:17 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 - 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:17 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:17 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:17 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:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:52:20 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:20 INFO - Installing collected packages: mozsystemmonitor 06:52:20 INFO - Running setup.py install for mozsystemmonitor 06:52:20 INFO - Successfully installed mozsystemmonitor 06:52:20 INFO - Cleaning up... 06:52:20 INFO - Return code: 0 06:52:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:52:20 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:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:20 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:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:20 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 0x102e24490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9332565a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c38d30>, '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 0x102a9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c30b20>, '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.QgkwKnHybB/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.H6bXBrpGxr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:20 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:20 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:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QgkwKnHybB/Render', 06:52:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:20 INFO - 'HOME': '/Users/cltbld', 06:52:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:20 INFO - 'LOGNAME': 'cltbld', 06:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:20 INFO - 'MOZ_NO_REMOTE': '1', 06:52:20 INFO - 'NO_EM_RESTART': '1', 06:52:20 INFO - 'PAGER': '/bin/cat', 06:52:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:20 INFO - 'PWD': '/builds/slave/test', 06:52:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:20 INFO - 'SHELL': '/bin/bash', 06:52:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6bXBrpGxr/Listeners', 06:52:20 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:52:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:20 INFO - 'USER': 'cltbld', 06:52:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:20 INFO - 'XPC_FLAGS': '0x0', 06:52:20 INFO - 'XPC_SERVICE_NAME': '0', 06:52:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:21 INFO - Downloading/unpacking jsonschema==2.5.1 06:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:52:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:52:23 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:23 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:23 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:23 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:23 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:23 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:24 INFO - warning: no files found matching '*.txt' 06:52:24 INFO - no previously-included directories found matching 'build' 06:52:24 INFO - no previously-included directories found matching 'dist' 06:52:24 INFO - no previously-included directories found matching '.git*' 06:52:24 INFO - Installing collected packages: jsonschema, functools32 06:52:24 INFO - Running setup.py install for functools32 06:52:24 INFO - warning: no files found matching '*.txt' 06:52:24 INFO - no previously-included directories found matching 'build' 06:52:24 INFO - no previously-included directories found matching 'dist' 06:52:24 INFO - no previously-included directories found matching '.git*' 06:52:24 INFO - Successfully installed jsonschema functools32 06:52:24 INFO - Cleaning up... 06:52:24 INFO - Return code: 0 06:52:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102e24490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9332565a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c38d30>, '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 0x102a9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c30b20>, '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.QgkwKnHybB/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.H6bXBrpGxr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:52:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QgkwKnHybB/Render', 06:52:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:24 INFO - 'HOME': '/Users/cltbld', 06:52:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:24 INFO - 'LOGNAME': 'cltbld', 06:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:24 INFO - 'MOZ_NO_REMOTE': '1', 06:52:24 INFO - 'NO_EM_RESTART': '1', 06:52:24 INFO - 'PAGER': '/bin/cat', 06:52:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:24 INFO - 'PWD': '/builds/slave/test', 06:52:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:24 INFO - 'SHELL': '/bin/bash', 06:52:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6bXBrpGxr/Listeners', 06:52:24 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:52:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:24 INFO - 'USER': 'cltbld', 06:52:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:24 INFO - 'XPC_FLAGS': '0x0', 06:52:24 INFO - 'XPC_SERVICE_NAME': '0', 06:52:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:52:24 INFO - Cleaning up... 06:52:24 INFO - Return code: 0 06:52:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102e24490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9332565a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c38d30>, '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 0x102a9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c30b20>, '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.QgkwKnHybB/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.H6bXBrpGxr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:52:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QgkwKnHybB/Render', 06:52:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:24 INFO - 'HOME': '/Users/cltbld', 06:52:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:24 INFO - 'LOGNAME': 'cltbld', 06:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:24 INFO - 'MOZ_NO_REMOTE': '1', 06:52:24 INFO - 'NO_EM_RESTART': '1', 06:52:24 INFO - 'PAGER': '/bin/cat', 06:52:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:24 INFO - 'PWD': '/builds/slave/test', 06:52:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:24 INFO - 'SHELL': '/bin/bash', 06:52:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6bXBrpGxr/Listeners', 06:52:24 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:52:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:24 INFO - 'USER': 'cltbld', 06:52:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:24 INFO - 'XPC_FLAGS': '0x0', 06:52:24 INFO - 'XPC_SERVICE_NAME': '0', 06:52:24 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:27 INFO - Downloading blobuploader-1.2.4.tar.gz 06:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:52:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:52:28 INFO - Downloading/unpacking docopt==0.6.1 (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 - Downloading docopt-0.6.1.tar.gz 06:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:52:28 INFO - Installing collected packages: blobuploader, requests, docopt 06:52:28 INFO - Running setup.py install for blobuploader 06:52:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:52:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:52:28 INFO - Running setup.py install for requests 06:52:29 INFO - Running setup.py install for docopt 06:52:29 INFO - Successfully installed blobuploader requests docopt 06:52:29 INFO - Cleaning up... 06:52:29 INFO - Return code: 0 06:52:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:52:29 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:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:29 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:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:29 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 0x102e24490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9332565a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c38d30>, '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 0x102a9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c30b20>, '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.QgkwKnHybB/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.H6bXBrpGxr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:29 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:29 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:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QgkwKnHybB/Render', 06:52:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:29 INFO - 'HOME': '/Users/cltbld', 06:52:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:29 INFO - 'LOGNAME': 'cltbld', 06:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:29 INFO - 'MOZ_NO_REMOTE': '1', 06:52:29 INFO - 'NO_EM_RESTART': '1', 06:52:29 INFO - 'PAGER': '/bin/cat', 06:52:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:29 INFO - 'PWD': '/builds/slave/test', 06:52:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:29 INFO - 'SHELL': '/bin/bash', 06:52:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6bXBrpGxr/Listeners', 06:52:29 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:52:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:29 INFO - 'USER': 'cltbld', 06:52:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:29 INFO - 'XPC_FLAGS': '0x0', 06:52:29 INFO - 'XPC_SERVICE_NAME': '0', 06:52:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:52:29 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-gSrNOD-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/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-KWHMrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:52:30 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-UpT08g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:52:30 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-pmAfbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:52:30 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-eeDc6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:52:30 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-OfNLIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:52:30 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-u_jB65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:52:30 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-dJRLgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:52:30 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-AZneUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:52:30 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-WE1Gk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:52:30 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-cGMIey-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/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-NemFPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:52:31 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-xdLPqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:52:31 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-sl1Wun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:31 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-8QODV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:52:31 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-l0OP8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:52:31 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-7_6fVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:52:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:52:31 INFO - Running setup.py install for manifestparser 06:52:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:52:31 INFO - Running setup.py install for mozcrash 06:52:31 INFO - Running setup.py install for mozdebug 06:52:32 INFO - Running setup.py install for mozdevice 06:52:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:52:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:52:32 INFO - Running setup.py install for mozfile 06:52:32 INFO - Running setup.py install for mozhttpd 06:52:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:52:32 INFO - Running setup.py install for mozinfo 06:52:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:52:32 INFO - Running setup.py install for mozInstall 06:52:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:52:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:52:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:52:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:52:32 INFO - Running setup.py install for mozleak 06:52:32 INFO - Running setup.py install for mozlog 06:52:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:52:33 INFO - Running setup.py install for moznetwork 06:52:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:52:33 INFO - Running setup.py install for mozprocess 06:52:33 INFO - Running setup.py install for mozprofile 06:52:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:52:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:52:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:52:33 INFO - Running setup.py install for mozrunner 06:52:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:52:33 INFO - Running setup.py install for mozscreenshot 06:52:33 INFO - Running setup.py install for moztest 06:52:34 INFO - Running setup.py install for mozversion 06:52:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:52:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:52:34 INFO - Cleaning up... 06:52:34 INFO - Return code: 0 06:52:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:52:34 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:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:34 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:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:34 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 0x102e24490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9332565a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c38d30>, '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 0x102a9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c30b20>, '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.QgkwKnHybB/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.H6bXBrpGxr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:34 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:34 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:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QgkwKnHybB/Render', 06:52:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:34 INFO - 'HOME': '/Users/cltbld', 06:52:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:34 INFO - 'LOGNAME': 'cltbld', 06:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:34 INFO - 'MOZ_NO_REMOTE': '1', 06:52:34 INFO - 'NO_EM_RESTART': '1', 06:52:34 INFO - 'PAGER': '/bin/cat', 06:52:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:34 INFO - 'PWD': '/builds/slave/test', 06:52:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:34 INFO - 'SHELL': '/bin/bash', 06:52:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6bXBrpGxr/Listeners', 06:52:34 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:52:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:34 INFO - 'USER': 'cltbld', 06:52:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:34 INFO - 'XPC_FLAGS': '0x0', 06:52:34 INFO - 'XPC_SERVICE_NAME': '0', 06:52:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:52:34 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-XFx2WB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:52:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:52:34 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-KzgJ1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:52:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:52:34 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-KWYn4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:52:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:52:34 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-D243qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:52:34 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:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:52:34 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-taPitA-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/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-YhuwvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:52:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:52:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-0du_Fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:52:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:52:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ZGFV0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:52:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:52:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-hwg47R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:52:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:52:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-VI2i5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:52:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:52:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-bY0rxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:52:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:52:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-mh9V77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:52:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:52:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-xt4NJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:52:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:52:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-NgzHKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:52:35 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:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ZkWYUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:52:36 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-p1G6In-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:52:36 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:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:52:36 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-letAzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:52:36 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:36 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:36 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:36 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:36 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:36 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:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:52:36 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:36 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:36 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:36 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:36 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:36 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:38 INFO - Downloading blessings-1.6.tar.gz 06:52:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:52:38 INFO - Installing collected packages: blessings 06:52:38 INFO - Running setup.py install for blessings 06:52:39 INFO - Successfully installed blessings 06:52:39 INFO - Cleaning up... 06:52:39 INFO - Return code: 0 06:52:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:52:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:52:39 INFO - Reading from file tmpfile_stdout 06:52:39 INFO - Current package versions: 06:52:39 INFO - blessings == 1.6 06:52:39 INFO - blobuploader == 1.2.4 06:52:39 INFO - docopt == 0.6.1 06:52:39 INFO - functools32 == 3.2.3-2 06:52:39 INFO - jsonschema == 2.5.1 06:52:39 INFO - manifestparser == 1.1 06:52:39 INFO - mozInstall == 1.12 06:52:39 INFO - mozcrash == 0.17 06:52:39 INFO - mozdebug == 0.1 06:52:39 INFO - mozdevice == 0.48 06:52:39 INFO - mozfile == 1.2 06:52:39 INFO - mozhttpd == 0.7 06:52:39 INFO - mozinfo == 0.9 06:52:39 INFO - mozleak == 0.1 06:52:39 INFO - mozlog == 3.4 06:52:39 INFO - moznetwork == 0.27 06:52:39 INFO - mozprocess == 0.23 06:52:39 INFO - mozprofile == 0.28 06:52:39 INFO - mozrunner == 6.12 06:52:39 INFO - mozscreenshot == 0.1 06:52:39 INFO - mozsystemmonitor == 0.3 06:52:39 INFO - moztest == 0.7 06:52:39 INFO - mozversion == 1.4 06:52:39 INFO - psutil == 3.1.1 06:52:39 INFO - requests == 1.2.3 06:52:39 INFO - wsgiref == 0.1.2 06:52:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:39 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 0x102e24490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9332565a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c38d30>, '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 0x102a9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c30b20>, '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.QgkwKnHybB/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.H6bXBrpGxr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:39 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:39 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:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QgkwKnHybB/Render', 06:52:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:39 INFO - 'HOME': '/Users/cltbld', 06:52:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:39 INFO - 'LOGNAME': 'cltbld', 06:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:39 INFO - 'MOZ_NO_REMOTE': '1', 06:52:39 INFO - 'NO_EM_RESTART': '1', 06:52:39 INFO - 'PAGER': '/bin/cat', 06:52:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:39 INFO - 'PWD': '/builds/slave/test', 06:52:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:39 INFO - 'SHELL': '/bin/bash', 06:52:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6bXBrpGxr/Listeners', 06:52:39 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:52:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:39 INFO - 'USER': 'cltbld', 06:52:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:39 INFO - 'XPC_FLAGS': '0x0', 06:52:39 INFO - 'XPC_SERVICE_NAME': '0', 06:52:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 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:39 INFO - Cleaning up... 06:52:39 INFO - Return code: 0 06:52:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102e24490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d9a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9332565a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102c38d30>, '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 0x102a9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c30b20>, '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.QgkwKnHybB/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.H6bXBrpGxr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:52:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QgkwKnHybB/Render', 06:52:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:39 INFO - 'HOME': '/Users/cltbld', 06:52:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:39 INFO - 'LOGNAME': 'cltbld', 06:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:39 INFO - 'MOZ_NO_REMOTE': '1', 06:52:39 INFO - 'NO_EM_RESTART': '1', 06:52:39 INFO - 'PAGER': '/bin/cat', 06:52:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:39 INFO - 'PWD': '/builds/slave/test', 06:52:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:39 INFO - 'SHELL': '/bin/bash', 06:52:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6bXBrpGxr/Listeners', 06:52:39 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:52:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:39 INFO - 'USER': 'cltbld', 06:52:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:39 INFO - 'XPC_FLAGS': '0x0', 06:52:39 INFO - 'XPC_SERVICE_NAME': '0', 06:52:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:52:39 INFO - Cleaning up... 06:52:39 INFO - Return code: 0 06:52:39 INFO - Running post-action listener: _resource_record_post_action 06:52:39 INFO - Running post-action listener: _start_resource_monitoring 06:52:39 INFO - Starting resource monitoring. 06:52:40 INFO - [mozharness: 2016-11-14 14:52:40.001464Z] Finished create-virtualenv step (success) 06:52:40 INFO - [mozharness: 2016-11-14 14:52:40.002419Z] 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:40 INFO - Reading from file tmpfile_stdout 06:52:40 INFO - Detecting whether we're running mozinstall >=1.0... 06:52:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:52:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:52:40 INFO - Reading from file tmpfile_stdout 06:52:40 INFO - Output received: 06:52:40 INFO - Usage: mozinstall [options] installer 06:52:40 INFO - Options: 06:52:40 INFO - -h, --help show this help message and exit 06:52:40 INFO - -d DEST, --destination=DEST 06:52:40 INFO - Directory to install application into. [default: 06:52:40 INFO - "/builds/slave/test"] 06:52:40 INFO - --app=APP Application being installed. [default: firefox] 06:52:40 INFO - mkdir: /builds/slave/test/build/application 06:52:40 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:40 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:12 INFO - Reading from file tmpfile_stdout 06:53:12 INFO - Output received: 06:53:12 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:53:12 INFO - Running post-action listener: _resource_record_post_action 06:53:12 INFO - [mozharness: 2016-11-14 14:53:12.621237Z] Finished install step (success) 06:53:12 INFO - [mozharness: 2016-11-14 14:53:12.621380Z] Running run-tests step. 06:53:12 INFO - Running pre-action listener: _resource_record_pre_action 06:53:12 INFO - Running main action method: run_tests 06:53:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:53:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:53:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:53:12 INFO - 2016-11-14 06:53:12.636 screenresolution[1916:16232] starting screenresolution argv=screenresolution get 06:53:12 INFO - 2016-11-14 06:53:12.639 screenresolution[1916:16232] Display 0: 1600x1200x32@60 06:53:12 INFO - 2016-11-14 06:53:12.644 screenresolution[1917:16234] starting screenresolution argv=screenresolution list 06:53:12 INFO - Available Modes on Display 0 06:53:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:53:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:53:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:53:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:53:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:53:12 INFO - Intel Iris: 06:53:12 INFO - Chipset Model: Intel Iris 06:53:12 INFO - Type: GPU 06:53:12 INFO - Bus: Built-In 06:53:12 INFO - VRAM (Dynamic, Max): 1536 MB 06:53:12 INFO - Vendor: Intel (0x8086) 06:53:12 INFO - Device ID: 0x0a2e 06:53:12 INFO - Revision ID: 0x0009 06:53:12 INFO - Displays: 06:53:12 INFO - Display: 06:53:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:53:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:53:12 INFO - Display Serial Number: 1600x1200 60 06:53:12 INFO - Main Display: Yes 06:53:12 INFO - Mirror: Off 06:53:12 INFO - Online: Yes 06:53:12 INFO - Rotation: Supported 06:53:12 INFO - Return code: 0 06:53:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:53:12 INFO - Python 2.7.3 06:53:12 INFO - Return code: 0 06:53:12 INFO - grabbing minidump binary from tooltool 06:53:12 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:12 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 0x102c38d30>, '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 0x102a9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102c30b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:53:12 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:12 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:12 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:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:53:13 INFO - Return code: 0 06:53:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:53:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:53:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:53:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:53:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:53:13 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-0071', '--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:13 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-0071 --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:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QgkwKnHybB/Render', 06:53:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:13 INFO - 'HOME': '/Users/cltbld', 06:53:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:13 INFO - 'LOGNAME': 'cltbld', 06:53:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:53:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:13 INFO - 'MOZ_NO_REMOTE': '1', 06:53:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:53:13 INFO - 'NO_EM_RESTART': '1', 06:53:13 INFO - 'PAGER': '/bin/cat', 06:53:13 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:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:13 INFO - 'PWD': '/builds/slave/test', 06:53:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:53:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:13 INFO - 'SHELL': '/bin/bash', 06:53:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.H6bXBrpGxr/Listeners', 06:53:13 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 06:53:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:13 INFO - 'USER': 'cltbld', 06:53:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:13 INFO - 'XPC_FLAGS': '0x0', 06:53:13 INFO - 'XPC_SERVICE_NAME': '0', 06:53:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:13 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-0071', '--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:13 INFO - mozversion application_buildid: 20161114021920 06:53:13 INFO - mozversion application_changeset: 2d9b6132e7d75327e063a15d8e5e279077adf987 06:53:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:53:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:53:13 INFO - mozversion application_name: Firefox 06:53:13 INFO - mozversion application_remotingname: firefox-dev 06:53:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:53:13 INFO - mozversion application_vendor: Mozilla 06:53:13 INFO - mozversion application_version: 51.0a2 06:53:13 INFO - mozversion platform_buildid: 20161114021920 06:53:13 INFO - mozversion platform_changeset: 2d9b6132e7d75327e063a15d8e5e279077adf987 06:53:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:53:13 INFO - mozversion platform_version: 51.0a2 06:53:13 INFO - using testdate: 1479135193 06:53:13 INFO - actual date: 1479135193 06:53:13 INFO - starting webserver on 'localhost:52721' 06:53:13 INFO - SUITE-START | Running 2 tests 06:53:13 INFO - TEST-START | dromaeo_css 06:53:13 INFO - operating with platform_type : mac_ 06:53:13 INFO - Initialising browser for dromaeo_css test... 06:53:13 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpkknEHE/profile http://localhost:52721/getInfo.html) 06:53:15 INFO - PROCESS | 1927 | __metrics Screen width/height:1600/1200 06:53:15 INFO - PROCESS | 1927 | colorDepth:24 06:53:15 INFO - PROCESS | 1927 | Browser inner width/height: 1024/689 06:53:15 INFO - PROCESS | 1927 | __metrics 06:53:15 INFO - PROCESS | 1927 | 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:15 INFO - PROCESS | 1927 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:53:16 INFO - TEST-INFO | 1927: exit 0 06:53:16 INFO - Browser initialized. 06:53:16 INFO - Running cycle 1/1 for dromaeo_css test... 06:53:16 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpkknEHE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:53:28 INFO - PROCESS | 1929 | RSS: Main: 240074752 06:53:28 INFO - PROCESS | 1929 | 06:54:19 INFO - PROCESS | 1929 | 1479135259870 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 | 1929 | Cycle 1(1): loaded http://localhost:52721/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52721/tests/dromaeo/cssquery-ext.html) 06:56:33 INFO - PROCESS | 1929 | RSS: Main: 368570368 06:56:33 INFO - PROCESS | 1929 | 06:59:36 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52721/tests/dromaeo/cssquery-ext.html (next: http://localhost:52721/tests/dromaeo/cssquery-jquery.html) 06:59:37 INFO - PROCESS | 1929 | RSS: Main: 369922048 06:59:37 INFO - PROCESS | 1929 | 07:02:39 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52721/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52721/tests/dromaeo/cssquery-mootools.html) 07:02:39 INFO - PROCESS | 1929 | RSS: Main: 353542144 07:02:39 INFO - PROCESS | 1929 | 07:05:42 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52721/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52721/tests/dromaeo/cssquery-prototype.html) 07:05:42 INFO - PROCESS | 1929 | RSS: Main: 341508096 07:05:42 INFO - PROCESS | 1929 | 07:08:46 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52721/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52721/tests/dromaeo/cssquery-yui.html) 07:08:46 INFO - PROCESS | 1929 | RSS: Main: 332349440 07:08:46 INFO - PROCESS | 1929 | 07:11:49 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52721/tests/dromaeo/cssquery-yui.html (next: http://localhost:52721/tests/dromaeo/cssquery-dojo.html) 07:11:50 INFO - PROCESS | 1929 | RSS: Main: 454680576 07:11:50 INFO - PROCESS | 1929 | 07:11:50 INFO - PROCESS | 1929 | __start_tp_report 07:11:50 INFO - PROCESS | 1929 | _x_x_mozilla_page_load 07:11:50 INFO - PROCESS | 1929 | _x_x_mozilla_page_load_details 07:11:50 INFO - PROCESS | 1929 | |i|pagename|runs| 07:11:50 INFO - PROCESS | 1929 | |0;dojo.html;2728.386113124547;3320.269540701046;3358.1436733632904;3383.2049468374944;3415.5047518109873;5722.799702010425;5776.971115144418;5808.622439541432;5831.504322132624;5843.532517398608;5741.052726300156;5794.942050579503;5802.332731735852;5804.390538993408;5821.621594596349;5219.739013049351;5283.63014588979;5311.73441327934;5314.070037743399;5359.624826262163;4637.466691330506;5178.446466060167;5242.292290540767;5243.816466423676;5382.730863456831;5248.0815857225025;5328.17413300939;5333.893322133555;5335.013022590813;5358.169483730028;5271.920921186185;5292.073887069748;5308.203769434577;5361.195820626898;5363.597730170253;5164.2770012198325;5276.261323414725;5288.2596436498925;5297.5232229099565;5322.121849894763;5001.824571225759;5583.441655834425;5594.468525490112;5618.213450116987;5657.943420565783;5039.672421292605;6275.152854364648;6298.2442106947;6306.1486699295465;6324.683765811737;6245.500359971192;6303;6337.714802833883;6362.5864318819595;6373.904391434132;5758.74085666146;5805.651660900359;5814.796482123105;5849.912251316234;5892.440218179266;5049.899002020013;6264.373562643699;6387.648679322682;6389.584676995981;6389.936100639027;6191.938080619227;6199.256089269316;6206.193194884727;6207;6208.627482351073;6160.10678451622;6175.382461753788;6258.186435763321;6261.8747625047245;6283.02613094971;6121.204243448323;6136.648568731431;6142.648617304186;6195.81412557624;6196.690165491797;6105.247473116927;6159.907601385983;6179.969100154561;6205.100260462208;6213.409726076106;4961.603071754251;4989.426215985208;4989.700617962933;4997.425296090996;5016.598672106223;4487.955120448819;4512.05246898155;4513.11994161142;4514.480834703985;4525.547445255448;5720.027595308808;5758.165066065397;5800.622959507618;5805.448482394166;5806.187133801272;6189.412005859436;6219;6227.408396202353;6236.438720515084;6249.343818899041;5819.854503637443;5828.737706803204;5883.235179426732;5906.675132867647;5958.463738263577;5368.812091576776;5416.0792665247;5464.754086066137;5465;5466.207399926989;6298.811035668938;6342.238931328178;6385.648789316447;6386.201724784402;6443.67781610927;6237.4698150657705;6238.407351301619;6240.126382306572;6253.812385628438;6266.185395898504;6361.109444677656;6398.744050238124;6443.420092191725;6453.935460645521;6459.903101453576;6123.601965872204;6136.8953588354525;6145.446909778141;6149.954507733606;6194.132821405097;6201.751929922752;6231.501479881508;6243.7814676486105;6247.312795592572;6260.060990851409;5904.439078287556;5981.312149102909;6029.939700602938;6103.786367477117;6144.508439324753;6042.818715438368;6116.092308610808;6143.477804386498;6145.4161854623735;6150.015997440388;6006.369331220334;6055.1522786810765;6079.240094988127;6084.11780291864;6114.082887566723;6209.348018458178;6223.813285601439;6235.220597425322;6240.7503699851495;6246.219222597176;6044.032954727222;6050.213472248755;6081.939180608138;6082.057281121433;6122.794608433986 07:11:50 INFO - PROCESS | 1929 | |1;ext.html;465.527489598058;512.3953734593181;517.3791450259688;524.6484855147052;547.4525474525475;30860.53709194361;41059;42070;42180;44088.77955610226;43663.345049824275;44101.7794911025;44132.558674413245;44277.33583996235;44294.671159865255;8825.382223244376;9098.590563424661;9711.562979665914;9903.801923961517;9905.603775848957;8815.867761983576;8997;11868.465919033664;12098.637040888787;12104.273743575413;12099.032077433783;12172.756544869097;12174.695632609211;12183.57357492488;12212.816807747891;12069.698257543589;12153.210041347284;12156.452959616883;12167.026637868948;12180.451879665436;8662.393632445732;8889.422187557853;11649.12631552637;11989.880101198964;12006.279623222546;41811.581884181076;42196.36705449421;42268.94327641803;42294.94262643428;42348.941276468024;2869.684334723179;3420.9486857697157;3469.3928562501715;3505.9474107888145;3691.907702307437;29268.707312927025;30000.69999300001;31435.528467072785;32168.517472237934;33130.024397072266;3157.842107894619;3192.8563214655396;3284.359549887773;3284.4744840825592;3307.140143562667;520512;522400;522923;524038;526887.9999999962;60592.69703651542;63340.36659633345;63575;63623.045654315225;63894.68052659707;66374.66812665906;66504.33495665078;66506;66573;66822.33177668258;16544.007359558225;17149.828501714823;17153.228104735317;17162.656746864992;17179.883307584965;12026.158168928267;13176.538821141407;13234.205947643171;13237;13272.203667779771;15901.284442199898;18052.63894722098;18203.08984550767;18537.629247414978;18951.81048189528;5755.65466072037;6590.868182636321;6673.132492775908;6727.327267273234;6734.191896972395;863.48622569571;968.4915419404728;1063.7181146996052;1080.5191689698165;1093.775775965941;27941.441171176462;29395.118146455214;29420;30538.694613053583;30876.073717788502;1065.169168048923;1082.9891701082888;1088.689723428835;1117.3296022386667;1136.72718547548;15812.051276923421;15919.442819501262;16164.676706465805;16195.919020404823;16224.026558406533;185173.07413462846;185787;186115.0694246547;186604;187133;59677.80644387088;59931.801363972474;59946;60111.398886011455;60282.39717602856;1229.299299399334;1263.3430616079588;1346.3941226447942;1381.716748066644;1401.2783416540285;29519.409611808074;29670.851645741634;32033.839830800698;32087.197820054684;32686.182845429055;51176;52107.13410762444;52231.477685222664;52418.95162096813;52454.688632782956;540896;542684;543284;544330;544372;26637.93448262048;26708.332291692863;27079.72920270772;27251.72748272492;42289.78855105705;47440.33958811425;47953.280700790216;48051.75974120107;48323.275150873465;48576.75711621561;38758.6124138755;39545;39804.40293395543;39980.000499987735;41176.794116029225;32832.31704284309;39787.00532486711;40750.38874416827;40767.38848917328;41195;38141.618583813804;38738;38990;39005.21989560136;39021.80489097536;33629.83185084059;34955.30089398249;35035.29929401448;35741.927742167776;35760.46359304665;25869.353266168495;26075.478490430465;26129;26153.539381854436;26401.867990659925 07:11:50 INFO - PROCESS | 1929 | |2;jquery.html;318.91389324882283;350.5145373657487;372.68508110646513;377.92819364320775;402.47878996699274;15144.848551514482;15341.309641066151;16233.10717910516;20665.586688266227;21089.47276318093;18957.14692838822;19906.303279385225;20079.297224597107;21201.469963250926;21204.89397553014;5772.884542309152;5890.64656120632;6169;6171.2594488661425;6175.07373893915;5609.80365687201;6131.846703832395;6191.442770150686;6206.596571222856;6209.782657606985;5827;6010.12853136295;6138.416850399205;6144.5084393248435;6152.969235153818;5958.851028724273;6000.639961602318;6008.36912124225;6009.789657361993;6011.849703757397;5029.917446778824;5128.871778205537;5220.686758794484;5244.056069907415;5245.213218017289;22855.314340569643;24936.750632493804;26179.607305890237;26183;26298.816553254957;2268.9092436302526;2365.7989070928993;2456.115798312606;2845.5304874695858;2874.2670618992024;13555.847752941012;15282;15815.367385304575;16041.518754437386;16115.597110072225;1574;1868.8164162696899;1886.9056547172586;1896.6111947050958;1937.6124775045048;78944;104013;122194;125274;128473.35763321217;10913.454327283604;10934.890651093547;11022.50398732059;11046.613368532062;11182;13788.241646709528;13795.793063104062;13808.723825523433;13820.516281930084;13824.654383640489;8537.615807288686;8813.206811387006;8831.205191532792;8920;8944.150305720947;7257.330813912829;8832.955835220911;8872.467651940904;9057.00372958974;9163.725088247364;6583.407493325623;6693.431058359996;6695.330466953363;6707.195136583544;6710.959801230817;1590.4433448293005;1825.1330617956364;1865.6940141900452;1866.6080123174286;1867.9626407471774;751.3988808952815;771.76846945916;827.1439060572279;876.5587837871498;1003.5383723487132;21539;22552.436189095402;22560.323190304316;22592.548149037255;22736.863156842424;931.6459745296744;951.4909523404945;963.7831487915303;989.0455710239653;998.1166667499315;11631.360275184777;11756.94121529387;11990.160688751877;11990.640280791416;12016.459259333176;243525.78237109055;243665;244072;244145.7792711025;244613;78155;117912;124388.75611243953;125802;127338;978.9314747967574;994.751312171957;1014.7057353367588;1016.4866742295094;1017.5675337981477;19487.317943872462;20214.898925505866;20548.589028219052;20563.280285189947;20600.27899023587;51542;51961;53735.462645373045;53911.73044134754;54956.450435495135;75336.62331688307;76997;77338.61330693311;77364;82078.58960705159;7806.4925779824125;7833.608319583884;7972.720954766555;8009.959950200212;8050.114487406264;13146.474141034252;13185.340732963505;13233.129232350539;13566.321683915961;13670.043096983116;11321.09431245482;11332.546698132312;11338.376389298337;11453.370064646524;11572.36352000648;11185.552577896793;11230.83153752678;11528.82706759416;11550.595729149776;11579.478923448296;11626.33905161415;11754.647360579196;11852.170348075551;12159.75680486403;12162.939185304016;7860.371170306247;7873.5275883447175;7918.208179182267;8012.078610959814;8107.297467531885;11254.155938304497;11305.71735706581;11666.76666466649;11702.2978621283;11778.411079445823 07:11:50 INFO - PROCESS | 1929 | |3;mootools.html;1258.207329382489;1362.9114107583007;1598.8161361443438;1818.0546116019677;1868.7290342900271;8474.788130296745;9070.727878163658;9076.8638470423;9090.590923408447;9093.636254549827;7917.683292668286;8186.672533098669;8193.057798353191;8609.182127697874;8806.91193088069;2026.412340421276;2371.1700904683353;2404.2066118181046;2404.5190961807707;2409.5301416223842;2112.26070875194;2297.7936583293736;2389.163792672568;2416.0215112879223;2417.697787776528;2102.6530622447276;2181.683655869906;2188.2559929623926;2324.5234726881035;2404.278716385086;2394.6647469354302;2413.155395611531;2421.32202983165;2429.149797570854;2430.963535546968;2391.5934291170543;2429.514097180571;2439.7194322652767;2440.1093600835743;2450.816188785848;9002.909970900273;9064.954675226647;9078.046805085503;9093.45439273639;9102.908970910272;5250.264962905197;5372.7045012524295;5439.292891924064;5446.891062178774;5449.972750136224;3596.37063513884;3668.8899333020054;3789.981050094732;3791;3811.275857587077;1115.130198445214;1138.6356365962895;1780.4480611010629;1836.2012524551728;1890.2816929566677;11285.871412858649;11950.342731149784;11978.760424791542;12056.758864822654;12087.576934807328;4391.385206071089;4521.683482156218;4686.179918514246;4693.577578017995;4703.858884233478;9293.95353023244;9304.97645259021;9312.44125352481;9314.673986410578;9323;5312.62811603184;5320.201969704498;5322.733863306819;5324.627276090714;5328.094223981932;4881.121398148367;4897.951020489821;4952.801887924443;4975;4979.576735977483;3024.941270555288;3566.9108272292883;3583.4624806279267;3589.94615080774;3640.908977275589;957.3107362698846;976.8730065091493;1152.1819508149308;1157.1784033336257;1161.9186656934103;641.5380925733465;789.8815177723387;873.9388242822941;906.7823722306731;930.5056576734357;5757.165211044459;5784.334801497797;5891.351951285355;5924.496417804448;5929.555283353766;462.4335189392967;480.8052738640856;490.2890808327939;491.3072567679555;642.601587016053;3722.3485889969147;3958.1094253792667;3988.9002774930277;4008.677136544933;4034.23349563582;10597.523111460003;11150.330980141056;11159.386233757059;11173.329600224013;11205.327680339205;10710.357378557312;10856.945715271373;10909.781804363869;11053.00522952938;11084.279521831055;8181.263686268265;8271.007479102425;8275.882755827886;8382.07797142314;8386.496810191285;5732.971335143297;5934.732937017931;5962.642241465526;6003.5797494174985;6022.8795424090395;9892.208623309974;10232.744181395525;10382.896171038194;10417.42704151279;10421.635242766466;8377.539235342114;10044.196464282986;10342.120919721909;10634.946825265824;10722.284434490444;7149.999000140088;7221.963890180516;7228.4940054197805;7230.313120253568;7231.63841807897;6663.500237482305;8493.278071363757;8500.914990850013;8511.872321915052;8512.616932237941;7446.218147094477;7500.399968002437;7615.885761713468;7618.085829700472;7647.158812530506;7290.671919763729;7391.593462359622;7486.139094004041;7552.320291173601;7565.130010048915;6983.790486285419;7146.392556632744;7149.392301654209;7153;7160.319769621878;4904.509549045067;4955.801767929387;5000.799968001239;5003.399592048831;5101.0818052750865;4736.692115012514;5009.974950125226;5039.21892106724;5132.9743351283005;5165.096108181128 07:11:50 INFO - PROCESS | 1929 | |4;prototype.html;302.9484987552116;303.90882735179457;307.3238874476152;314.8126864515614;315.4306476809358;4509.346144809001;4900.632452566054;5401.622586240508;5406.972965135179;5492.423295553965;4421.557844215577;4585.426821647294;5095.566876815476;5249.4750524947485;5271.049711606711;3406.540117084199;3422.623511413749;3426.190523770509;4081.9183616327655;4110.239605672945;3433.4678124890684;3808.428735689641;4102.200070986159;4129.6283334499885;4141.068259641586;3356.832158392083;4029.89177976056;4039.53545342285;4070.796460176994;4072.8370865165357;3338.1306468377543;3354.480055591387;3498.4577390504514;4009.258287216874;4053.3312003519677;2946;3212.5823642926503;3493.4410494320787;3498.2888261597213;3505.9824700876334;4320.4599425071865;4673.728390126891;4972.95567930735;5197.974010129963;5200.685694865786;4251.659867210616;4632.2819962905805;4638.79125439356;4647.814087436498;4660.16117098922;4708.623310135181;4749.453812811502;4938.38270216223;5186.429492755794;5654.123610840326;3249.4151052810485;3711.406175012012;3838.5201849768778;3878.312933873774;3882.9029274268087;4499.75251361175;5813.069908814612;5869.413058694096;5906.4347947794295;5913;3886.106195574977;3889.649931506178;3897.8635747748694;3910.667593254548;3922.3135951208424;3331.200511877132;3577.6601222883783;3763.454299126611;3989.9601003989587;3996.760194388346;4273.380359847804;4381.823178195783;4427.760227136407;4583.931241031387;4594.264917613166;5178.974105129526;5669.574781891375;5683.232763576947;5698.230738850285;5768.50967667753;1067.1356201476829;1275.655572995286;1276.304414094321;1295.799151131576;1324.8410190776976;729.6862349189793;765.8353454007304;898.4609234459272;906.3519583497831;911.3210658059655;4766.76166191689;5123.23248479274;5295.967286379119;5352.384475785335;5353.304070470892;4589.967257367066;5259.476150978777;5382.165764306539;5805.606654402997;5828.679422631796;4430.977845110754;4607.590383116537;5198.996772485165;5252.44849290819;5298.841034768963;1969.1040576537641;2360.905563777464;2494.3514686181725;2516.572182728904;2525.4720893858953;4152.691902050905;4544.00031992961;4830.420349558076;4899.804007839646;4914.697605134642;4817.867801066746;4823.758812059383;4832.830850920201;4859.792536925612;4874.8537543873745;3945.277758346789;4806.351142595705;4863.884210368501;4866.7079975201605;4887.193613053806;3991.880243592697;4046.866877274368;4461.330800379969;4715.439842918575;4748.430188377279;4249.406472572785;4551.499335073206;4690.319903614025;4699.389079419653;4715.712879253628;4537.410136682211;4767.499412561631;4845.854624361275;4871.196252618278;4889.682170658896;3282.015395381424;3309.9172520687175;3312.8840490582716;3369.2419205678525;3392.8473218705712;4002.0195052212393;4013.3779264214095;4344.522102568778;4687.015726697432;4711.552402521755;4333.71830830995;4343.739375637472;4605.545840619536;4643.981412082174;4702.741349225826;3845.8846234613006;4249.596288352602;4261.254280500838;4556.450806725729;4580.938577640142;4495.505494395679;4531.864044078683;5208.374995000624;5289.894202116013;5326.440723723953;5294.602904782079;5697.173909783141;5711.400302968129;5716.5426765859465;5808.6224395414165;4708.505606911362;5270.262163297218;5575;5603.439656034364;5679.545636348999 07:11:50 INFO - PROCESS | 1929 | |5;yui.html;704.3907020427329;752.033636776742;759.2066290726191;775.1976704111245;797.326259310882;15551;16395.344186232567;16406.26171822268;16509.257083431243;16643.66712665746;16727;16916.661666766657;16922.492325230232;16928.98426094435;16960;665.6139439125295;683.5249501596393;827.210014436212;851.6295411495988;854.9914500855006;679.663566534566;824.056455358614;836.4186890111375;841.7474757572704;847.9109693482188;877.6971944679076;878.8330217258732;879.9792241000441;883.2227639677075;883.7437143228456;661.4509956735945;718.7699936020475;795.9612705419426;878.6529320918233;879.463527248378;639.7696829141552;651.5601968671175;651.6253154436218;655.220287857448;657.4017643943988;15575.844241557552;15591.922040389838;15601.219939003004;15603.92198039014;15621.687566248725;13439.932800336033;13719.657008574766;13784.172949622955;13853.445862165601;14077.64805879851;12478.50085996559;12600.36998150098;12678.873211267954;12929.224246545238;13458.192508449525;4484.8430304939175;4563.840265590688;4571.474280457756;4755.690880092818;4778.092162489116;109913.35129972977;112415.43792281068;112613.43693281563;112754.95920652656;116169.83830161675;10649.733756656145;10761.946190268998;10767.515461804238;10965.451727413756;10999.835002474969;21223.257185998416;21242.468938276357;21248.575028499654;21260.574788504142;21279.78720212778;7522.746644993738;7527.736529221561;7683.385329173652;7724.536527808349;7861.489003214772;4335.82656693735;4346.326319420432;4375.0962173544185;4439.977800110979;4516.554702495236;3497.0732755819727;3587.031501494634;3591.3715099857423;3601.423772196436;3923.8234279457492;719.4208662027119;722.2380388689877;726.702052158623;727.8398752274492;733.0470388495041;522.7438555108046;638.5306799502362;646.2987658390605;663.7776344924408;672.3243140643622;9524.809503809885;9757.902420975699;9784.9021509784;9800.95099524512;9935.80128397428;604.8427408873724;612.8375980365207;649.2047242128449;655.4723447624708;681.6693903456819;4423.20382331177;5073.188289873677;5182.689038657692;5191.896162076813;5248.475152484721;167306;167724;170371;171100;172672;144916;146258.2687086579;146806;147678;150812;118825.40587297181;122488.38755806164;125417.37291313485;126154.36922815327;126943;8527.859003403328;9716.562754675915;10092.596296148366;10210.846837297298;10234.33476824004;66543.33456665372;67059.66470167619;67355;67373.31566710872;69054.9641755364;90759.63860541965;94838;101218.49390753293;102489.90040398599;111091.44454277676;12647.430865610886;12952.935235323763;13070.477180913038;13706.588802335547;13774.862251377357;14539.709205816036;14812.407503699731;14903.925480372529;15704.76442853381;15900.12549309799;13410.513266550572;13641.522546710818;14193.361298741374;14227.430902763774;14310.212938288494;13491.325433728078;14427.92786036063;14432.061915975428;14530.709385812435;15086.094834309977;12326.691832704255;14182.787258190929;14231.64420889486;14632.561023169323;14825.40698372053;11202.327860328407;11361.602343917923;11500.482478288664;11804.468798904241;11841.644750657493;11620.709482263012;11676.06591472697;11699.707507312385;11798.298724791188;11869.584564540544 07:11:50 INFO - PROCESS | 1929 | __end_tp_report 07:11:50 INFO - PROCESS | 1929 | __start_cc_report 07:11:50 INFO - PROCESS | 1929 | _x_x_mozilla_cycle_collect,1234 07:11:50 INFO - PROCESS | 1929 | __end_cc_report 07:11:50 INFO - PROCESS | 1929 | __startTimestamp1479136310065__endTimestamp 07:11:50 INFO - PROCESS | 1929 | 07:11:50 INFO - PROCESS | 1929 | ------- Summary: start ------- 07:11:50 INFO - PROCESS | 1929 | Number of tests: 6 07:11:50 INFO - PROCESS | 1929 | 07:11:50 INFO - PROCESS | 1929 | [#0] dojo.html Cycles:165 Average:5772.66 Median:6044.03 stddev:658.25 (10.9%) stddev-sans-first:615.43 07:11:50 INFO - PROCESS | 1929 | Values: 2728.4 3320.3 3358.1 3383.2 3415.5 5722.8 5777.0 5808.6 5831.5 5843.5 5741.1 5794.9 5802.3 5804.4 5821.6 5219.7 5283.6 5311.7 5314.1 5359.6 4637.5 5178.4 5242.3 5243.8 5382.7 5248.1 5328.2 5333.9 5335.0 5358.2 5271.9 5292.1 5308.2 5361.2 5363.6 5164.3 5276.3 5288.3 5297.5 5322.1 5001.8 5583.4 5594.5 5618.2 5657.9 5039.7 6275.2 6298.2 6306.1 6324.7 6245.5 6303.0 6337.7 6362.6 6373.9 5758.7 5805.7 5814.8 5849.9 5892.4 5049.9 6264.4 6387.6 6389.6 6389.9 6191.9 6199.3 6206.2 6207.0 6208.6 6160.1 6175.4 6258.2 6261.9 6283.0 6121.2 6136.6 6142.6 6195.8 6196.7 6105.2 6159.9 6180.0 6205.1 6213.4 4961.6 4989.4 4989.7 4997.4 5016.6 4488.0 4512.1 4513.1 4514.5 4525.5 5720.0 5758.2 5800.6 5805.4 5806.2 6189.4 6219.0 6227.4 6236.4 6249.3 5819.9 5828.7 5883.2 5906.7 5958.5 5368.8 5416.1 5464.8 5465.0 5466.2 6298.8 6342.2 6385.6 6386.2 6443.7 6237.5 6238.4 6240.1 6253.8 6266.2 6361.1 6398.7 6443.4 6453.9 6459.9 6123.6 6136.9 6145.4 6150.0 6194.1 6201.8 6231.5 6243.8 6247.3 6260.1 5904.4 5981.3 6029.9 6103.8 6144.5 6042.8 6116.1 6143.5 6145.4 6150.0 6006.4 6055.2 6079.2 6084.1 6114.1 6209.3 6223.8 6235.2 6240.8 6246.2 6044.0 6050.2 6081.9 6082.1 6122.8 07:11:50 INFO - PROCESS | 1929 | 07:11:50 INFO - PROCESS | 1929 | [#1] ext.html Cycles:180 Average:58495.96 Median:19270.62 stddev:119911.05 (622.2%) stddev-sans-first:120168.28 07:11:50 INFO - PROCESS | 1929 | Values: 465.5 512.4 517.4 524.6 547.5 30860.5 41059.0 42070.0 42180.0 44088.8 43663.3 44101.8 44132.6 44277.3 44294.7 8825.4 9098.6 9711.6 9903.8 9905.6 8815.9 8997.0 11868.5 12098.6 12104.3 12099.0 12172.8 12174.7 12183.6 12212.8 12069.7 12153.2 12156.5 12167.0 12180.5 8662.4 8889.4 11649.1 11989.9 12006.3 41811.6 42196.4 42268.9 42294.9 42348.9 2869.7 3420.9 3469.4 3505.9 3691.9 29268.7 30000.7 31435.5 32168.5 33130.0 3157.8 3192.9 3284.4 3284.5 3307.1 520512.0 522400.0 522923.0 524038.0 526888.0 60592.7 63340.4 63575.0 63623.0 63894.7 66374.7 66504.3 66506.0 66573.0 66822.3 16544.0 17149.8 17153.2 17162.7 17179.9 12026.2 13176.5 13234.2 13237.0 13272.2 15901.3 18052.6 18203.1 18537.6 18951.8 5755.7 6590.9 6673.1 6727.3 6734.2 863.5 968.5 1063.7 1080.5 1093.8 27941.4 29395.1 29420.0 30538.7 30876.1 1065.2 1083.0 1088.7 1117.3 1136.7 15812.1 15919.4 16164.7 16195.9 16224.0 185173.1 185787.0 186115.1 186604.0 187133.0 59677.8 59931.8 59946.0 60111.4 60282.4 1229.3 1263.3 1346.4 1381.7 1401.3 29519.4 29670.9 32033.8 32087.2 32686.2 51176.0 52107.1 52231.5 52419.0 52454.7 540896.0 542684.0 543284.0 544330.0 544372.0 26637.9 26708.3 27079.7 27251.7 42289.8 47440.3 47953.3 48051.8 48323.3 48576.8 38758.6 39545.0 39804.4 39980.0 41176.8 32832.3 39787.0 40750.4 40767.4 41195.0 38141.6 38738.0 38990.0 39005.2 39021.8 33629.8 34955.3 35035.3 35741.9 35760.5 25869.4 26075.5 26129.0 26153.5 26401.9 07:11:50 INFO - PROCESS | 1929 | 07:11:50 INFO - PROCESS | 1929 | [#2] jquery.html Cycles:180 Average:24941.80 Median:243595.39 stddev:46251.28 (19.0%) stddev-sans-first:46344.08 07:11:50 INFO - PROCESS | 1929 | Values: 318.9 350.5 372.7 377.9 402.5 15144.8 15341.3 16233.1 20665.6 21089.5 18957.1 19906.3 20079.3 21201.5 21204.9 5772.9 5890.6 6169.0 6171.3 6175.1 5609.8 6131.8 6191.4 6206.6 6209.8 5827.0 6010.1 6138.4 6144.5 6153.0 5958.9 6000.6 6008.4 6009.8 6011.8 5029.9 5128.9 5220.7 5244.1 5245.2 22855.3 24936.8 26179.6 26183.0 26298.8 2268.9 2365.8 2456.1 2845.5 2874.3 13555.8 15282.0 15815.4 16041.5 16115.6 1574.0 1868.8 1886.9 1896.6 1937.6 78944.0 104013.0 122194.0 125274.0 128473.4 10913.5 10934.9 11022.5 11046.6 11182.0 13788.2 13795.8 13808.7 13820.5 13824.7 8537.6 8813.2 8831.2 8920.0 8944.2 7257.3 8833.0 8872.5 9057.0 9163.7 6583.4 6693.4 6695.3 6707.2 6711.0 1590.4 1825.1 1865.7 1866.6 1868.0 751.4 771.8 827.1 876.6 1003.5 21539.0 22552.4 22560.3 22592.5 22736.9 931.6 951.5 963.8 989.0 998.1 11631.4 11756.9 11990.2 11990.6 12016.5 243525.8 243665.0 244072.0 244145.8 244613.0 78155.0 117912.0 124388.8 125802.0 127338.0 978.9 994.8 1014.7 1016.5 1017.6 19487.3 20214.9 20548.6 20563.3 20600.3 51542.0 51961.0 53735.5 53911.7 54956.5 75336.6 76997.0 77338.6 77364.0 82078.6 7806.5 7833.6 7972.7 8010.0 8050.1 13146.5 13185.3 13233.1 13566.3 13670.0 11321.1 11332.5 11338.4 11453.4 11572.4 11185.6 11230.8 11528.8 11550.6 11579.5 11626.3 11754.6 11852.2 12159.8 12162.9 7860.4 7873.5 7918.2 8012.1 8107.3 11254.2 11305.7 11666.8 11702.3 11778.4 07:11:50 INFO - PROCESS | 1929 | 07:11:50 INFO - PROCESS | 1929 | [#3] mootools.html Cycles:180 Average:5725.45 Median:4965.40 stddev:3251.79 (65.5%) stddev-sans-first:3243.58 07:11:50 INFO - PROCESS | 1929 | Values: 1258.2 1362.9 1598.8 1818.1 1868.7 8474.8 9070.7 9076.9 9090.6 9093.6 7917.7 8186.7 8193.1 8609.2 8806.9 2026.4 2371.2 2404.2 2404.5 2409.5 2112.3 2297.8 2389.2 2416.0 2417.7 2102.7 2181.7 2188.3 2324.5 2404.3 2394.7 2413.2 2421.3 2429.1 2431.0 2391.6 2429.5 2439.7 2440.1 2450.8 9002.9 9065.0 9078.0 9093.5 9102.9 5250.3 5372.7 5439.3 5446.9 5450.0 3596.4 3668.9 3790.0 3791.0 3811.3 1115.1 1138.6 1780.4 1836.2 1890.3 11285.9 11950.3 11978.8 12056.8 12087.6 4391.4 4521.7 4686.2 4693.6 4703.9 9294.0 9305.0 9312.4 9314.7 9323.0 5312.6 5320.2 5322.7 5324.6 5328.1 4881.1 4898.0 4952.8 4975.0 4979.6 3024.9 3566.9 3583.5 3589.9 3640.9 957.3 976.9 1152.2 1157.2 1161.9 641.5 789.9 873.9 906.8 930.5 5757.2 5784.3 5891.4 5924.5 5929.6 462.4 480.8 490.3 491.3 642.6 3722.3 3958.1 3988.9 4008.7 4034.2 10597.5 11150.3 11159.4 11173.3 11205.3 10710.4 10856.9 10909.8 11053.0 11084.3 8181.3 8271.0 8275.9 8382.1 8386.5 5733.0 5934.7 5962.6 6003.6 6022.9 9892.2 10232.7 10382.9 10417.4 10421.6 8377.5 10044.2 10342.1 10634.9 10722.3 7150.0 7222.0 7228.5 7230.3 7231.6 6663.5 8493.3 8500.9 8511.9 8512.6 7446.2 7500.4 7615.9 7618.1 7647.2 7290.7 7391.6 7486.1 7552.3 7565.1 6983.8 7146.4 7149.4 7153.0 7160.3 4904.5 4955.8 5000.8 5003.4 5101.1 4736.7 5010.0 5039.2 5133.0 5165.1 07:11:50 INFO - PROCESS | 1929 | 07:11:50 INFO - PROCESS | 1929 | [#4] prototype.html Cycles:180 Average:4188.19 Median:4584.68 stddev:1285.29 (28.0%) stddev-sans-first:1255.38 07:11:50 INFO - PROCESS | 1929 | Values: 302.9 303.9 307.3 314.8 315.4 4509.3 4900.6 5401.6 5407.0 5492.4 4421.6 4585.4 5095.6 5249.5 5271.0 3406.5 3422.6 3426.2 4081.9 4110.2 3433.5 3808.4 4102.2 4129.6 4141.1 3356.8 4029.9 4039.5 4070.8 4072.8 3338.1 3354.5 3498.5 4009.3 4053.3 2946.0 3212.6 3493.4 3498.3 3506.0 4320.5 4673.7 4973.0 5198.0 5200.7 4251.7 4632.3 4638.8 4647.8 4660.2 4708.6 4749.5 4938.4 5186.4 5654.1 3249.4 3711.4 3838.5 3878.3 3882.9 4499.8 5813.1 5869.4 5906.4 5913.0 3886.1 3889.6 3897.9 3910.7 3922.3 3331.2 3577.7 3763.5 3990.0 3996.8 4273.4 4381.8 4427.8 4583.9 4594.3 5179.0 5669.6 5683.2 5698.2 5768.5 1067.1 1275.7 1276.3 1295.8 1324.8 729.7 765.8 898.5 906.4 911.3 4766.8 5123.2 5296.0 5352.4 5353.3 4590.0 5259.5 5382.2 5805.6 5828.7 4431.0 4607.6 5199.0 5252.4 5298.8 1969.1 2360.9 2494.4 2516.6 2525.5 4152.7 4544.0 4830.4 4899.8 4914.7 4817.9 4823.8 4832.8 4859.8 4874.9 3945.3 4806.4 4863.9 4866.7 4887.2 3991.9 4046.9 4461.3 4715.4 4748.4 4249.4 4551.5 4690.3 4699.4 4715.7 4537.4 4767.5 4845.9 4871.2 4889.7 3282.0 3309.9 3312.9 3369.2 3392.8 4002.0 4013.4 4344.5 4687.0 4711.6 4333.7 4343.7 4605.5 4644.0 4702.7 3845.9 4249.6 4261.3 4556.5 4580.9 4495.5 4531.9 5208.4 5289.9 5326.4 5294.6 5697.2 5711.4 5716.5 5808.6 4708.5 5270.3 5575.0 5603.4 5679.5 07:11:50 INFO - PROCESS | 1929 | 07:11:50 INFO - PROCESS | 1929 | [#5] yui.html Cycles:180 Average:27069.45 Median:96947.63 stddev:44286.29 (45.7%) stddev-sans-first:44366.28 07:11:50 INFO - PROCESS | 1929 | Values: 704.4 752.0 759.2 775.2 797.3 15551.0 16395.3 16406.3 16509.3 16643.7 16727.0 16916.7 16922.5 16929.0 16960.0 665.6 683.5 827.2 851.6 855.0 679.7 824.1 836.4 841.7 847.9 877.7 878.8 880.0 883.2 883.7 661.5 718.8 796.0 878.7 879.5 639.8 651.6 651.6 655.2 657.4 15575.8 15591.9 15601.2 15603.9 15621.7 13439.9 13719.7 13784.2 13853.4 14077.6 12478.5 12600.4 12678.9 12929.2 13458.2 4484.8 4563.8 4571.5 4755.7 4778.1 109913.4 112415.4 112613.4 112755.0 116169.8 10649.7 10761.9 10767.5 10965.5 10999.8 21223.3 21242.5 21248.6 21260.6 21279.8 7522.7 7527.7 7683.4 7724.5 7861.5 4335.8 4346.3 4375.1 4440.0 4516.6 3497.1 3587.0 3591.4 3601.4 3923.8 719.4 722.2 726.7 727.8 733.0 522.7 638.5 646.3 663.8 672.3 9524.8 9757.9 9784.9 9801.0 9935.8 604.8 612.8 649.2 655.5 681.7 4423.2 5073.2 5182.7 5191.9 5248.5 167306.0 167724.0 170371.0 171100.0 172672.0 144916.0 146258.3 146806.0 147678.0 150812.0 118825.4 122488.4 125417.4 126154.4 126943.0 8527.9 9716.6 10092.6 10210.8 10234.3 66543.3 67059.7 67355.0 67373.3 69055.0 90759.6 94838.0 101218.5 102489.9 111091.4 12647.4 12952.9 13070.5 13706.6 13774.9 14539.7 14812.4 14903.9 15704.8 15900.1 13410.5 13641.5 14193.4 14227.4 14310.2 13491.3 14427.9 14432.1 14530.7 15086.1 12326.7 14182.8 14231.6 14632.6 14825.4 11202.3 11361.6 11500.5 11804.5 11841.6 11620.7 11676.1 11699.7 11798.3 11869.6 07:11:50 INFO - PROCESS | 1929 | -------- Summary: end -------- 07:11:50 INFO - PROCESS | 1929 | 07:11:50 INFO - TEST-INFO | 1929: exit 0 07:11:50 INFO - TEST-OK | dromaeo_css | took 1117472ms 07:11:50 INFO - TEST-START | kraken 07:11:50 INFO - operating with platform_type : mac_ 07:11:50 INFO - Initialising browser for kraken test... 07:11:50 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpkDZ6Cn/profile http://localhost:52721/getInfo.html) 07:11:53 INFO - PROCESS | 1937 | __metrics Screen width/height:1600/1200 07:11:53 INFO - PROCESS | 1937 | colorDepth:24 07:11:53 INFO - PROCESS | 1937 | Browser inner width/height: 1024/689 07:11:53 INFO - PROCESS | 1937 | __metrics 07:11:53 INFO - PROCESS | 1937 | 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 | 1937 | 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 | 1937: 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 1938 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpkDZ6Cn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:12:05 INFO - PROCESS | 1938 | RSS: Main: 236961792 07:12:05 INFO - PROCESS | 1938 | 07:12:08 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52721/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52721/tests/kraken/driver.html?testName=audio-beat-detection) 07:12:09 INFO - PROCESS | 1938 | RSS: Main: 283918336 07:12:09 INFO - PROCESS | 1938 | 07:12:12 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52721/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52721/tests/kraken/driver.html?testName=audio-dft) 07:12:13 INFO - PROCESS | 1938 | RSS: Main: 295460864 07:12:13 INFO - PROCESS | 1938 | 07:12:16 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52721/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52721/tests/kraken/driver.html?testName=audio-fft) 07:12:16 INFO - PROCESS | 1938 | RSS: Main: 390406144 07:12:16 INFO - PROCESS | 1938 | 07:12:18 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52721/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52721/tests/kraken/driver.html?testName=audio-oscillator) 07:12:19 INFO - PROCESS | 1938 | RSS: Main: 290512896 07:12:19 INFO - PROCESS | 1938 | 07:12:21 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52721/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52721/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:12:22 INFO - PROCESS | 1938 | RSS: Main: 291028992 07:12:22 INFO - PROCESS | 1938 | 07:12:24 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52721/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52721/tests/kraken/driver.html?testName=imaging-darkroom) 07:12:25 INFO - PROCESS | 1938 | RSS: Main: 328888320 07:12:25 INFO - PROCESS | 1938 | 07:12:28 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52721/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52721/tests/kraken/driver.html?testName=imaging-desaturate) 07:12:28 INFO - PROCESS | 1938 | RSS: Main: 328626176 07:12:28 INFO - PROCESS | 1938 | 07:12:31 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52721/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52721/tests/kraken/driver.html?testName=json-parse-financial) 07:12:32 INFO - PROCESS | 1938 | RSS: Main: 325562368 07:12:32 INFO - PROCESS | 1938 | 07:12:34 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52721/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52721/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:12:34 INFO - PROCESS | 1938 | RSS: Main: 302116864 07:12:34 INFO - PROCESS | 1938 | 07:12:36 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52721/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52721/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:12:37 INFO - PROCESS | 1938 | RSS: Main: 306896896 07:12:37 INFO - PROCESS | 1938 | 07:12:39 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52721/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52721/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:12:39 INFO - PROCESS | 1938 | RSS: Main: 312004608 07:12:39 INFO - PROCESS | 1938 | 07:12:42 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52721/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52721/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:12:43 INFO - PROCESS | 1938 | RSS: Main: 319258624 07:12:43 INFO - PROCESS | 1938 | 07:12:46 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52721/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52721/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:12:47 INFO - PROCESS | 1938 | RSS: Main: 318681088 07:12:47 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | Cycle 1(1): loaded http://localhost:52721/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52721/tests/kraken/driver.html?testName=ai-astar) 07:12:49 INFO - PROCESS | 1938 | RSS: Main: 362151936 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | __start_tp_report 07:12:49 INFO - PROCESS | 1938 | _x_x_mozilla_page_load 07:12:49 INFO - PROCESS | 1938 | _x_x_mozilla_page_load_details 07:12:49 INFO - PROCESS | 1938 | |i|pagename|runs| 07:12:49 INFO - PROCESS | 1938 | |0;ai-astar;116;114;116;115;118;167;169;114;111;92 07:12:49 INFO - PROCESS | 1938 | |1;audio-beat-detection;144;109;115;174;114;109;108;109;139;108 07:12:49 INFO - PROCESS | 1938 | |2;audio-dft;184;184;195;184;184;182;186;185;183;185 07:12:49 INFO - PROCESS | 1938 | |3;audio-fft;81;59;60;95;63;62;58;57;83;58 07:12:49 INFO - PROCESS | 1938 | |4;audio-oscillator;85;70;94;72;69;68;94;67;68;90 07:12:49 INFO - PROCESS | 1938 | |5;imaging-gaussian-blur;87;85;88;85;87;84;87;84;88;85 07:12:49 INFO - PROCESS | 1938 | |6;imaging-darkroom;98;92;92;94;92;93;93;93;132;103 07:12:49 INFO - PROCESS | 1938 | |7;imaging-desaturate;94;86;87;85;87;102;110;71;124;132 07:12:49 INFO - PROCESS | 1938 | |8;json-parse-financial;55;52;54;52;55;56;56;57;57;57 07:12:49 INFO - PROCESS | 1938 | |9;json-stringify-tinderbox;73;71;67;77;72;70;71;70;72;74 07:12:49 INFO - PROCESS | 1938 | |10;stanford-crypto-aes;83;81;83;84;85;90;82;80;83;83 07:12:49 INFO - PROCESS | 1938 | |11;stanford-crypto-ccm;141;137;138;137;138;138;136;149;200;133 07:12:49 INFO - PROCESS | 1938 | |12;stanford-crypto-pbkdf2;174;161;142;213;232;218;166;167;166;169 07:12:49 INFO - PROCESS | 1938 | |13;stanford-crypto-sha256-iterative;69;80;90;63;58;89;85;85;87;86 07:12:49 INFO - PROCESS | 1938 | __end_tp_report 07:12:49 INFO - PROCESS | 1938 | __start_cc_report 07:12:49 INFO - PROCESS | 1938 | _x_x_mozilla_cycle_collect,2085 07:12:49 INFO - PROCESS | 1938 | __end_cc_report 07:12:49 INFO - PROCESS | 1938 | __startTimestamp1479136369470__endTimestamp 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | ------- Summary: start ------- 07:12:49 INFO - PROCESS | 1938 | Number of tests: 14 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | [#0] ai-astar Cycles:10 Average:123.20 Median:117.00 stddev:24.73 (21.1%) stddev-sans-first:26.10 07:12:49 INFO - PROCESS | 1938 | Values: 116.0 114.0 116.0 115.0 118.0 167.0 169.0 114.0 111.0 92.0 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | [#1] audio-beat-detection Cycles:10 Average:122.90 Median:114.50 stddev:22.31 (19.5%) stddev-sans-first:22.32 07:12:49 INFO - PROCESS | 1938 | Values: 144.0 109.0 115.0 174.0 114.0 109.0 108.0 109.0 139.0 108.0 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | [#2] audio-dft Cycles:10 Average:185.20 Median:184.50 stddev:3.61 (2.0%) stddev-sans-first:3.81 07:12:49 INFO - PROCESS | 1938 | Values: 184.0 184.0 195.0 184.0 184.0 182.0 186.0 185.0 183.0 185.0 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | [#3] audio-fft Cycles:10 Average:67.60 Median:62.50 stddev:13.53 (21.7%) stddev-sans-first:13.46 07:12:49 INFO - PROCESS | 1938 | Values: 81.0 59.0 60.0 95.0 63.0 62.0 58.0 57.0 83.0 58.0 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:78.50 stddev:11.58 (14.7%) stddev-sans-first:11.97 07:12:49 INFO - PROCESS | 1938 | Values: 85.0 70.0 94.0 72.0 69.0 68.0 94.0 67.0 68.0 90.0 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:87.00 stddev:1.56 (1.8%) stddev-sans-first:1.62 07:12:49 INFO - PROCESS | 1938 | Values: 87.0 85.0 88.0 85.0 87.0 84.0 87.0 84.0 88.0 85.0 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | [#6] imaging-darkroom Cycles:10 Average:98.20 Median:93.00 stddev:12.38 (13.3%) stddev-sans-first:13.13 07:12:49 INFO - PROCESS | 1938 | Values: 98.0 92.0 92.0 94.0 92.0 93.0 93.0 93.0 132.0 103.0 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | [#7] imaging-desaturate Cycles:10 Average:97.80 Median:85.50 stddev:19.12 (22.4%) stddev-sans-first:20.23 07:12:49 INFO - PROCESS | 1938 | Values: 94.0 86.0 87.0 85.0 87.0 102.0 110.0 71.0 124.0 132.0 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:56.00 stddev:1.91 (3.4%) stddev-sans-first:2.03 07:12:49 INFO - PROCESS | 1938 | Values: 55.0 52.0 54.0 52.0 55.0 56.0 56.0 57.0 57.0 57.0 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.00 stddev:2.67 (3.7%) stddev-sans-first:2.79 07:12:49 INFO - PROCESS | 1938 | Values: 73.0 71.0 67.0 77.0 72.0 70.0 71.0 70.0 72.0 74.0 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.72 (3.3%) stddev-sans-first:2.88 07:12:49 INFO - PROCESS | 1938 | Values: 83.0 81.0 83.0 84.0 85.0 90.0 82.0 80.0 83.0 83.0 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:138.00 stddev:19.88 (14.4%) stddev-sans-first:21.04 07:12:49 INFO - PROCESS | 1938 | Values: 141.0 137.0 138.0 137.0 138.0 138.0 136.0 149.0 200.0 133.0 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:171.50 stddev:29.35 (17.1%) stddev-sans-first:31.03 07:12:49 INFO - PROCESS | 1938 | Values: 174.0 161.0 142.0 213.0 232.0 218.0 166.0 167.0 166.0 169.0 07:12:49 INFO - PROCESS | 1938 | 07:12:49 INFO - PROCESS | 1938 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.20 Median:85.50 stddev:11.56 (13.5%) stddev-sans-first:11.66 07:12:49 INFO - PROCESS | 1938 | Values: 69.0 80.0 90.0 63.0 58.0 89.0 85.0 85.0 87.0 86.0 07:12:49 INFO - PROCESS | 1938 | -------- Summary: end -------- 07:12:49 INFO - PROCESS | 1938 | 07:12:50 INFO - TEST-INFO | 1938: exit 0 07:12:50 INFO - TEST-OK | kraken | took 59672ms 07:12:50 INFO - SUITE-END | took 1177s 07:12:50 INFO - Completed test suite (00:19:37) 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": [2728.386113124547, 3320.269540701046, 3358.1436733632904, 3383.2049468374944, 3415.5047518109873, 5722.799702010425, 5776.971115144418, 5808.622439541432, 5831.504322132624, 5843.532517398608, 5741.052726300156, 5794.942050579503, 5802.332731735852, 5804.390538993408, 5821.621594596349, 5219.739013049351, 5283.63014588979, 5311.73441327934, 5314.070037743399, 5359.624826262163, 4637.466691330506, 5178.446466060167, 5242.292290540767, 5243.816466423676, 5382.730863456831, 5248.0815857225025, 5328.17413300939, 5333.893322133555, 5335.013022590813, 5358.169483730028, 5271.920921186185, 5292.073887069748, 5308.203769434577, 5361.195820626898, 5363.597730170253, 5164.2770012198325, 5276.261323414725, 5288.2596436498925, 5297.5232229099565, 5322.121849894763, 5001.824571225759, 5583.441655834425, 5594.468525490112, 5618.213450116987, 5657.943420565783, 5039.672421292605, 6275.152854364648, 6298.2442106947, 6306.1486699295465, 6324.683765811737, 6245.500359971192, 6303.0, 6337.714802833883, 6362.5864318819595, 6373.904391434132, 5758.74085666146, 5805.651660900359, 5814.796482123105, 5849.912251316234, 5892.440218179266, 5049.899002020013, 6264.373562643699, 6387.648679322682, 6389.584676995981, 6389.936100639027, 6191.938080619227, 6199.256089269316, 6206.193194884727, 6207.0, 6208.627482351073, 6160.10678451622, 6175.382461753788, 6258.186435763321, 6261.8747625047245, 6283.02613094971, 6121.204243448323, 6136.648568731431, 6142.648617304186, 6195.81412557624, 6196.690165491797, 6105.247473116927, 6159.907601385983, 6179.969100154561, 6205.100260462208, 6213.409726076106, 4961.603071754251, 4989.426215985208, 4989.700617962933, 4997.425296090996, 5016.598672106223, 4487.955120448819, 4512.05246898155, 4513.11994161142, 4514.480834703985, 4525.547445255448, 5720.027595308808, 5758.165066065397, 5800.622959507618, 5805.448482394166, 5806.187133801272, 6189.412005859436, 6219.0, 6227.408396202353, 6236.438720515084, 6249.343818899041, 5819.854503637443, 5828.737706803204, 5883.235179426732, 5906.675132867647, 5958.463738263577, 5368.812091576776, 5416.0792665247, 5464.754086066137, 5465.0, 5466.207399926989, 6298.811035668938, 6342.238931328178, 6385.648789316447, 6386.201724784402, 6443.67781610927, 6237.4698150657705, 6238.407351301619, 6240.126382306572, 6253.812385628438, 6266.185395898504, 6361.109444677656, 6398.744050238124, 6443.420092191725, 6453.935460645521, 6459.903101453576, 6123.601965872204, 6136.8953588354525, 6145.446909778141, 6149.954507733606, 6194.132821405097, 6201.751929922752, 6231.501479881508, 6243.7814676486105, 6247.312795592572, 6260.060990851409, 5904.439078287556, 5981.312149102909, 6029.939700602938, 6103.786367477117, 6144.508439324753, 6042.818715438368, 6116.092308610808, 6143.477804386498, 6145.4161854623735, 6150.015997440388, 6006.369331220334, 6055.1522786810765, 6079.240094988127, 6084.11780291864, 6114.082887566723, 6209.348018458178, 6223.813285601439, 6235.220597425322, 6240.7503699851495, 6246.219222597176, 6044.032954727222, 6050.213472248755, 6081.939180608138, 6082.057281121433, 6122.794608433986], "value": 5729.418079103286, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.527489598058, 512.3953734593181, 517.3791450259688, 524.6484855147052, 547.4525474525475, 30860.53709194361, 41059.0, 42070.0, 42180.0, 44088.77955610226, 43663.345049824275, 44101.7794911025, 44132.558674413245, 44277.33583996235, 44294.671159865255, 8825.382223244376, 9098.590563424661, 9711.562979665914, 9903.801923961517, 9905.603775848957, 8815.867761983576, 8997.0, 11868.465919033664, 12098.637040888787, 12104.273743575413, 12099.032077433783, 12172.756544869097, 12174.695632609211, 12183.57357492488, 12212.816807747891, 12069.698257543589, 12153.210041347284, 12156.452959616883, 12167.026637868948, 12180.451879665436, 8662.393632445732, 8889.422187557853, 11649.12631552637, 11989.880101198964, 12006.279623222546, 41811.581884181076, 42196.36705449421, 42268.94327641803, 42294.94262643428, 42348.941276468024, 2869.684334723179, 3420.9486857697157, 3469.3928562501715, 3505.9474107888145, 3691.907702307437, 29268.707312927025, 30000.69999300001, 31435.528467072785, 32168.517472237934, 33130.024397072266, 3157.842107894619, 3192.8563214655396, 3284.359549887773, 3284.4744840825592, 3307.140143562667, 520512.0, 522400.0, 522923.0, 524038.0, 526887.9999999962, 60592.69703651542, 63340.36659633345, 63575.0, 63623.045654315225, 63894.68052659707, 66374.66812665906, 66504.33495665078, 66506.0, 66573.0, 66822.33177668258, 16544.007359558225, 17149.828501714823, 17153.228104735317, 17162.656746864992, 17179.883307584965, 12026.158168928267, 13176.538821141407, 13234.205947643171, 13237.0, 13272.203667779771, 15901.284442199898, 18052.63894722098, 18203.08984550767, 18537.629247414978, 18951.81048189528, 5755.65466072037, 6590.868182636321, 6673.132492775908, 6727.327267273234, 6734.191896972395, 863.48622569571, 968.4915419404728, 1063.7181146996052, 1080.5191689698165, 1093.775775965941, 27941.441171176462, 29395.118146455214, 29420.0, 30538.694613053583, 30876.073717788502, 1065.169168048923, 1082.9891701082888, 1088.689723428835, 1117.3296022386667, 1136.72718547548, 15812.051276923421, 15919.442819501262, 16164.676706465805, 16195.919020404823, 16224.026558406533, 185173.07413462846, 185787.0, 186115.0694246547, 186604.0, 187133.0, 59677.80644387088, 59931.801363972474, 59946.0, 60111.398886011455, 60282.39717602856, 1229.299299399334, 1263.3430616079588, 1346.3941226447942, 1381.716748066644, 1401.2783416540285, 29519.409611808074, 29670.851645741634, 32033.839830800698, 32087.197820054684, 32686.182845429055, 51176.0, 52107.13410762444, 52231.477685222664, 52418.95162096813, 52454.688632782956, 540896.0, 542684.0, 543284.0, 544330.0, 544372.0, 26637.93448262048, 26708.332291692863, 27079.72920270772, 27251.72748272492, 42289.78855105705, 47440.33958811425, 47953.280700790216, 48051.75974120107, 48323.275150873465, 48576.75711621561, 38758.6124138755, 39545.0, 39804.40293395543, 39980.000499987735, 41176.794116029225, 32832.31704284309, 39787.00532486711, 40750.38874416827, 40767.38848917328, 41195.0, 38141.618583813804, 38738.0, 38990.0, 39005.21989560136, 39021.80489097536, 33629.83185084059, 34955.30089398249, 35035.29929401448, 35741.927742167776, 35760.46359304665, 25869.353266168495, 26075.478490430465, 26129.0, 26153.539381854436, 26401.867990659925], "value": 19978.95895691433, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.91389324882283, 350.5145373657487, 372.68508110646513, 377.92819364320775, 402.47878996699274, 15144.848551514482, 15341.309641066151, 16233.10717910516, 20665.586688266227, 21089.47276318093, 18957.14692838822, 19906.303279385225, 20079.297224597107, 21201.469963250926, 21204.89397553014, 5772.884542309152, 5890.64656120632, 6169.0, 6171.2594488661425, 6175.07373893915, 5609.80365687201, 6131.846703832395, 6191.442770150686, 6206.596571222856, 6209.782657606985, 5827.0, 6010.12853136295, 6138.416850399205, 6144.5084393248435, 6152.969235153818, 5958.851028724273, 6000.639961602318, 6008.36912124225, 6009.789657361993, 6011.849703757397, 5029.917446778824, 5128.871778205537, 5220.686758794484, 5244.056069907415, 5245.213218017289, 22855.314340569643, 24936.750632493804, 26179.607305890237, 26183.0, 26298.816553254957, 2268.9092436302526, 2365.7989070928993, 2456.115798312606, 2845.5304874695858, 2874.2670618992024, 13555.847752941012, 15282.0, 15815.367385304575, 16041.518754437386, 16115.597110072225, 1574.0, 1868.8164162696899, 1886.9056547172586, 1896.6111947050958, 1937.6124775045048, 78944.0, 104013.0, 122194.0, 125274.0, 128473.35763321217, 10913.454327283604, 10934.890651093547, 11022.50398732059, 11046.613368532062, 11182.0, 13788.241646709528, 13795.793063104062, 13808.723825523433, 13820.516281930084, 13824.654383640489, 8537.615807288686, 8813.206811387006, 8831.205191532792, 8920.0, 8944.150305720947, 7257.330813912829, 8832.955835220911, 8872.467651940904, 9057.00372958974, 9163.725088247364, 6583.407493325623, 6693.431058359996, 6695.330466953363, 6707.195136583544, 6710.959801230817, 1590.4433448293005, 1825.1330617956364, 1865.6940141900452, 1866.6080123174286, 1867.9626407471774, 751.3988808952815, 771.76846945916, 827.1439060572279, 876.5587837871498, 1003.5383723487132, 21539.0, 22552.436189095402, 22560.323190304316, 22592.548149037255, 22736.863156842424, 931.6459745296744, 951.4909523404945, 963.7831487915303, 989.0455710239653, 998.1166667499315, 11631.360275184777, 11756.94121529387, 11990.160688751877, 11990.640280791416, 12016.459259333176, 243525.78237109055, 243665.0, 244072.0, 244145.7792711025, 244613.0, 78155.0, 117912.0, 124388.75611243953, 125802.0, 127338.0, 978.9314747967574, 994.751312171957, 1014.7057353367588, 1016.4866742295094, 1017.5675337981477, 19487.317943872462, 20214.898925505866, 20548.589028219052, 20563.280285189947, 20600.27899023587, 51542.0, 51961.0, 53735.462645373045, 53911.73044134754, 54956.450435495135, 75336.62331688307, 76997.0, 77338.61330693311, 77364.0, 82078.58960705159, 7806.4925779824125, 7833.608319583884, 7972.720954766555, 8009.959950200212, 8050.114487406264, 13146.474141034252, 13185.340732963505, 13233.129232350539, 13566.321683915961, 13670.043096983116, 11321.09431245482, 11332.546698132312, 11338.376389298337, 11453.370064646524, 11572.36352000648, 11185.552577896793, 11230.83153752678, 11528.82706759416, 11550.595729149776, 11579.478923448296, 11626.33905161415, 11754.647360579196, 11852.170348075551, 12159.75680486403, 12162.939185304016, 7860.371170306247, 7873.5275883447175, 7918.208179182267, 8012.078610959814, 8107.297467531885, 11254.155938304497, 11305.71735706581, 11666.76666466649, 11702.2978621283, 11778.411079445823], "value": 9562.310913887362, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1258.207329382489, 1362.9114107583007, 1598.8161361443438, 1818.0546116019677, 1868.7290342900271, 8474.788130296745, 9070.727878163658, 9076.8638470423, 9090.590923408447, 9093.636254549827, 7917.683292668286, 8186.672533098669, 8193.057798353191, 8609.182127697874, 8806.91193088069, 2026.412340421276, 2371.1700904683353, 2404.2066118181046, 2404.5190961807707, 2409.5301416223842, 2112.26070875194, 2297.7936583293736, 2389.163792672568, 2416.0215112879223, 2417.697787776528, 2102.6530622447276, 2181.683655869906, 2188.2559929623926, 2324.5234726881035, 2404.278716385086, 2394.6647469354302, 2413.155395611531, 2421.32202983165, 2429.149797570854, 2430.963535546968, 2391.5934291170543, 2429.514097180571, 2439.7194322652767, 2440.1093600835743, 2450.816188785848, 9002.909970900273, 9064.954675226647, 9078.046805085503, 9093.45439273639, 9102.908970910272, 5250.264962905197, 5372.7045012524295, 5439.292891924064, 5446.891062178774, 5449.972750136224, 3596.37063513884, 3668.8899333020054, 3789.981050094732, 3791.0, 3811.275857587077, 1115.130198445214, 1138.6356365962895, 1780.4480611010629, 1836.2012524551728, 1890.2816929566677, 11285.871412858649, 11950.342731149784, 11978.760424791542, 12056.758864822654, 12087.576934807328, 4391.385206071089, 4521.683482156218, 4686.179918514246, 4693.577578017995, 4703.858884233478, 9293.95353023244, 9304.97645259021, 9312.44125352481, 9314.673986410578, 9323.0, 5312.62811603184, 5320.201969704498, 5322.733863306819, 5324.627276090714, 5328.094223981932, 4881.121398148367, 4897.951020489821, 4952.801887924443, 4975.0, 4979.576735977483, 3024.941270555288, 3566.9108272292883, 3583.4624806279267, 3589.94615080774, 3640.908977275589, 957.3107362698846, 976.8730065091493, 1152.1819508149308, 1157.1784033336257, 1161.9186656934103, 641.5380925733465, 789.8815177723387, 873.9388242822941, 906.7823722306731, 930.5056576734357, 5757.165211044459, 5784.334801497797, 5891.351951285355, 5924.496417804448, 5929.555283353766, 462.4335189392967, 480.8052738640856, 490.2890808327939, 491.3072567679555, 642.601587016053, 3722.3485889969147, 3958.1094253792667, 3988.9002774930277, 4008.677136544933, 4034.23349563582, 10597.523111460003, 11150.330980141056, 11159.386233757059, 11173.329600224013, 11205.327680339205, 10710.357378557312, 10856.945715271373, 10909.781804363869, 11053.00522952938, 11084.279521831055, 8181.263686268265, 8271.007479102425, 8275.882755827886, 8382.07797142314, 8386.496810191285, 5732.971335143297, 5934.732937017931, 5962.642241465526, 6003.5797494174985, 6022.8795424090395, 9892.208623309974, 10232.744181395525, 10382.896171038194, 10417.42704151279, 10421.635242766466, 8377.539235342114, 10044.196464282986, 10342.120919721909, 10634.946825265824, 10722.284434490444, 7149.999000140088, 7221.963890180516, 7228.4940054197805, 7230.313120253568, 7231.63841807897, 6663.500237482305, 8493.278071363757, 8500.914990850013, 8511.872321915052, 8512.616932237941, 7446.218147094477, 7500.399968002437, 7615.885761713468, 7618.085829700472, 7647.158812530506, 7290.671919763729, 7391.593462359622, 7486.139094004041, 7552.320291173601, 7565.130010048915, 6983.790486285419, 7146.392556632744, 7149.392301654209, 7153.0, 7160.319769621878, 4904.509549045067, 4955.801767929387, 5000.799968001239, 5003.399592048831, 5101.0818052750865, 4736.692115012514, 5009.974950125226, 5039.21892106724, 5132.9743351283005, 5165.096108181128], "value": 4533.044525859134, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.9484987552116, 303.90882735179457, 307.3238874476152, 314.8126864515614, 315.4306476809358, 4509.346144809001, 4900.632452566054, 5401.622586240508, 5406.972965135179, 5492.423295553965, 4421.557844215577, 4585.426821647294, 5095.566876815476, 5249.4750524947485, 5271.049711606711, 3406.540117084199, 3422.623511413749, 3426.190523770509, 4081.9183616327655, 4110.239605672945, 3433.4678124890684, 3808.428735689641, 4102.200070986159, 4129.6283334499885, 4141.068259641586, 3356.832158392083, 4029.89177976056, 4039.53545342285, 4070.796460176994, 4072.8370865165357, 3338.1306468377543, 3354.480055591387, 3498.4577390504514, 4009.258287216874, 4053.3312003519677, 2946.0, 3212.5823642926503, 3493.4410494320787, 3498.2888261597213, 3505.9824700876334, 4320.4599425071865, 4673.728390126891, 4972.95567930735, 5197.974010129963, 5200.685694865786, 4251.659867210616, 4632.2819962905805, 4638.79125439356, 4647.814087436498, 4660.16117098922, 4708.623310135181, 4749.453812811502, 4938.38270216223, 5186.429492755794, 5654.123610840326, 3249.4151052810485, 3711.406175012012, 3838.5201849768778, 3878.312933873774, 3882.9029274268087, 4499.75251361175, 5813.069908814612, 5869.413058694096, 5906.4347947794295, 5913.0, 3886.106195574977, 3889.649931506178, 3897.8635747748694, 3910.667593254548, 3922.3135951208424, 3331.200511877132, 3577.6601222883783, 3763.454299126611, 3989.9601003989587, 3996.760194388346, 4273.380359847804, 4381.823178195783, 4427.760227136407, 4583.931241031387, 4594.264917613166, 5178.974105129526, 5669.574781891375, 5683.232763576947, 5698.230738850285, 5768.50967667753, 1067.1356201476829, 1275.655572995286, 1276.304414094321, 1295.799151131576, 1324.8410190776976, 729.6862349189793, 765.8353454007304, 898.4609234459272, 906.3519583497831, 911.3210658059655, 4766.76166191689, 5123.23248479274, 5295.967286379119, 5352.384475785335, 5353.304070470892, 4589.967257367066, 5259.476150978777, 5382.165764306539, 5805.606654402997, 5828.679422631796, 4430.977845110754, 4607.590383116537, 5198.996772485165, 5252.44849290819, 5298.841034768963, 1969.1040576537641, 2360.905563777464, 2494.3514686181725, 2516.572182728904, 2525.4720893858953, 4152.691902050905, 4544.00031992961, 4830.420349558076, 4899.804007839646, 4914.697605134642, 4817.867801066746, 4823.758812059383, 4832.830850920201, 4859.792536925612, 4874.8537543873745, 3945.277758346789, 4806.351142595705, 4863.884210368501, 4866.7079975201605, 4887.193613053806, 3991.880243592697, 4046.866877274368, 4461.330800379969, 4715.439842918575, 4748.430188377279, 4249.406472572785, 4551.499335073206, 4690.319903614025, 4699.389079419653, 4715.712879253628, 4537.410136682211, 4767.499412561631, 4845.854624361275, 4871.196252618278, 4889.682170658896, 3282.015395381424, 3309.9172520687175, 3312.8840490582716, 3369.2419205678525, 3392.8473218705712, 4002.0195052212393, 4013.3779264214095, 4344.522102568778, 4687.015726697432, 4711.552402521755, 4333.71830830995, 4343.739375637472, 4605.545840619536, 4643.981412082174, 4702.741349225826, 3845.8846234613006, 4249.596288352602, 4261.254280500838, 4556.450806725729, 4580.938577640142, 4495.505494395679, 4531.864044078683, 5208.374995000624, 5289.894202116013, 5326.440723723953, 5294.602904782079, 5697.173909783141, 5711.400302968129, 5716.5426765859465, 5808.6224395414165, 4708.505606911362, 5270.262163297218, 5575.0, 5603.439656034364, 5679.545636348999], "value": 3790.603558940758, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.3907020427329, 752.033636776742, 759.2066290726191, 775.1976704111245, 797.326259310882, 15551.0, 16395.344186232567, 16406.26171822268, 16509.257083431243, 16643.66712665746, 16727.0, 16916.661666766657, 16922.492325230232, 16928.98426094435, 16960.0, 665.6139439125295, 683.5249501596393, 827.210014436212, 851.6295411495988, 854.9914500855006, 679.663566534566, 824.056455358614, 836.4186890111375, 841.7474757572704, 847.9109693482188, 877.6971944679076, 878.8330217258732, 879.9792241000441, 883.2227639677075, 883.7437143228456, 661.4509956735945, 718.7699936020475, 795.9612705419426, 878.6529320918233, 879.463527248378, 639.7696829141552, 651.5601968671175, 651.6253154436218, 655.220287857448, 657.4017643943988, 15575.844241557552, 15591.922040389838, 15601.219939003004, 15603.92198039014, 15621.687566248725, 13439.932800336033, 13719.657008574766, 13784.172949622955, 13853.445862165601, 14077.64805879851, 12478.50085996559, 12600.36998150098, 12678.873211267954, 12929.224246545238, 13458.192508449525, 4484.8430304939175, 4563.840265590688, 4571.474280457756, 4755.690880092818, 4778.092162489116, 109913.35129972977, 112415.43792281068, 112613.43693281563, 112754.95920652656, 116169.83830161675, 10649.733756656145, 10761.946190268998, 10767.515461804238, 10965.451727413756, 10999.835002474969, 21223.257185998416, 21242.468938276357, 21248.575028499654, 21260.574788504142, 21279.78720212778, 7522.746644993738, 7527.736529221561, 7683.385329173652, 7724.536527808349, 7861.489003214772, 4335.82656693735, 4346.326319420432, 4375.0962173544185, 4439.977800110979, 4516.554702495236, 3497.0732755819727, 3587.031501494634, 3591.3715099857423, 3601.423772196436, 3923.8234279457492, 719.4208662027119, 722.2380388689877, 726.702052158623, 727.8398752274492, 733.0470388495041, 522.7438555108046, 638.5306799502362, 646.2987658390605, 663.7776344924408, 672.3243140643622, 9524.809503809885, 9757.902420975699, 9784.9021509784, 9800.95099524512, 9935.80128397428, 604.8427408873724, 612.8375980365207, 649.2047242128449, 655.4723447624708, 681.6693903456819, 4423.20382331177, 5073.188289873677, 5182.689038657692, 5191.896162076813, 5248.475152484721, 167306.0, 167724.0, 170371.0, 171100.0, 172672.0, 144916.0, 146258.2687086579, 146806.0, 147678.0, 150812.0, 118825.40587297181, 122488.38755806164, 125417.37291313485, 126154.36922815327, 126943.0, 8527.859003403328, 9716.562754675915, 10092.596296148366, 10210.846837297298, 10234.33476824004, 66543.33456665372, 67059.66470167619, 67355.0, 67373.31566710872, 69054.9641755364, 90759.63860541965, 94838.0, 101218.49390753293, 102489.90040398599, 111091.44454277676, 12647.430865610886, 12952.935235323763, 13070.477180913038, 13706.588802335547, 13774.862251377357, 14539.709205816036, 14812.407503699731, 14903.925480372529, 15704.76442853381, 15900.12549309799, 13410.513266550572, 13641.522546710818, 14193.361298741374, 14227.430902763774, 14310.212938288494, 13491.325433728078, 14427.92786036063, 14432.061915975428, 14530.709385812435, 15086.094834309977, 12326.691832704255, 14182.787258190929, 14231.64420889486, 14632.561023169323, 14825.40698372053, 11202.327860328407, 11361.602343917923, 11500.482478288664, 11804.468798904241, 11841.644750657493, 11620.709482263012, 11676.06591472697, 11699.707507312385, 11798.298724791188, 11869.584564540544], "value": 8115.651284114982, "unit": "score"}], "name": "dromaeo_css", "value": 7310.60062063622, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 116.0, 115.0, 118.0, 167.0, 169.0, 114.0, 111.0, 92.0], "value": 123.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 115.0, 174.0, 114.0, 109.0, 108.0, 109.0, 139.0, 108.0], "value": 122.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 195.0, 184.0, 184.0, 182.0, 186.0, 185.0, 183.0, 185.0], "value": 185.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 95.0, 63.0, 62.0, 58.0, 57.0, 83.0, 58.0], "value": 67.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 94.0, 72.0, 69.0, 68.0, 94.0, 67.0, 68.0, 90.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 85.0, 87.0, 84.0, 87.0, 84.0, 88.0, 85.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 92.0, 92.0, 94.0, 92.0, 93.0, 93.0, 93.0, 132.0, 103.0], "value": 98.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 86.0, 87.0, 85.0, 87.0, 102.0, 110.0, 71.0, 124.0, 132.0], "value": 97.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 54.0, 52.0, 55.0, 56.0, 56.0, 57.0, 57.0, 57.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 67.0, 77.0, 72.0, 70.0, 71.0, 70.0, 72.0, 74.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 83.0, 84.0, 85.0, 90.0, 82.0, 80.0, 83.0, 83.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 137.0, 138.0, 137.0, 138.0, 138.0, 136.0, 149.0, 200.0, 133.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 161.0, 142.0, 213.0, 232.0, 218.0, 166.0, 167.0, 166.0, 169.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 80.0, 90.0, 63.0, 58.0, 89.0, 85.0, 85.0, 87.0, 86.0], "value": 79.2, "unit": "score"}], "name": "kraken", "value": 1473.5000000000002, "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.764 screenresolution[1942:18581] starting screenresolution argv=screenresolution get 07:12:50 INFO - 2016-11-14 07:12:50.766 screenresolution[1942:18581] Display 0: 1600x1200x32@60 07:12:50 INFO - 2016-11-14 07:12:50.773 screenresolution[1943:18584] 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.015783Z] 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: 1211s; CPU: 53.0%; Read bytes: 1581056; Write bytes: 666673152; Read time: 16; Write time: 2288 07:12:51 INFO - TinderboxPrint: CPU usage
53.4% 07:12:51 INFO - TinderboxPrint: I/O read bytes / time
1,581,056 / 16 07:12:51 INFO - TinderboxPrint: I/O write bytes / time
666,673,152 / 2,288 07:12:51 INFO - TinderboxPrint: CPU idle
2,256.7 (46.6%) 07:12:51 INFO - TinderboxPrint: CPU system
969.8 (20.0%) 07:12:51 INFO - TinderboxPrint: CPU user
1,615.4 (33.4%) 07:12:51 INFO - TinderboxPrint: Swap in / out
364,982,272 / 0 07:12:51 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 358556160; Write bytes: 356186112; Read time: 27594; Write time: 681 07:12:51 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 745472; Write bytes: 299489280; Read time: 12; Write time: 1452 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:51 INFO - (blobuploader) - INFO - Open directory for files ... 07:12:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:12:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:12:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:52 INFO - (blobuploader) - INFO - Done attempting. 07:12:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:12:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:52 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/620bda65265cddd151bf33bfadb9b393c5034cd84965b23fdd09090dc82f27580d8e1866f346cfa4ff7b9a431dba0b3d9ce3390f8d244c5683524e7ec89e92a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b9f48d0a784e80e60c51b8bd989429a82204f6cf5ce7961b9f8dfd4edd8b12c44fd38bb53168a355a4f73f7e3e818f7569363f984764abd5b4648c901f3f57f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f840dd4009e09911dd18f16ad70352a22ed7d217b24d0aa69fa934a0d6464e6425694b62825727df426a66aa5a8a47f03911acf21ef31088440079776b7a0224"} 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/620bda65265cddd151bf33bfadb9b393c5034cd84965b23fdd09090dc82f27580d8e1866f346cfa4ff7b9a431dba0b3d9ce3390f8d244c5683524e7ec89e92a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b9f48d0a784e80e60c51b8bd989429a82204f6cf5ce7961b9f8dfd4edd8b12c44fd38bb53168a355a4f73f7e3e818f7569363f984764abd5b4648c901f3f57f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f840dd4009e09911dd18f16ad70352a22ed7d217b24d0aa69fa934a0d6464e6425694b62825727df426a66aa5a8a47f03911acf21ef31088440079776b7a0224"} 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=1270.184293 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-14 07:12:56.405897) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:12:56.409233) ========= 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.QgkwKnHybB/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.H6bXBrpGxr/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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/620bda65265cddd151bf33bfadb9b393c5034cd84965b23fdd09090dc82f27580d8e1866f346cfa4ff7b9a431dba0b3d9ce3390f8d244c5683524e7ec89e92a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b9f48d0a784e80e60c51b8bd989429a82204f6cf5ce7961b9f8dfd4edd8b12c44fd38bb53168a355a4f73f7e3e818f7569363f984764abd5b4648c901f3f57f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f840dd4009e09911dd18f16ad70352a22ed7d217b24d0aa69fa934a0d6464e6425694b62825727df426a66aa5a8a47f03911acf21ef31088440079776b7a0224"} 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.011102 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/620bda65265cddd151bf33bfadb9b393c5034cd84965b23fdd09090dc82f27580d8e1866f346cfa4ff7b9a431dba0b3d9ce3390f8d244c5683524e7ec89e92a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b9f48d0a784e80e60c51b8bd989429a82204f6cf5ce7961b9f8dfd4edd8b12c44fd38bb53168a355a4f73f7e3e818f7569363f984764abd5b4648c901f3f57f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f840dd4009e09911dd18f16ad70352a22ed7d217b24d0aa69fa934a0d6464e6425694b62825727df426a66aa5a8a47f03911acf21ef31088440079776b7a0224"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 07:12:56.441732) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:12:56.442069) ========= 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.QgkwKnHybB/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.H6bXBrpGxr/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.005258 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 07:12:56.490565) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:12:56.490908) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 07:12:56.491222) ========= ========= Total master_lag: 0.18 =========