builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0184 starttime: 1491998110.8 results: success (0) buildid: 20170412030252 builduid: c004e0543c5c42da8c77b56fef099d92 revision: f40e24f40b4c4556944c762d4764eace261297f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 04:55:10.802304) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 04:55:10.802775) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 04:55:10.803094) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 04:55:10.830314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 04:55:10.830725) ========= 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.pjQxT87tPk/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.IAqGPqNrHL/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-12 04:55:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 232M=0s 2017-04-12 04:55:10 (232 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103685 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 04:55:10.958819) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 04:55:10.959134) ========= 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.pjQxT87tPk/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.IAqGPqNrHL/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.028523 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 04:55:11.008929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-12 04:55:11.009277) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f40e24f40b4c4556944c762d4764eace261297f5 --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 f40e24f40b4c4556944c762d4764eace261297f5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pjQxT87tPk/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.IAqGPqNrHL/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-12 04:55:11,112 truncating revision to first 12 chars 2017-04-12 04:55:11,112 Setting DEBUG logging. 2017-04-12 04:55:11,112 attempt 1/10 2017-04-12 04:55:11,112 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f40e24f40b4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-12 04:55:12,318 unpacking tar archive at: mozilla-central-f40e24f40b4c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.482259 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-12 04:55:12.515607) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 04:55:12.515962) ========= script_repo_revision: f40e24f40b4c4556944c762d4764eace261297f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 04:55:12.516403) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 04:55:12.516693) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 04:55:12.537375) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-12 04:55:12.537804) ========= /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.pjQxT87tPk/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.IAqGPqNrHL/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:55:12 INFO - MultiFileLogger online at 20170412 04:55:12 in /builds/slave/test 04:55:12 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:55:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:55:12 INFO - {'append_to_log': False, 04:55:12 INFO - 'base_work_dir': '/builds/slave/test', 04:55:12 INFO - 'blob_upload_branch': 'Firefox', 04:55:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:55:12 INFO - 'branch': 'Firefox', 04:55:12 INFO - 'buildbot_json_path': 'buildprops.json', 04:55:12 INFO - 'config_files': ('talos/mac_config.py',), 04:55:12 INFO - 'default_actions': ('clobber', 04:55:12 INFO - 'read-buildbot-config', 04:55:12 INFO - 'download-and-extract', 04:55:12 INFO - 'populate-webroot', 04:55:12 INFO - 'create-virtualenv', 04:55:12 INFO - 'install', 04:55:12 INFO - 'run-tests'), 04:55:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:55:12 INFO - 'download_minidump_stackwalk': True, 04:55:12 INFO - 'download_symbols': 'ondemand', 04:55:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:55:12 INFO - 'tooltool.py': '/tools/tooltool.py', 04:55:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:55:12 INFO - '/tools/misc-python/virtualenv.py')}, 04:55:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:55:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:55:12 INFO - 'gecko_profile': False, 04:55:12 INFO - 'gecko_profile_interval': 0, 04:55:12 INFO - 'installer_path': 'installer.exe', 04:55:12 INFO - 'log_level': 'info', 04:55:12 INFO - 'log_name': 'talos', 04:55:12 INFO - 'log_to_console': True, 04:55:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:55:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:55:12 INFO - 'opt_config_files': (), 04:55:12 INFO - 'pip_index': False, 04:55:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:55:12 INFO - 'cmd': ('bash', 04:55:12 INFO - '-c', 04:55:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:55:12 INFO - 'enabled': True, 04:55:12 INFO - 'halt_on_failure': False, 04:55:12 INFO - 'name': 'check_screen_resolution'},), 04:55:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:55:12 INFO - 'cmd': ('bash', 04:55:12 INFO - '-c', 04:55:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:55:12 INFO - 'enabled': True, 04:55:12 INFO - 'halt_on_failure': False, 04:55:12 INFO - 'name': 'check_screen_resolution'},), 04:55:12 INFO - 'run_cmd_checks_enabled': True, 04:55:12 INFO - 'suite': 'dromaeojs', 04:55:12 INFO - 'system_bits': '32', 04:55:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:55:12 INFO - 'title': 't-yosemite-r7-0184', 04:55:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:55:12 INFO - 'use_talos_json': True, 04:55:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:55:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:55:12 INFO - 'work_dir': 'build'} 04:55:12 INFO - [mozharness: 2017-04-12 11:55:12.756203Z] Running clobber step. 04:55:12 INFO - Running pre-action listener: _resource_record_pre_action 04:55:12 INFO - Running main action method: clobber 04:55:12 INFO - rmtree: /builds/slave/test/build 04:55:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:55:15 INFO - Running post-action listener: _resource_record_post_action 04:55:15 INFO - [mozharness: 2017-04-12 11:55:15.312121Z] Finished clobber step (success) 04:55:15 INFO - [mozharness: 2017-04-12 11:55:15.312384Z] Running read-buildbot-config step. 04:55:15 INFO - Running pre-action listener: _resource_record_pre_action 04:55:15 INFO - Running main action method: read_buildbot_config 04:55:15 INFO - Using buildbot properties: 04:55:15 INFO - { 04:55:15 INFO - "project": "", 04:55:15 INFO - "product": "firefox", 04:55:15 INFO - "script_repo_revision": "production", 04:55:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:55:15 INFO - "repository": "", 04:55:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:55:15 INFO - "buildid": "20170412030252", 04:55:15 INFO - "stage_platform": "macosx64", 04:55:15 INFO - "basedir": "/builds/slave/test", 04:55:15 INFO - "nightly_build": "True", 04:55:15 INFO - "buildnumber": 4, 04:55:15 INFO - "slavename": "t-yosemite-r7-0184", 04:55:15 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:55:15 INFO - "platform": "yosemite_r7", 04:55:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:55:15 INFO - "branch": "mozilla-central", 04:55:15 INFO - "repo_path": "mozilla-central", 04:55:15 INFO - "revision": "f40e24f40b4c4556944c762d4764eace261297f5", 04:55:15 INFO - "pgo_build": "False", 04:55:15 INFO - "builduid": "c004e0543c5c42da8c77b56fef099d92", 04:55:15 INFO - "slavebuilddir": "test" 04:55:15 INFO - } 04:55:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:55:15 INFO - Running post-action listener: _resource_record_post_action 04:55:15 INFO - [mozharness: 2017-04-12 11:55:15.318265Z] Finished read-buildbot-config step (success) 04:55:15 INFO - [mozharness: 2017-04-12 11:55:15.318495Z] Running download-and-extract step. 04:55:15 INFO - Running pre-action listener: _resource_record_pre_action 04:55:15 INFO - Running main action method: download_and_extract 04:55:15 INFO - mkdir: /builds/slave/test/build/tests 04:55:15 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:55:15 INFO - trying https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:55:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:55:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:55:16 INFO - Downloaded 1325 bytes. 04:55:16 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:55:16 INFO - Using the following test package requirements: 04:55:16 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:55:16 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:55:16 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:55:16 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:55:16 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:55:16 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:55:16 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:55:16 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:55:16 INFO - u'jsshell-mac.zip'], 04:55:16 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:55:16 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:55:16 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:55:16 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:55:16 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:55:16 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:55:16 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:55:16 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:55:16 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:55:16 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:55:16 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:55:16 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:55:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:55:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:55:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:55:18 INFO - Expected file size: 52596298 04:55:18 INFO - Obtained file size: 52596298 04:55:34 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:55:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:55:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:55:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:55:36 INFO - Expected file size: 52596298 04:55:36 INFO - Obtained file size: 52596298 04:55:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:55:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:55:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:55:52 INFO - Expected file size: 14405596 04:55:52 INFO - Obtained file size: 14405596 04:55:53 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:55:53 INFO - trying https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:55:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:55:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:55:55 INFO - Downloaded 71039858 bytes. 04:55:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:55:55 INFO - mkdir: /builds/slave/test/properties 04:55:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:55:55 INFO - Writing to file /builds/slave/test/properties/build_url 04:55:55 INFO - Contents: 04:55:55 INFO - build_url:https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:55:55 INFO - Running post-action listener: _resource_record_post_action 04:55:55 INFO - Running post-action listener: set_extra_try_arguments 04:55:55 INFO - [mozharness: 2017-04-12 11:55:55.913438Z] Finished download-and-extract step (success) 04:55:55 INFO - [mozharness: 2017-04-12 11:55:55.913591Z] Running populate-webroot step. 04:55:55 INFO - Running pre-action listener: _resource_record_pre_action 04:55:55 INFO - Running main action method: populate_webroot 04:55:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:55:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:55:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:55:55 INFO - '--tppagecycles', 04:55:55 INFO - '7'], 04:55:55 INFO - 'tests': ['tsvgm']}}, 04:55:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:55:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:55:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:55:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:55:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:55:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:55:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:55:55 INFO - 'talos_options': ['--disable-e10s'], 04:55:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:55:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:55:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:55:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:55:55 INFO - 'talos_options': ['--disable-e10s'], 04:55:55 INFO - 'tests': ['damp', 'tps']}, 04:55:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:55:55 INFO - 'tests': ['damp', 'tps']}, 04:55:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:55:55 INFO - 'tests': ['dromaeo_dom']}, 04:55:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:55:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:55:55 INFO - 'tests': ['basic_compositor_video']}, 04:55:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:55:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:55:55 INFO - 'tests': ['a11yr', 04:55:55 INFO - 'ts_paint', 04:55:55 INFO - 'tpaint', 04:55:55 INFO - 'sessionrestore', 04:55:55 INFO - 'sessionrestore_no_auto_restore', 04:55:55 INFO - 'tabpaint']}, 04:55:55 INFO - 'other-e10s': {'tests': ['a11yr', 04:55:55 INFO - 'ts_paint', 04:55:55 INFO - 'tpaint', 04:55:55 INFO - 'sessionrestore', 04:55:55 INFO - 'sessionrestore_no_auto_restore', 04:55:55 INFO - 'tabpaint']}, 04:55:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:55:55 INFO - 'ts_paint', 04:55:55 INFO - 'tpaint', 04:55:55 INFO - 'sessionrestore', 04:55:55 INFO - 'sessionrestore_no_auto_restore', 04:55:55 INFO - 'tabpaint']}, 04:55:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:55:55 INFO - 'ts_paint', 04:55:55 INFO - 'tpaint', 04:55:55 INFO - 'sessionrestore', 04:55:55 INFO - 'sessionrestore_no_auto_restore', 04:55:55 INFO - 'tabpaint']}, 04:55:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:55:55 INFO - 'tests': ['a11yr', 04:55:55 INFO - 'ts_paint', 04:55:55 INFO - 'tpaint', 04:55:55 INFO - 'sessionrestore', 04:55:55 INFO - 'sessionrestore_no_auto_restore', 04:55:55 INFO - 'tabpaint']}, 04:55:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:55:55 INFO - 'tests': ['a11yr', 04:55:55 INFO - 'ts_paint', 04:55:55 INFO - 'tpaint', 04:55:55 INFO - 'sessionrestore', 04:55:55 INFO - 'sessionrestore_no_auto_restore', 04:55:55 INFO - 'tabpaint']}, 04:55:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:55:55 INFO - 'tests': ['tsvgx', 04:55:55 INFO - 'tsvgr_opacity', 04:55:55 INFO - 'tart', 04:55:55 INFO - 'tscrollx', 04:55:55 INFO - 'cart', 04:55:55 INFO - 'tsvg_static']}, 04:55:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:55:55 INFO - 'tsvgr_opacity', 04:55:55 INFO - 'tart', 04:55:55 INFO - 'tscrollx', 04:55:55 INFO - 'cart', 04:55:55 INFO - 'tsvg_static']}, 04:55:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:55:55 INFO - 'talos_options': ['--disable-e10s'], 04:55:55 INFO - 'tests': ['tp5o']}, 04:55:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:55:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:55:55 INFO - 'talos_options': ['--disable-e10s', 04:55:55 INFO - '--xperf_path', 04:55:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:55:55 INFO - 'tests': ['tp5n']}, 04:55:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:55:55 INFO - 'talos_options': ['--xperf_path', 04:55:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:55:55 INFO - 'tests': ['tp5n']}}, 04:55:55 INFO - 'talos.zip': {'path': '', 04:55:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:55:55 INFO - Running post-action listener: _resource_record_post_action 04:55:55 INFO - [mozharness: 2017-04-12 11:55:55.932343Z] Finished populate-webroot step (success) 04:55:55 INFO - [mozharness: 2017-04-12 11:55:55.932474Z] Running create-virtualenv step. 04:55:55 INFO - Running pre-action listener: _resource_record_pre_action 04:55:55 INFO - Running main action method: create_virtualenv 04:55:55 INFO - Creating virtualenv /builds/slave/test/build/venv 04:55:55 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:55:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:55:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:55:56 INFO - Using real prefix '/tools/python27' 04:55:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:55:56 INFO - Installing distribute.............................................................................................................................................................................................done. 04:55:59 INFO - Installing pip.................done. 04:55:59 INFO - Return code: 0 04:55:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:55:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:55:59 INFO - Reading from file tmpfile_stdout 04:55:59 INFO - Output received: 04:55:59 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:55:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:55:59 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:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:59 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:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:59 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 0x10951cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10951f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360d74e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092fad30>, '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 0x109221db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092efbe8>, '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.pjQxT87tPk/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.IAqGPqNrHL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:55:59 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:55:59 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:55:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjQxT87tPk/Render', 04:55:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:59 INFO - 'HOME': '/Users/cltbld', 04:55:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:59 INFO - 'LOGNAME': 'cltbld', 04:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:59 INFO - 'MOZ_NO_REMOTE': '1', 04:55:59 INFO - 'NO_EM_RESTART': '1', 04:55:59 INFO - 'PAGER': '/bin/cat', 04:55:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:59 INFO - 'PWD': '/builds/slave/test', 04:55:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:59 INFO - 'SHELL': '/bin/bash', 04:55:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAqGPqNrHL/Listeners', 04:55:59 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 04:55:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:59 INFO - 'USER': 'cltbld', 04:55:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:59 INFO - 'XPC_FLAGS': '0x0', 04:55:59 INFO - 'XPC_SERVICE_NAME': '0', 04:55:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:00 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:56:00 INFO - Cleaning up... 04:56:00 INFO - Return code: 0 04:56:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:56:00 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:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:00 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:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:00 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 0x10951cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10951f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360d74e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092fad30>, '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 0x109221db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092efbe8>, '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.pjQxT87tPk/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.IAqGPqNrHL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:56:00 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:56:00 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:56:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjQxT87tPk/Render', 04:56:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:00 INFO - 'HOME': '/Users/cltbld', 04:56:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:00 INFO - 'LOGNAME': 'cltbld', 04:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:00 INFO - 'MOZ_NO_REMOTE': '1', 04:56:00 INFO - 'NO_EM_RESTART': '1', 04:56:00 INFO - 'PAGER': '/bin/cat', 04:56:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:00 INFO - 'PWD': '/builds/slave/test', 04:56:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:00 INFO - 'SHELL': '/bin/bash', 04:56:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAqGPqNrHL/Listeners', 04:56:00 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 04:56:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:00 INFO - 'USER': 'cltbld', 04:56:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:00 INFO - 'XPC_FLAGS': '0x0', 04:56:00 INFO - 'XPC_SERVICE_NAME': '0', 04:56:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:00 INFO - Downloading/unpacking psutil>=3.1.1 04:56:00 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:56:00 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:56:00 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:56:00 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:56:00 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:56:00 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:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:56:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:04 INFO - Installing collected packages: psutil 04:56:04 INFO - Running setup.py install for psutil 04:56:04 INFO - building 'psutil._psutil_osx' extension 04:56:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:56:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:56:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:56:04 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:56:04 INFO - building 'psutil._psutil_posix' extension 04:56:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:56:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:56:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:56:05 INFO - ^ 04:56:05 INFO - 1 warning generated. 04:56:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:56:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:05 INFO - Successfully installed psutil 04:56:05 INFO - Cleaning up... 04:56:05 INFO - Return code: 0 04:56:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:05 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 0x10951cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10951f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360d74e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092fad30>, '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 0x109221db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092efbe8>, '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.pjQxT87tPk/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.IAqGPqNrHL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:56:05 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:56:05 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:56:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjQxT87tPk/Render', 04:56:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:05 INFO - 'HOME': '/Users/cltbld', 04:56:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:05 INFO - 'LOGNAME': 'cltbld', 04:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:05 INFO - 'MOZ_NO_REMOTE': '1', 04:56:05 INFO - 'NO_EM_RESTART': '1', 04:56:05 INFO - 'PAGER': '/bin/cat', 04:56:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:05 INFO - 'PWD': '/builds/slave/test', 04:56:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:05 INFO - 'SHELL': '/bin/bash', 04:56:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAqGPqNrHL/Listeners', 04:56:05 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 04:56:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:05 INFO - 'USER': 'cltbld', 04:56:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:05 INFO - 'XPC_FLAGS': '0x0', 04:56:05 INFO - 'XPC_SERVICE_NAME': '0', 04:56:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:56:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:56:08 INFO - Installing collected packages: mozsystemmonitor 04:56:08 INFO - Running setup.py install for mozsystemmonitor 04:56:08 INFO - Successfully installed mozsystemmonitor 04:56:08 INFO - Cleaning up... 04:56:08 INFO - Return code: 0 04:56:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:09 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 0x10951cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10951f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360d74e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092fad30>, '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 0x109221db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092efbe8>, '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.pjQxT87tPk/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.IAqGPqNrHL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:56:09 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:56:09 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:56:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjQxT87tPk/Render', 04:56:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:09 INFO - 'HOME': '/Users/cltbld', 04:56:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:09 INFO - 'LOGNAME': 'cltbld', 04:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:09 INFO - 'MOZ_NO_REMOTE': '1', 04:56:09 INFO - 'NO_EM_RESTART': '1', 04:56:09 INFO - 'PAGER': '/bin/cat', 04:56:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:09 INFO - 'PWD': '/builds/slave/test', 04:56:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:09 INFO - 'SHELL': '/bin/bash', 04:56:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAqGPqNrHL/Listeners', 04:56:09 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 04:56:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:09 INFO - 'USER': 'cltbld', 04:56:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:09 INFO - 'XPC_FLAGS': '0x0', 04:56:09 INFO - 'XPC_SERVICE_NAME': '0', 04:56:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:09 INFO - Downloading/unpacking jsonschema==2.5.1 04:56:09 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:56:09 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:56:09 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:56:09 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:56:09 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:56:09 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:56:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:56:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:12 INFO - Downloading functools32-3.2.3-2.tar.gz 04:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:56:13 INFO - warning: no files found matching '*.txt' 04:56:13 INFO - no previously-included directories found matching 'build' 04:56:13 INFO - no previously-included directories found matching 'dist' 04:56:13 INFO - no previously-included directories found matching '.git*' 04:56:13 INFO - Installing collected packages: jsonschema, functools32 04:56:13 INFO - Running setup.py install for functools32 04:56:13 INFO - warning: no files found matching '*.txt' 04:56:13 INFO - no previously-included directories found matching 'build' 04:56:13 INFO - no previously-included directories found matching 'dist' 04:56:13 INFO - no previously-included directories found matching '.git*' 04:56:13 INFO - Successfully installed jsonschema functools32 04:56:13 INFO - Cleaning up... 04:56:13 INFO - Return code: 0 04:56:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10951cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10951f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360d74e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092fad30>, '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 0x109221db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092efbe8>, '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.pjQxT87tPk/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.IAqGPqNrHL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:56:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjQxT87tPk/Render', 04:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:13 INFO - 'HOME': '/Users/cltbld', 04:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:13 INFO - 'LOGNAME': 'cltbld', 04:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:13 INFO - 'MOZ_NO_REMOTE': '1', 04:56:13 INFO - 'NO_EM_RESTART': '1', 04:56:13 INFO - 'PAGER': '/bin/cat', 04:56:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:13 INFO - 'PWD': '/builds/slave/test', 04:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:13 INFO - 'SHELL': '/bin/bash', 04:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAqGPqNrHL/Listeners', 04:56:13 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 04:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:13 INFO - 'USER': 'cltbld', 04:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:13 INFO - 'XPC_FLAGS': '0x0', 04:56:13 INFO - 'XPC_SERVICE_NAME': '0', 04:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:56:13 INFO - Cleaning up... 04:56:13 INFO - Return code: 0 04:56:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10951cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10951f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360d74e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092fad30>, '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 0x109221db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092efbe8>, '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.pjQxT87tPk/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.IAqGPqNrHL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:56:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:56:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjQxT87tPk/Render', 04:56:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:13 INFO - 'HOME': '/Users/cltbld', 04:56:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:13 INFO - 'LOGNAME': 'cltbld', 04:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:13 INFO - 'MOZ_NO_REMOTE': '1', 04:56:13 INFO - 'NO_EM_RESTART': '1', 04:56:13 INFO - 'PAGER': '/bin/cat', 04:56:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:13 INFO - 'PWD': '/builds/slave/test', 04:56:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:13 INFO - 'SHELL': '/bin/bash', 04:56:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAqGPqNrHL/Listeners', 04:56:13 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 04:56:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:13 INFO - 'USER': 'cltbld', 04:56:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:13 INFO - 'XPC_FLAGS': '0x0', 04:56:13 INFO - 'XPC_SERVICE_NAME': '0', 04:56:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:13 INFO - Downloading/unpacking blobuploader==1.2.4 04:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:16 INFO - Downloading blobuploader-1.2.4.tar.gz 04:56:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:56:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:56:16 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:56:16 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:56:16 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:56:16 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:56:16 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:56:16 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:56:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:56:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:17 INFO - Downloading docopt-0.6.1.tar.gz 04:56:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:56:18 INFO - Installing collected packages: blobuploader, requests, docopt 04:56:18 INFO - Running setup.py install for blobuploader 04:56:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:56:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:56:18 INFO - Running setup.py install for requests 04:56:18 INFO - Running setup.py install for docopt 04:56:18 INFO - Successfully installed blobuploader requests docopt 04:56:18 INFO - Cleaning up... 04:56:18 INFO - Return code: 0 04:56:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:18 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 0x10951cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10951f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360d74e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092fad30>, '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 0x109221db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092efbe8>, '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.pjQxT87tPk/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.IAqGPqNrHL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:56:18 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:56:18 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:56:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjQxT87tPk/Render', 04:56:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:18 INFO - 'HOME': '/Users/cltbld', 04:56:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:18 INFO - 'LOGNAME': 'cltbld', 04:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:18 INFO - 'MOZ_NO_REMOTE': '1', 04:56:18 INFO - 'NO_EM_RESTART': '1', 04:56:18 INFO - 'PAGER': '/bin/cat', 04:56:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:18 INFO - 'PWD': '/builds/slave/test', 04:56:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:18 INFO - 'SHELL': '/bin/bash', 04:56:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAqGPqNrHL/Listeners', 04:56:18 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 04:56:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:18 INFO - 'USER': 'cltbld', 04:56:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:18 INFO - 'XPC_FLAGS': '0x0', 04:56:18 INFO - 'XPC_SERVICE_NAME': '0', 04:56:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:19 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-5pyvEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:19 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-ITpKJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:19 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-vSPkcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:19 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-lf910b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:19 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-KovJDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:19 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-rPDzbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:19 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-314XKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:19 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-Kc6YP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:19 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-qqQOLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:20 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-bNQoEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:20 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-Xc1JWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:20 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-XR9OMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:20 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-6FMZbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:20 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-DPA7hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:20 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-mdCMpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:20 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-PFWchh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:20 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-p778cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:56:20 INFO - Running setup.py install for manifestparser 04:56:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:56:21 INFO - Running setup.py install for mozcrash 04:56:21 INFO - Running setup.py install for mozdebug 04:56:21 INFO - Running setup.py install for mozdevice 04:56:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:56:21 INFO - Running setup.py install for mozfile 04:56:21 INFO - Running setup.py install for mozhttpd 04:56:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:56:21 INFO - Running setup.py install for mozinfo 04:56:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:56:21 INFO - Running setup.py install for mozInstall 04:56:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:56:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:56:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:56:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:56:22 INFO - Running setup.py install for mozleak 04:56:22 INFO - Running setup.py install for mozlog 04:56:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:56:22 INFO - Running setup.py install for moznetwork 04:56:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:56:22 INFO - Running setup.py install for mozprocess 04:56:22 INFO - Running setup.py install for mozprofile 04:56:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:56:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:56:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:56:22 INFO - Running setup.py install for mozrunner 04:56:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:56:23 INFO - Running setup.py install for mozscreenshot 04:56:23 INFO - Running setup.py install for moztest 04:56:23 INFO - Running setup.py install for mozversion 04:56:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:56:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:56:23 INFO - Cleaning up... 04:56:23 INFO - Return code: 0 04:56:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:23 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 0x10951cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10951f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360d74e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092fad30>, '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 0x109221db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092efbe8>, '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.pjQxT87tPk/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.IAqGPqNrHL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:56:23 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:56:23 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:56:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjQxT87tPk/Render', 04:56:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:23 INFO - 'HOME': '/Users/cltbld', 04:56:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:23 INFO - 'LOGNAME': 'cltbld', 04:56:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:23 INFO - 'MOZ_NO_REMOTE': '1', 04:56:23 INFO - 'NO_EM_RESTART': '1', 04:56:23 INFO - 'PAGER': '/bin/cat', 04:56:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:23 INFO - 'PWD': '/builds/slave/test', 04:56:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:23 INFO - 'SHELL': '/bin/bash', 04:56:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAqGPqNrHL/Listeners', 04:56:23 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 04:56:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:23 INFO - 'USER': 'cltbld', 04:56:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:23 INFO - 'XPC_FLAGS': '0x0', 04:56:23 INFO - 'XPC_SERVICE_NAME': '0', 04:56:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:23 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-PxXhKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:23 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:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:23 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-WDJtCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:23 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:56:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:23 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-SSDKWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:24 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:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-sg1Oki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-_Mi2hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:24 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:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-2Figc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:24 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:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-Pbso4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:24 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:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-XcAhAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:24 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:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-5Uzbw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:24 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:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-GjLJmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:24 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:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-8ZqYci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:24 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:56:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-2P2_6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:25 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-nUn_st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:25 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:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:25 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-Mz1jfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:25 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:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:25 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-3F7zt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:25 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:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:25 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-MiL0hZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:25 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:56:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:25 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-5UrSMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:25 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:56:25 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:56:25 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:56:25 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:56:25 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:56:25 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:56:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:28 INFO - Downloading blessings-1.6.tar.gz 04:56:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:56:28 INFO - Installing collected packages: blessings 04:56:28 INFO - Running setup.py install for blessings 04:56:28 INFO - Successfully installed blessings 04:56:28 INFO - Cleaning up... 04:56:28 INFO - Return code: 0 04:56:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:56:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:28 INFO - Reading from file tmpfile_stdout 04:56:28 INFO - Current package versions: 04:56:28 INFO - blessings == 1.6 04:56:28 INFO - blobuploader == 1.2.4 04:56:28 INFO - docopt == 0.6.1 04:56:28 INFO - functools32 == 3.2.3-2 04:56:28 INFO - jsonschema == 2.5.1 04:56:28 INFO - manifestparser == 1.1 04:56:28 INFO - mozInstall == 1.12 04:56:28 INFO - mozcrash == 1.0 04:56:28 INFO - mozdebug == 0.1 04:56:28 INFO - mozdevice == 0.50 04:56:28 INFO - mozfile == 1.2 04:56:28 INFO - mozhttpd == 0.7 04:56:28 INFO - mozinfo == 0.9 04:56:28 INFO - mozleak == 0.1 04:56:28 INFO - mozlog == 3.4 04:56:28 INFO - moznetwork == 0.27 04:56:28 INFO - mozprocess == 0.25 04:56:28 INFO - mozprofile == 0.28 04:56:28 INFO - mozrunner == 6.13 04:56:28 INFO - mozscreenshot == 0.1 04:56:28 INFO - mozsystemmonitor == 0.3 04:56:28 INFO - moztest == 0.8 04:56:28 INFO - mozversion == 1.4 04:56:28 INFO - psutil == 3.1.1 04:56:28 INFO - requests == 1.2.3 04:56:28 INFO - wsgiref == 0.1.2 04:56:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:28 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:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:28 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:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:28 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 0x10951cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10951f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360d74e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092fad30>, '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 0x109221db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092efbe8>, '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.pjQxT87tPk/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.IAqGPqNrHL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:56:28 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:56:28 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:56:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjQxT87tPk/Render', 04:56:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:28 INFO - 'HOME': '/Users/cltbld', 04:56:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:28 INFO - 'LOGNAME': 'cltbld', 04:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:28 INFO - 'MOZ_NO_REMOTE': '1', 04:56:28 INFO - 'NO_EM_RESTART': '1', 04:56:28 INFO - 'PAGER': '/bin/cat', 04:56:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:28 INFO - 'PWD': '/builds/slave/test', 04:56:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:28 INFO - 'SHELL': '/bin/bash', 04:56:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAqGPqNrHL/Listeners', 04:56:28 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 04:56:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:28 INFO - 'USER': 'cltbld', 04:56:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:28 INFO - 'XPC_FLAGS': '0x0', 04:56:28 INFO - 'XPC_SERVICE_NAME': '0', 04:56:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:29 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:56:29 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:56:29 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:56:29 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:56:29 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:56:29 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:56:29 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:56:29 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:56:29 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:56:29 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:56:29 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:56:29 INFO - Cleaning up... 04:56:29 INFO - Return code: 0 04:56:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:56: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:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56: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:56:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10951cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10951f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8360d74e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1092fad30>, '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 0x109221db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092efbe8>, '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.pjQxT87tPk/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.IAqGPqNrHL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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:56: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', 'jsonschema'] in /builds/slave/test/build 04:56: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 jsonschema 04:56:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjQxT87tPk/Render', 04:56:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:29 INFO - 'HOME': '/Users/cltbld', 04:56:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:29 INFO - 'LOGNAME': 'cltbld', 04:56:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:29 INFO - 'MOZ_NO_REMOTE': '1', 04:56:29 INFO - 'NO_EM_RESTART': '1', 04:56:29 INFO - 'PAGER': '/bin/cat', 04:56:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:29 INFO - 'PWD': '/builds/slave/test', 04:56:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:29 INFO - 'SHELL': '/bin/bash', 04:56:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAqGPqNrHL/Listeners', 04:56:29 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 04:56:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:29 INFO - 'USER': 'cltbld', 04:56:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:29 INFO - 'XPC_FLAGS': '0x0', 04:56:29 INFO - 'XPC_SERVICE_NAME': '0', 04:56:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:56:29 INFO - Cleaning up... 04:56:29 INFO - Return code: 0 04:56:29 INFO - Running post-action listener: _resource_record_post_action 04:56:29 INFO - Running post-action listener: _start_resource_monitoring 04:56:29 INFO - Starting resource monitoring. 04:56:29 INFO - [mozharness: 2017-04-12 11:56:29.426431Z] Finished create-virtualenv step (success) 04:56:29 INFO - [mozharness: 2017-04-12 11:56:29.427391Z] Running install step. 04:56:29 INFO - Running pre-action listener: _resource_record_pre_action 04:56:29 INFO - Running main action method: install 04:56:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:29 INFO - Reading from file tmpfile_stdout 04:56:29 INFO - Detecting whether we're running mozinstall >=1.0... 04:56:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:56:29 INFO - Reading from file tmpfile_stdout 04:56:29 INFO - Output received: 04:56:29 INFO - Usage: mozinstall [options] installer 04:56:29 INFO - Options: 04:56:29 INFO - -h, --help show this help message and exit 04:56:29 INFO - -d DEST, --destination=DEST 04:56:29 INFO - Directory to install application into. [default: 04:56:29 INFO - "/builds/slave/test"] 04:56:29 INFO - --app=APP Application being installed. [default: firefox] 04:56:29 INFO - mkdir: /builds/slave/test/build/application 04:56:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:56:49 INFO - Reading from file tmpfile_stdout 04:56:49 INFO - Output received: 04:56:49 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:56:49 INFO - Running post-action listener: _resource_record_post_action 04:56:49 INFO - [mozharness: 2017-04-12 11:56:49.681087Z] Finished install step (success) 04:56:49 INFO - [mozharness: 2017-04-12 11:56:49.681247Z] Running run-tests step. 04:56:49 INFO - Running pre-action listener: _resource_record_pre_action 04:56:49 INFO - Running main action method: run_tests 04:56:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:56:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:56:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:56:49 INFO - 2017-04-12 04:56:49.695 screenresolution[1620:7490] starting screenresolution argv=screenresolution get 04:56:49 INFO - 2017-04-12 04:56:49.698 screenresolution[1620:7490] Display 0: 1600x1200x32@60 04:56:49 INFO - 2017-04-12 04:56:49.704 screenresolution[1621:7493] starting screenresolution argv=screenresolution list 04:56:49 INFO - Available Modes on Display 0 04:56:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:56:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:56:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:56:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:56:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:56:49 INFO - Intel Iris: 04:56:49 INFO - Chipset Model: Intel Iris 04:56:49 INFO - Type: GPU 04:56:49 INFO - Bus: Built-In 04:56:49 INFO - VRAM (Dynamic, Max): 1536 MB 04:56:49 INFO - Vendor: Intel (0x8086) 04:56:49 INFO - Device ID: 0x0a2e 04:56:49 INFO - Revision ID: 0x0009 04:56:49 INFO - Displays: 04:56:49 INFO - Display: 04:56:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:56:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:56:49 INFO - Display Serial Number: 1600x1200 60 04:56:49 INFO - Main Display: Yes 04:56:49 INFO - Mirror: Off 04:56:49 INFO - Online: Yes 04:56:49 INFO - Rotation: Supported 04:56:49 INFO - Return code: 0 04:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:56:49 INFO - Python 2.7.3 04:56:49 INFO - Return code: 0 04:56:49 INFO - grabbing minidump binary from tooltool 04:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:49 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 0x1092fad30>, '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 0x109221db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1092efbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:56:49 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:56:49 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:56:49 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:56:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:56:50 INFO - Return code: 0 04:56:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:56:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:56:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:56:50 INFO - ENV: RUST_BACKTRACE is now 1 04:56:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:56:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:56:50 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/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0184', '--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:56:50 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/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0184 --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:56:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pjQxT87tPk/Render', 04:56:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:56:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:56:50 INFO - 'HOME': '/Users/cltbld', 04:56:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:56:50 INFO - 'LOGNAME': 'cltbld', 04:56:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:56:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:50 INFO - 'MOZ_NO_REMOTE': '1', 04:56:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:56:50 INFO - 'NO_EM_RESTART': '1', 04:56:50 INFO - 'PAGER': '/bin/cat', 04:56:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:50 INFO - 'PWD': '/builds/slave/test', 04:56:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:56:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:56:50 INFO - 'RUST_BACKTRACE': '1', 04:56:50 INFO - 'SHELL': '/bin/bash', 04:56:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IAqGPqNrHL/Listeners', 04:56:50 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 04:56:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:56:50 INFO - 'USER': 'cltbld', 04:56:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:56:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:50 INFO - 'XPC_FLAGS': '0x0', 04:56:50 INFO - 'XPC_SERVICE_NAME': '0', 04:56:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:56:50 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/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0184', '--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:56:50 INFO - mozversion application_buildid: 20170412030252 04:56:50 INFO - mozversion application_changeset: f40e24f40b4c4556944c762d4764eace261297f5 04:56:50 INFO - mozversion application_display_name: Nightly 04:56:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:56:50 INFO - mozversion application_name: Firefox 04:56:50 INFO - mozversion application_remotingname: firefox 04:56:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:56:50 INFO - mozversion application_vendor: Mozilla 04:56:50 INFO - mozversion application_version: 55.0a1 04:56:50 INFO - mozversion platform_buildid: 20170412030252 04:56:50 INFO - mozversion platform_changeset: f40e24f40b4c4556944c762d4764eace261297f5 04:56:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:56:50 INFO - mozversion platform_version: 55.0a1 04:56:50 INFO - using testdate: 1491998210 04:56:50 INFO - actual date: 1491998210 04:56:50 INFO - starting webserver on 'localhost:49237' 04:56:50 INFO - SUITE-START | Running 2 tests 04:56:50 INFO - TEST-START | dromaeo_css 04:56:50 INFO - operating with platform_type : mac_ 04:56:50 INFO - Initialising browser for dromaeo_css test... 04:56:50 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpw44xsc/profile http://localhost:49237/getInfo.html) 04:56:53 INFO - PID 1631 | __metrics Screen width/height:1600/1200 04:56:53 INFO - PID 1631 | colorDepth:24 04:56:53 INFO - PID 1631 | Browser inner width/height: 1024/689 04:56:53 INFO - PID 1631 | __metrics 04:56:53 INFO - PID 1631 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:56:53 INFO - PID 1631 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:56:54 INFO - TEST-INFO | 1631: exit 0 04:56:54 INFO - Browser initialized. 04:56:54 INFO - Running cycle 1/1 for dromaeo_css test... 04:56:54 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpw44xsc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:06 INFO - PID 1634 | RSS: Main: 238514176 04:57:06 INFO - PID 1634 | 05:00:11 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 05:00:13 INFO - PID 1634 | RSS: Main: 421134336 05:00:13 INFO - PID 1634 | 05:01:56 INFO - PID 1634 | ************************* 05:01:56 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 05:01:56 INFO - PID 1634 | 05:01:56 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:01:56 INFO - PID 1634 | Full stack: 05:01:56 INFO - PID 1634 | ************************* 05:01:56 INFO - PID 1634 | ************************* 05:01:56 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 05:01:56 INFO - PID 1634 | 05:01:56 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:01:56 INFO - PID 1634 | Full stack: 05:01:56 INFO - PID 1634 | ************************* 05:01:56 INFO - PID 1634 | ************************* 05:01:56 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 05:01:56 INFO - PID 1634 | 05:01:56 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:01:56 INFO - PID 1634 | Full stack: 05:01:56 INFO - PID 1634 | ************************* 05:01:56 INFO - PID 1634 | ************************* 05:01:56 INFO - PID 1634 | A coding exception was thrown and uncaught in a Task. 05:01:56 INFO - PID 1634 | 05:01:56 ERROR - PID 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:01:56 INFO - PID 1634 | Full stack: 05:01:56 INFO - PID 1634 | ************************* 05:03:16 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 05:03:16 INFO - PID 1634 | RSS: Main: 372641792 05:03:16 INFO - PID 1634 | 05:06:18 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 05:06:19 INFO - PID 1634 | RSS: Main: 331313152 05:06:19 INFO - PID 1634 | 05:09:21 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 05:09:22 INFO - PID 1634 | RSS: Main: 358268928 05:09:22 INFO - PID 1634 | 05:12:25 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 05:12:26 INFO - PID 1634 | RSS: Main: 337170432 05:12:26 INFO - PID 1634 | 05:15:28 INFO - PID 1634 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 05:15:29 INFO - PID 1634 | RSS: Main: 377565184 05:15:29 INFO - PID 1634 | 05:15:29 INFO - PID 1634 | __start_tp_report 05:15:29 INFO - PID 1634 | _x_x_mozilla_page_load 05:15:29 INFO - PID 1634 | _x_x_mozilla_page_load_details 05:15:29 INFO - PID 1634 | |i|pagename|runs| 05:15:29 INFO - PID 1634 | |0;dojo.html;3295.8516866741;3450.2064525159212;3482.7213822894173;3495.5106285120087;3550.591681956576;6019.277686677599;6024.1566180734735;6072.240969878765;6093.927390448616;6112.205413296277;6050.699842947655;6097.695115244231;6129.601575897564;6131.101423540794;6145.340757995338;4843.854684359458;5140.717260550687;5253.0544501989625;5289.8942021159555;5388.811391601294;5316.175992721134;5316.787328506855;5359.705216213107;5364.007658583175;5418.729063546826;5145.948540514603;5212.139996900507;5232.555232805216;5274.789008439658;5361.865953351197;5263.552598029172;5283.86790330241;5287.259783630295;5354.330708661418;5360.517553420172;5273.446288139767;5291.28567643367;5292.259083728281;5296.3379577552805;5348.866278343034;5816.88366232673;5876.030454974924;6076.027835546335;6129.988551888933;6139.324674285825;6330.27201871786;6370.58591191571;6380.10678505005;6407.167068281094;6411.070394792776;6333.145025421555;6340.746370145189;6357.809265722036;6397.296297407328;6503.122078519386;6178.135061091451;6218.81343559694;6220.937790622081;6224.1597384352535;6254.9687251563455;6681;6687.866242675119;6693.698783554752;6699.464042876558;6706.161729783777;6266.968665156645;6297.275813281532;6344.048392741126;6353.332900045429;6372.522060845455;6445.2265728112925;6451.225852897683;6459.709313080923;6463.6768161591735;6466.450351720063;6361.14124593174;6361.968190159019;6363.268224154189;6365.745370185234;6370.713317900613;6304.054391841169;6355.809325720235;6393;6398.648074355955;6411.647359395278;5145.253938178943;5177.948220517746;5221.686698798084;5223.373195216598;5254.106801843619;4611.723296602215;4633.698809577367;4639.280911458729;4645.512221216791;4678.274867395559;5940.554458415636;6059.909101363483;6187.071939209065;6222.937770622236;6238.968805155945;6340.270868850142;6433.710483028275;6491.318411566717;6497.577657452251;6499.155109835786;6162.5378096642935;6200.503959683305;6212.0371342441995;6214.533909956771;6215.9378406215355;5728.398518155617;5739.483446489836;5745.052066408995;5747.712614369265;5798.971005144947;6334.683265836782;6355.046742988404;6415;6417.294097649162;6418.967905160444;6347.365263473615;6361.745530178741;6373.521985850987;6379.96810015947;6390.105385245976;6508.186476690414;6566.540342176002;6591.242007169045;6593.208814942238;6626.701798419179;6357.14178585885;6383.138276332821;6383.904241436289;6387.55287129915;6391.265004524539;6296;6452.064450654722;6468.353164683494;6480.963045912631;6483.967580162258;6244.594101383395;6249.593776404519;6257;6323.588966717149;6330;6342.080398342307;6357.968210159104;6358.713857876314;6382.712777924911;6385.13800636908;6265.154204182377;6325.240971083499;6336.239651241881;6338.11266422692;6353.8729225416155;6206.224221972254;6281.528885333527;6290.528210384331;6295.748170073146;6330.968345158245;5114.79540818378;6349.904751428639;6351.650659213788;6359.236891573041;6363.300036996019 05:15:29 INFO - PID 1634 | |1;ext.html;729.7263526177684;786.2452046035805;812.3704129299792;1115.8437818705377;1137.2494153858454;27436.72563274369;27875.721242787567;27915.58126628102;27940.161795146152;27940.99999999995;37768;38213.808930955376;38226;38229.235415291674;38348.61651383485;8472.237498625107;8653.350998675092;8658.740237792845;8660.17728315809;8677.609507572142;6059.42435468632;6212.378762123797;8452.704155354564;8600.827983440327;8610.009848867398;8510.191531804468;8692.608832602516;8718.956405217998;8724.563771811416;8738.038815730264;8693.347998900077;8751.868721969111;8752.824943501095;8777.824443511126;8784.56077196144;5303.946960530422;6029.095635654687;8430.45202061864;8528.403011789178;8535.317174626016;36212.818935905154;36698.7155449558;36736.448953265724;36764.816175919215;36796.264074718354;3617.5478065241846;3663.8351274192723;3666.4683620874825;3667.5965643779164;3671.706263498914;30506;30826.921057763095;30836;30837.537436938463;30857.537136942738;3106.2544989202656;3129.264622813637;3153.5269709543522;3161.936761264762;3170.746340292771;266549;270530.647346762;270746;270920;271510;48996.26505602419;49183;49232.507674922796;49275.50724492709;49279.753601231765;51087;51187.74406127945;51199.7440012805;51235.7438212814;51281.743591281804;13398.799018014737;13470.528531501546;13485.797713034312;13527.98540109476;13569.25369104689;10800.297980631234;10881.945590272157;10962;10973.23187376876;10992.505337259843;8653.221210091122;10580.25938184335;10723.14214862809;12033.939830300968;12295.385230738606;4297;5528.087865502228;5545.77816887328;5563.666180029211;5565.387807341189;1000.7698229407277;1019.5615885169449;1026.6919924022764;1062.8671416072991;1065.7974984752873;23173.884130579238;24264.16948294592;24286.392840179138;24297.635535466983;24320.756792432203;1120.2270433400927;1123.612353737959;1135.6422726841183;1161.3670549550347;1172.197045024161;11824.586139485249;12385.318807465675;12442.875571244353;12525.749485010248;12534.498620055278;285445;322790.7720922761;336119;336592;337065;50033;50138;50209.24267650615;50237.24644130341;50274.74862625664;1497.10922001409;1508.057464084947;1545.4436402894949;1547.7523596224776;1553.0759198277008;22534.098636054376;23730.644040339062;23752.643710344015;23832.642510362013;23916.40208994789;37563;37593.24813503769;37634.62365376421;37670.434943475324;37675.81162094172;308909;308995;309246;310057;310195.8980410167;33889;34662.30675386528;34809.65190348064;34842.30315393729;34862.12844678904;36513.81743091268;37050;37051;45007.54992450034;45028.549714502435;23611.40971475658;24884.05804320824;27930;28313.57529637016;29217.61735739656;23254.455156295568;29839.254018649706;30520.11140617905;30532.389352213275;30637.846810765805;29133.417331653673;35378.82310588431;36008;36748.81625591855;36870.446943295334;29604;30085.398292034475;30517.23706907345;30549.389012220076;30726.078217653507;17614.383496577557;21040;23002.424939376648;23600.763992359858;23750 05:15:29 INFO - PID 1634 | |2;jquery.html;382.74164938666394;390.83780231204054;415.14687317562397;427.12226374799775;430.7372502773309;20486.487837804045;20987.580248395025;21538.246161384315;21745.456363590918;21889.67165492519;16465.83534164658;21137.15451381943;22356.21753238637;22952.196673116443;23139.421514462105;6038.154658347835;6327.936720632781;6334.651594162319;6334.873302533946;6341.04884267359;5984.072468767326;6169.691515424233;6194.50443964484;6277.4664153547;6292.276388215368;6227.1282020517165;6243.8126856194385;6246.906296405557;6251.781187658433;6267.279262884781;6071.210742603455;6142.723577439004;6170.413810688;6250.718717657671;6254.781082662131;5218.478152184789;5559.166125081229;5559.610827242094;5569.637973531748;5581.302337207849;22348.10607575695;26869.865650671818;27132.728672713216;27373.863130684418;27522.862385688142;2200.5378870437225;2211.579799838026;2216.1357070742424;2245.7978781909706;2248.022110381989;17898.836575622543;18037.18832652534;18332.54168645781;18486.15138486154;18623.161957711935;2137.4335801012744;2138.711273978024;2149.0544160569298;2171.83711221659;2184.421128400975;142149.28925355308;142300;143660.28169859084;144199;157417.21291393583;11611;11767.705807354885;12186.57346992851;12202.023838092931;12280.938595307145;13840.93079534596;16291.185440727917;16293.755593666105;16296.918515407348;16300.836991629933;7347.88978165328;8693.217890332468;8990.595423205972;9010;9057.003729589871;7460.328570428579;7499;8293.170682931659;8565.357598180037;8792.252658524098;6893.827654308582;7650.196729343339;7694.778402043691;7746.573938433327;7847.450678452567;1787.294018862568;1919.6256729937807;2145.5065334972733;2148.5810266997787;2216.34617787753;905.298393744853;925.3291363761354;935.6351023100996;973.532704301939;1008.0473952115327;16719.91640041792;20317.79682203159;21132.47168820792;21138.57722845565;21233.256836010976;962.2109869906609;967.583938906263;992.7716625176106;993.5429702336861;1004.0060340263233;10655.520501577448;10997.61508347204;11013.889861101447;11063.214810754274;11105.666829995112;615174;621938;626406;638709;643863;105774.47112764388;138718;144662;147681;153151;1078.5200585739271;1156.7686462707493;1189.3696340939316;1192.1952681939656;1197.7544603356291;18238.361657341928;19778.109985050418;22221;22449.551008980055;22670.773292266866;59250.70374648099;59668.70165649144;62033.68983155055;62820;63100;86842;87760.5611971936;88174;89352;93934.53032734792;7662.7394918500295;7814;7977.48146370484;8987.101289871222;9004.054574269607;14310.713785724436;14351.928240358731;14467.85532144665;14710.823134149028;14714.55856324312;11449.656510304705;11587.536498539965;11916.34460104668;11946.880531194576;12048.337341446304;11102.777944441228;11122.388268645302;11258.324500529994;11530.94234528822;11783.057355411718;10710.410927399067;11576.710582235175;11952;11997.100217483548;12116.151869369412;8866.049469116784;8951.328650351119;8967.282617390463;9063.68277110298;9181.77045573866;11917.642470725892;12020.437343145684;12144.635660930186;12181.33002684861;12198.817017744563 05:15:29 INFO - PID 1634 | |3;mootools.html;1353.5668586052461;1406.1492796857901;1430.113329735564;1434.1251836379813;1438.129931391508;11354.772904541904;11676.824847627282;11681.707957301072;11692.766144677102;11705.648830535087;9867.654632087879;11447.198696091276;11728.185235543473;11821.113416493776;11841.993430558412;2449.9632505512386;2529.481456301463;2529.911453099142;2530.00064974335;2532.1390727152766;2082.427332483564;2344;2397.7602239776056;2413.5776239158163;2426.8907899144583;2161.049138379108;2184.3446965910243;2436.4517983453757;2527.8609676467786;2528.987355063222;2447.2535876557645;2465.4206261528525;2479.801615870726;2482.441450673602;2485.5153245117117;2078.6362386582286;2455.680761501011;2457.619069044301;2462.913798017061;2463.4210960424284;11455.828162577567;11752.412379381083;11755.58855440064;11757.059435245246;11772.823407648892;6328.335524769925;6624.304448032935;6627.93372066278;6629.0056491526175;6632.303608121174;3912.5109361329833;4099.467069281004;4100.097978444737;4238.258304796679;4332.501762297313;1224.687704635321;1243.608263397027;1247.1706315300314;1285.4472576791975;1290.6386211860695;16050.197490125447;16359.83640163607;16385.59036024097;16400;16407.261673224613;5775.48020678141;5796.188533605298;5919.911201331984;6035.245594300713;6056.939430605637;13804.723905521832;13823.723525529635;13827.446902123802;13827.51603693866;13827.962902782332;5707.71461426927;6722.865542689119;6738.124043874265;6740.83147921296;6743.662816859138;5897.7935772247765;6109.266887973472;6191.349908259568;6227.782027629102;6258.405451482102;4496.775161241925;4649.465311489154;4657.673962822638;4698.224792909132;4748.264019077049;1402.8917155447082;1453.872850764233;1458.8541145885326;1476.9556913292618;1485.581269887255;666.8720619366109;712.750537311947;796.5141263829059;802.7792357101844;809.5304723260494;6599.70301336441;6716.899246511306;6771.221309549464;6844.657767111724;6852.383285504328;582.3477704970376;583.6206465797181;589.6049646736697;593.3206478581999;641.4900154377189;4170.687198460128;4213.578642135762;4217.894552636209;4325.372820941009;4332.631726303236;14228.715425691427;14968.081224161402;14991.775123373158;15010.174440405883;15011.324490397958;14298.213598252196;14705.632359191106;14793.704125917637;14794.926025369805;14800.925995369955;10717.946410268054;10843.891561084289;10845.891541084646;10849.457527123612;10851.67444976652;6270.5924114934205;6287.2140982377205;6590.703418346282;6703.865922681616;6736.528443009139;13033.674158145743;13421.261830599411;13434.992375571675;13438.924886008901;13447.798283025566;13406.865931340952;13632.386542605806;13861.930690346888;13868.514601988882;13885.652858678613;9146.862797058182;9247.583858726508;9253.352265341631;9367.156955874005;9394.765130871783;10351.844722329322;10484.52819623134;10484.63303784364;10488;10502.789944201226;8424.03123640789;8599.95700021496;8676.479411235347;8682.34882383811;8844.425112367675;8172.550509721785;8327.875081873897;8343.749687509384;8356.289715374262;8400.159984001551;6634.900476492953;8015.438919275594;8017.559034253172;8023.879641805261;8033.277005069338;5851.736671849691;5961.2846458425265;6044.546659000504;6112.572119951738;6138.877222455615;5251.606129540223;5301.231321458444;5441.037256583363;5546.223528706065;5587.770690448095 05:15:29 INFO - PID 1634 | |4;prototype.html;384.3216722484813;391.4734681852907;391.99999999999994;407.0353262767241;409.9587048895805;5358.598105142115;5567.359753628334;5756.194132821398;5919;5940;5611.663300201981;5612.382637909837;5690.687012214326;5724.084146536555;5783.2481777368985;3854.6338097880657;4488.708233964798;4493.9550604494025;4513.864584062467;4539.863804085882;4252.489701235856;4346.282863327548;4454.33185022246;4467.17357288901;4515.841945531907;3729.533808273966;3781.6596506314427;4117.2177286315655;4253.191893540233;4366.297144113782;3050.908472745821;3890.754958413309;4049.5343035550995;4460.620847227973;4466.53101424349;3305.520699498559;3981.6814654827544;3984.860529881469;4003;4004.5795191505053;5406.675599464044;5642.915356269659;5681.687507187103;5713.971430142823;5727.971360143214;4460.4647442306805;4841.7337046462435;4844.971892567146;5077.796888124471;5095.439501654815;5464.9453505465235;5863.5341164708825;6170.784022559234;6173.197484327009;6249.625022498664;4066.166435880667;4174.540800511942;4189.2668782963165;4218.873433796991;4254.91490170198;5491.423400542965;6416.615003099829;6491.740330386826;6496.350364963513;6514.967425162891;3685.5761587417255;3848.288066707612;4068.7355321904574;4238.21593005295;4255.978720106442;3536.550014494045;3750.1374683822874;4091.509018917749;4317.784110794448;4378.233809083397;5036.169032109734;5046.62150338726;5056.64603477753;5075.137226671474;5075.771590278447;5378.596605254622;5389.514943655012;6181.96909015452;6182.536309776785;6189.978653522208;1254.5420921363636;1255.8869701726887;1408.7745960646248;1461.9780703289246;1477;969.3327476739996;981.5926390547985;981.9116279534876;1001.7910507331317;1002.3835341265069;5802.564807639444;5839.649621022752;5862.560307976919;5866.208061911672;5920;5510.889782204334;6214.502839772807;6361.809145725636;6370.777022804273;6381.361863813581;5323.973380133075;5453.209284653703;5590.413006634326;5734;5836.358000619928;2803.8644349038673;2974.628171478565;3308.569885914864;3338.2655815720505;3342.699157075875;6180.629162250189;6201.782787704314;6528.575642583217;6539.5149843059335;6557.7704780333415;6498.288740662982;6512.804615861532;6527.118838956775;6532.706028228741;6534.738610455529;5195.804964858104;5936.13925980739;6362.377593713573;6366.5252656863495;6441.935580644134;5559.638623489622;6357.491400687842;6369.8726025480155;6381.8723625528155;6389.137466441971;5607.214989901336;5866.530677545871;6056.1824153740445;6231.657258850625;6260.7495700171485;5924.911126333194;6437.967810160919;6480.222373315044;6514.133781136285;6514.315996820265;3747.306748251582;4263.253930562201;4265.616094551505;4267.914641707086;4274.893127671833;5641.689707065987;5850.385709500441;6318.273398559225;6352.142460767737;6366.586171898812;5942.257217847769;6081.5134789217645;6152.261728592597;6157.538184636081;6167.784127555514;4849.496656036499;5364.436734142859;5732.194358776972;5767.961766882002;6154.446099850856;4743.762811859462;5085.64400491962;5591.692456914909;5744.511716504144;5955.40445955401;5492.80775172883;6083.361247068994;6105.603135796159;6150.446459818638;6180.258368995749;5016.996600679951;5743.253377060955;5932.79235226765;5958.152972578515;6024.6745715942425 05:15:29 INFO - PID 1634 | |5;yui.html;703.0508813102316;727.9454040946929;852.6078004118109;855.6235256487145;863.9977625953894;13317.467301307948;17908.47777938875;18001.729974050366;18647.720284195748;18679.906600467013;13898.93050534746;16841.073740944244;17336.393226237084;17392;17398.478045658652;970.6602689058843;991.732232297283;995.2635050062937;998.121652945407;1000.7147962830595;679.259607028339;695.686940876605;984.7784248544092;994.1351024608565;1017.9592816287377;1052.715766742979;1053.7681710023821;1054.9261551691384;1056.968290951269;1061.8566493523354;1044.968650940473;1047.6856942917095;1048.4233671480656;1050.9106725928305;1067.3169171730099;780.594091072639;782.1982467970319;787.5668382389663;787.7676085554775;793.3692714292151;16444.34222631093;16638.75041874373;16855.325786968508;16856;17153.914230428894;16079.598010049725;16232.675346493123;16275.51173464798;16452.095134767584;16701.749473757904;13473.595792126252;13551.864481355158;13601.979851511078;13625.046246762731;13721.45114195431;3406.369821583015;3411.880584179542;3412.436947903593;3417.2482053948092;3417.2994536120036;101029.494852526;101066;101562.49218753933;101589;101700;10628.14974802014;11951.641450756491;12020.218685785396;12104.57633982824;12293.877061229452;24085.51828963411;24343.878280608482;24381.14665986682;24625.384365391008;24675;8615.870761938577;8634.6977855776;8652.740417787476;8668.653253869901;8705.91294087051;4696.81212751493;4885.2427873679635;4886.120498310267;4886.340344053508;4887.0714564232685;4294.141171765659;4345.500267469219;4375.5405682403525;4402.823887044482;4410.757408342508;885.3581153663671;897.5781382750097;909.4725059465494;910.0717268386342;910.1899309614448;648.2706954675989;653.2683394598081;654.2149420695184;661.1999480628493;680.1905732178692;10349.689509314732;11134.944325278484;11634.592789252505;11658.6502404928;11671.766564668658;638.6902352359102;657.81252343082;658.6805399381392;684.9794506164823;691.3328637864485;5269.446708095671;5289.2859463972645;5478.671279723229;5613.129964855454;5810.157527158538;95609;96067;98011.50994244983;100225;104181.47909260406;70083.89748307559;90243;92045;92912.53543732374;95858.33133349454;62897.68551157215;77007;80953.59523202346;81783.18216817874;83467.64517677143;12152.878471215176;12322.753544928872;12329.136960412685;12564.371781411075;12636.87363126357;39009.414858776574;40234;40353;41288.38067429051;41708.79145604253;67816.6609166951;68437.31562684309;70193.94709079266;70471.94292085725;71275;15894.092708875009;16735.414260500824;16749.497515074567;16750.497485075466;16776;18176.909115454866;18203.271869125616;18355.174017169527;18426.262949481872;18655.626887462447;12867.906227970727;14817.259137042889;15626.140562269184;15858.207089645703;15962.68074638524;13801.171929684251;16390.508284751475;16619.002859828448;16959.321627134777;17035.574110646838;14140.575782726122;16228.51314460568;16265.51203463898;16270.837291626933;16316.592085197964;11399;11655.18413711066;11683.474243658886;11800.586979456022;11850.05199584014;11176.776464470502;12313.44589493457;12685.175463594836;12689.794563639667;12862.807057893951 05:15:29 INFO - PID 1634 | __end_tp_report 05:15:29 INFO - PID 1634 | __start_cc_report 05:15:29 INFO - PID 1634 | _x_x_mozilla_cycle_collect,1971 05:15:29 INFO - PID 1634 | __end_cc_report 05:15:29 INFO - PID 1634 | __startTimestamp1491999329128__endTimestamp 05:15:29 INFO - PID 1634 | 05:15:29 INFO - PID 1634 | ------- Summary: start ------- 05:15:29 INFO - PID 1634 | Number of tests: 6 05:15:29 INFO - PID 1634 | 05:15:29 INFO - PID 1634 | [#0] dojo.html Cycles:165 Average:5973.51 Median:6281.53 stddev:676.78 (10.8%) stddev-sans-first:645.44 05:15:29 INFO - PID 1634 | Values: 3295.9 3450.2 3482.7 3495.5 3550.6 6019.3 6024.2 6072.2 6093.9 6112.2 6050.7 6097.7 6129.6 6131.1 6145.3 4843.9 5140.7 5253.1 5289.9 5388.8 5316.2 5316.8 5359.7 5364.0 5418.7 5145.9 5212.1 5232.6 5274.8 5361.9 5263.6 5283.9 5287.3 5354.3 5360.5 5273.4 5291.3 5292.3 5296.3 5348.9 5816.9 5876.0 6076.0 6130.0 6139.3 6330.3 6370.6 6380.1 6407.2 6411.1 6333.1 6340.7 6357.8 6397.3 6503.1 6178.1 6218.8 6220.9 6224.2 6255.0 6681.0 6687.9 6693.7 6699.5 6706.2 6267.0 6297.3 6344.0 6353.3 6372.5 6445.2 6451.2 6459.7 6463.7 6466.5 6361.1 6362.0 6363.3 6365.7 6370.7 6304.1 6355.8 6393.0 6398.6 6411.6 5145.3 5177.9 5221.7 5223.4 5254.1 4611.7 4633.7 4639.3 4645.5 4678.3 5940.6 6059.9 6187.1 6222.9 6239.0 6340.3 6433.7 6491.3 6497.6 6499.2 6162.5 6200.5 6212.0 6214.5 6215.9 5728.4 5739.5 5745.1 5747.7 5799.0 6334.7 6355.0 6415.0 6417.3 6419.0 6347.4 6361.7 6373.5 6380.0 6390.1 6508.2 6566.5 6591.2 6593.2 6626.7 6357.1 6383.1 6383.9 6387.6 6391.3 6296.0 6452.1 6468.4 6481.0 6484.0 6244.6 6249.6 6257.0 6323.6 6330.0 6342.1 6358.0 6358.7 6382.7 6385.1 6265.2 6325.2 6336.2 6338.1 6353.9 6206.2 6281.5 6290.5 6295.7 6331.0 5114.8 6349.9 6351.7 6359.2 6363.3 05:15:29 INFO - PID 1634 | 05:15:29 INFO - PID 1634 | [#1] ext.html Cycles:180 Average:44308.57 Median:3157.73 stddev:79410.97 (2514.8%) stddev-sans-first:79566.33 05:15:29 INFO - PID 1634 | Values: 729.7 786.2 812.4 1115.8 1137.2 27436.7 27875.7 27915.6 27940.2 27941.0 37768.0 38213.8 38226.0 38229.2 38348.6 8472.2 8653.4 8658.7 8660.2 8677.6 6059.4 6212.4 8452.7 8600.8 8610.0 8510.2 8692.6 8719.0 8724.6 8738.0 8693.3 8751.9 8752.8 8777.8 8784.6 5303.9 6029.1 8430.5 8528.4 8535.3 36212.8 36698.7 36736.4 36764.8 36796.3 3617.5 3663.8 3666.5 3667.6 3671.7 30506.0 30826.9 30836.0 30837.5 30857.5 3106.3 3129.3 3153.5 3161.9 3170.7 266549.0 270530.6 270746.0 270920.0 271510.0 48996.3 49183.0 49232.5 49275.5 49279.8 51087.0 51187.7 51199.7 51235.7 51281.7 13398.8 13470.5 13485.8 13528.0 13569.3 10800.3 10881.9 10962.0 10973.2 10992.5 8653.2 10580.3 10723.1 12033.9 12295.4 4297.0 5528.1 5545.8 5563.7 5565.4 1000.8 1019.6 1026.7 1062.9 1065.8 23173.9 24264.2 24286.4 24297.6 24320.8 1120.2 1123.6 1135.6 1161.4 1172.2 11824.6 12385.3 12442.9 12525.7 12534.5 285445.0 322790.8 336119.0 336592.0 337065.0 50033.0 50138.0 50209.2 50237.2 50274.7 1497.1 1508.1 1545.4 1547.8 1553.1 22534.1 23730.6 23752.6 23832.6 23916.4 37563.0 37593.2 37634.6 37670.4 37675.8 308909.0 308995.0 309246.0 310057.0 310195.9 33889.0 34662.3 34809.7 34842.3 34862.1 36513.8 37050.0 37051.0 45007.5 45028.5 23611.4 24884.1 27930.0 28313.6 29217.6 23254.5 29839.3 30520.1 30532.4 30637.8 29133.4 35378.8 36008.0 36748.8 36870.4 29604.0 30085.4 30517.2 30549.4 30726.1 17614.4 21040.0 23002.4 23600.8 23750.0 05:15:29 INFO - PID 1634 | 05:15:29 INFO - PID 1634 | [#2] jquery.html Cycles:180 Average:38169.80 Median:22352.16 stddev:105781.36 (473.2%) stddev-sans-first:106040.05 05:15:29 INFO - PID 1634 | Values: 382.7 390.8 415.1 427.1 430.7 20486.5 20987.6 21538.2 21745.5 21889.7 16465.8 21137.2 22356.2 22952.2 23139.4 6038.2 6327.9 6334.7 6334.9 6341.0 5984.1 6169.7 6194.5 6277.5 6292.3 6227.1 6243.8 6246.9 6251.8 6267.3 6071.2 6142.7 6170.4 6250.7 6254.8 5218.5 5559.2 5559.6 5569.6 5581.3 22348.1 26869.9 27132.7 27373.9 27522.9 2200.5 2211.6 2216.1 2245.8 2248.0 17898.8 18037.2 18332.5 18486.2 18623.2 2137.4 2138.7 2149.1 2171.8 2184.4 142149.3 142300.0 143660.3 144199.0 157417.2 11611.0 11767.7 12186.6 12202.0 12280.9 13840.9 16291.2 16293.8 16296.9 16300.8 7347.9 8693.2 8990.6 9010.0 9057.0 7460.3 7499.0 8293.2 8565.4 8792.3 6893.8 7650.2 7694.8 7746.6 7847.5 1787.3 1919.6 2145.5 2148.6 2216.3 905.3 925.3 935.6 973.5 1008.0 16719.9 20317.8 21132.5 21138.6 21233.3 962.2 967.6 992.8 993.5 1004.0 10655.5 10997.6 11013.9 11063.2 11105.7 615174.0 621938.0 626406.0 638709.0 643863.0 105774.5 138718.0 144662.0 147681.0 153151.0 1078.5 1156.8 1189.4 1192.2 1197.8 18238.4 19778.1 22221.0 22449.6 22670.8 59250.7 59668.7 62033.7 62820.0 63100.0 86842.0 87760.6 88174.0 89352.0 93934.5 7662.7 7814.0 7977.5 8987.1 9004.1 14310.7 14351.9 14467.9 14710.8 14714.6 11449.7 11587.5 11916.3 11946.9 12048.3 11102.8 11122.4 11258.3 11530.9 11783.1 10710.4 11576.7 11952.0 11997.1 12116.2 8866.0 8951.3 8967.3 9063.7 9181.8 11917.6 12020.4 12144.6 12181.3 12198.8 05:15:29 INFO - PID 1634 | 05:15:29 INFO - PID 1634 | [#3] mootools.html Cycles:180 Average:7143.20 Median:2529.70 stddev:4567.50 (180.6%) stddev-sans-first:4559.59 05:15:29 INFO - PID 1634 | Values: 1353.6 1406.1 1430.1 1434.1 1438.1 11354.8 11676.8 11681.7 11692.8 11705.6 9867.7 11447.2 11728.2 11821.1 11842.0 2450.0 2529.5 2529.9 2530.0 2532.1 2082.4 2344.0 2397.8 2413.6 2426.9 2161.0 2184.3 2436.5 2527.9 2529.0 2447.3 2465.4 2479.8 2482.4 2485.5 2078.6 2455.7 2457.6 2462.9 2463.4 11455.8 11752.4 11755.6 11757.1 11772.8 6328.3 6624.3 6627.9 6629.0 6632.3 3912.5 4099.5 4100.1 4238.3 4332.5 1224.7 1243.6 1247.2 1285.4 1290.6 16050.2 16359.8 16385.6 16400.0 16407.3 5775.5 5796.2 5919.9 6035.2 6056.9 13804.7 13823.7 13827.4 13827.5 13828.0 5707.7 6722.9 6738.1 6740.8 6743.7 5897.8 6109.3 6191.3 6227.8 6258.4 4496.8 4649.5 4657.7 4698.2 4748.3 1402.9 1453.9 1458.9 1477.0 1485.6 666.9 712.8 796.5 802.8 809.5 6599.7 6716.9 6771.2 6844.7 6852.4 582.3 583.6 589.6 593.3 641.5 4170.7 4213.6 4217.9 4325.4 4332.6 14228.7 14968.1 14991.8 15010.2 15011.3 14298.2 14705.6 14793.7 14794.9 14800.9 10717.9 10843.9 10845.9 10849.5 10851.7 6270.6 6287.2 6590.7 6703.9 6736.5 13033.7 13421.3 13435.0 13438.9 13447.8 13406.9 13632.4 13861.9 13868.5 13885.7 9146.9 9247.6 9253.4 9367.2 9394.8 10351.8 10484.5 10484.6 10488.0 10502.8 8424.0 8600.0 8676.5 8682.3 8844.4 8172.6 8327.9 8343.7 8356.3 8400.2 6634.9 8015.4 8017.6 8023.9 8033.3 5851.7 5961.3 6044.5 6112.6 6138.9 5251.6 5301.2 5441.0 5546.2 5587.8 05:15:29 INFO - PID 1634 | 05:15:29 INFO - PID 1634 | [#4] prototype.html Cycles:180 Average:4949.24 Median:5591.05 stddev:1541.65 (27.6%) stddev-sans-first:1507.42 05:15:29 INFO - PID 1634 | Values: 384.3 391.5 392.0 407.0 410.0 5358.6 5567.4 5756.2 5919.0 5940.0 5611.7 5612.4 5690.7 5724.1 5783.2 3854.6 4488.7 4494.0 4513.9 4539.9 4252.5 4346.3 4454.3 4467.2 4515.8 3729.5 3781.7 4117.2 4253.2 4366.3 3050.9 3890.8 4049.5 4460.6 4466.5 3305.5 3981.7 3984.9 4003.0 4004.6 5406.7 5642.9 5681.7 5714.0 5728.0 4460.5 4841.7 4845.0 5077.8 5095.4 5464.9 5863.5 6170.8 6173.2 6249.6 4066.2 4174.5 4189.3 4218.9 4254.9 5491.4 6416.6 6491.7 6496.4 6515.0 3685.6 3848.3 4068.7 4238.2 4256.0 3536.6 3750.1 4091.5 4317.8 4378.2 5036.2 5046.6 5056.6 5075.1 5075.8 5378.6 5389.5 6182.0 6182.5 6190.0 1254.5 1255.9 1408.8 1462.0 1477.0 969.3 981.6 981.9 1001.8 1002.4 5802.6 5839.6 5862.6 5866.2 5920.0 5510.9 6214.5 6361.8 6370.8 6381.4 5324.0 5453.2 5590.4 5734.0 5836.4 2803.9 2974.6 3308.6 3338.3 3342.7 6180.6 6201.8 6528.6 6539.5 6557.8 6498.3 6512.8 6527.1 6532.7 6534.7 5195.8 5936.1 6362.4 6366.5 6441.9 5559.6 6357.5 6369.9 6381.9 6389.1 5607.2 5866.5 6056.2 6231.7 6260.7 5924.9 6438.0 6480.2 6514.1 6514.3 3747.3 4263.3 4265.6 4267.9 4274.9 5641.7 5850.4 6318.3 6352.1 6366.6 5942.3 6081.5 6152.3 6157.5 6167.8 4849.5 5364.4 5732.2 5768.0 6154.4 4743.8 5085.6 5591.7 5744.5 5955.4 5492.8 6083.4 6105.6 6150.4 6180.3 5017.0 5743.3 5932.8 5958.2 6024.7 05:15:29 INFO - PID 1634 | 05:15:29 INFO - PID 1634 | [#5] yui.html Cycles:180 Average:21025.27 Median:18536.99 stddev:28296.48 (152.6%) stddev-sans-first:28334.72 05:15:29 INFO - PID 1634 | Values: 703.1 727.9 852.6 855.6 864.0 13317.5 17908.5 18001.7 18647.7 18679.9 13898.9 16841.1 17336.4 17392.0 17398.5 970.7 991.7 995.3 998.1 1000.7 679.3 695.7 984.8 994.1 1018.0 1052.7 1053.8 1054.9 1057.0 1061.9 1045.0 1047.7 1048.4 1050.9 1067.3 780.6 782.2 787.6 787.8 793.4 16444.3 16638.8 16855.3 16856.0 17153.9 16079.6 16232.7 16275.5 16452.1 16701.7 13473.6 13551.9 13602.0 13625.0 13721.5 3406.4 3411.9 3412.4 3417.2 3417.3 101029.5 101066.0 101562.5 101589.0 101700.0 10628.1 11951.6 12020.2 12104.6 12293.9 24085.5 24343.9 24381.1 24625.4 24675.0 8615.9 8634.7 8652.7 8668.7 8705.9 4696.8 4885.2 4886.1 4886.3 4887.1 4294.1 4345.5 4375.5 4402.8 4410.8 885.4 897.6 909.5 910.1 910.2 648.3 653.3 654.2 661.2 680.2 10349.7 11134.9 11634.6 11658.7 11671.8 638.7 657.8 658.7 685.0 691.3 5269.4 5289.3 5478.7 5613.1 5810.2 95609.0 96067.0 98011.5 100225.0 104181.5 70083.9 90243.0 92045.0 92912.5 95858.3 62897.7 77007.0 80953.6 81783.2 83467.6 12152.9 12322.8 12329.1 12564.4 12636.9 39009.4 40234.0 40353.0 41288.4 41708.8 67816.7 68437.3 70193.9 70471.9 71275.0 15894.1 16735.4 16749.5 16750.5 16776.0 18176.9 18203.3 18355.2 18426.3 18655.6 12867.9 14817.3 15626.1 15858.2 15962.7 13801.2 16390.5 16619.0 16959.3 17035.6 14140.6 16228.5 16265.5 16270.8 16316.6 11399.0 11655.2 11683.5 11800.6 11850.1 11176.8 12313.4 12685.2 12689.8 12862.8 05:15:29 INFO - PID 1634 | -------- Summary: end -------- 05:15:29 INFO - PID 1634 | 05:15:29 INFO - TEST-INFO | 1634: exit 0 05:15:29 INFO - TEST-OK | dromaeo_css | took 1119473ms 05:15:29 INFO - TEST-START | kraken 05:15:29 INFO - operating with platform_type : mac_ 05:15:29 INFO - Initialising browser for kraken test... 05:15:29 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpbodsfD/profile http://localhost:49237/getInfo.html) 05:15:32 INFO - PID 1643 | __metrics Screen width/height:1600/1200 05:15:32 INFO - PID 1643 | colorDepth:24 05:15:32 INFO - PID 1643 | Browser inner width/height: 1024/689 05:15:32 INFO - PID 1643 | __metrics 05:15:32 INFO - PID 1643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:15:32 INFO - PID 1643 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:15:33 INFO - TEST-INFO | 1643: exit 0 05:15:33 INFO - Browser initialized. 05:15:33 INFO - Running cycle 1/1 for kraken test... 05:15:33 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpbodsfD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:45 INFO - PID 1645 | RSS: Main: 238612480 05:15:45 INFO - PID 1645 | 05:15:48 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 05:15:49 INFO - PID 1645 | RSS: Main: 292147200 05:15:49 INFO - PID 1645 | 05:15:52 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 05:15:52 INFO - PID 1645 | RSS: Main: 292880384 05:15:52 INFO - PID 1645 | 05:15:56 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 05:15:57 INFO - PID 1645 | RSS: Main: 385216512 05:15:57 INFO - PID 1645 | 05:15:59 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 05:15:59 INFO - PID 1645 | RSS: Main: 289873920 05:15:59 INFO - PID 1645 | 05:16:01 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:16:02 INFO - PID 1645 | RSS: Main: 291807232 05:16:02 INFO - PID 1645 | 05:16:05 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 05:16:06 INFO - PID 1645 | RSS: Main: 334368768 05:16:06 INFO - PID 1645 | 05:16:09 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 05:16:10 INFO - PID 1645 | RSS: Main: 342077440 05:16:10 INFO - PID 1645 | 05:16:13 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 05:16:14 INFO - PID 1645 | RSS: Main: 343175168 05:16:14 INFO - PID 1645 | 05:16:15 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:16:16 INFO - PID 1645 | RSS: Main: 310804480 05:16:16 INFO - PID 1645 | 05:16:18 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:16:18 INFO - PID 1645 | RSS: Main: 315228160 05:16:18 INFO - PID 1645 | 05:16:21 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:16:21 INFO - PID 1645 | RSS: Main: 317644800 05:16:21 INFO - PID 1645 | 05:16:25 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:16:25 INFO - PID 1645 | RSS: Main: 329773056 05:16:25 INFO - PID 1645 | 05:16:29 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:16:29 INFO - PID 1645 | RSS: Main: 317202432 05:16:29 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 05:16:31 INFO - PID 1645 | RSS: Main: 382955520 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | __start_tp_report 05:16:31 INFO - PID 1645 | _x_x_mozilla_page_load 05:16:31 INFO - PID 1645 | _x_x_mozilla_page_load_details 05:16:31 INFO - PID 1645 | |i|pagename|runs| 05:16:31 INFO - PID 1645 | |0;ai-astar;104;121;122;120;122;122;121;121;122;122 05:16:31 INFO - PID 1645 | |1;audio-beat-detection;158;117;117;162;116;128;116;121;139;120 05:16:31 INFO - PID 1645 | |2;audio-dft;210;212;213;216;214;212;208;213;211;215 05:16:31 INFO - PID 1645 | |3;audio-fft;85;64;63;99;66;64;67;64;82;60 05:16:31 INFO - PID 1645 | |4;audio-oscillator;99;77;96;75;74;74;97;98;81;90 05:16:31 INFO - PID 1645 | |5;imaging-gaussian-blur;90;90;92;91;92;92;91;93;93;91 05:16:31 INFO - PID 1645 | |6;imaging-darkroom;100;100;126;153;99;124;147;100;100;100 05:16:31 INFO - PID 1645 | |7;imaging-desaturate;132;154;100;102;102;102;100;99;102;102 05:16:31 INFO - PID 1645 | |8;json-parse-financial;50;51;51;50;52;52;52;51;52;52 05:16:31 INFO - PID 1645 | |9;json-stringify-tinderbox;58;66;61;77;69;67;63;62;64;63 05:16:31 INFO - PID 1645 | |10;stanford-crypto-aes;95;116;120;91;90;89;93;80;89;108 05:16:31 INFO - PID 1645 | |11;stanford-crypto-ccm;161;181;154;158;150;153;175;159;272;211 05:16:31 INFO - PID 1645 | |12;stanford-crypto-pbkdf2;202;201;201;239;245;228;199;201;201;198 05:16:31 INFO - PID 1645 | |13;stanford-crypto-sha256-iterative;74;73;71;73;73;72;72;73;72;73 05:16:31 INFO - PID 1645 | __end_tp_report 05:16:31 INFO - PID 1645 | __start_cc_report 05:16:31 INFO - PID 1645 | _x_x_mozilla_cycle_collect,2147 05:16:31 INFO - PID 1645 | __end_cc_report 05:16:31 INFO - PID 1645 | __startTimestamp1491999391947__endTimestamp 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | ------- Summary: start ------- 05:16:31 INFO - PID 1645 | Number of tests: 14 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | [#0] ai-astar Cycles:10 Average:119.70 Median:122.00 stddev:5.56 (4.6%) stddev-sans-first:0.73 05:16:31 INFO - PID 1645 | Values: 104.0 121.0 122.0 120.0 122.0 122.0 121.0 121.0 122.0 122.0 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:124.50 stddev:17.64 (14.2%) stddev-sans-first:15.38 05:16:31 INFO - PID 1645 | Values: 158.0 117.0 117.0 162.0 116.0 128.0 116.0 121.0 139.0 120.0 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | [#2] audio-dft Cycles:10 Average:212.40 Median:213.00 stddev:2.37 (1.1%) stddev-sans-first:2.35 05:16:31 INFO - PID 1645 | Values: 210.0 212.0 213.0 216.0 214.0 212.0 208.0 213.0 211.0 215.0 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | [#3] audio-fft Cycles:10 Average:71.40 Median:66.50 stddev:12.79 (19.2%) stddev-sans-first:12.58 05:16:31 INFO - PID 1645 | Values: 85.0 64.0 63.0 99.0 66.0 64.0 67.0 64.0 82.0 60.0 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | [#4] audio-oscillator Cycles:10 Average:86.10 Median:93.00 stddev:10.88 (11.7%) stddev-sans-first:10.49 05:16:31 INFO - PID 1645 | Values: 99.0 77.0 96.0 75.0 74.0 74.0 97.0 98.0 81.0 90.0 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:91.50 Median:92.00 stddev:1.08 (1.2%) stddev-sans-first:1.00 05:16:31 INFO - PID 1645 | Values: 90.0 90.0 92.0 91.0 92.0 92.0 91.0 93.0 93.0 91.0 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | [#6] imaging-darkroom Cycles:10 Average:114.90 Median:125.00 stddev:21.22 (17.0%) stddev-sans-first:21.81 05:16:31 INFO - PID 1645 | Values: 100.0 100.0 126.0 153.0 99.0 124.0 147.0 100.0 100.0 100.0 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | [#7] imaging-desaturate Cycles:10 Average:109.50 Median:102.00 stddev:18.43 (18.1%) stddev-sans-first:17.66 05:16:31 INFO - PID 1645 | Values: 132.0 154.0 100.0 102.0 102.0 102.0 100.0 99.0 102.0 102.0 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.73 05:16:31 INFO - PID 1645 | Values: 50.0 51.0 51.0 50.0 52.0 52.0 52.0 51.0 52.0 52.0 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:5.25 (8.1%) stddev-sans-first:4.92 05:16:31 INFO - PID 1645 | Values: 58.0 66.0 61.0 77.0 69.0 67.0 63.0 62.0 64.0 63.0 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | [#10] stanford-crypto-aes Cycles:10 Average:97.10 Median:89.50 stddev:13.05 (14.6%) stddev-sans-first:13.82 05:16:31 INFO - PID 1645 | Values: 95.0 116.0 120.0 91.0 90.0 89.0 93.0 80.0 89.0 108.0 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:177.40 Median:168.00 stddev:37.97 (22.6%) stddev-sans-first:39.81 05:16:31 INFO - PID 1645 | Values: 161.0 181.0 154.0 158.0 150.0 153.0 175.0 159.0 272.0 211.0 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:211.50 Median:201.50 stddev:18.32 (9.1%) stddev-sans-first:19.11 05:16:31 INFO - PID 1645 | Values: 202.0 201.0 201.0 239.0 245.0 228.0 199.0 201.0 201.0 198.0 05:16:31 INFO - PID 1645 | 05:16:31 INFO - PID 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:73.00 stddev:0.84 (1.2%) stddev-sans-first:0.73 05:16:31 INFO - PID 1645 | Values: 74.0 73.0 71.0 73.0 73.0 72.0 72.0 73.0 72.0 73.0 05:16:31 INFO - PID 1645 | -------- Summary: end -------- 05:16:31 INFO - PID 1645 | 05:16:33 INFO - TEST-INFO | 1645: exit 0 05:16:33 INFO - TEST-OK | kraken | took 63309ms 05:16:33 INFO - SUITE-END | took 1182s 05:16:33 INFO - Completed test suite (00:19:43) 05:16:33 INFO - javascript benchmark 05:16:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7693.044069878175, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3295.8516866741, 3450.2064525159212, 3482.7213822894173, 3495.5106285120087, 3550.591681956576, 6019.277686677599, 6024.1566180734735, 6072.240969878765, 6093.927390448616, 6112.205413296277, 6050.699842947655, 6097.695115244231, 6129.601575897564, 6131.101423540794, 6145.340757995338, 4843.854684359458, 5140.717260550687, 5253.0544501989625, 5289.8942021159555, 5388.811391601294, 5316.175992721134, 5316.787328506855, 5359.705216213107, 5364.007658583175, 5418.729063546826, 5145.948540514603, 5212.139996900507, 5232.555232805216, 5274.789008439658, 5361.865953351197, 5263.552598029172, 5283.86790330241, 5287.259783630295, 5354.330708661418, 5360.517553420172, 5273.446288139767, 5291.28567643367, 5292.259083728281, 5296.3379577552805, 5348.866278343034, 5816.88366232673, 5876.030454974924, 6076.027835546335, 6129.988551888933, 6139.324674285825, 6330.27201871786, 6370.58591191571, 6380.10678505005, 6407.167068281094, 6411.070394792776, 6333.145025421555, 6340.746370145189, 6357.809265722036, 6397.296297407328, 6503.122078519386, 6178.135061091451, 6218.81343559694, 6220.937790622081, 6224.1597384352535, 6254.9687251563455, 6681.0, 6687.866242675119, 6693.698783554752, 6699.464042876558, 6706.161729783777, 6266.968665156645, 6297.275813281532, 6344.048392741126, 6353.332900045429, 6372.522060845455, 6445.2265728112925, 6451.225852897683, 6459.709313080923, 6463.6768161591735, 6466.450351720063, 6361.14124593174, 6361.968190159019, 6363.268224154189, 6365.745370185234, 6370.713317900613, 6304.054391841169, 6355.809325720235, 6393.0, 6398.648074355955, 6411.647359395278, 5145.253938178943, 5177.948220517746, 5221.686698798084, 5223.373195216598, 5254.106801843619, 4611.723296602215, 4633.698809577367, 4639.280911458729, 4645.512221216791, 4678.274867395559, 5940.554458415636, 6059.909101363483, 6187.071939209065, 6222.937770622236, 6238.968805155945, 6340.270868850142, 6433.710483028275, 6491.318411566717, 6497.577657452251, 6499.155109835786, 6162.5378096642935, 6200.503959683305, 6212.0371342441995, 6214.533909956771, 6215.9378406215355, 5728.398518155617, 5739.483446489836, 5745.052066408995, 5747.712614369265, 5798.971005144947, 6334.683265836782, 6355.046742988404, 6415.0, 6417.294097649162, 6418.967905160444, 6347.365263473615, 6361.745530178741, 6373.521985850987, 6379.96810015947, 6390.105385245976, 6508.186476690414, 6566.540342176002, 6591.242007169045, 6593.208814942238, 6626.701798419179, 6357.14178585885, 6383.138276332821, 6383.904241436289, 6387.55287129915, 6391.265004524539, 6296.0, 6452.064450654722, 6468.353164683494, 6480.963045912631, 6483.967580162258, 6244.594101383395, 6249.593776404519, 6257.0, 6323.588966717149, 6330.0, 6342.080398342307, 6357.968210159104, 6358.713857876314, 6382.712777924911, 6385.13800636908, 6265.154204182377, 6325.240971083499, 6336.239651241881, 6338.11266422692, 6353.8729225416155, 6206.224221972254, 6281.528885333527, 6290.528210384331, 6295.748170073146, 6330.968345158245, 5114.79540818378, 6349.904751428639, 6351.650659213788, 6359.236891573041, 6363.300036996019], "value": 5928.734256954813, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.7263526177684, 786.2452046035805, 812.3704129299792, 1115.8437818705377, 1137.2494153858454, 27436.72563274369, 27875.721242787567, 27915.58126628102, 27940.161795146152, 27940.99999999995, 37768.0, 38213.808930955376, 38226.0, 38229.235415291674, 38348.61651383485, 8472.237498625107, 8653.350998675092, 8658.740237792845, 8660.17728315809, 8677.609507572142, 6059.42435468632, 6212.378762123797, 8452.704155354564, 8600.827983440327, 8610.009848867398, 8510.191531804468, 8692.608832602516, 8718.956405217998, 8724.563771811416, 8738.038815730264, 8693.347998900077, 8751.868721969111, 8752.824943501095, 8777.824443511126, 8784.56077196144, 5303.946960530422, 6029.095635654687, 8430.45202061864, 8528.403011789178, 8535.317174626016, 36212.818935905154, 36698.7155449558, 36736.448953265724, 36764.816175919215, 36796.264074718354, 3617.5478065241846, 3663.8351274192723, 3666.4683620874825, 3667.5965643779164, 3671.706263498914, 30506.0, 30826.921057763095, 30836.0, 30837.537436938463, 30857.537136942738, 3106.2544989202656, 3129.264622813637, 3153.5269709543522, 3161.936761264762, 3170.746340292771, 266549.0, 270530.647346762, 270746.0, 270920.0, 271510.0, 48996.26505602419, 49183.0, 49232.507674922796, 49275.50724492709, 49279.753601231765, 51087.0, 51187.74406127945, 51199.7440012805, 51235.7438212814, 51281.743591281804, 13398.799018014737, 13470.528531501546, 13485.797713034312, 13527.98540109476, 13569.25369104689, 10800.297980631234, 10881.945590272157, 10962.0, 10973.23187376876, 10992.505337259843, 8653.221210091122, 10580.25938184335, 10723.14214862809, 12033.939830300968, 12295.385230738606, 4297.0, 5528.087865502228, 5545.77816887328, 5563.666180029211, 5565.387807341189, 1000.7698229407277, 1019.5615885169449, 1026.6919924022764, 1062.8671416072991, 1065.7974984752873, 23173.884130579238, 24264.16948294592, 24286.392840179138, 24297.635535466983, 24320.756792432203, 1120.2270433400927, 1123.612353737959, 1135.6422726841183, 1161.3670549550347, 1172.197045024161, 11824.586139485249, 12385.318807465675, 12442.875571244353, 12525.749485010248, 12534.498620055278, 285445.0, 322790.7720922761, 336119.0, 336592.0, 337065.0, 50033.0, 50138.0, 50209.24267650615, 50237.24644130341, 50274.74862625664, 1497.10922001409, 1508.057464084947, 1545.4436402894949, 1547.7523596224776, 1553.0759198277008, 22534.098636054376, 23730.644040339062, 23752.643710344015, 23832.642510362013, 23916.40208994789, 37563.0, 37593.24813503769, 37634.62365376421, 37670.434943475324, 37675.81162094172, 308909.0, 308995.0, 309246.0, 310057.0, 310195.8980410167, 33889.0, 34662.30675386528, 34809.65190348064, 34842.30315393729, 34862.12844678904, 36513.81743091268, 37050.0, 37051.0, 45007.54992450034, 45028.549714502435, 23611.40971475658, 24884.05804320824, 27930.0, 28313.57529637016, 29217.61735739656, 23254.455156295568, 29839.254018649706, 30520.11140617905, 30532.389352213275, 30637.846810765805, 29133.417331653673, 35378.82310588431, 36008.0, 36748.81625591855, 36870.446943295334, 29604.0, 30085.398292034475, 30517.23706907345, 30549.389012220076, 30726.078217653507, 17614.383496577557, 21040.0, 23002.424939376648, 23600.763992359858, 23750.0], "value": 16896.16556774307, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.74164938666394, 390.83780231204054, 415.14687317562397, 427.12226374799775, 430.7372502773309, 20486.487837804045, 20987.580248395025, 21538.246161384315, 21745.456363590918, 21889.67165492519, 16465.83534164658, 21137.15451381943, 22356.21753238637, 22952.196673116443, 23139.421514462105, 6038.154658347835, 6327.936720632781, 6334.651594162319, 6334.873302533946, 6341.04884267359, 5984.072468767326, 6169.691515424233, 6194.50443964484, 6277.4664153547, 6292.276388215368, 6227.1282020517165, 6243.8126856194385, 6246.906296405557, 6251.781187658433, 6267.279262884781, 6071.210742603455, 6142.723577439004, 6170.413810688, 6250.718717657671, 6254.781082662131, 5218.478152184789, 5559.166125081229, 5559.610827242094, 5569.637973531748, 5581.302337207849, 22348.10607575695, 26869.865650671818, 27132.728672713216, 27373.863130684418, 27522.862385688142, 2200.5378870437225, 2211.579799838026, 2216.1357070742424, 2245.7978781909706, 2248.022110381989, 17898.836575622543, 18037.18832652534, 18332.54168645781, 18486.15138486154, 18623.161957711935, 2137.4335801012744, 2138.711273978024, 2149.0544160569298, 2171.83711221659, 2184.421128400975, 142149.28925355308, 142300.0, 143660.28169859084, 144199.0, 157417.21291393583, 11611.0, 11767.705807354885, 12186.57346992851, 12202.023838092931, 12280.938595307145, 13840.93079534596, 16291.185440727917, 16293.755593666105, 16296.918515407348, 16300.836991629933, 7347.88978165328, 8693.217890332468, 8990.595423205972, 9010.0, 9057.003729589871, 7460.328570428579, 7499.0, 8293.170682931659, 8565.357598180037, 8792.252658524098, 6893.827654308582, 7650.196729343339, 7694.778402043691, 7746.573938433327, 7847.450678452567, 1787.294018862568, 1919.6256729937807, 2145.5065334972733, 2148.5810266997787, 2216.34617787753, 905.298393744853, 925.3291363761354, 935.6351023100996, 973.532704301939, 1008.0473952115327, 16719.91640041792, 20317.79682203159, 21132.47168820792, 21138.57722845565, 21233.256836010976, 962.2109869906609, 967.583938906263, 992.7716625176106, 993.5429702336861, 1004.0060340263233, 10655.520501577448, 10997.61508347204, 11013.889861101447, 11063.214810754274, 11105.666829995112, 615174.0, 621938.0, 626406.0, 638709.0, 643863.0, 105774.47112764388, 138718.0, 144662.0, 147681.0, 153151.0, 1078.5200585739271, 1156.7686462707493, 1189.3696340939316, 1192.1952681939656, 1197.7544603356291, 18238.361657341928, 19778.109985050418, 22221.0, 22449.551008980055, 22670.773292266866, 59250.70374648099, 59668.70165649144, 62033.68983155055, 62820.0, 63100.0, 86842.0, 87760.5611971936, 88174.0, 89352.0, 93934.53032734792, 7662.7394918500295, 7814.0, 7977.48146370484, 8987.101289871222, 9004.054574269607, 14310.713785724436, 14351.928240358731, 14467.85532144665, 14710.823134149028, 14714.55856324312, 11449.656510304705, 11587.536498539965, 11916.34460104668, 11946.880531194576, 12048.337341446304, 11102.777944441228, 11122.388268645302, 11258.324500529994, 11530.94234528822, 11783.057355411718, 10710.410927399067, 11576.710582235175, 11952.0, 11997.100217483548, 12116.151869369412, 8866.049469116784, 8951.328650351119, 8967.282617390463, 9063.68277110298, 9181.77045573866, 11917.642470725892, 12020.437343145684, 12144.635660930186, 12181.33002684861, 12198.817017744563], "value": 10468.654858951611, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.5668586052461, 1406.1492796857901, 1430.113329735564, 1434.1251836379813, 1438.129931391508, 11354.772904541904, 11676.824847627282, 11681.707957301072, 11692.766144677102, 11705.648830535087, 9867.654632087879, 11447.198696091276, 11728.185235543473, 11821.113416493776, 11841.993430558412, 2449.9632505512386, 2529.481456301463, 2529.911453099142, 2530.00064974335, 2532.1390727152766, 2082.427332483564, 2344.0, 2397.7602239776056, 2413.5776239158163, 2426.8907899144583, 2161.049138379108, 2184.3446965910243, 2436.4517983453757, 2527.8609676467786, 2528.987355063222, 2447.2535876557645, 2465.4206261528525, 2479.801615870726, 2482.441450673602, 2485.5153245117117, 2078.6362386582286, 2455.680761501011, 2457.619069044301, 2462.913798017061, 2463.4210960424284, 11455.828162577567, 11752.412379381083, 11755.58855440064, 11757.059435245246, 11772.823407648892, 6328.335524769925, 6624.304448032935, 6627.93372066278, 6629.0056491526175, 6632.303608121174, 3912.5109361329833, 4099.467069281004, 4100.097978444737, 4238.258304796679, 4332.501762297313, 1224.687704635321, 1243.608263397027, 1247.1706315300314, 1285.4472576791975, 1290.6386211860695, 16050.197490125447, 16359.83640163607, 16385.59036024097, 16400.0, 16407.261673224613, 5775.48020678141, 5796.188533605298, 5919.911201331984, 6035.245594300713, 6056.939430605637, 13804.723905521832, 13823.723525529635, 13827.446902123802, 13827.51603693866, 13827.962902782332, 5707.71461426927, 6722.865542689119, 6738.124043874265, 6740.83147921296, 6743.662816859138, 5897.7935772247765, 6109.266887973472, 6191.349908259568, 6227.782027629102, 6258.405451482102, 4496.775161241925, 4649.465311489154, 4657.673962822638, 4698.224792909132, 4748.264019077049, 1402.8917155447082, 1453.872850764233, 1458.8541145885326, 1476.9556913292618, 1485.581269887255, 666.8720619366109, 712.750537311947, 796.5141263829059, 802.7792357101844, 809.5304723260494, 6599.70301336441, 6716.899246511306, 6771.221309549464, 6844.657767111724, 6852.383285504328, 582.3477704970376, 583.6206465797181, 589.6049646736697, 593.3206478581999, 641.4900154377189, 4170.687198460128, 4213.578642135762, 4217.894552636209, 4325.372820941009, 4332.631726303236, 14228.715425691427, 14968.081224161402, 14991.775123373158, 15010.174440405883, 15011.324490397958, 14298.213598252196, 14705.632359191106, 14793.704125917637, 14794.926025369805, 14800.925995369955, 10717.946410268054, 10843.891561084289, 10845.891541084646, 10849.457527123612, 10851.67444976652, 6270.5924114934205, 6287.2140982377205, 6590.703418346282, 6703.865922681616, 6736.528443009139, 13033.674158145743, 13421.261830599411, 13434.992375571675, 13438.924886008901, 13447.798283025566, 13406.865931340952, 13632.386542605806, 13861.930690346888, 13868.514601988882, 13885.652858678613, 9146.862797058182, 9247.583858726508, 9253.352265341631, 9367.156955874005, 9394.765130871783, 10351.844722329322, 10484.52819623134, 10484.63303784364, 10488.0, 10502.789944201226, 8424.03123640789, 8599.95700021496, 8676.479411235347, 8682.34882383811, 8844.425112367675, 8172.550509721785, 8327.875081873897, 8343.749687509384, 8356.289715374262, 8400.159984001551, 6634.900476492953, 8015.438919275594, 8017.559034253172, 8023.879641805261, 8033.277005069338, 5851.736671849691, 5961.2846458425265, 6044.546659000504, 6112.572119951738, 6138.877222455615, 5251.606129540223, 5301.231321458444, 5441.037256583363, 5546.223528706065, 5587.770690448095], "value": 5328.33273566617, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.3216722484813, 391.4734681852907, 391.99999999999994, 407.0353262767241, 409.9587048895805, 5358.598105142115, 5567.359753628334, 5756.194132821398, 5919.0, 5940.0, 5611.663300201981, 5612.382637909837, 5690.687012214326, 5724.084146536555, 5783.2481777368985, 3854.6338097880657, 4488.708233964798, 4493.9550604494025, 4513.864584062467, 4539.863804085882, 4252.489701235856, 4346.282863327548, 4454.33185022246, 4467.17357288901, 4515.841945531907, 3729.533808273966, 3781.6596506314427, 4117.2177286315655, 4253.191893540233, 4366.297144113782, 3050.908472745821, 3890.754958413309, 4049.5343035550995, 4460.620847227973, 4466.53101424349, 3305.520699498559, 3981.6814654827544, 3984.860529881469, 4003.0, 4004.5795191505053, 5406.675599464044, 5642.915356269659, 5681.687507187103, 5713.971430142823, 5727.971360143214, 4460.4647442306805, 4841.7337046462435, 4844.971892567146, 5077.796888124471, 5095.439501654815, 5464.9453505465235, 5863.5341164708825, 6170.784022559234, 6173.197484327009, 6249.625022498664, 4066.166435880667, 4174.540800511942, 4189.2668782963165, 4218.873433796991, 4254.91490170198, 5491.423400542965, 6416.615003099829, 6491.740330386826, 6496.350364963513, 6514.967425162891, 3685.5761587417255, 3848.288066707612, 4068.7355321904574, 4238.21593005295, 4255.978720106442, 3536.550014494045, 3750.1374683822874, 4091.509018917749, 4317.784110794448, 4378.233809083397, 5036.169032109734, 5046.62150338726, 5056.64603477753, 5075.137226671474, 5075.771590278447, 5378.596605254622, 5389.514943655012, 6181.96909015452, 6182.536309776785, 6189.978653522208, 1254.5420921363636, 1255.8869701726887, 1408.7745960646248, 1461.9780703289246, 1477.0, 969.3327476739996, 981.5926390547985, 981.9116279534876, 1001.7910507331317, 1002.3835341265069, 5802.564807639444, 5839.649621022752, 5862.560307976919, 5866.208061911672, 5920.0, 5510.889782204334, 6214.502839772807, 6361.809145725636, 6370.777022804273, 6381.361863813581, 5323.973380133075, 5453.209284653703, 5590.413006634326, 5734.0, 5836.358000619928, 2803.8644349038673, 2974.628171478565, 3308.569885914864, 3338.2655815720505, 3342.699157075875, 6180.629162250189, 6201.782787704314, 6528.575642583217, 6539.5149843059335, 6557.7704780333415, 6498.288740662982, 6512.804615861532, 6527.118838956775, 6532.706028228741, 6534.738610455529, 5195.804964858104, 5936.13925980739, 6362.377593713573, 6366.5252656863495, 6441.935580644134, 5559.638623489622, 6357.491400687842, 6369.8726025480155, 6381.8723625528155, 6389.137466441971, 5607.214989901336, 5866.530677545871, 6056.1824153740445, 6231.657258850625, 6260.7495700171485, 5924.911126333194, 6437.967810160919, 6480.222373315044, 6514.133781136285, 6514.315996820265, 3747.306748251582, 4263.253930562201, 4265.616094551505, 4267.914641707086, 4274.893127671833, 5641.689707065987, 5850.385709500441, 6318.273398559225, 6352.142460767737, 6366.586171898812, 5942.257217847769, 6081.5134789217645, 6152.261728592597, 6157.538184636081, 6167.784127555514, 4849.496656036499, 5364.436734142859, 5732.194358776972, 5767.961766882002, 6154.446099850856, 4743.762811859462, 5085.64400491962, 5591.692456914909, 5744.511716504144, 5955.40445955401, 5492.80775172883, 6083.361247068994, 6105.603135796159, 6150.446459818638, 6180.258368995749, 5016.996600679951, 5743.253377060955, 5932.79235226765, 5958.152972578515, 6024.6745715942425], "value": 4474.702351827612, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.0508813102316, 727.9454040946929, 852.6078004118109, 855.6235256487145, 863.9977625953894, 13317.467301307948, 17908.47777938875, 18001.729974050366, 18647.720284195748, 18679.906600467013, 13898.93050534746, 16841.073740944244, 17336.393226237084, 17392.0, 17398.478045658652, 970.6602689058843, 991.732232297283, 995.2635050062937, 998.121652945407, 1000.7147962830595, 679.259607028339, 695.686940876605, 984.7784248544092, 994.1351024608565, 1017.9592816287377, 1052.715766742979, 1053.7681710023821, 1054.9261551691384, 1056.968290951269, 1061.8566493523354, 1044.968650940473, 1047.6856942917095, 1048.4233671480656, 1050.9106725928305, 1067.3169171730099, 780.594091072639, 782.1982467970319, 787.5668382389663, 787.7676085554775, 793.3692714292151, 16444.34222631093, 16638.75041874373, 16855.325786968508, 16856.0, 17153.914230428894, 16079.598010049725, 16232.675346493123, 16275.51173464798, 16452.095134767584, 16701.749473757904, 13473.595792126252, 13551.864481355158, 13601.979851511078, 13625.046246762731, 13721.45114195431, 3406.369821583015, 3411.880584179542, 3412.436947903593, 3417.2482053948092, 3417.2994536120036, 101029.494852526, 101066.0, 101562.49218753933, 101589.0, 101700.0, 10628.14974802014, 11951.641450756491, 12020.218685785396, 12104.57633982824, 12293.877061229452, 24085.51828963411, 24343.878280608482, 24381.14665986682, 24625.384365391008, 24675.0, 8615.870761938577, 8634.6977855776, 8652.740417787476, 8668.653253869901, 8705.91294087051, 4696.81212751493, 4885.2427873679635, 4886.120498310267, 4886.340344053508, 4887.0714564232685, 4294.141171765659, 4345.500267469219, 4375.5405682403525, 4402.823887044482, 4410.757408342508, 885.3581153663671, 897.5781382750097, 909.4725059465494, 910.0717268386342, 910.1899309614448, 648.2706954675989, 653.2683394598081, 654.2149420695184, 661.1999480628493, 680.1905732178692, 10349.689509314732, 11134.944325278484, 11634.592789252505, 11658.6502404928, 11671.766564668658, 638.6902352359102, 657.81252343082, 658.6805399381392, 684.9794506164823, 691.3328637864485, 5269.446708095671, 5289.2859463972645, 5478.671279723229, 5613.129964855454, 5810.157527158538, 95609.0, 96067.0, 98011.50994244983, 100225.0, 104181.47909260406, 70083.89748307559, 90243.0, 92045.0, 92912.53543732374, 95858.33133349454, 62897.68551157215, 77007.0, 80953.59523202346, 81783.18216817874, 83467.64517677143, 12152.878471215176, 12322.753544928872, 12329.136960412685, 12564.371781411075, 12636.87363126357, 39009.414858776574, 40234.0, 40353.0, 41288.38067429051, 41708.79145604253, 67816.6609166951, 68437.31562684309, 70193.94709079266, 70471.94292085725, 71275.0, 15894.092708875009, 16735.414260500824, 16749.497515074567, 16750.497485075466, 16776.0, 18176.909115454866, 18203.271869125616, 18355.174017169527, 18426.262949481872, 18655.626887462447, 12867.906227970727, 14817.259137042889, 15626.140562269184, 15858.207089645703, 15962.68074638524, 13801.171929684251, 16390.508284751475, 16619.002859828448, 16959.321627134777, 17035.574110646838, 14140.575782726122, 16228.51314460568, 16265.51203463898, 16270.837291626933, 16316.592085197964, 11399.0, 11655.18413711066, 11683.474243658886, 11800.586979456022, 11850.05199584014, 11176.776464470502, 12313.44589493457, 12685.175463594836, 12689.794563639667, 12862.807057893951], "value": 8290.107169213556, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1609.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 121.0, 122.0, 120.0, 122.0, 122.0, 121.0, 121.0, 122.0, 122.0], "value": 119.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 117.0, 117.0, 162.0, 116.0, 128.0, 116.0, 121.0, 139.0, 120.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [210.0, 212.0, 213.0, 216.0, 214.0, 212.0, 208.0, 213.0, 211.0, 215.0], "value": 212.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 64.0, 63.0, 99.0, 66.0, 64.0, 67.0, 64.0, 82.0, 60.0], "value": 71.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 77.0, 96.0, 75.0, 74.0, 74.0, 97.0, 98.0, 81.0, 90.0], "value": 86.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 92.0, 91.0, 92.0, 92.0, 91.0, 93.0, 93.0, 91.0], "value": 91.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 100.0, 126.0, 153.0, 99.0, 124.0, 147.0, 100.0, 100.0, 100.0], "value": 114.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 154.0, 100.0, 102.0, 102.0, 102.0, 100.0, 99.0, 102.0, 102.0], "value": 109.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 51.0, 50.0, 52.0, 52.0, 52.0, 51.0, 52.0, 52.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 66.0, 61.0, 77.0, 69.0, 67.0, 63.0, 62.0, 64.0, 63.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 116.0, 120.0, 91.0, 90.0, 89.0, 93.0, 80.0, 89.0, 108.0], "value": 97.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 181.0, 154.0, 158.0, 150.0, 153.0, 175.0, 159.0, 272.0, 211.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 201.0, 201.0, 239.0, 245.0, 228.0, 199.0, 201.0, 201.0, 198.0], "value": 211.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 71.0, 73.0, 73.0, 72.0, 72.0, 73.0, 72.0, 73.0], "value": 72.6, "unit": "score"}]}]} 05:16:33 INFO - Return code: 0 05:16:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:16:33 ERROR - # TBPL SUCCESS # 05:16:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:16:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:16:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:16:33 INFO - 2017-04-12 05:16:33.746 screenresolution[1649:9867] starting screenresolution argv=screenresolution get 05:16:33 INFO - 2017-04-12 05:16:33.749 screenresolution[1649:9867] Display 0: 1600x1200x32@60 05:16:33 INFO - 2017-04-12 05:16:33.755 screenresolution[1650:9870] starting screenresolution argv=screenresolution list 05:16:33 INFO - Available Modes on Display 0 05:16:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:16:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:16:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:16:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:16:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:16:33 INFO - Intel Iris: 05:16:33 INFO - Chipset Model: Intel Iris 05:16:33 INFO - Type: GPU 05:16:33 INFO - Bus: Built-In 05:16:33 INFO - VRAM (Dynamic, Max): 1536 MB 05:16:33 INFO - Vendor: Intel (0x8086) 05:16:33 INFO - Device ID: 0x0a2e 05:16:33 INFO - Revision ID: 0x0009 05:16:33 INFO - Displays: 05:16:33 INFO - Display: 05:16:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:16:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:16:33 INFO - Display Serial Number: 1600x1200 60 05:16:33 INFO - Main Display: Yes 05:16:33 INFO - Mirror: Off 05:16:33 INFO - Online: Yes 05:16:33 INFO - Rotation: Supported 05:16:33 INFO - Return code: 0 05:16:33 INFO - Running post-action listener: _resource_record_post_action 05:16:33 INFO - [mozharness: 2017-04-12 12:16:33.993418Z] Finished run-tests step (success) 05:16:33 INFO - Running post-run listener: _resource_record_post_run 05:16:34 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 39302144; Write bytes: 518942208; Read time: 460; Write time: 1635 05:16:34 INFO - TinderboxPrint: CPU usage
53.6% 05:16:34 INFO - TinderboxPrint: I/O read bytes / time
39,302,144 / 460 05:16:34 INFO - TinderboxPrint: I/O write bytes / time
518,942,208 / 1,635 05:16:34 INFO - TinderboxPrint: CPU idle
2,235.3 (46.4%) 05:16:34 INFO - TinderboxPrint: CPU system
964.9 (20.0%) 05:16:34 INFO - TinderboxPrint: CPU user
1,617.4 (33.6%) 05:16:34 INFO - TinderboxPrint: Swap in / out
246,788,096 / 0 05:16:34 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207487488; Write bytes: 204215808; Read time: 15827; Write time: 408 05:16:34 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 37106688; Write bytes: 307656704; Read time: 360; Write time: 1199 05:16:34 INFO - Running post-run listener: _upload_blobber_files 05:16:34 INFO - Blob upload gear active. 05:16:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:16:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:16:34 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'] 05:16:34 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 05:16:34 INFO - (blobuploader) - INFO - Open directory for files ... 05:16:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:16:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:16:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:36 INFO - (blobuploader) - INFO - Done attempting. 05:16:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:16:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:16:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:36 INFO - (blobuploader) - INFO - Done attempting. 05:16:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:16:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:16:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:37 INFO - (blobuploader) - INFO - Done attempting. 05:16:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:16:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:16:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:39 INFO - (blobuploader) - INFO - Done attempting. 05:16:39 INFO - (blobuploader) - INFO - Iteration through files over. 05:16:39 INFO - Return code: 0 05:16:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:16:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:16:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3363448dda523ca091694a030148d29199e3167b667de86e7f9681a505727c635ac016aa8d33f29296e7c3264069c4574f64649a66acdc1630490a0ec4d4881", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25eee2c908300c7b9ca39593fa855adb9ffe11c5027b18295d9fc1d72c22663ff53784412b1c5a7cc3996e2ef48e2c71c8d0cd7c7b485ac4ce9392f1a3bd6d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8056a71cfef854dd285d102e075d9619ad1f3561ba46712df9b92ce97995cf123f60435904f0c73c8373eeb562c0e2cfe35450701e54f1dea1436b049cb5757", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c23e4a91f5dd2a87561cdb2ce0fa60ea7df2c420d992b245ade921a50f304745ac0ab3cdbf76bd5a16d1f5f0a0e9d05f2646ff53dd56a95d968740c883d686a"} 05:16:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:16:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:16:39 INFO - Contents: 05:16:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3363448dda523ca091694a030148d29199e3167b667de86e7f9681a505727c635ac016aa8d33f29296e7c3264069c4574f64649a66acdc1630490a0ec4d4881", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25eee2c908300c7b9ca39593fa855adb9ffe11c5027b18295d9fc1d72c22663ff53784412b1c5a7cc3996e2ef48e2c71c8d0cd7c7b485ac4ce9392f1a3bd6d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8056a71cfef854dd285d102e075d9619ad1f3561ba46712df9b92ce97995cf123f60435904f0c73c8373eeb562c0e2cfe35450701e54f1dea1436b049cb5757", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c23e4a91f5dd2a87561cdb2ce0fa60ea7df2c420d992b245ade921a50f304745ac0ab3cdbf76bd5a16d1f5f0a0e9d05f2646ff53dd56a95d968740c883d686a"} 05:16:39 INFO - Running post-run listener: copy_logs_to_upload_dir 05:16:39 INFO - Copying logs to upload dir... 05:16:39 INFO - mkdir: /builds/slave/test/build/upload/logs 05:16:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.455397 ========= master_lag: 1.36 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-04-12 05:16:41.354230) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 05:16:41.362909) ========= 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.pjQxT87tPk/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.IAqGPqNrHL/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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/b3363448dda523ca091694a030148d29199e3167b667de86e7f9681a505727c635ac016aa8d33f29296e7c3264069c4574f64649a66acdc1630490a0ec4d4881", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25eee2c908300c7b9ca39593fa855adb9ffe11c5027b18295d9fc1d72c22663ff53784412b1c5a7cc3996e2ef48e2c71c8d0cd7c7b485ac4ce9392f1a3bd6d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8056a71cfef854dd285d102e075d9619ad1f3561ba46712df9b92ce97995cf123f60435904f0c73c8373eeb562c0e2cfe35450701e54f1dea1436b049cb5757", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c23e4a91f5dd2a87561cdb2ce0fa60ea7df2c420d992b245ade921a50f304745ac0ab3cdbf76bd5a16d1f5f0a0e9d05f2646ff53dd56a95d968740c883d686a"} build_url:https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/Nuelwv5HSC2ttXj2gwzGqw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3363448dda523ca091694a030148d29199e3167b667de86e7f9681a505727c635ac016aa8d33f29296e7c3264069c4574f64649a66acdc1630490a0ec4d4881", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25eee2c908300c7b9ca39593fa855adb9ffe11c5027b18295d9fc1d72c22663ff53784412b1c5a7cc3996e2ef48e2c71c8d0cd7c7b485ac4ce9392f1a3bd6d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8056a71cfef854dd285d102e075d9619ad1f3561ba46712df9b92ce97995cf123f60435904f0c73c8373eeb562c0e2cfe35450701e54f1dea1436b049cb5757", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c23e4a91f5dd2a87561cdb2ce0fa60ea7df2c420d992b245ade921a50f304745ac0ab3cdbf76bd5a16d1f5f0a0e9d05f2646ff53dd56a95d968740c883d686a"}' ========= master_lag: 0.88 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 05:16:42.252739) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 05:16:42.253173) ========= 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.pjQxT87tPk/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.IAqGPqNrHL/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.005243 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 05:16:42.280717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 05:16:42.281035) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 05:16:42.281397) ========= ========= Total master_lag: 2.33 =========