builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0204 starttime: 1484483100.33 results: success (0) buildid: 20170115030210 builduid: ccd28d71259f477eb807d96d7db7334d revision: 5ce3882eec21be3a70e4afc050959ca2f76bfa76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:00.326791) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:00.327215) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:00.327564) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:00.355409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:00.355703) ========= 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.PoVlNLgbIH/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.EWNTPrxrfM/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-15 04:25:00-- 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% 68.3M=0s 2017-01-15 04:25:00 (68.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.179478 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:00.696668) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:00.696977) ========= 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.PoVlNLgbIH/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.EWNTPrxrfM/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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.024578 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:00.746570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:00.747104) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5ce3882eec21be3a70e4afc050959ca2f76bfa76 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5ce3882eec21be3a70e4afc050959ca2f76bfa76 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PoVlNLgbIH/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.EWNTPrxrfM/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-15 04:25:00,847 truncating revision to first 12 chars 2017-01-15 04:25:00,848 Setting DEBUG logging. 2017-01-15 04:25:00,848 attempt 1/10 2017-01-15 04:25:00,848 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5ce3882eec21?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-15 04:25:01,321 unpacking tar archive at: mozilla-central-5ce3882eec21/testing/mozharness/ program finished with exit code 0 elapsedTime=0.752322 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:01.540179) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:01.540504) ========= script_repo_revision: 5ce3882eec21be3a70e4afc050959ca2f76bfa76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:01.540884) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:01.541151) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-15 04:25:01.571676) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-15 04:25:01.571947) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PoVlNLgbIH/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.EWNTPrxrfM/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:25:01 INFO - MultiFileLogger online at 20170115 04:25:01 in /builds/slave/test 04:25:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:25:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:25:01 INFO - {'append_to_log': False, 04:25:01 INFO - 'base_work_dir': '/builds/slave/test', 04:25:01 INFO - 'blob_upload_branch': 'Firefox', 04:25:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:25:01 INFO - 'branch': 'Firefox', 04:25:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:25:01 INFO - 'config_files': ('talos/mac_config.py',), 04:25:01 INFO - 'default_actions': ('clobber', 04:25:01 INFO - 'read-buildbot-config', 04:25:01 INFO - 'download-and-extract', 04:25:01 INFO - 'populate-webroot', 04:25:01 INFO - 'create-virtualenv', 04:25:01 INFO - 'install', 04:25:01 INFO - 'run-tests'), 04:25:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:25:01 INFO - 'download_minidump_stackwalk': True, 04:25:01 INFO - 'download_symbols': 'ondemand', 04:25:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:25:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:25:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:25:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:25:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:25:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:25:01 INFO - 'installer_path': 'installer.exe', 04:25:01 INFO - 'log_level': 'info', 04:25:01 INFO - 'log_name': 'talos', 04:25:01 INFO - 'log_to_console': True, 04:25:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:25:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:25:01 INFO - 'opt_config_files': (), 04:25:01 INFO - 'pip_index': False, 04:25:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:25:01 INFO - 'cmd': ('bash', 04:25:01 INFO - '-c', 04:25:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:25:01 INFO - 'enabled': True, 04:25:01 INFO - 'halt_on_failure': False, 04:25:01 INFO - 'name': 'check_screen_resolution'},), 04:25:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:25:01 INFO - 'cmd': ('bash', 04:25:01 INFO - '-c', 04:25:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:25:01 INFO - 'enabled': True, 04:25:01 INFO - 'halt_on_failure': False, 04:25:01 INFO - 'name': 'check_screen_resolution'},), 04:25:01 INFO - 'run_cmd_checks_enabled': True, 04:25:01 INFO - 'sps_profile': False, 04:25:01 INFO - 'sps_profile_interval': 0, 04:25:01 INFO - 'suite': 'dromaeojs', 04:25:01 INFO - 'system_bits': '32', 04:25:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:25:01 INFO - 'title': 't-yosemite-r7-0204', 04:25:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:25:01 INFO - 'use_talos_json': True, 04:25:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:25:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:25:01 INFO - 'work_dir': 'build'} 04:25:01 INFO - [mozharness: 2017-01-15 12:25:01.775077Z] Running clobber step. 04:25:01 INFO - Running pre-action listener: _resource_record_pre_action 04:25:01 INFO - Running main action method: clobber 04:25:01 INFO - rmtree: /builds/slave/test/build 04:25:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:25:04 INFO - Running post-action listener: _resource_record_post_action 04:25:04 INFO - [mozharness: 2017-01-15 12:25:04.257696Z] Finished clobber step (success) 04:25:04 INFO - [mozharness: 2017-01-15 12:25:04.257879Z] Running read-buildbot-config step. 04:25:04 INFO - Running pre-action listener: _resource_record_pre_action 04:25:04 INFO - Running main action method: read_buildbot_config 04:25:04 INFO - Using buildbot properties: 04:25:04 INFO - { 04:25:04 INFO - "project": "", 04:25:04 INFO - "product": "firefox", 04:25:04 INFO - "script_repo_revision": "production", 04:25:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:25:04 INFO - "repository": "", 04:25:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:25:04 INFO - "buildid": "20170115030210", 04:25:04 INFO - "stage_platform": "macosx64", 04:25:04 INFO - "basedir": "/builds/slave/test", 04:25:04 INFO - "nightly_build": "True", 04:25:04 INFO - "buildnumber": 23, 04:25:04 INFO - "slavename": "t-yosemite-r7-0204", 04:25:04 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:25:04 INFO - "platform": "yosemite_r7", 04:25:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:25:04 INFO - "branch": "mozilla-central", 04:25:04 INFO - "repo_path": "mozilla-central", 04:25:04 INFO - "revision": "5ce3882eec21be3a70e4afc050959ca2f76bfa76", 04:25:04 INFO - "pgo_build": "False", 04:25:04 INFO - "builduid": "ccd28d71259f477eb807d96d7db7334d", 04:25:04 INFO - "slavebuilddir": "test" 04:25:04 INFO - } 04:25:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:25:04 INFO - Running post-action listener: _resource_record_post_action 04:25:04 INFO - [mozharness: 2017-01-15 12:25:04.261446Z] Finished read-buildbot-config step (success) 04:25:04 INFO - [mozharness: 2017-01-15 12:25:04.261555Z] Running download-and-extract step. 04:25:04 INFO - Running pre-action listener: _resource_record_pre_action 04:25:04 INFO - Running main action method: download_and_extract 04:25:04 INFO - mkdir: /builds/slave/test/build/tests 04:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:04 INFO - trying https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:25:04 INFO - Downloading https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:25:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:25:05 INFO - Downloaded 1199 bytes. 04:25:05 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:25:05 INFO - Using the following test package requirements: 04:25:05 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:25:05 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:25:05 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:25:05 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'jsshell-mac.zip'], 04:25:05 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:25:05 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:25:05 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:25:05 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:25:05 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:25:05 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:25:05 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:25:05 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:25:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:25:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:25:05 INFO - Fetch https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:25:06 INFO - Expected file size: 16319157 04:25:06 INFO - Obtained file size: 16319157 04:25:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:25:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:25:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:25:13 INFO - Fetch https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:25:14 INFO - Expected file size: 16319157 04:25:14 INFO - Obtained file size: 16319157 04:25:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:25:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:25:20 INFO - Fetch https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:25:22 INFO - Expected file size: 14403463 04:25:22 INFO - Obtained file size: 14403463 04:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:22 INFO - trying https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:25:22 INFO - Downloading https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:25:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:25:24 INFO - Downloaded 70195349 bytes. 04:25:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:25:24 INFO - mkdir: /builds/slave/test/properties 04:25:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:25:24 INFO - Writing to file /builds/slave/test/properties/build_url 04:25:24 INFO - Contents: 04:25:24 INFO - build_url:https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:25:25 INFO - Running post-action listener: _resource_record_post_action 04:25:25 INFO - Running post-action listener: set_extra_try_arguments 04:25:25 INFO - [mozharness: 2017-01-15 12:25:25.522676Z] Finished download-and-extract step (success) 04:25:25 INFO - [mozharness: 2017-01-15 12:25:25.522822Z] Running populate-webroot step. 04:25:25 INFO - Running pre-action listener: _resource_record_pre_action 04:25:25 INFO - Running main action method: populate_webroot 04:25:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:25:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:25:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:25:25 INFO - '--tppagecycles', 04:25:25 INFO - '7'], 04:25:25 INFO - 'tests': ['tsvgm']}}, 04:25:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:25:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:25:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:25:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:25:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:25:25 INFO - 'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:25:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:25:25 INFO - 'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['damp', 'tps']}, 04:25:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:25:25 INFO - 'tests': ['damp', 'tps']}, 04:25:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['dromaeo_dom']}, 04:25:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:25:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['basic_compositor_video']}, 04:25:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:25:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['a11yr', 04:25:25 INFO - 'ts_paint', 04:25:25 INFO - 'tpaint', 04:25:25 INFO - 'sessionrestore', 04:25:25 INFO - 'sessionrestore_no_auto_restore', 04:25:25 INFO - 'tabpaint']}, 04:25:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:25:25 INFO - 'ts_paint', 04:25:25 INFO - 'tpaint', 04:25:25 INFO - 'sessionrestore', 04:25:25 INFO - 'sessionrestore_no_auto_restore', 04:25:25 INFO - 'tabpaint']}, 04:25:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:25:25 INFO - 'ts_paint', 04:25:25 INFO - 'tpaint', 04:25:25 INFO - 'sessionrestore', 04:25:25 INFO - 'sessionrestore_no_auto_restore', 04:25:25 INFO - 'tabpaint']}, 04:25:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:25:25 INFO - 'ts_paint', 04:25:25 INFO - 'tpaint', 04:25:25 INFO - 'sessionrestore', 04:25:25 INFO - 'sessionrestore_no_auto_restore', 04:25:25 INFO - 'tabpaint']}, 04:25:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['a11yr', 04:25:25 INFO - 'ts_paint', 04:25:25 INFO - 'tpaint', 04:25:25 INFO - 'sessionrestore', 04:25:25 INFO - 'sessionrestore_no_auto_restore', 04:25:25 INFO - 'tabpaint']}, 04:25:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['a11yr', 04:25:25 INFO - 'ts_paint', 04:25:25 INFO - 'tpaint', 04:25:25 INFO - 'sessionrestore', 04:25:25 INFO - 'sessionrestore_no_auto_restore', 04:25:25 INFO - 'tabpaint']}, 04:25:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['tsvgx', 04:25:25 INFO - 'tsvgr_opacity', 04:25:25 INFO - 'tart', 04:25:25 INFO - 'tscrollx', 04:25:25 INFO - 'cart', 04:25:25 INFO - 'tsvg_static']}, 04:25:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:25:25 INFO - 'tsvgr_opacity', 04:25:25 INFO - 'tart', 04:25:25 INFO - 'tscrollx', 04:25:25 INFO - 'cart', 04:25:25 INFO - 'tsvg_static']}, 04:25:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:25:25 INFO - 'talos_options': ['--disable-e10s'], 04:25:25 INFO - 'tests': ['tp5o']}, 04:25:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:25:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:25:25 INFO - 'talos_options': ['--disable-e10s', 04:25:25 INFO - '--xperf_path', 04:25:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:25 INFO - 'tests': ['tp5n']}, 04:25:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:25:25 INFO - 'talos_options': ['--xperf_path', 04:25:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:25 INFO - 'tests': ['tp5n']}}, 04:25:25 INFO - 'talos.zip': {'path': '', 04:25:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:25:25 INFO - Running post-action listener: _resource_record_post_action 04:25:25 INFO - [mozharness: 2017-01-15 12:25:25.541532Z] Finished populate-webroot step (success) 04:25:25 INFO - [mozharness: 2017-01-15 12:25:25.541662Z] Running create-virtualenv step. 04:25:25 INFO - Running pre-action listener: _resource_record_pre_action 04:25:25 INFO - Running main action method: create_virtualenv 04:25:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:25:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:25:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:25:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:25:25 INFO - Using real prefix '/tools/python27' 04:25:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:25:26 INFO - Installing distribute.............................................................................................................................................................................................done. 04:25:29 INFO - Installing pip.................done. 04:25:29 INFO - Return code: 0 04:25:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:25:29 INFO - Reading from file tmpfile_stdout 04:25:29 INFO - Output received: 04:25:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:25:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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')]} 04:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:29 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 0x10c393b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c396768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3da5ad570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c171d30>, '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 0x10c098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c166be8>, '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.PoVlNLgbIH/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.EWNTPrxrfM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:25:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoVlNLgbIH/Render', 04:25:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:29 INFO - 'HOME': '/Users/cltbld', 04:25:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:29 INFO - 'LOGNAME': 'cltbld', 04:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:29 INFO - 'MOZ_NO_REMOTE': '1', 04:25:29 INFO - 'NO_EM_RESTART': '1', 04:25:29 INFO - 'PAGER': '/bin/cat', 04:25:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:29 INFO - 'PWD': '/builds/slave/test', 04:25:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:29 INFO - 'SHELL': '/bin/bash', 04:25:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EWNTPrxrfM/Listeners', 04:25:29 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 04:25:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:29 INFO - 'USER': 'cltbld', 04:25:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:29 INFO - 'XPC_FLAGS': '0x0', 04:25:29 INFO - 'XPC_SERVICE_NAME': '0', 04:25:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:25:29 INFO - Cleaning up... 04:25:29 INFO - Return code: 0 04:25:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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')]} 04:25:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:29 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 0x10c393b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c396768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3da5ad570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c171d30>, '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 0x10c098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c166be8>, '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.PoVlNLgbIH/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.EWNTPrxrfM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:25:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoVlNLgbIH/Render', 04:25:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:29 INFO - 'HOME': '/Users/cltbld', 04:25:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:29 INFO - 'LOGNAME': 'cltbld', 04:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:29 INFO - 'MOZ_NO_REMOTE': '1', 04:25:29 INFO - 'NO_EM_RESTART': '1', 04:25:29 INFO - 'PAGER': '/bin/cat', 04:25:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:29 INFO - 'PWD': '/builds/slave/test', 04:25:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:29 INFO - 'SHELL': '/bin/bash', 04:25:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EWNTPrxrfM/Listeners', 04:25:29 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 04:25:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:29 INFO - 'USER': 'cltbld', 04:25:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:29 INFO - 'XPC_FLAGS': '0x0', 04:25:29 INFO - 'XPC_SERVICE_NAME': '0', 04:25:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:30 INFO - Downloading/unpacking psutil>=3.1.1 04:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:25:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:34 INFO - Installing collected packages: psutil 04:25:34 INFO - Running setup.py install for psutil 04:25:34 INFO - building 'psutil._psutil_osx' extension 04:25:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:25:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:25:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:25:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:25:35 INFO - building 'psutil._psutil_posix' extension 04:25:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:25:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:25:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:25:35 INFO - ^ 04:25:35 INFO - 1 warning generated. 04:25:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:25:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:35 INFO - Successfully installed psutil 04:25:35 INFO - Cleaning up... 04:25:35 INFO - Return code: 0 04:25:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c393b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c396768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3da5ad570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c171d30>, '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 0x10c098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c166be8>, '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.PoVlNLgbIH/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.EWNTPrxrfM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:25:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:25:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoVlNLgbIH/Render', 04:25:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:35 INFO - 'HOME': '/Users/cltbld', 04:25:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:35 INFO - 'LOGNAME': 'cltbld', 04:25:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:35 INFO - 'MOZ_NO_REMOTE': '1', 04:25:35 INFO - 'NO_EM_RESTART': '1', 04:25:35 INFO - 'PAGER': '/bin/cat', 04:25:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:35 INFO - 'PWD': '/builds/slave/test', 04:25:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:35 INFO - 'SHELL': '/bin/bash', 04:25:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EWNTPrxrfM/Listeners', 04:25:35 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 04:25:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:35 INFO - 'USER': 'cltbld', 04:25:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:35 INFO - 'XPC_FLAGS': '0x0', 04:25:35 INFO - 'XPC_SERVICE_NAME': '0', 04:25:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:25:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:25:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:25:38 INFO - Installing collected packages: mozsystemmonitor 04:25:38 INFO - Running setup.py install for mozsystemmonitor 04:25:38 INFO - Successfully installed mozsystemmonitor 04:25:38 INFO - Cleaning up... 04:25:38 INFO - Return code: 0 04:25:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:25:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c393b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c396768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3da5ad570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c171d30>, '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 0x10c098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c166be8>, '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.PoVlNLgbIH/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.EWNTPrxrfM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:25:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoVlNLgbIH/Render', 04:25:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:38 INFO - 'HOME': '/Users/cltbld', 04:25:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:38 INFO - 'LOGNAME': 'cltbld', 04:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:38 INFO - 'MOZ_NO_REMOTE': '1', 04:25:38 INFO - 'NO_EM_RESTART': '1', 04:25:38 INFO - 'PAGER': '/bin/cat', 04:25:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:38 INFO - 'PWD': '/builds/slave/test', 04:25:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:38 INFO - 'SHELL': '/bin/bash', 04:25:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EWNTPrxrfM/Listeners', 04:25:38 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 04:25:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:38 INFO - 'USER': 'cltbld', 04:25:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:38 INFO - 'XPC_FLAGS': '0x0', 04:25:38 INFO - 'XPC_SERVICE_NAME': '0', 04:25:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:39 INFO - Downloading/unpacking jsonschema==2.5.1 04:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:25:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:42 INFO - Downloading functools32-3.2.3-2.tar.gz 04:25:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:25:42 INFO - warning: no files found matching '*.txt' 04:25:42 INFO - no previously-included directories found matching 'build' 04:25:42 INFO - no previously-included directories found matching 'dist' 04:25:42 INFO - no previously-included directories found matching '.git*' 04:25:42 INFO - Installing collected packages: jsonschema, functools32 04:25:42 INFO - Running setup.py install for functools32 04:25:42 INFO - warning: no files found matching '*.txt' 04:25:42 INFO - no previously-included directories found matching 'build' 04:25:42 INFO - no previously-included directories found matching 'dist' 04:25:42 INFO - no previously-included directories found matching '.git*' 04:25:42 INFO - Successfully installed jsonschema functools32 04:25:42 INFO - Cleaning up... 04:25:42 INFO - Return code: 0 04:25:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:42 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 0x10c393b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c396768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3da5ad570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c171d30>, '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 0x10c098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c166be8>, '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.PoVlNLgbIH/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.EWNTPrxrfM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:25:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoVlNLgbIH/Render', 04:25:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:42 INFO - 'HOME': '/Users/cltbld', 04:25:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:42 INFO - 'LOGNAME': 'cltbld', 04:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:42 INFO - 'MOZ_NO_REMOTE': '1', 04:25:42 INFO - 'NO_EM_RESTART': '1', 04:25:42 INFO - 'PAGER': '/bin/cat', 04:25:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:42 INFO - 'PWD': '/builds/slave/test', 04:25:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:42 INFO - 'SHELL': '/bin/bash', 04:25:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EWNTPrxrfM/Listeners', 04:25:42 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 04:25:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:42 INFO - 'USER': 'cltbld', 04:25:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:42 INFO - 'XPC_FLAGS': '0x0', 04:25:42 INFO - 'XPC_SERVICE_NAME': '0', 04:25:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:25:42 INFO - Cleaning up... 04:25:42 INFO - Return code: 0 04:25:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:42 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 0x10c393b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c396768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3da5ad570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c171d30>, '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 0x10c098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c166be8>, '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.PoVlNLgbIH/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.EWNTPrxrfM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:25:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:25:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoVlNLgbIH/Render', 04:25:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:42 INFO - 'HOME': '/Users/cltbld', 04:25:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:42 INFO - 'LOGNAME': 'cltbld', 04:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:42 INFO - 'MOZ_NO_REMOTE': '1', 04:25:42 INFO - 'NO_EM_RESTART': '1', 04:25:42 INFO - 'PAGER': '/bin/cat', 04:25:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:42 INFO - 'PWD': '/builds/slave/test', 04:25:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:42 INFO - 'SHELL': '/bin/bash', 04:25:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EWNTPrxrfM/Listeners', 04:25:42 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 04:25:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:42 INFO - 'USER': 'cltbld', 04:25:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:42 INFO - 'XPC_FLAGS': '0x0', 04:25:42 INFO - 'XPC_SERVICE_NAME': '0', 04:25:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:45 INFO - Downloading blobuploader-1.2.4.tar.gz 04:25:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:25:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:25:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:46 INFO - Downloading docopt-0.6.1.tar.gz 04:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:25:47 INFO - Installing collected packages: blobuploader, requests, docopt 04:25:47 INFO - Running setup.py install for blobuploader 04:25:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:25:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:25:47 INFO - Running setup.py install for requests 04:25:47 INFO - Running setup.py install for docopt 04:25:47 INFO - Successfully installed blobuploader requests docopt 04:25:47 INFO - Cleaning up... 04:25:48 INFO - Return code: 0 04:25:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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')]} 04:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:48 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 0x10c393b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c396768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3da5ad570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c171d30>, '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 0x10c098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c166be8>, '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.PoVlNLgbIH/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.EWNTPrxrfM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:25:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoVlNLgbIH/Render', 04:25:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:48 INFO - 'HOME': '/Users/cltbld', 04:25:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:48 INFO - 'LOGNAME': 'cltbld', 04:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:48 INFO - 'MOZ_NO_REMOTE': '1', 04:25:48 INFO - 'NO_EM_RESTART': '1', 04:25:48 INFO - 'PAGER': '/bin/cat', 04:25:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:48 INFO - 'PWD': '/builds/slave/test', 04:25:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:48 INFO - 'SHELL': '/bin/bash', 04:25:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EWNTPrxrfM/Listeners', 04:25:48 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 04:25:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:48 INFO - 'USER': 'cltbld', 04:25:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:48 INFO - 'XPC_FLAGS': '0x0', 04:25:48 INFO - 'XPC_SERVICE_NAME': '0', 04:25:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:48 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-igO4Ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:48 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-cafrV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:48 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-T1ukSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:48 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-xXK4Ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:48 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-ZR2zcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:48 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-G3IcZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:48 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-HxpfW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:49 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-6lbZIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:49 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-bygaVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:49 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-nBEIr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:49 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-V6R6kQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:49 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-FEem0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:49 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-v0_ae0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:49 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-sQfzyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:49 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-V7sP3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:49 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-N_oN0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:49 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-aRKy06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:25:50 INFO - Running setup.py install for manifestparser 04:25:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:25:50 INFO - Running setup.py install for mozcrash 04:25:50 INFO - Running setup.py install for mozdebug 04:25:50 INFO - Running setup.py install for mozdevice 04:25:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:25:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:25:50 INFO - Running setup.py install for mozfile 04:25:50 INFO - Running setup.py install for mozhttpd 04:25:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:25:50 INFO - Running setup.py install for mozinfo 04:25:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:25:51 INFO - Running setup.py install for mozInstall 04:25:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:25:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:25:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:25:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:25:51 INFO - Running setup.py install for mozleak 04:25:51 INFO - Running setup.py install for mozlog 04:25:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:25:51 INFO - Running setup.py install for moznetwork 04:25:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:25:51 INFO - Running setup.py install for mozprocess 04:25:51 INFO - Running setup.py install for mozprofile 04:25:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:25:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:25:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:25:52 INFO - Running setup.py install for mozrunner 04:25:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:25:52 INFO - Running setup.py install for mozscreenshot 04:25:52 INFO - Running setup.py install for moztest 04:25:52 INFO - Running setup.py install for mozversion 04:25:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:25:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:25:52 INFO - Cleaning up... 04:25:52 INFO - Return code: 0 04:25:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:52 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 0x10c393b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c396768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3da5ad570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c171d30>, '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 0x10c098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c166be8>, '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.PoVlNLgbIH/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.EWNTPrxrfM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:25:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:25:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoVlNLgbIH/Render', 04:25:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:52 INFO - 'HOME': '/Users/cltbld', 04:25:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:52 INFO - 'LOGNAME': 'cltbld', 04:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:52 INFO - 'MOZ_NO_REMOTE': '1', 04:25:52 INFO - 'NO_EM_RESTART': '1', 04:25:52 INFO - 'PAGER': '/bin/cat', 04:25:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:52 INFO - 'PWD': '/builds/slave/test', 04:25:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:52 INFO - 'SHELL': '/bin/bash', 04:25:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EWNTPrxrfM/Listeners', 04:25:52 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 04:25:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:52 INFO - 'USER': 'cltbld', 04:25:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:52 INFO - 'XPC_FLAGS': '0x0', 04:25:52 INFO - 'XPC_SERVICE_NAME': '0', 04:25:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:52 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-Wk4wJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:53 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-PEvmyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:53 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-pu0ZQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:53 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-k7pOwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:53 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-RBVMZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:53 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-v3BUIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:53 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-HnWwOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:53 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-Iwl6aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:53 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-jA3h53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:53 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-BlwHUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:53 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-MKWJd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:54 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-oJm8Av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:54 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-J178RH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:54 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-wBmZay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:54 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-BjeLhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:54 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-LOYmCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:54 INFO - Running setup.py (path:/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/pip-Gqn584-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:57 INFO - Downloading blessings-1.6.tar.gz 04:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:25:57 INFO - Installing collected packages: blessings 04:25:57 INFO - Running setup.py install for blessings 04:25:57 INFO - Successfully installed blessings 04:25:57 INFO - Cleaning up... 04:25:57 INFO - Return code: 0 04:25:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:25:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:57 INFO - Reading from file tmpfile_stdout 04:25:57 INFO - Current package versions: 04:25:57 INFO - blessings == 1.6 04:25:57 INFO - blobuploader == 1.2.4 04:25:57 INFO - docopt == 0.6.1 04:25:57 INFO - functools32 == 3.2.3-2 04:25:57 INFO - jsonschema == 2.5.1 04:25:57 INFO - manifestparser == 1.1 04:25:57 INFO - mozInstall == 1.12 04:25:57 INFO - mozcrash == 1.0 04:25:57 INFO - mozdebug == 0.1 04:25:57 INFO - mozdevice == 0.49 04:25:57 INFO - mozfile == 1.2 04:25:57 INFO - mozhttpd == 0.7 04:25:57 INFO - mozinfo == 0.9 04:25:57 INFO - mozleak == 0.1 04:25:57 INFO - mozlog == 3.4 04:25:57 INFO - moznetwork == 0.27 04:25:57 INFO - mozprocess == 0.24 04:25:57 INFO - mozprofile == 0.28 04:25:57 INFO - mozrunner == 6.13 04:25:57 INFO - mozscreenshot == 0.1 04:25:57 INFO - mozsystemmonitor == 0.3 04:25:57 INFO - moztest == 0.8 04:25:57 INFO - mozversion == 1.4 04:25:57 INFO - psutil == 3.1.1 04:25:57 INFO - requests == 1.2.3 04:25:57 INFO - wsgiref == 0.1.2 04:25:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:57 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 0x10c393b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c396768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3da5ad570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c171d30>, '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 0x10c098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c166be8>, '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.PoVlNLgbIH/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.EWNTPrxrfM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:25:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoVlNLgbIH/Render', 04:25:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:57 INFO - 'HOME': '/Users/cltbld', 04:25:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:57 INFO - 'LOGNAME': 'cltbld', 04:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:57 INFO - 'MOZ_NO_REMOTE': '1', 04:25:57 INFO - 'NO_EM_RESTART': '1', 04:25:57 INFO - 'PAGER': '/bin/cat', 04:25:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:57 INFO - 'PWD': '/builds/slave/test', 04:25:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:57 INFO - 'SHELL': '/bin/bash', 04:25:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EWNTPrxrfM/Listeners', 04:25:57 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 04:25:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:57 INFO - 'USER': 'cltbld', 04:25:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:57 INFO - 'XPC_FLAGS': '0x0', 04:25:57 INFO - 'XPC_SERVICE_NAME': '0', 04:25:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:25:58 INFO - Cleaning up... 04:25:58 INFO - Return code: 0 04:25:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:58 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 0x10c393b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c396768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3da5ad570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c171d30>, '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 0x10c098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c166be8>, '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.PoVlNLgbIH/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.EWNTPrxrfM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoVlNLgbIH/Render', 04:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:58 INFO - 'HOME': '/Users/cltbld', 04:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:58 INFO - 'LOGNAME': 'cltbld', 04:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:58 INFO - 'MOZ_NO_REMOTE': '1', 04:25:58 INFO - 'NO_EM_RESTART': '1', 04:25:58 INFO - 'PAGER': '/bin/cat', 04:25:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:58 INFO - 'PWD': '/builds/slave/test', 04:25:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:58 INFO - 'SHELL': '/bin/bash', 04:25:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EWNTPrxrfM/Listeners', 04:25:58 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 04:25:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:58 INFO - 'USER': 'cltbld', 04:25:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:58 INFO - 'XPC_FLAGS': '0x0', 04:25:58 INFO - 'XPC_SERVICE_NAME': '0', 04:25:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:25:58 INFO - Cleaning up... 04:25:58 INFO - Return code: 0 04:25:58 INFO - Running post-action listener: _resource_record_post_action 04:25:58 INFO - Running post-action listener: _start_resource_monitoring 04:25:58 INFO - Starting resource monitoring. 04:25:58 INFO - [mozharness: 2017-01-15 12:25:58.547502Z] Finished create-virtualenv step (success) 04:25:58 INFO - [mozharness: 2017-01-15 12:25:58.548445Z] Running install step. 04:25:58 INFO - Running pre-action listener: _resource_record_pre_action 04:25:58 INFO - Running main action method: install 04:25:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:58 INFO - Reading from file tmpfile_stdout 04:25:58 INFO - Detecting whether we're running mozinstall >=1.0... 04:25:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:25:58 INFO - Reading from file tmpfile_stdout 04:25:58 INFO - Output received: 04:25:58 INFO - Usage: mozinstall [options] installer 04:25:58 INFO - Options: 04:25:58 INFO - -h, --help show this help message and exit 04:25:58 INFO - -d DEST, --destination=DEST 04:25:58 INFO - Directory to install application into. [default: 04:25:58 INFO - "/builds/slave/test"] 04:25:58 INFO - --app=APP Application being installed. [default: firefox] 04:25:58 INFO - mkdir: /builds/slave/test/build/application 04:25:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:26:21 INFO - Reading from file tmpfile_stdout 04:26:21 INFO - Output received: 04:26:21 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:26:21 INFO - Running post-action listener: _resource_record_post_action 04:26:21 INFO - [mozharness: 2017-01-15 12:26:21.119384Z] Finished install step (success) 04:26:21 INFO - [mozharness: 2017-01-15 12:26:21.119532Z] Running run-tests step. 04:26:21 INFO - Running pre-action listener: _resource_record_pre_action 04:26:21 INFO - Running main action method: run_tests 04:26:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:26:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:26:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:26:21 INFO - 2017-01-15 04:26:21.133 screenresolution[1663:9744] starting screenresolution argv=screenresolution get 04:26:21 INFO - 2017-01-15 04:26:21.136 screenresolution[1663:9744] Display 0: 1600x1200x32@60 04:26:21 INFO - 2017-01-15 04:26:21.142 screenresolution[1664:9747] starting screenresolution argv=screenresolution list 04:26:21 INFO - Available Modes on Display 0 04:26:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:26:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:26:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:26:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:26:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:26:21 INFO - Intel Iris: 04:26:21 INFO - Chipset Model: Intel Iris 04:26:21 INFO - Type: GPU 04:26:21 INFO - Bus: Built-In 04:26:21 INFO - VRAM (Dynamic, Max): 1536 MB 04:26:21 INFO - Vendor: Intel (0x8086) 04:26:21 INFO - Device ID: 0x0a2e 04:26:21 INFO - Revision ID: 0x0009 04:26:21 INFO - Displays: 04:26:21 INFO - Display: 04:26:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:26:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:26:21 INFO - Display Serial Number: 1600x1200 60 04:26:21 INFO - Main Display: Yes 04:26:21 INFO - Mirror: Off 04:26:21 INFO - Online: Yes 04:26:21 INFO - Rotation: Supported 04:26:21 INFO - Return code: 0 04:26:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:26:21 INFO - Python 2.7.3 04:26:21 INFO - Return code: 0 04:26:21 INFO - grabbing minidump binary from tooltool 04:26:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:26:21 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 0x10c171d30>, '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 0x10c098db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c166be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:26:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:26:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:26:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:26:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:26:21 INFO - Return code: 0 04:26:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:26:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:26:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:26:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:26:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:26:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0204', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:26:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0204 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:26:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PoVlNLgbIH/Render', 04:26:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:26:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:26:21 INFO - 'HOME': '/Users/cltbld', 04:26:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:26:21 INFO - 'LOGNAME': 'cltbld', 04:26:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:26:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:26:21 INFO - 'MOZ_NO_REMOTE': '1', 04:26:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:26:21 INFO - 'NO_EM_RESTART': '1', 04:26:21 INFO - 'PAGER': '/bin/cat', 04:26:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:26:21 INFO - 'PWD': '/builds/slave/test', 04:26:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:26:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:26:21 INFO - 'SHELL': '/bin/bash', 04:26:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EWNTPrxrfM/Listeners', 04:26:21 INFO - 'TMPDIR': '/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/', 04:26:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:26:21 INFO - 'USER': 'cltbld', 04:26:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:26:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:26:21 INFO - 'XPC_FLAGS': '0x0', 04:26:21 INFO - 'XPC_SERVICE_NAME': '0', 04:26:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:26:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0204', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:26:21 INFO - mozversion application_buildid: 20170115030210 04:26:21 INFO - mozversion application_changeset: 5ce3882eec21be3a70e4afc050959ca2f76bfa76 04:26:21 INFO - mozversion application_display_name: Nightly 04:26:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:26:21 INFO - mozversion application_name: Firefox 04:26:21 INFO - mozversion application_remotingname: firefox 04:26:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:26:21 INFO - mozversion application_vendor: Mozilla 04:26:21 INFO - mozversion application_version: 53.0a1 04:26:21 INFO - mozversion platform_buildid: 20170115030210 04:26:21 INFO - mozversion platform_changeset: 5ce3882eec21be3a70e4afc050959ca2f76bfa76 04:26:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:26:21 INFO - mozversion platform_version: 53.0a1 04:26:21 INFO - using testdate: 1484483181 04:26:21 INFO - actual date: 1484483181 04:26:21 INFO - starting webserver on 'localhost:49248' 04:26:21 INFO - SUITE-START | Running 2 tests 04:26:21 INFO - TEST-START | dromaeo_css 04:26:21 INFO - operating with platform_type : mac_ 04:26:21 INFO - Initialising browser for dromaeo_css test... 04:26:21 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/tmpJewmCv/profile http://localhost:49248/getInfo.html) 04:26:24 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 04:26:24 INFO - PROCESS | 1674 | colorDepth:24 04:26:24 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 04:26:24 INFO - PROCESS | 1674 | __metrics 04:26:24 INFO - PROCESS | 1674 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:26:24 INFO - PROCESS | 1674 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:26:24 INFO - TEST-INFO | 1674: exit 0 04:26:24 INFO - Browser initialized. 04:26:24 INFO - Running cycle 1/1 for dromaeo_css test... 04:26:24 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/tmpJewmCv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:37 INFO - PROCESS | 1678 | RSS: Main: 236158976 04:26:37 INFO - PROCESS | 1678 | 04:29:40 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 04:29:42 INFO - PROCESS | 1678 | RSS: Main: 343728128 04:29:42 INFO - PROCESS | 1678 | 04:31:27 INFO - PROCESS | 1678 | ************************* 04:31:27 INFO - PROCESS | 1678 | A coding exception was thrown and uncaught in a Task. 04:31:27 INFO - PROCESS | 1678 | 04:31:27 ERROR - PROCESS | 1678 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:31:27 INFO - PROCESS | 1678 | Full stack: 04:31:27 INFO - PROCESS | 1678 | ************************* 04:32:45 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 04:32:45 INFO - PROCESS | 1678 | RSS: Main: 364752896 04:32:45 INFO - PROCESS | 1678 | 04:35:47 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 04:35:48 INFO - PROCESS | 1678 | RSS: Main: 332529664 04:35:48 INFO - PROCESS | 1678 | 04:38:50 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 04:38:51 INFO - PROCESS | 1678 | RSS: Main: 339595264 04:38:51 INFO - PROCESS | 1678 | 04:41:55 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 04:41:55 INFO - PROCESS | 1678 | RSS: Main: 329248768 04:41:55 INFO - PROCESS | 1678 | 04:44:58 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 04:44:59 INFO - PROCESS | 1678 | RSS: Main: 431505408 04:44:59 INFO - PROCESS | 1678 | 04:44:59 INFO - PROCESS | 1678 | __start_tp_report 04:44:59 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 04:44:59 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 04:44:59 INFO - PROCESS | 1678 | |i|pagename|runs| 04:44:59 INFO - PROCESS | 1678 | |0;dojo.html;3133.326334838009;3352.7988320700742;3359.3617212729587;3374.2913988062505;3415.4193787056197;5609.551235901128;5685.800996965107;5711.942880571193;5785.826425207245;5802.448767367098;5716.685582292972;5728.68492232927;5777.017906955817;5838.9124163137485;5914.9112763308585;5210.895782084375;5247.134222853225;5287.206918962148;5293.52358287754;5317.149256119022;4840.467548569654;5231.607629427789;5327.360716714;5339.759710813003;5370.812021579245;5341.759620817073;5358.785648574052;5360.597955153359;5369.24830523727;5376.758045887945;5208.687478751249;5222.529972302511;5240.34495688039;5250.08123578376;5311.973440132813;5230.110881150214;5242.659227150223;5259.579233661298;5311.176767601028;5338.039152952467;5715.371309155989;5720.485156335908;5721.456461636138;5740.6268592541355;5754.223179870705;6065;6181.289151747562;6304.779332723333;6324;6334.588251763621;6222.191115155046;6289;6289.150964619764;6318.2733985591785;6359.20509936258;5872.295324561037;5939.1388248704125;5943.138244954457;5946.672932988728;5978.073398623221;6308.400701933309;6322.088413493885;6358.777442789573;6380.234371875312;6401.487880969511;6133.977404287557;6135.44780969706;6147.047207682816;6174.536909731788;6219.751209951642;6315.842103947438;6319.873602527924;6334.524910631629;6337.9683101585115;6345.206849143857;6118.223266370716;6124.075808605183;6164.938350616526;6171.59884607499;6240.843978900564;5260.92108618371;6231.470325022333;6261.029540421151;6266.404691554295;6283.842903927347;4338.479382474124;5063.215201643751;5068.366454193226;5068.847934561969;5097.1844504879045;4448.354988526646;4478.843240486633;4487.640988720895;4488.326750987378;4566.406367172246;5756.42435756421;5858.56060795442;5861.88276234473;5880.7353669085;5900.232969713996;5297.788088476418;6311.589746666544;6326.873462530815;6330;6346.397092276226;5676.035074037423;5680.744366503517;5857.4435428634215;5868.2664666916635;5879.088741245114;5450.5639548836;5476;5509.201165831012;5509.228707980886;5517.751701173457;6410.935890641033;6433;6436.485081193587;6440.645764482999;6445.323241059808;6351.142595749515;6352.36476352361;6360.268569114426;6366.586171898812;6463.644499552382;6241.687915604292;6269.0909818075215;6274.121622972696;6291.496680265659;6325.209348831396;6287.905681414691;6300.369963003663;6302.71637776292;6307.590006649553;6311.0217916223055;6321.5574909757715;6340.49276057905;6342.778002769881;6352.110704501281;6353.428191462791;6057.636541807506;6100.145979562776;6101.7559297627595;6108.888502348341;6208.1308616792785;6208.441240288395;6221.191245138103;6223.159873417031;6224.1597384352535;6249.312575616769;5820.94179058204;5847.883042339215;6040.848978775566;6070.967935450895;6074.817755467343;4869.4400143982475;6115.0273862886115;6120.447133218705;6120.816375508742;6137.285055221685;6043.516518678407;6053.667048312385;6060.696965151813;6061.545384096298;6085.939140608714 04:44:59 INFO - PROCESS | 1678 | |1;ext.html;472.21612123874354;472.9361536192614;498.81294514557044;500.14475247327067;501.2706512025004;30081.247968800762;39697;41483.585164148426;41492;43617;42232.15535689284;42533.7873310633;42536.787316063455;42551.361729574084;42576.78711606446;8511.957440212791;9229.21551668109;9438.905610943872;9448.66929657462;9459.337846350758;8502.702405415812;11343.489542970545;11624.360660163687;11624.651260462157;11633.127515436334;10478.842817357745;10635.893641063567;11312.604058857942;11377.544898204062;11409.657710268706;8482.703105391281;8686.913130868674;11344.886551134465;11428.771424571461;11443.771124577544;11077.11383089351;11416.71458213543;11416.885831141666;11561.364124973123;11569.710757231136;38009.619903800885;40461.79769101136;40505.59494405048;40563.59436405628;40570.39144412836;4004.3392840181336;4048.5748996355255;4072.816723247461;4102.630763231294;4139.875803725893;30163.69836301631;30759.846200768854;30938.845305773553;30989.22526936822;31063.534046989313;3152.4168028914496;3164.1456806662304;3177.253345463814;3244.2700392411753;3300.669933006704;356624;356780.21609892044;356851;358067.20966395264;358071;58035.709821450626;58061.41938580645;58094.7095264521;58334.708326458946;58574;62100.37899621036;62798.37201627925;62899.056514152326;63096.05355919665;63195;13055.673608159872;15992.600184995468;16015;16017.878748487494;16029.438969636007;11147.275427097213;11428.485718142703;12231.938840305742;12410.81383779244;12462.937685311697;14214.933879959044;14610.707785844224;15572.922135389477;15957.04257744539;16010.679786404207;6239;6608.702608382634;6932.688029038705;7138.714451421989;7331.596762178131;828.3000864269683;870.9825803483894;903.6927444668844;912.5619702542684;920.0845159066771;25844.612330815053;27062.458750824873;29625.666844991596;29670;30506;920.9731149767961;1066.1364294921138;1094.9288296260718;1100.1418893263267;1218.4456072486996;14881.851181488262;15435.459758908384;15549.431897601762;15549.533513994598;15810.841891581167;591610;594762;595827;596109;597592;58962.70518647465;59291.407085928586;59299.11051334233;59316;59743.70128149331;1256.7863463211277;1419.6734751007325;1445.3062529985666;1462.5027490653229;1463.8243410790774;29070.7092929068;29310.706892931652;29328.56007159937;30006.549901751056;30048;49233.2615010768;49511.76220594514;49575;49624;49667.50332496629;519467;520730;522189.3890530523;522791;522910;32783.016509504756;33677;38276.425853612775;39362.4255029807;39496.01259968524;39810.60189398069;46154.76922615366;46555;49158;49787.51912327908;33529;34808.47787283142;36368.27263454769;37802.432963505016;39989.40015899822;34875.825620871736;35098.649013510556;35106;36009;36041.639583604876;34988.77539286113;35507;35539;35757.82121089378;35859.46210806788;30401.695983040772;31523;31526.684733152375;31544.526832097996;31602.209944751565;22078.668819968036;23299.534009320058;23456;23995.28014159578;24084.51830963406 04:44:59 INFO - PROCESS | 1678 | |2;jquery.html;396.8452303601595;398.23340070364543;404.3570722551147;404.6135940177131;427.6130102257456;19602.823830570174;20026.799732002677;20887.164513419444;21312.89343553282;21438.928053597334;19928.70106948397;21366.465838354048;21509.892450537725;21597.892010539963;21752.782472175273;5653.802116925908;5980.401959804007;5985.910211346833;5992.43071908168;6008.279006519224;5834.154047663086;5935.52515798735;5941.316748573926;7136.643167841613;7461.925380746177;7631.732889348874;7640.388768898475;7644.197359277279;7645.082590089197;7650.579218143;7343.302386273295;7583.544987300779;7644.80887977805;7645.3119219269975;7651.732189373401;7186.928130718678;7426.665800039012;7456.664450099758;7512.887306690404;7539.8869016964245;28421.58940927081;28441.715582844114;28479.57280640792;28486;28486.724026736774;2497.675302210701;2868.297267169536;2900.1589539033653;2908.0694177863093;2913.766898648103;15684.980476269006;16230.675386492323;16348.509544713677;16808.57978550534;17230.827691723174;1999.7600287965538;2000.2299114840746;2007.3275452723356;2019.2932473634257;2035;141807;150529;151694;154427;155732;20208.79791202069;21110.577788444145;22817.7718222819;22855;23363.415914602272;32621.836890815393;40469.39295910564;40510.392344114865;40560.79719601383;40918.38622420666;9289.256859451363;10587.311824731369;10740.409277489813;10945.398003109905;11160.051395631463;8691.739247822576;8718.694845680498;8735.213830755263;8869.467831930106;8919.331050171264;8517.531535765593;10797.56809727602;10812.62155824558;10943.781124377627;10956.397398143179;4043.757374557536;4167.312393455046;4175.958240417557;4189.581041895786;4191.622753952159;983.4394395194813;989.0307498651362;992.1963209800085;1010.434156872154;1030.1192480429274;17754.733678994824;19136.851788892713;20270.79729202689;20684.482887927923;21214.78785212159;983.4640121133999;1018.9796204075877;1042.4579218806177;1049.6746008737316;1053.4364115198332;10327.277090603737;11045.33727976324;11060.949209825054;11068.654877194384;11295.887041129648;726103;732838;735925;747443;754958;125108.37445812895;156658.41769778778;159729;160333;160769.54997925097;948.5304774136708;962.7352478068448;985.5269470654126;986.9703908882601;987.4223579206101;15455.690886182438;17977.191026404103;18486.81513184905;18553.907230463763;18842.717359239898;40074;57333.42666573281;57803;58622.7068864653;59322;79281.60359198166;81074.59462702648;82462.58768706118;82797.58601206956;82811.5859420699;7979.9202007979175;8083.797905052185;8208;8275.875861862198;8533.31733461334;11772.529098836294;12137.514499419924;12192.451339689558;12461.87538124607;12578.496860125493;8988.011318755063;9548.474833883925;11026;11107.72230694239;11184.105271578092;10582.941705829355;10765.407902565434;10956.233063685466;11147.219694621299;11413.657590272305;10890.455477226265;11141.331520108819;11184.832227516756;11672.124590655905;11988.340641264815;7100.396466300423;7105.857882842418;7303.233160518069;7406.185319614946;8567.186117318844;7553.395728341609;7866.8819967701675;7997.480163789335;8191.590420479071;9105.630916560915 04:44:59 INFO - PROCESS | 1678 | |3;mootools.html;1327.2235742090877;1347.8315210598676;1460.8612181842727;1479.1420975834017;1486.7026594681067;7485.850282994344;7838.960805195973;8124.8781268280945;8356.791080222998;8368.414211005233;7633.160352361236;7700.653470593823;8323.33413326934;8324.875126873087;8331.458455200407;2068.5552606189667;2309.1340747219833;2343.355577216271;2346.507233480971;2353.670486131943;2135.0712440088532;2157.7087093242367;2158.622241107808;2159.082389984258;2281.646344816556;2314.085936055257;2333.4982978659586;2335.1359996801207;2335.4978679583887;2345.061975209913;2270.9886450567806;2284.7829456201634;2295.988520057397;2304.4584522637165;2305.7578954209735;2013.617412691584;2323.581755284048;2348.412896775806;2348.8473249238746;2354.646802979567;8315.459495132796;8350.498970061815;8425.662973481054;8431.789205269855;8434.57827108642;5060;5215.947840521584;5220.765065572058;5222.92165617516;5230.973845130788;3453.2748122893972;3484.4250698634696;3490.4415293553166;3539.43369060949;3553.733469989735;1206.6802297391198;1218.4212499062962;1245.7944439167527;1253.1228140301826;1253.266838899245;9178.311626627963;10929.726756831064;10956.959088886622;10965.780684386267;10984.505697243643;4411.580899814512;4646.210144275481;4678.929816052762;4713;4718.457377401574;9500;9515.334816407101;9520.047995200563;9542.141207291239;9548.092931171528;5230.215467679803;5230.947690523122;5233.900880814996;5258.2375555544995;5282.102042652758;4520.0507893342765;4687.81248750053;4775;4782.33047373368;4805.495422980606;3600.4959305697225;3642.817859107034;3751.531058617673;3851.441540976543;3873.186630807562;1278.7058976435471;1286.3696788573718;1302.2577131035218;1303.69363199648;1304.706441050756;877.2017464107631;904.1681652879366;918.1323649151487;928.4267386900726;935.4387367579534;5623.212750214973;5674.120511320752;5825.155352473952;5829.44620261083;5973.790917317873;812.5043723328765;1020.8417695257247;1026.8459731040405;1027.845823126522;1029.7065336379246;3460.8615655374006;3723.9255214896093;3816.3702989007056;3856;3856.8842934712;9790.755231119136;10119.494025298705;10133.64532241368;10151.644692435877;10173.54219060144;9499.335046546814;10051.447170405698;10083.092521672937;10106.14097801695;10120.797584048278;7647.388208943271;7875.56684382353;7897.052353717706;7934.008248968879;7943.801404964806;5604.775808967595;5614.157876318585;5623.8189980104635;5816.272965879265;5855.765769369177;9113.498757568132;9359.532023398939;9384.81230375375;9404.153626173404;9405.623775049195;9116;9299.256059515088;9533.285003624616;9560.426374417557;9564;6050.364711705208;7218.675159617725;7271.963640181765;7287.1984081752025;7342.926570734225;7228.566286022856;7481.625918703934;7813.726519571787;7913.287804097658;7920.84158316842;6695.263521012587;7062.788116356517;7079.858402832017;7173.820654483679;7208.171060328129;6910.032595436543;6986.126734158231;7007.159140903124;7029.859402811813;7058.129595657258;6286.491242101954;6392.648404337806;6398.840028999312;6401.391867772554;6406.615603063831;4845.685030473008;4889.731064791471;4981.925271121008;5033.47148549397;5179.92230116541;4867.488913664014;4910.631702622389;5006.6495345325475;5139.1263485206855;5187.662801917863 04:44:59 INFO - PROCESS | 1678 | |4;prototype.html;362.9110867837379;367.15554225281846;372.2406291166021;381.84344418788305;386.1832224844453;4764.4277388461815;5329.840104796857;5337.786488540459;5402.486763757446;5411.540019098381;4542.159700455418;4882.804687812492;5104.566111880495;5109.514596113372;5337.839864804052;3740.3641380965164;3948.8617898373564;4017.63400443849;4098.790856697274;4116.814743336542;3332.8500217490273;4130.731502452346;4187.602177793105;4199.1733595885735;4211.768352740598;3066.4940284852973;4055.1889622075555;4119.196756632457;4172.18642364739;4222.0922501662135;3449.6032956209856;4161.146964872224;4194.818694278988;4225;4247.532771395159;2863.7565806906437;3362.529245905575;3442.9843196256916;3640.981795091034;3667.889963301105;4277.807498662536;5150.690958542499;5167.268964896726;5169.198774190007;5192.273081768555;4139.778765264255;4264.125854199912;4473.463184417858;4620.745858977755;4703.858884233478;4655;4826.155422801031;5404.973294895328;5606.495415412592;5643.294588176478;3326.7005969462866;3872.5740168581433;3901.2197560488016;3925.509311336083;3926.8429262829736;5129.948020791676;5492.945070549284;5783.797567085132;5865;5982.312034116088;3262.9021129366156;3506.9123271917897;3835.9424608630893;3841.5966323536186;3858.344081506151;3706.8517259309324;3885.746267165094;3919.8040097994985;3926.2147570486018;3934.842606295716;4148.419221309019;4301.78491075445;4527.619076181731;4541.886452838639;4550.224363138483;5413.269208656781;5589.385167631557;5617.550595952314;5619.8595035123635;5635.408282130399;1135.7387800805861;1150.355800751565;1210.0501106631252;1214.7548762518313;1275.2730943362194;781.8428725486312;809.5142914251402;835.1439774231461;839.215333663027;852.3138873207128;4349.651188358251;4776.641751868624;4963;5027.296178535008;5033.734819331243;4762.309465127537;4911.803527858846;5160.587153027749;5530.073647710091;5562.86092847674;4662.836800712027;4775.856724298276;4927.630427717864;5152.819651312261;5247.5569218465225;2309.2148669452467;2614.1700809433473;2849.3873817129;2857.5427931530853;2873.6120623715947;4978.850634480971;5359.356877174764;5519.840833424945;5631.605787594829;5690.459406356389;4978.452370239271;5311.105447531105;5479.274028680953;5614.691191984399;5764.971175144097;4860.420363381844;5323.893522129536;5446.428125046892;5742.880138373061;5756.971215143982;4679.461861885927;4744.715317080986;5397.406285308692;5441.347038355423;5500.4499550044675;5321;5334.599905007062;5605.747741351731;5650.23721797552;5657.5473962082115;5209.76556054986;5895.322037965689;5918.23063001807;5960.523158147251;5962.940370596412;3758.4174452959833;3800.2399520096646;3819.809009549567;3850.9037274068373;3865.439511270906;4303.483581970184;4309.935350969675;5657.038303488499;5662.754194077296;5810.954028274951;5440.918386224289;5617.32592088952;5623.775048997994;5636.041872881702;5646.3788983212635;4888.657793954531;5013.598912087097;5090.440051594395;5170.689758614495;5586.184490040834;4373.912521749611;4518.570735780096;5179.611529135254;5488;5498.230247765396;4647.697899636512;4853.320535125156;4985.725785081855;5444.992676354887;5449.400565937823;5306.575473961997;5421.783128674967;5423.864403389947;5473.890522189614;5479.561635069264 04:44:59 INFO - PROCESS | 1678 | |5;yui.html;626.764963138823;674.3425160468544;686.9381755641992;713.5005496152694;730.9269073092688;15083.396664133435;15575.387971639648;15638.296276667563;16092.919535402336;16099.436519721812;14777.335019924103;14943.701125977474;14951.327190276437;14960.850391496082;14962.476313329036;704.7639040921298;885.7874110213551;919.2278486071698;922.7001224601997;924.1636319131197;713.3365969648225;862.8446879561676;891.5943245823167;897.4794619120927;911.0024523147176;952.7665721898145;954.2175416158752;954.2318433660901;954.5227386306847;955.0974329258853;944.5466176235377;945.5366870233605;945.6595625574788;947.5499137909507;949.7198326493701;549.2639862584117;565.2651552981108;688.3770187979886;702.6873041496536;712.8681193979079;15487.225638718019;15537.533873983799;15538.456154034555;15560.299786509635;15563.92218038914;13783.448662053506;13786.553361659586;13815.378307976165;13867.23730194839;13893.305334733222;10492;12206.329429354597;12372.1958072725;12524.74950500985;12937.676558086028;4376.846810361654;4386.978065109654;4437.822487100512;4442.622377097919;4618.930716039262;106759.93240067655;107829.46085269602;111011.88988110177;111701;112091.30721698969;10752.569897204181;10767.6231331903;10964.890351096386;11006.944965275123;11019.72450688723;22005.559888802134;22016.44958876009;22022.33932982013;22045;22056.88971555132;7567.356774674105;7786.727464538714;7789.766307010798;7828.138904720477;7872.763817085496;3982.9402558961638;4141.316682747313;4149.33610622299;4156.189543039139;4178.519470260898;3329.417351963397;3351.2794749128566;3432.3821712091562;3446;3448.293094918032;637.2162240444279;642.331974746268;644.690548536705;647.527305067294;657.8355411147213;553.4990833295874;622.3341025103097;631.9810405687837;633.6356594957917;653.3074940563018;8507.106753790762;8792.8681069784;9357.111074448052;9542.475163866055;9640.662576809778;607.7325976570295;613.3958051319447;639.4532674563275;644.9355064493607;666.9199696036507;4329.956700433018;4612.192866248393;4644.140833945731;4671.579557839811;4736.100140973273;100224.49663255057;102180.85664728923;102268.48865755773;102290;106210.46894765476;89412;90321;91285.54357228172;91903.5404822985;93695;78319.21680783233;79855;80004;80316.19683803321;80801.59599201966;8541.273991710774;8924.32411004512;9026.45841249527;9145.908540914772;9280.535973201178;47685.569432917066;48044.9999999986;49047.75476122739;49081.75459122682;49998.50001500084;62431.6878415605;65363.346366537626;66304.6684766573;67490.3250967484;68862;11009.037788073396;11161.609343672932;11211.327320360804;11243.887561124284;11771.52913883435;11956.461959211681;12005.63983080509;12026.098042647012;12033.759324813629;12557.497700091893;11568.190226684052;11576.594819181288;11584;11778.705532361759;12122.151449398458;11441.019366775234;11520.884791152317;11536.019438347499;11550.942245289056;11567.710807229887;10991.890081099087;11010.889891100986;11016.449177541252;11042.944785276022;11075.889241107809;7378.557286562824;9120.407173533698;9465.290103242147;9650;9757.853632195382;8622.655093796178;9249.630014799333;9610.711678649652;9735.561899714388;9758.219342452729 04:44:59 INFO - PROCESS | 1678 | __end_tp_report 04:44:59 INFO - PROCESS | 1678 | __start_cc_report 04:44:59 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1557 04:44:59 INFO - PROCESS | 1678 | __end_cc_report 04:44:59 INFO - PROCESS | 1678 | __startTimestamp1484484299074__endTimestamp 04:44:59 INFO - PROCESS | 1678 | 04:44:59 INFO - PROCESS | 1678 | ------- Summary: start ------- 04:44:59 INFO - PROCESS | 1678 | Number of tests: 6 04:44:59 INFO - PROCESS | 1678 | 04:44:59 INFO - PROCESS | 1678 | [#0] dojo.html Cycles:165 Average:5792.62 Median:6053.67 stddev:658.85 (10.9%) stddev-sans-first:626.98 04:44:59 INFO - PROCESS | 1678 | Values: 3133.3 3352.8 3359.4 3374.3 3415.4 5609.6 5685.8 5711.9 5785.8 5802.4 5716.7 5728.7 5777.0 5838.9 5914.9 5210.9 5247.1 5287.2 5293.5 5317.1 4840.5 5231.6 5327.4 5339.8 5370.8 5341.8 5358.8 5360.6 5369.2 5376.8 5208.7 5222.5 5240.3 5250.1 5312.0 5230.1 5242.7 5259.6 5311.2 5338.0 5715.4 5720.5 5721.5 5740.6 5754.2 6065.0 6181.3 6304.8 6324.0 6334.6 6222.2 6289.0 6289.2 6318.3 6359.2 5872.3 5939.1 5943.1 5946.7 5978.1 6308.4 6322.1 6358.8 6380.2 6401.5 6134.0 6135.4 6147.0 6174.5 6219.8 6315.8 6319.9 6334.5 6338.0 6345.2 6118.2 6124.1 6164.9 6171.6 6240.8 5260.9 6231.5 6261.0 6266.4 6283.8 4338.5 5063.2 5068.4 5068.8 5097.2 4448.4 4478.8 4487.6 4488.3 4566.4 5756.4 5858.6 5861.9 5880.7 5900.2 5297.8 6311.6 6326.9 6330.0 6346.4 5676.0 5680.7 5857.4 5868.3 5879.1 5450.6 5476.0 5509.2 5509.2 5517.8 6410.9 6433.0 6436.5 6440.6 6445.3 6351.1 6352.4 6360.3 6366.6 6463.6 6241.7 6269.1 6274.1 6291.5 6325.2 6287.9 6300.4 6302.7 6307.6 6311.0 6321.6 6340.5 6342.8 6352.1 6353.4 6057.6 6100.1 6101.8 6108.9 6208.1 6208.4 6221.2 6223.2 6224.2 6249.3 5820.9 5847.9 6040.8 6071.0 6074.8 4869.4 6115.0 6120.4 6120.8 6137.3 6043.5 6053.7 6060.7 6061.5 6085.9 04:44:59 INFO - PROCESS | 1678 | 04:44:59 INFO - PROCESS | 1678 | [#1] ext.html Cycles:180 Average:63576.57 Median:196912.52 stddev:133682.39 (67.9%) stddev-sans-first:133973.45 04:44:59 INFO - PROCESS | 1678 | Values: 472.2 472.9 498.8 500.1 501.3 30081.2 39697.0 41483.6 41492.0 43617.0 42232.2 42533.8 42536.8 42551.4 42576.8 8512.0 9229.2 9438.9 9448.7 9459.3 8502.7 11343.5 11624.4 11624.7 11633.1 10478.8 10635.9 11312.6 11377.5 11409.7 8482.7 8686.9 11344.9 11428.8 11443.8 11077.1 11416.7 11416.9 11561.4 11569.7 38009.6 40461.8 40505.6 40563.6 40570.4 4004.3 4048.6 4072.8 4102.6 4139.9 30163.7 30759.8 30938.8 30989.2 31063.5 3152.4 3164.1 3177.3 3244.3 3300.7 356624.0 356780.2 356851.0 358067.2 358071.0 58035.7 58061.4 58094.7 58334.7 58574.0 62100.4 62798.4 62899.1 63096.1 63195.0 13055.7 15992.6 16015.0 16017.9 16029.4 11147.3 11428.5 12231.9 12410.8 12462.9 14214.9 14610.7 15572.9 15957.0 16010.7 6239.0 6608.7 6932.7 7138.7 7331.6 828.3 871.0 903.7 912.6 920.1 25844.6 27062.5 29625.7 29670.0 30506.0 921.0 1066.1 1094.9 1100.1 1218.4 14881.9 15435.5 15549.4 15549.5 15810.8 591610.0 594762.0 595827.0 596109.0 597592.0 58962.7 59291.4 59299.1 59316.0 59743.7 1256.8 1419.7 1445.3 1462.5 1463.8 29070.7 29310.7 29328.6 30006.5 30048.0 49233.3 49511.8 49575.0 49624.0 49667.5 519467.0 520730.0 522189.4 522791.0 522910.0 32783.0 33677.0 38276.4 39362.4 39496.0 39810.6 46154.8 46555.0 49158.0 49787.5 33529.0 34808.5 36368.3 37802.4 39989.4 34875.8 35098.6 35106.0 36009.0 36041.6 34988.8 35507.0 35539.0 35757.8 35859.5 30401.7 31523.0 31526.7 31544.5 31602.2 22078.7 23299.5 23456.0 23995.3 24084.5 04:44:59 INFO - PROCESS | 1678 | 04:44:59 INFO - PROCESS | 1678 | [#2] jquery.html Cycles:180 Average:42267.25 Median:2910.92 stddev:123340.14 (4237.2%) stddev-sans-first:123646.07 04:44:59 INFO - PROCESS | 1678 | Values: 396.8 398.2 404.4 404.6 427.6 19602.8 20026.8 20887.2 21312.9 21438.9 19928.7 21366.5 21509.9 21597.9 21752.8 5653.8 5980.4 5985.9 5992.4 6008.3 5834.2 5935.5 5941.3 7136.6 7461.9 7631.7 7640.4 7644.2 7645.1 7650.6 7343.3 7583.5 7644.8 7645.3 7651.7 7186.9 7426.7 7456.7 7512.9 7539.9 28421.6 28441.7 28479.6 28486.0 28486.7 2497.7 2868.3 2900.2 2908.1 2913.8 15685.0 16230.7 16348.5 16808.6 17230.8 1999.8 2000.2 2007.3 2019.3 2035.0 141807.0 150529.0 151694.0 154427.0 155732.0 20208.8 21110.6 22817.8 22855.0 23363.4 32621.8 40469.4 40510.4 40560.8 40918.4 9289.3 10587.3 10740.4 10945.4 11160.1 8691.7 8718.7 8735.2 8869.5 8919.3 8517.5 10797.6 10812.6 10943.8 10956.4 4043.8 4167.3 4176.0 4189.6 4191.6 983.4 989.0 992.2 1010.4 1030.1 17754.7 19136.9 20270.8 20684.5 21214.8 983.5 1019.0 1042.5 1049.7 1053.4 10327.3 11045.3 11060.9 11068.7 11295.9 726103.0 732838.0 735925.0 747443.0 754958.0 125108.4 156658.4 159729.0 160333.0 160769.5 948.5 962.7 985.5 987.0 987.4 15455.7 17977.2 18486.8 18553.9 18842.7 40074.0 57333.4 57803.0 58622.7 59322.0 79281.6 81074.6 82462.6 82797.6 82811.6 7979.9 8083.8 8208.0 8275.9 8533.3 11772.5 12137.5 12192.5 12461.9 12578.5 8988.0 9548.5 11026.0 11107.7 11184.1 10582.9 10765.4 10956.2 11147.2 11413.7 10890.5 11141.3 11184.8 11672.1 11988.3 7100.4 7105.9 7303.2 7406.2 8567.2 7553.4 7866.9 7997.5 8191.6 9105.6 04:44:59 INFO - PROCESS | 1678 | 04:44:59 INFO - PROCESS | 1678 | [#3] mootools.html Cycles:180 Average:5441.16 Median:5183.79 stddev:2952.88 (57.0%) stddev-sans-first:2944.98 04:44:59 INFO - PROCESS | 1678 | Values: 1327.2 1347.8 1460.9 1479.1 1486.7 7485.9 7839.0 8124.9 8356.8 8368.4 7633.2 7700.7 8323.3 8324.9 8331.5 2068.6 2309.1 2343.4 2346.5 2353.7 2135.1 2157.7 2158.6 2159.1 2281.6 2314.1 2333.5 2335.1 2335.5 2345.1 2271.0 2284.8 2296.0 2304.5 2305.8 2013.6 2323.6 2348.4 2348.8 2354.6 8315.5 8350.5 8425.7 8431.8 8434.6 5060.0 5215.9 5220.8 5222.9 5231.0 3453.3 3484.4 3490.4 3539.4 3553.7 1206.7 1218.4 1245.8 1253.1 1253.3 9178.3 10929.7 10957.0 10965.8 10984.5 4411.6 4646.2 4678.9 4713.0 4718.5 9500.0 9515.3 9520.0 9542.1 9548.1 5230.2 5230.9 5233.9 5258.2 5282.1 4520.1 4687.8 4775.0 4782.3 4805.5 3600.5 3642.8 3751.5 3851.4 3873.2 1278.7 1286.4 1302.3 1303.7 1304.7 877.2 904.2 918.1 928.4 935.4 5623.2 5674.1 5825.2 5829.4 5973.8 812.5 1020.8 1026.8 1027.8 1029.7 3460.9 3723.9 3816.4 3856.0 3856.9 9790.8 10119.5 10133.6 10151.6 10173.5 9499.3 10051.4 10083.1 10106.1 10120.8 7647.4 7875.6 7897.1 7934.0 7943.8 5604.8 5614.2 5623.8 5816.3 5855.8 9113.5 9359.5 9384.8 9404.2 9405.6 9116.0 9299.3 9533.3 9560.4 9564.0 6050.4 7218.7 7272.0 7287.2 7342.9 7228.6 7481.6 7813.7 7913.3 7920.8 6695.3 7062.8 7079.9 7173.8 7208.2 6910.0 6986.1 7007.2 7029.9 7058.1 6286.5 6392.6 6398.8 6401.4 6406.6 4845.7 4889.7 4981.9 5033.5 5179.9 4867.5 4910.6 5006.6 5139.1 5187.7 04:44:59 INFO - PROCESS | 1678 | 04:44:59 INFO - PROCESS | 1678 | [#4] prototype.html Cycles:180 Average:4424.36 Median:4900.23 stddev:1354.51 (27.6%) stddev-sans-first:1323.56 04:44:59 INFO - PROCESS | 1678 | Values: 362.9 367.2 372.2 381.8 386.2 4764.4 5329.8 5337.8 5402.5 5411.5 4542.2 4882.8 5104.6 5109.5 5337.8 3740.4 3948.9 4017.6 4098.8 4116.8 3332.9 4130.7 4187.6 4199.2 4211.8 3066.5 4055.2 4119.2 4172.2 4222.1 3449.6 4161.1 4194.8 4225.0 4247.5 2863.8 3362.5 3443.0 3641.0 3667.9 4277.8 5150.7 5167.3 5169.2 5192.3 4139.8 4264.1 4473.5 4620.7 4703.9 4655.0 4826.2 5405.0 5606.5 5643.3 3326.7 3872.6 3901.2 3925.5 3926.8 5129.9 5492.9 5783.8 5865.0 5982.3 3262.9 3506.9 3835.9 3841.6 3858.3 3706.9 3885.7 3919.8 3926.2 3934.8 4148.4 4301.8 4527.6 4541.9 4550.2 5413.3 5589.4 5617.6 5619.9 5635.4 1135.7 1150.4 1210.1 1214.8 1275.3 781.8 809.5 835.1 839.2 852.3 4349.7 4776.6 4963.0 5027.3 5033.7 4762.3 4911.8 5160.6 5530.1 5562.9 4662.8 4775.9 4927.6 5152.8 5247.6 2309.2 2614.2 2849.4 2857.5 2873.6 4978.9 5359.4 5519.8 5631.6 5690.5 4978.5 5311.1 5479.3 5614.7 5765.0 4860.4 5323.9 5446.4 5742.9 5757.0 4679.5 4744.7 5397.4 5441.3 5500.4 5321.0 5334.6 5605.7 5650.2 5657.5 5209.8 5895.3 5918.2 5960.5 5962.9 3758.4 3800.2 3819.8 3850.9 3865.4 4303.5 4309.9 5657.0 5662.8 5811.0 5440.9 5617.3 5623.8 5636.0 5646.4 4888.7 5013.6 5090.4 5170.7 5586.2 4373.9 4518.6 5179.6 5488.0 5498.2 4647.7 4853.3 4985.7 5445.0 5449.4 5306.6 5421.8 5423.9 5473.9 5479.6 04:44:59 INFO - PROCESS | 1678 | 04:44:59 INFO - PROCESS | 1678 | [#5] yui.html Cycles:180 Average:20252.07 Median:47865.28 stddev:29950.63 (62.6%) stddev-sans-first:29998.40 04:44:59 INFO - PROCESS | 1678 | Values: 626.8 674.3 686.9 713.5 730.9 15083.4 15575.4 15638.3 16092.9 16099.4 14777.3 14943.7 14951.3 14960.9 14962.5 704.8 885.8 919.2 922.7 924.2 713.3 862.8 891.6 897.5 911.0 952.8 954.2 954.2 954.5 955.1 944.5 945.5 945.7 947.5 949.7 549.3 565.3 688.4 702.7 712.9 15487.2 15537.5 15538.5 15560.3 15563.9 13783.4 13786.6 13815.4 13867.2 13893.3 10492.0 12206.3 12372.2 12524.7 12937.7 4376.8 4387.0 4437.8 4442.6 4618.9 106759.9 107829.5 111011.9 111701.0 112091.3 10752.6 10767.6 10964.9 11006.9 11019.7 22005.6 22016.4 22022.3 22045.0 22056.9 7567.4 7786.7 7789.8 7828.1 7872.8 3982.9 4141.3 4149.3 4156.2 4178.5 3329.4 3351.3 3432.4 3446.0 3448.3 637.2 642.3 644.7 647.5 657.8 553.5 622.3 632.0 633.6 653.3 8507.1 8792.9 9357.1 9542.5 9640.7 607.7 613.4 639.5 644.9 666.9 4330.0 4612.2 4644.1 4671.6 4736.1 100224.5 102180.9 102268.5 102290.0 106210.5 89412.0 90321.0 91285.5 91903.5 93695.0 78319.2 79855.0 80004.0 80316.2 80801.6 8541.3 8924.3 9026.5 9145.9 9280.5 47685.6 48045.0 49047.8 49081.8 49998.5 62431.7 65363.3 66304.7 67490.3 68862.0 11009.0 11161.6 11211.3 11243.9 11771.5 11956.5 12005.6 12026.1 12033.8 12557.5 11568.2 11576.6 11584.0 11778.7 12122.2 11441.0 11520.9 11536.0 11550.9 11567.7 10991.9 11010.9 11016.4 11042.9 11075.9 7378.6 9120.4 9465.3 9650.0 9757.9 8622.7 9249.6 9610.7 9735.6 9758.2 04:44:59 INFO - PROCESS | 1678 | -------- Summary: end -------- 04:44:59 INFO - PROCESS | 1678 | 04:44:59 INFO - TEST-INFO | 1678: exit 0 04:44:59 INFO - TEST-OK | dromaeo_css | took 1118011ms 04:44:59 INFO - TEST-START | kraken 04:44:59 INFO - operating with platform_type : mac_ 04:44:59 INFO - Initialising browser for kraken test... 04:44:59 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/tmp541tGa/profile http://localhost:49248/getInfo.html) 04:45:02 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 04:45:02 INFO - PROCESS | 1684 | colorDepth:24 04:45:02 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 04:45:02 INFO - PROCESS | 1684 | __metrics 04:45:02 INFO - PROCESS | 1684 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:45:02 INFO - PROCESS | 1684 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:45:02 INFO - TEST-INFO | 1684: exit 0 04:45:02 INFO - Browser initialized. 04:45:02 INFO - Running cycle 1/1 for kraken test... 04:45:02 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/T/tmp541tGa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:15 INFO - PROCESS | 1686 | RSS: Main: 235814912 04:45:15 INFO - PROCESS | 1686 | 04:45:17 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 04:45:18 INFO - PROCESS | 1686 | RSS: Main: 288075776 04:45:18 INFO - PROCESS | 1686 | 04:45:21 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 04:45:22 INFO - PROCESS | 1686 | RSS: Main: 287477760 04:45:22 INFO - PROCESS | 1686 | 04:45:25 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 04:45:25 INFO - PROCESS | 1686 | RSS: Main: 379957248 04:45:25 INFO - PROCESS | 1686 | 04:45:27 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 04:45:28 INFO - PROCESS | 1686 | RSS: Main: 283615232 04:45:28 INFO - PROCESS | 1686 | 04:45:30 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:45:31 INFO - PROCESS | 1686 | RSS: Main: 287285248 04:45:31 INFO - PROCESS | 1686 | 04:45:33 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 04:45:34 INFO - PROCESS | 1686 | RSS: Main: 330248192 04:45:34 INFO - PROCESS | 1686 | 04:45:37 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 04:45:38 INFO - PROCESS | 1686 | RSS: Main: 332423168 04:45:38 INFO - PROCESS | 1686 | 04:45:40 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 04:45:41 INFO - PROCESS | 1686 | RSS: Main: 329420800 04:45:41 INFO - PROCESS | 1686 | 04:45:43 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:45:43 INFO - PROCESS | 1686 | RSS: Main: 304369664 04:45:43 INFO - PROCESS | 1686 | 04:45:45 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:45:46 INFO - PROCESS | 1686 | RSS: Main: 307314688 04:45:46 INFO - PROCESS | 1686 | 04:45:48 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:45:49 INFO - PROCESS | 1686 | RSS: Main: 309358592 04:45:49 INFO - PROCESS | 1686 | 04:45:52 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:45:52 INFO - PROCESS | 1686 | RSS: Main: 324816896 04:45:52 INFO - PROCESS | 1686 | 04:45:55 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:45:56 INFO - PROCESS | 1686 | RSS: Main: 319303680 04:45:56 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 04:45:58 INFO - PROCESS | 1686 | RSS: Main: 363356160 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | __start_tp_report 04:45:58 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 04:45:58 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 04:45:58 INFO - PROCESS | 1686 | |i|pagename|runs| 04:45:58 INFO - PROCESS | 1686 | |0;ai-astar;113;114;114;113;114;112;113;113;113;119 04:45:58 INFO - PROCESS | 1686 | |1;audio-beat-detection;151;131;137;178;143;111;106;112;131;111 04:45:58 INFO - PROCESS | 1686 | |2;audio-dft;182;184;185;187;184;182;215;190;185;183 04:45:58 INFO - PROCESS | 1686 | |3;audio-fft;80;58;59;86;63;60;58;58;74;59 04:45:58 INFO - PROCESS | 1686 | |4;audio-oscillator;90;73;86;70;68;72;115;81;70;84 04:45:58 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;88;86;87;85;87;85;89;84;87;84 04:45:58 INFO - PROCESS | 1686 | |6;imaging-darkroom;93;93;93;93;93;93;93;94;93;94 04:45:58 INFO - PROCESS | 1686 | |7;imaging-desaturate;124;138;92;87;88;87;87;87;87;88 04:45:58 INFO - PROCESS | 1686 | |8;json-parse-financial;56;56;56;55;57;57;54;55;58;57 04:45:58 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;65;71;80;76;87;101;103;87;70;72 04:45:58 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;89;87;85;87;86;86;85;85;87;88 04:45:58 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;140;140;141;141;139;138;158;150;203;140 04:45:58 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;174;174;172;174;173;230;173;175;174;174 04:45:58 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;67;67;67;66;68;69;76;83;85;85 04:45:58 INFO - PROCESS | 1686 | __end_tp_report 04:45:58 INFO - PROCESS | 1686 | __start_cc_report 04:45:58 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,1962 04:45:58 INFO - PROCESS | 1686 | __end_cc_report 04:45:58 INFO - PROCESS | 1686 | __startTimestamp1484484358599__endTimestamp 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | ------- Summary: start ------- 04:45:58 INFO - PROCESS | 1686 | Number of tests: 14 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.50 stddev:1.93 (1.7%) stddev-sans-first:2.03 04:45:58 INFO - PROCESS | 1686 | Values: 113.0 114.0 114.0 113.0 114.0 112.0 113.0 113.0 113.0 119.0 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:134.00 stddev:22.55 (16.8%) stddev-sans-first:22.73 04:45:58 INFO - PROCESS | 1686 | Values: 151.0 131.0 137.0 178.0 143.0 111.0 106.0 112.0 131.0 111.0 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:187.70 Median:185.00 stddev:9.89 (5.3%) stddev-sans-first:10.27 04:45:58 INFO - PROCESS | 1686 | Values: 182.0 184.0 185.0 187.0 184.0 182.0 215.0 190.0 185.0 183.0 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:65.50 Median:61.50 stddev:10.50 (17.1%) stddev-sans-first:9.74 04:45:58 INFO - PROCESS | 1686 | Values: 80.0 58.0 59.0 86.0 63.0 60.0 58.0 58.0 74.0 59.0 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:80.90 Median:77.00 stddev:14.25 (18.5%) stddev-sans-first:14.73 04:45:58 INFO - PROCESS | 1686 | Values: 90.0 73.0 86.0 70.0 68.0 72.0 115.0 81.0 70.0 84.0 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:87.00 stddev:1.69 (1.9%) stddev-sans-first:1.66 04:45:58 INFO - PROCESS | 1686 | Values: 88.0 86.0 87.0 85.0 87.0 85.0 89.0 84.0 87.0 84.0 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 04:45:58 INFO - PROCESS | 1686 | Values: 93.0 93.0 93.0 93.0 93.0 93.0 93.0 94.0 93.0 94.0 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:87.00 stddev:18.54 (21.3%) stddev-sans-first:16.79 04:45:58 INFO - PROCESS | 1686 | Values: 124.0 138.0 92.0 87.0 88.0 87.0 87.0 87.0 87.0 88.0 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.50 stddev:1.20 (2.1%) stddev-sans-first:1.27 04:45:58 INFO - PROCESS | 1686 | Values: 56.0 56.0 56.0 55.0 57.0 57.0 54.0 55.0 58.0 57.0 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:81.20 Median:74.00 stddev:13.08 (17.7%) stddev-sans-first:12.49 04:45:58 INFO - PROCESS | 1686 | Values: 65.0 71.0 80.0 76.0 87.0 101.0 103.0 87.0 70.0 72.0 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:87.00 stddev:1.35 (1.6%) stddev-sans-first:1.09 04:45:58 INFO - PROCESS | 1686 | Values: 89.0 87.0 85.0 87.0 86.0 86.0 85.0 85.0 87.0 88.0 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:149.00 Median:141.00 stddev:19.97 (14.2%) stddev-sans-first:20.92 04:45:58 INFO - PROCESS | 1686 | Values: 140.0 140.0 141.0 141.0 139.0 138.0 158.0 150.0 203.0 140.0 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:174.00 stddev:17.83 (10.2%) stddev-sans-first:18.81 04:45:58 INFO - PROCESS | 1686 | Values: 174.0 174.0 172.0 174.0 173.0 230.0 173.0 175.0 174.0 174.0 04:45:58 INFO - PROCESS | 1686 | 04:45:58 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:72.50 stddev:8.12 (11.2%) stddev-sans-first:8.29 04:45:58 INFO - PROCESS | 1686 | Values: 67.0 67.0 67.0 66.0 68.0 69.0 76.0 83.0 85.0 85.0 04:45:58 INFO - PROCESS | 1686 | -------- Summary: end -------- 04:45:58 INFO - PROCESS | 1686 | 04:45:59 INFO - TEST-INFO | 1686: exit 0 04:45:59 INFO - TEST-OK | kraken | took 59760ms 04:45:59 INFO - SUITE-END | took 1177s 04:45:59 INFO - Completed test suite (00:19:37) 04:45:59 INFO - javascript benchmark 04:45:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.326334838009, 3352.7988320700742, 3359.3617212729587, 3374.2913988062505, 3415.4193787056197, 5609.551235901128, 5685.800996965107, 5711.942880571193, 5785.826425207245, 5802.448767367098, 5716.685582292972, 5728.68492232927, 5777.017906955817, 5838.9124163137485, 5914.9112763308585, 5210.895782084375, 5247.134222853225, 5287.206918962148, 5293.52358287754, 5317.149256119022, 4840.467548569654, 5231.607629427789, 5327.360716714, 5339.759710813003, 5370.812021579245, 5341.759620817073, 5358.785648574052, 5360.597955153359, 5369.24830523727, 5376.758045887945, 5208.687478751249, 5222.529972302511, 5240.34495688039, 5250.08123578376, 5311.973440132813, 5230.110881150214, 5242.659227150223, 5259.579233661298, 5311.176767601028, 5338.039152952467, 5715.371309155989, 5720.485156335908, 5721.456461636138, 5740.6268592541355, 5754.223179870705, 6065.0, 6181.289151747562, 6304.779332723333, 6324.0, 6334.588251763621, 6222.191115155046, 6289.0, 6289.150964619764, 6318.2733985591785, 6359.20509936258, 5872.295324561037, 5939.1388248704125, 5943.138244954457, 5946.672932988728, 5978.073398623221, 6308.400701933309, 6322.088413493885, 6358.777442789573, 6380.234371875312, 6401.487880969511, 6133.977404287557, 6135.44780969706, 6147.047207682816, 6174.536909731788, 6219.751209951642, 6315.842103947438, 6319.873602527924, 6334.524910631629, 6337.9683101585115, 6345.206849143857, 6118.223266370716, 6124.075808605183, 6164.938350616526, 6171.59884607499, 6240.843978900564, 5260.92108618371, 6231.470325022333, 6261.029540421151, 6266.404691554295, 6283.842903927347, 4338.479382474124, 5063.215201643751, 5068.366454193226, 5068.847934561969, 5097.1844504879045, 4448.354988526646, 4478.843240486633, 4487.640988720895, 4488.326750987378, 4566.406367172246, 5756.42435756421, 5858.56060795442, 5861.88276234473, 5880.7353669085, 5900.232969713996, 5297.788088476418, 6311.589746666544, 6326.873462530815, 6330.0, 6346.397092276226, 5676.035074037423, 5680.744366503517, 5857.4435428634215, 5868.2664666916635, 5879.088741245114, 5450.5639548836, 5476.0, 5509.201165831012, 5509.228707980886, 5517.751701173457, 6410.935890641033, 6433.0, 6436.485081193587, 6440.645764482999, 6445.323241059808, 6351.142595749515, 6352.36476352361, 6360.268569114426, 6366.586171898812, 6463.644499552382, 6241.687915604292, 6269.0909818075215, 6274.121622972696, 6291.496680265659, 6325.209348831396, 6287.905681414691, 6300.369963003663, 6302.71637776292, 6307.590006649553, 6311.0217916223055, 6321.5574909757715, 6340.49276057905, 6342.778002769881, 6352.110704501281, 6353.428191462791, 6057.636541807506, 6100.145979562776, 6101.7559297627595, 6108.888502348341, 6208.1308616792785, 6208.441240288395, 6221.191245138103, 6223.159873417031, 6224.1597384352535, 6249.312575616769, 5820.94179058204, 5847.883042339215, 6040.848978775566, 6070.967935450895, 6074.817755467343, 4869.4400143982475, 6115.0273862886115, 6120.447133218705, 6120.816375508742, 6137.285055221685, 6043.516518678407, 6053.667048312385, 6060.696965151813, 6061.545384096298, 6085.939140608714], "value": 5750.104968349676, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.21612123874354, 472.9361536192614, 498.81294514557044, 500.14475247327067, 501.2706512025004, 30081.247968800762, 39697.0, 41483.585164148426, 41492.0, 43617.0, 42232.15535689284, 42533.7873310633, 42536.787316063455, 42551.361729574084, 42576.78711606446, 8511.957440212791, 9229.21551668109, 9438.905610943872, 9448.66929657462, 9459.337846350758, 8502.702405415812, 11343.489542970545, 11624.360660163687, 11624.651260462157, 11633.127515436334, 10478.842817357745, 10635.893641063567, 11312.604058857942, 11377.544898204062, 11409.657710268706, 8482.703105391281, 8686.913130868674, 11344.886551134465, 11428.771424571461, 11443.771124577544, 11077.11383089351, 11416.71458213543, 11416.885831141666, 11561.364124973123, 11569.710757231136, 38009.619903800885, 40461.79769101136, 40505.59494405048, 40563.59436405628, 40570.39144412836, 4004.3392840181336, 4048.5748996355255, 4072.816723247461, 4102.630763231294, 4139.875803725893, 30163.69836301631, 30759.846200768854, 30938.845305773553, 30989.22526936822, 31063.534046989313, 3152.4168028914496, 3164.1456806662304, 3177.253345463814, 3244.2700392411753, 3300.669933006704, 356624.0, 356780.21609892044, 356851.0, 358067.20966395264, 358071.0, 58035.709821450626, 58061.41938580645, 58094.7095264521, 58334.708326458946, 58574.0, 62100.37899621036, 62798.37201627925, 62899.056514152326, 63096.05355919665, 63195.0, 13055.673608159872, 15992.600184995468, 16015.0, 16017.878748487494, 16029.438969636007, 11147.275427097213, 11428.485718142703, 12231.938840305742, 12410.81383779244, 12462.937685311697, 14214.933879959044, 14610.707785844224, 15572.922135389477, 15957.04257744539, 16010.679786404207, 6239.0, 6608.702608382634, 6932.688029038705, 7138.714451421989, 7331.596762178131, 828.3000864269683, 870.9825803483894, 903.6927444668844, 912.5619702542684, 920.0845159066771, 25844.612330815053, 27062.458750824873, 29625.666844991596, 29670.0, 30506.0, 920.9731149767961, 1066.1364294921138, 1094.9288296260718, 1100.1418893263267, 1218.4456072486996, 14881.851181488262, 15435.459758908384, 15549.431897601762, 15549.533513994598, 15810.841891581167, 591610.0, 594762.0, 595827.0, 596109.0, 597592.0, 58962.70518647465, 59291.407085928586, 59299.11051334233, 59316.0, 59743.70128149331, 1256.7863463211277, 1419.6734751007325, 1445.3062529985666, 1462.5027490653229, 1463.8243410790774, 29070.7092929068, 29310.706892931652, 29328.56007159937, 30006.549901751056, 30048.0, 49233.2615010768, 49511.76220594514, 49575.0, 49624.0, 49667.50332496629, 519467.0, 520730.0, 522189.3890530523, 522791.0, 522910.0, 32783.016509504756, 33677.0, 38276.425853612775, 39362.4255029807, 39496.01259968524, 39810.60189398069, 46154.76922615366, 46555.0, 49158.0, 49787.51912327908, 33529.0, 34808.47787283142, 36368.27263454769, 37802.432963505016, 39989.40015899822, 34875.825620871736, 35098.649013510556, 35106.0, 36009.0, 36041.639583604876, 34988.77539286113, 35507.0, 35539.0, 35757.82121089378, 35859.46210806788, 30401.695983040772, 31523.0, 31526.684733152375, 31544.526832097996, 31602.209944751565, 22078.668819968036, 23299.534009320058, 23456.0, 23995.28014159578, 24084.51830963406], "value": 19699.39721641489, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.8452303601595, 398.23340070364543, 404.3570722551147, 404.6135940177131, 427.6130102257456, 19602.823830570174, 20026.799732002677, 20887.164513419444, 21312.89343553282, 21438.928053597334, 19928.70106948397, 21366.465838354048, 21509.892450537725, 21597.892010539963, 21752.782472175273, 5653.802116925908, 5980.401959804007, 5985.910211346833, 5992.43071908168, 6008.279006519224, 5834.154047663086, 5935.52515798735, 5941.316748573926, 7136.643167841613, 7461.925380746177, 7631.732889348874, 7640.388768898475, 7644.197359277279, 7645.082590089197, 7650.579218143, 7343.302386273295, 7583.544987300779, 7644.80887977805, 7645.3119219269975, 7651.732189373401, 7186.928130718678, 7426.665800039012, 7456.664450099758, 7512.887306690404, 7539.8869016964245, 28421.58940927081, 28441.715582844114, 28479.57280640792, 28486.0, 28486.724026736774, 2497.675302210701, 2868.297267169536, 2900.1589539033653, 2908.0694177863093, 2913.766898648103, 15684.980476269006, 16230.675386492323, 16348.509544713677, 16808.57978550534, 17230.827691723174, 1999.7600287965538, 2000.2299114840746, 2007.3275452723356, 2019.2932473634257, 2035.0, 141807.0, 150529.0, 151694.0, 154427.0, 155732.0, 20208.79791202069, 21110.577788444145, 22817.7718222819, 22855.0, 23363.415914602272, 32621.836890815393, 40469.39295910564, 40510.392344114865, 40560.79719601383, 40918.38622420666, 9289.256859451363, 10587.311824731369, 10740.409277489813, 10945.398003109905, 11160.051395631463, 8691.739247822576, 8718.694845680498, 8735.213830755263, 8869.467831930106, 8919.331050171264, 8517.531535765593, 10797.56809727602, 10812.62155824558, 10943.781124377627, 10956.397398143179, 4043.757374557536, 4167.312393455046, 4175.958240417557, 4189.581041895786, 4191.622753952159, 983.4394395194813, 989.0307498651362, 992.1963209800085, 1010.434156872154, 1030.1192480429274, 17754.733678994824, 19136.851788892713, 20270.79729202689, 20684.482887927923, 21214.78785212159, 983.4640121133999, 1018.9796204075877, 1042.4579218806177, 1049.6746008737316, 1053.4364115198332, 10327.277090603737, 11045.33727976324, 11060.949209825054, 11068.654877194384, 11295.887041129648, 726103.0, 732838.0, 735925.0, 747443.0, 754958.0, 125108.37445812895, 156658.41769778778, 159729.0, 160333.0, 160769.54997925097, 948.5304774136708, 962.7352478068448, 985.5269470654126, 986.9703908882601, 987.4223579206101, 15455.690886182438, 17977.191026404103, 18486.81513184905, 18553.907230463763, 18842.717359239898, 40074.0, 57333.42666573281, 57803.0, 58622.7068864653, 59322.0, 79281.60359198166, 81074.59462702648, 82462.58768706118, 82797.58601206956, 82811.5859420699, 7979.9202007979175, 8083.797905052185, 8208.0, 8275.875861862198, 8533.31733461334, 11772.529098836294, 12137.514499419924, 12192.451339689558, 12461.87538124607, 12578.496860125493, 8988.011318755063, 9548.474833883925, 11026.0, 11107.72230694239, 11184.105271578092, 10582.941705829355, 10765.407902565434, 10956.233063685466, 11147.219694621299, 11413.657590272305, 10890.455477226265, 11141.331520108819, 11184.832227516756, 11672.124590655905, 11988.340641264815, 7100.396466300423, 7105.857882842418, 7303.233160518069, 7406.185319614946, 8567.186117318844, 7553.395728341609, 7866.8819967701675, 7997.480163789335, 8191.590420479071, 9105.630916560915], "value": 11221.645586371229, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.2235742090877, 1347.8315210598676, 1460.8612181842727, 1479.1420975834017, 1486.7026594681067, 7485.850282994344, 7838.960805195973, 8124.8781268280945, 8356.791080222998, 8368.414211005233, 7633.160352361236, 7700.653470593823, 8323.33413326934, 8324.875126873087, 8331.458455200407, 2068.5552606189667, 2309.1340747219833, 2343.355577216271, 2346.507233480971, 2353.670486131943, 2135.0712440088532, 2157.7087093242367, 2158.622241107808, 2159.082389984258, 2281.646344816556, 2314.085936055257, 2333.4982978659586, 2335.1359996801207, 2335.4978679583887, 2345.061975209913, 2270.9886450567806, 2284.7829456201634, 2295.988520057397, 2304.4584522637165, 2305.7578954209735, 2013.617412691584, 2323.581755284048, 2348.412896775806, 2348.8473249238746, 2354.646802979567, 8315.459495132796, 8350.498970061815, 8425.662973481054, 8431.789205269855, 8434.57827108642, 5060.0, 5215.947840521584, 5220.765065572058, 5222.92165617516, 5230.973845130788, 3453.2748122893972, 3484.4250698634696, 3490.4415293553166, 3539.43369060949, 3553.733469989735, 1206.6802297391198, 1218.4212499062962, 1245.7944439167527, 1253.1228140301826, 1253.266838899245, 9178.311626627963, 10929.726756831064, 10956.959088886622, 10965.780684386267, 10984.505697243643, 4411.580899814512, 4646.210144275481, 4678.929816052762, 4713.0, 4718.457377401574, 9500.0, 9515.334816407101, 9520.047995200563, 9542.141207291239, 9548.092931171528, 5230.215467679803, 5230.947690523122, 5233.900880814996, 5258.2375555544995, 5282.102042652758, 4520.0507893342765, 4687.81248750053, 4775.0, 4782.33047373368, 4805.495422980606, 3600.4959305697225, 3642.817859107034, 3751.531058617673, 3851.441540976543, 3873.186630807562, 1278.7058976435471, 1286.3696788573718, 1302.2577131035218, 1303.69363199648, 1304.706441050756, 877.2017464107631, 904.1681652879366, 918.1323649151487, 928.4267386900726, 935.4387367579534, 5623.212750214973, 5674.120511320752, 5825.155352473952, 5829.44620261083, 5973.790917317873, 812.5043723328765, 1020.8417695257247, 1026.8459731040405, 1027.845823126522, 1029.7065336379246, 3460.8615655374006, 3723.9255214896093, 3816.3702989007056, 3856.0, 3856.8842934712, 9790.755231119136, 10119.494025298705, 10133.64532241368, 10151.644692435877, 10173.54219060144, 9499.335046546814, 10051.447170405698, 10083.092521672937, 10106.14097801695, 10120.797584048278, 7647.388208943271, 7875.56684382353, 7897.052353717706, 7934.008248968879, 7943.801404964806, 5604.775808967595, 5614.157876318585, 5623.8189980104635, 5816.272965879265, 5855.765769369177, 9113.498757568132, 9359.532023398939, 9384.81230375375, 9404.153626173404, 9405.623775049195, 9116.0, 9299.256059515088, 9533.285003624616, 9560.426374417557, 9564.0, 6050.364711705208, 7218.675159617725, 7271.963640181765, 7287.1984081752025, 7342.926570734225, 7228.566286022856, 7481.625918703934, 7813.726519571787, 7913.287804097658, 7920.84158316842, 6695.263521012587, 7062.788116356517, 7079.858402832017, 7173.820654483679, 7208.171060328129, 6910.032595436543, 6986.126734158231, 7007.159140903124, 7029.859402811813, 7058.129595657258, 6286.491242101954, 6392.648404337806, 6398.840028999312, 6401.391867772554, 6406.615603063831, 4845.685030473008, 4889.731064791471, 4981.925271121008, 5033.47148549397, 5179.92230116541, 4867.488913664014, 4910.631702622389, 5006.6495345325475, 5139.1263485206855, 5187.662801917863], "value": 4434.487730284875, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.9110867837379, 367.15554225281846, 372.2406291166021, 381.84344418788305, 386.1832224844453, 4764.4277388461815, 5329.840104796857, 5337.786488540459, 5402.486763757446, 5411.540019098381, 4542.159700455418, 4882.804687812492, 5104.566111880495, 5109.514596113372, 5337.839864804052, 3740.3641380965164, 3948.8617898373564, 4017.63400443849, 4098.790856697274, 4116.814743336542, 3332.8500217490273, 4130.731502452346, 4187.602177793105, 4199.1733595885735, 4211.768352740598, 3066.4940284852973, 4055.1889622075555, 4119.196756632457, 4172.18642364739, 4222.0922501662135, 3449.6032956209856, 4161.146964872224, 4194.818694278988, 4225.0, 4247.532771395159, 2863.7565806906437, 3362.529245905575, 3442.9843196256916, 3640.981795091034, 3667.889963301105, 4277.807498662536, 5150.690958542499, 5167.268964896726, 5169.198774190007, 5192.273081768555, 4139.778765264255, 4264.125854199912, 4473.463184417858, 4620.745858977755, 4703.858884233478, 4655.0, 4826.155422801031, 5404.973294895328, 5606.495415412592, 5643.294588176478, 3326.7005969462866, 3872.5740168581433, 3901.2197560488016, 3925.509311336083, 3926.8429262829736, 5129.948020791676, 5492.945070549284, 5783.797567085132, 5865.0, 5982.312034116088, 3262.9021129366156, 3506.9123271917897, 3835.9424608630893, 3841.5966323536186, 3858.344081506151, 3706.8517259309324, 3885.746267165094, 3919.8040097994985, 3926.2147570486018, 3934.842606295716, 4148.419221309019, 4301.78491075445, 4527.619076181731, 4541.886452838639, 4550.224363138483, 5413.269208656781, 5589.385167631557, 5617.550595952314, 5619.8595035123635, 5635.408282130399, 1135.7387800805861, 1150.355800751565, 1210.0501106631252, 1214.7548762518313, 1275.2730943362194, 781.8428725486312, 809.5142914251402, 835.1439774231461, 839.215333663027, 852.3138873207128, 4349.651188358251, 4776.641751868624, 4963.0, 5027.296178535008, 5033.734819331243, 4762.309465127537, 4911.803527858846, 5160.587153027749, 5530.073647710091, 5562.86092847674, 4662.836800712027, 4775.856724298276, 4927.630427717864, 5152.819651312261, 5247.5569218465225, 2309.2148669452467, 2614.1700809433473, 2849.3873817129, 2857.5427931530853, 2873.6120623715947, 4978.850634480971, 5359.356877174764, 5519.840833424945, 5631.605787594829, 5690.459406356389, 4978.452370239271, 5311.105447531105, 5479.274028680953, 5614.691191984399, 5764.971175144097, 4860.420363381844, 5323.893522129536, 5446.428125046892, 5742.880138373061, 5756.971215143982, 4679.461861885927, 4744.715317080986, 5397.406285308692, 5441.347038355423, 5500.4499550044675, 5321.0, 5334.599905007062, 5605.747741351731, 5650.23721797552, 5657.5473962082115, 5209.76556054986, 5895.322037965689, 5918.23063001807, 5960.523158147251, 5962.940370596412, 3758.4174452959833, 3800.2399520096646, 3819.809009549567, 3850.9037274068373, 3865.439511270906, 4303.483581970184, 4309.935350969675, 5657.038303488499, 5662.754194077296, 5810.954028274951, 5440.918386224289, 5617.32592088952, 5623.775048997994, 5636.041872881702, 5646.3788983212635, 4888.657793954531, 5013.598912087097, 5090.440051594395, 5170.689758614495, 5586.184490040834, 4373.912521749611, 4518.570735780096, 5179.611529135254, 5488.0, 5498.230247765396, 4647.697899636512, 4853.320535125156, 4985.725785081855, 5444.992676354887, 5449.400565937823, 5306.575473961997, 5421.783128674967, 5423.864403389947, 5473.890522189614, 5479.561635069264], "value": 4006.5544932751905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.764963138823, 674.3425160468544, 686.9381755641992, 713.5005496152694, 730.9269073092688, 15083.396664133435, 15575.387971639648, 15638.296276667563, 16092.919535402336, 16099.436519721812, 14777.335019924103, 14943.701125977474, 14951.327190276437, 14960.850391496082, 14962.476313329036, 704.7639040921298, 885.7874110213551, 919.2278486071698, 922.7001224601997, 924.1636319131197, 713.3365969648225, 862.8446879561676, 891.5943245823167, 897.4794619120927, 911.0024523147176, 952.7665721898145, 954.2175416158752, 954.2318433660901, 954.5227386306847, 955.0974329258853, 944.5466176235377, 945.5366870233605, 945.6595625574788, 947.5499137909507, 949.7198326493701, 549.2639862584117, 565.2651552981108, 688.3770187979886, 702.6873041496536, 712.8681193979079, 15487.225638718019, 15537.533873983799, 15538.456154034555, 15560.299786509635, 15563.92218038914, 13783.448662053506, 13786.553361659586, 13815.378307976165, 13867.23730194839, 13893.305334733222, 10492.0, 12206.329429354597, 12372.1958072725, 12524.74950500985, 12937.676558086028, 4376.846810361654, 4386.978065109654, 4437.822487100512, 4442.622377097919, 4618.930716039262, 106759.93240067655, 107829.46085269602, 111011.88988110177, 111701.0, 112091.30721698969, 10752.569897204181, 10767.6231331903, 10964.890351096386, 11006.944965275123, 11019.72450688723, 22005.559888802134, 22016.44958876009, 22022.33932982013, 22045.0, 22056.88971555132, 7567.356774674105, 7786.727464538714, 7789.766307010798, 7828.138904720477, 7872.763817085496, 3982.9402558961638, 4141.316682747313, 4149.33610622299, 4156.189543039139, 4178.519470260898, 3329.417351963397, 3351.2794749128566, 3432.3821712091562, 3446.0, 3448.293094918032, 637.2162240444279, 642.331974746268, 644.690548536705, 647.527305067294, 657.8355411147213, 553.4990833295874, 622.3341025103097, 631.9810405687837, 633.6356594957917, 653.3074940563018, 8507.106753790762, 8792.8681069784, 9357.111074448052, 9542.475163866055, 9640.662576809778, 607.7325976570295, 613.3958051319447, 639.4532674563275, 644.9355064493607, 666.9199696036507, 4329.956700433018, 4612.192866248393, 4644.140833945731, 4671.579557839811, 4736.100140973273, 100224.49663255057, 102180.85664728923, 102268.48865755773, 102290.0, 106210.46894765476, 89412.0, 90321.0, 91285.54357228172, 91903.5404822985, 93695.0, 78319.21680783233, 79855.0, 80004.0, 80316.19683803321, 80801.59599201966, 8541.273991710774, 8924.32411004512, 9026.45841249527, 9145.908540914772, 9280.535973201178, 47685.569432917066, 48044.9999999986, 49047.75476122739, 49081.75459122682, 49998.50001500084, 62431.6878415605, 65363.346366537626, 66304.6684766573, 67490.3250967484, 68862.0, 11009.037788073396, 11161.609343672932, 11211.327320360804, 11243.887561124284, 11771.52913883435, 11956.461959211681, 12005.63983080509, 12026.098042647012, 12033.759324813629, 12557.497700091893, 11568.190226684052, 11576.594819181288, 11584.0, 11778.705532361759, 12122.151449398458, 11441.019366775234, 11520.884791152317, 11536.019438347499, 11550.942245289056, 11567.710807229887, 10991.890081099087, 11010.889891100986, 11016.449177541252, 11042.944785276022, 11075.889241107809, 7378.557286562824, 9120.407173533698, 9465.290103242147, 9650.0, 9757.853632195382, 8622.655093796178, 9249.630014799333, 9610.711678649652, 9735.561899714388, 9758.219342452729], "value": 7250.977853504138, "unit": "score"}], "name": "dromaeo_css", "value": 7396.7525810007755, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 113.0, 114.0, 112.0, 113.0, 113.0, 113.0, 119.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 131.0, 137.0, 178.0, 143.0, 111.0, 106.0, 112.0, 131.0, 111.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 185.0, 187.0, 184.0, 182.0, 215.0, 190.0, 185.0, 183.0], "value": 187.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 86.0, 63.0, 60.0, 58.0, 58.0, 74.0, 59.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 73.0, 86.0, 70.0, 68.0, 72.0, 115.0, 81.0, 70.0, 84.0], "value": 80.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 85.0, 87.0, 85.0, 89.0, 84.0, 87.0, 84.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 94.0, 93.0, 94.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 138.0, 92.0, 87.0, 88.0, 87.0, 87.0, 87.0, 87.0, 88.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 55.0, 57.0, 57.0, 54.0, 55.0, 58.0, 57.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 80.0, 76.0, 87.0, 101.0, 103.0, 87.0, 70.0, 72.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 85.0, 87.0, 86.0, 86.0, 85.0, 85.0, 87.0, 88.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 141.0, 141.0, 139.0, 138.0, 158.0, 150.0, 203.0, 140.0], "value": 149.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 172.0, 174.0, 173.0, 230.0, 173.0, 175.0, 174.0, 174.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 68.0, 69.0, 76.0, 83.0, 85.0, 85.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1480.3000000000002, "alertThreshold": 2.0}]} 04:45:59 INFO - Return code: 0 04:45:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:45:59 ERROR - # TBPL SUCCESS # 04:45:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:45:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:45:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:45:59 INFO - 2017-01-15 04:45:59.870 screenresolution[1693:12120] starting screenresolution argv=screenresolution get 04:45:59 INFO - 2017-01-15 04:45:59.873 screenresolution[1693:12120] Display 0: 1600x1200x32@60 04:45:59 INFO - 2017-01-15 04:45:59.879 screenresolution[1694:12122] starting screenresolution argv=screenresolution list 04:45:59 INFO - Available Modes on Display 0 04:45:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:45:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:45:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:45:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:46:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:46:00 INFO - Intel Iris: 04:46:00 INFO - Chipset Model: Intel Iris 04:46:00 INFO - Type: GPU 04:46:00 INFO - Bus: Built-In 04:46:00 INFO - VRAM (Dynamic, Max): 1536 MB 04:46:00 INFO - Vendor: Intel (0x8086) 04:46:00 INFO - Device ID: 0x0a2e 04:46:00 INFO - Revision ID: 0x0009 04:46:00 INFO - Displays: 04:46:00 INFO - Display: 04:46:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:46:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:46:00 INFO - Display Serial Number: 1600x1200 60 04:46:00 INFO - Main Display: Yes 04:46:00 INFO - Mirror: Off 04:46:00 INFO - Online: Yes 04:46:00 INFO - Rotation: Supported 04:46:00 INFO - Return code: 0 04:46:00 INFO - Running post-action listener: _resource_record_post_action 04:46:00 INFO - [mozharness: 2017-01-15 12:46:00.119328Z] Finished run-tests step (success) 04:46:00 INFO - Running post-run listener: _resource_record_post_run 04:46:00 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 32455680; Write bytes: 555660288; Read time: 351; Write time: 1668 04:46:00 INFO - TinderboxPrint: CPU usage
53.7% 04:46:00 INFO - TinderboxPrint: I/O read bytes / time
32,455,680 / 351 04:46:00 INFO - TinderboxPrint: I/O write bytes / time
555,660,288 / 1,668 04:46:00 INFO - TinderboxPrint: CPU idle
2,223.9 (46.3%) 04:46:00 INFO - TinderboxPrint: CPU system
961.4 (20.0%) 04:46:00 INFO - TinderboxPrint: CPU user
1,620.4 (33.7%) 04:46:00 INFO - TinderboxPrint: Swap in / out
279,519,232 / 0 04:46:00 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 241394176; Write bytes: 233721856; Read time: 17380; Write time: 489 04:46:00 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30551040; Write bytes: 300674048; Read time: 333; Write time: 1124 04:46:00 INFO - Running post-run listener: _upload_blobber_files 04:46:00 INFO - Blob upload gear active. 04:46:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:46:00 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 04:46:00 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:46:00 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:46:00 INFO - (blobuploader) - INFO - Open directory for files ... 04:46:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:46:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:46:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:02 INFO - (blobuploader) - INFO - Done attempting. 04:46:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:46:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:46:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:03 INFO - (blobuploader) - INFO - Done attempting. 04:46:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:46:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:46:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:04 INFO - (blobuploader) - INFO - Done attempting. 04:46:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:46:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:46:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:06 INFO - (blobuploader) - INFO - Done attempting. 04:46:06 INFO - (blobuploader) - INFO - Iteration through files over. 04:46:06 INFO - Return code: 0 04:46:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:46:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:46:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/081ef221ff18a3430d9a657290722437fa633b9bff0669b072113494f018c19c1a917b3e8a5e849421e24ce85097c4442cd9518418d077a608db9afc230fd6b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/189a9066791a1529168528e99b491686c86e3a1d0a4894d0bba8afb4093034fe178792de2196218d3de11a8d86a12a21882f305384a367d7134b9c2c34e72526", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae7519034ae92cc81edec4eb6b2a4894b1a2d2a637e15e400ec809e6f187d5dfd32b2ee689d2c4a810772d5008056601dff67c7adb58c13c5f61796f533848b1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aaf168c7c978b36909ec26b05f73d9602e7753c6461795e57521db5e1223f198613fc8a5b29b33210a3a236c0f5197359bd2ef1129768ecd3af6fef71119b49e"} 04:46:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:46:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:46:06 INFO - Contents: 04:46:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/081ef221ff18a3430d9a657290722437fa633b9bff0669b072113494f018c19c1a917b3e8a5e849421e24ce85097c4442cd9518418d077a608db9afc230fd6b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/189a9066791a1529168528e99b491686c86e3a1d0a4894d0bba8afb4093034fe178792de2196218d3de11a8d86a12a21882f305384a367d7134b9c2c34e72526", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae7519034ae92cc81edec4eb6b2a4894b1a2d2a637e15e400ec809e6f187d5dfd32b2ee689d2c4a810772d5008056601dff67c7adb58c13c5f61796f533848b1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aaf168c7c978b36909ec26b05f73d9602e7753c6461795e57521db5e1223f198613fc8a5b29b33210a3a236c0f5197359bd2ef1129768ecd3af6fef71119b49e"} 04:46:06 INFO - Running post-run listener: copy_logs_to_upload_dir 04:46:06 INFO - Copying logs to upload dir... 04:46:06 INFO - mkdir: /builds/slave/test/build/upload/logs 04:46:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.802515 ========= master_lag: 0.81 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-15 04:46:07.184909) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-15 04:46:07.188840) ========= 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.PoVlNLgbIH/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.EWNTPrxrfM/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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/Firefox/sha512/081ef221ff18a3430d9a657290722437fa633b9bff0669b072113494f018c19c1a917b3e8a5e849421e24ce85097c4442cd9518418d077a608db9afc230fd6b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/189a9066791a1529168528e99b491686c86e3a1d0a4894d0bba8afb4093034fe178792de2196218d3de11a8d86a12a21882f305384a367d7134b9c2c34e72526", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae7519034ae92cc81edec4eb6b2a4894b1a2d2a637e15e400ec809e6f187d5dfd32b2ee689d2c4a810772d5008056601dff67c7adb58c13c5f61796f533848b1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aaf168c7c978b36909ec26b05f73d9602e7753c6461795e57521db5e1223f198613fc8a5b29b33210a3a236c0f5197359bd2ef1129768ecd3af6fef71119b49e"} build_url:https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/IyJWPtNKTZ-8r6FAqikyLA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/081ef221ff18a3430d9a657290722437fa633b9bff0669b072113494f018c19c1a917b3e8a5e849421e24ce85097c4442cd9518418d077a608db9afc230fd6b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/189a9066791a1529168528e99b491686c86e3a1d0a4894d0bba8afb4093034fe178792de2196218d3de11a8d86a12a21882f305384a367d7134b9c2c34e72526", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae7519034ae92cc81edec4eb6b2a4894b1a2d2a637e15e400ec809e6f187d5dfd32b2ee689d2c4a810772d5008056601dff67c7adb58c13c5f61796f533848b1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aaf168c7c978b36909ec26b05f73d9602e7753c6461795e57521db5e1223f198613fc8a5b29b33210a3a236c0f5197359bd2ef1129768ecd3af6fef71119b49e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-15 04:46:07.223660) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 04:46:07.223968) ========= 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.PoVlNLgbIH/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.EWNTPrxrfM/Listeners TMPDIR=/var/folders/z3/6pjmk_m51bs66d77l9w689q000000w/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.005205 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-15 04:46:07.275468) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-15 04:46:07.276056) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-15 04:46:07.276954) ========= ========= Total master_lag: 1.11 =========