builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0374 starttime: 1490017885.3 results: success (0) buildid: 20170320050941 builduid: a0f9e0d752ee4c17a64295da920709a7 revision: cb4e80abb488f37ec67c4760a128ae177697667b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 06:51:25.300855) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 06:51:25.301292) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 06:51:25.301571) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 06:51:25.327650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 06:51:25.327977) ========= 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.tD6dP4YpRU/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.6QAWnJk68A/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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-03-20 06:51:25-- 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% 23.0M=0.001s 2017-03-20 06:51:25 (23.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130782 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 06:51:25.483581) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 06:51:25.483921) ========= 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.tD6dP4YpRU/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.6QAWnJk68A/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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.031702 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 06:51:25.538367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-20 06:51:25.538736) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cb4e80abb488f37ec67c4760a128ae177697667b --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 cb4e80abb488f37ec67c4760a128ae177697667b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tD6dP4YpRU/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.6QAWnJk68A/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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-03-20 06:51:25,639 truncating revision to first 12 chars 2017-03-20 06:51:25,640 Setting DEBUG logging. 2017-03-20 06:51:25,640 attempt 1/10 2017-03-20 06:51:25,640 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cb4e80abb488?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-20 06:51:26,832 unpacking tar archive at: mozilla-central-cb4e80abb488/testing/mozharness/ program finished with exit code 0 elapsedTime=1.472818 ========= master_lag: 1.59 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-20 06:51:28.599628) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 06:51:28.599964) ========= script_repo_revision: cb4e80abb488f37ec67c4760a128ae177697667b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 06:51:28.600364) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 06:51:28.600632) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 06:51:28.635834) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-20 06:51:28.636206) ========= /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.tD6dP4YpRU/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.6QAWnJk68A/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:51:28 INFO - MultiFileLogger online at 20170320 06:51:28 in /builds/slave/test 06:51:28 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 06:51:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:51:28 INFO - {'append_to_log': False, 06:51:28 INFO - 'base_work_dir': '/builds/slave/test', 06:51:28 INFO - 'blob_upload_branch': 'Firefox', 06:51:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:51:28 INFO - 'branch': 'Firefox', 06:51:28 INFO - 'buildbot_json_path': 'buildprops.json', 06:51:28 INFO - 'config_files': ('talos/mac_config.py',), 06:51:28 INFO - 'default_actions': ('clobber', 06:51:28 INFO - 'read-buildbot-config', 06:51:28 INFO - 'download-and-extract', 06:51:28 INFO - 'populate-webroot', 06:51:28 INFO - 'create-virtualenv', 06:51:28 INFO - 'install', 06:51:28 INFO - 'run-tests'), 06:51:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:51:28 INFO - 'download_minidump_stackwalk': True, 06:51:28 INFO - 'download_symbols': 'ondemand', 06:51:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:51:28 INFO - 'tooltool.py': '/tools/tooltool.py', 06:51:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:51:28 INFO - '/tools/misc-python/virtualenv.py')}, 06:51:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:51:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:51:28 INFO - 'gecko_profile': False, 06:51:28 INFO - 'gecko_profile_interval': 0, 06:51:28 INFO - 'installer_path': 'installer.exe', 06:51:28 INFO - 'log_level': 'info', 06:51:28 INFO - 'log_name': 'talos', 06:51:28 INFO - 'log_to_console': True, 06:51:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:51:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:51:28 INFO - 'opt_config_files': (), 06:51:28 INFO - 'pip_index': False, 06:51:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:51:28 INFO - 'cmd': ('bash', 06:51:28 INFO - '-c', 06:51:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:51:28 INFO - 'enabled': True, 06:51:28 INFO - 'halt_on_failure': False, 06:51:28 INFO - 'name': 'check_screen_resolution'},), 06:51:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:51:28 INFO - 'cmd': ('bash', 06:51:28 INFO - '-c', 06:51:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:51:28 INFO - 'enabled': True, 06:51:28 INFO - 'halt_on_failure': False, 06:51:28 INFO - 'name': 'check_screen_resolution'},), 06:51:28 INFO - 'run_cmd_checks_enabled': True, 06:51:28 INFO - 'suite': 'dromaeojs', 06:51:28 INFO - 'system_bits': '32', 06:51:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:51:28 INFO - 'title': 't-yosemite-r7-0374', 06:51:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:51:28 INFO - 'use_talos_json': True, 06:51:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:51:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:51:28 INFO - 'work_dir': 'build'} 06:51:28 INFO - [mozharness: 2017-03-20 13:51:28.845651Z] Running clobber step. 06:51:28 INFO - Running pre-action listener: _resource_record_pre_action 06:51:28 INFO - Running main action method: clobber 06:51:28 INFO - rmtree: /builds/slave/test/build 06:51:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:51:31 INFO - Running post-action listener: _resource_record_post_action 06:51:31 INFO - [mozharness: 2017-03-20 13:51:31.325733Z] Finished clobber step (success) 06:51:31 INFO - [mozharness: 2017-03-20 13:51:31.325926Z] Running read-buildbot-config step. 06:51:31 INFO - Running pre-action listener: _resource_record_pre_action 06:51:31 INFO - Running main action method: read_buildbot_config 06:51:31 INFO - Using buildbot properties: 06:51:31 INFO - { 06:51:31 INFO - "project": "", 06:51:31 INFO - "product": "firefox", 06:51:31 INFO - "script_repo_revision": "production", 06:51:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:51:31 INFO - "repository": "", 06:51:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:51:31 INFO - "buildid": "20170320050941", 06:51:31 INFO - "pgo_build": "False", 06:51:31 INFO - "basedir": "/builds/slave/test", 06:51:31 INFO - "buildnumber": 82, 06:51:31 INFO - "slavename": "t-yosemite-r7-0374", 06:51:31 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:51:31 INFO - "platform": "yosemite_r7", 06:51:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:51:31 INFO - "branch": "mozilla-central", 06:51:31 INFO - "repo_path": "mozilla-central", 06:51:31 INFO - "revision": "cb4e80abb488f37ec67c4760a128ae177697667b", 06:51:31 INFO - "stage_platform": "macosx64", 06:51:31 INFO - "builduid": "a0f9e0d752ee4c17a64295da920709a7", 06:51:31 INFO - "slavebuilddir": "test" 06:51:31 INFO - } 06:51:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 06:51:31 INFO - Running post-action listener: _resource_record_post_action 06:51:31 INFO - [mozharness: 2017-03-20 13:51:31.329931Z] Finished read-buildbot-config step (success) 06:51:31 INFO - [mozharness: 2017-03-20 13:51:31.330057Z] Running download-and-extract step. 06:51:31 INFO - Running pre-action listener: _resource_record_pre_action 06:51:31 INFO - Running main action method: download_and_extract 06:51:31 INFO - mkdir: /builds/slave/test/build/tests 06:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:51:31 INFO - trying https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 06:51:31 INFO - Downloading https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/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 06:51:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/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 06:51:32 INFO - Downloaded 1325 bytes. 06:51:32 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 06:51:32 INFO - Using the following test package requirements: 06:51:32 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:51:32 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 06:51:32 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 06:51:32 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:51:32 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 06:51:32 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:51:32 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 06:51:32 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:51:32 INFO - u'jsshell-mac.zip'], 06:51:32 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:51:32 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 06:51:32 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 06:51:32 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:51:32 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 06:51:32 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:51:32 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 06:51:32 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:51:32 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 06:51:32 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:51:32 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 06:51:32 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:51:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 06:51:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:51:32 INFO - Fetch https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 06:51:33 INFO - Expected file size: 52476109 06:51:33 INFO - Obtained file size: 52476109 06:51:50 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 06:51:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 06:51:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:51:50 INFO - Fetch https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 06:51:51 INFO - Expected file size: 52476109 06:51:51 INFO - Obtained file size: 52476109 06:52:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 06:52:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:52:07 INFO - Fetch https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 06:52:08 INFO - Expected file size: 14404171 06:52:08 INFO - Obtained file size: 14404171 06:52: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')]} 06:52:08 INFO - trying https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:52:08 INFO - Downloading https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 06:52:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/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 06:52:10 INFO - Downloaded 75188003 bytes. 06:52:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:52:10 INFO - mkdir: /builds/slave/test/properties 06:52:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:52:10 INFO - Writing to file /builds/slave/test/properties/build_url 06:52:10 INFO - Contents: 06:52:10 INFO - build_url:https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:52:11 INFO - Running post-action listener: _resource_record_post_action 06:52:11 INFO - Running post-action listener: set_extra_try_arguments 06:52:11 INFO - [mozharness: 2017-03-20 13:52:11.376431Z] Finished download-and-extract step (success) 06:52:11 INFO - [mozharness: 2017-03-20 13:52:11.376594Z] Running populate-webroot step. 06:52:11 INFO - Running pre-action listener: _resource_record_pre_action 06:52:11 INFO - Running main action method: populate_webroot 06:52:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:52:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:52:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:52:11 INFO - '--tppagecycles', 06:52:11 INFO - '7'], 06:52:11 INFO - 'tests': ['tsvgm']}}, 06:52:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:52:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:52:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:52:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:52:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:52:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:52:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:52:11 INFO - 'talos_options': ['--disable-e10s'], 06:52:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:52:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:52:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:52:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:52:11 INFO - 'talos_options': ['--disable-e10s'], 06:52:11 INFO - 'tests': ['damp', 'tps']}, 06:52:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:52:11 INFO - 'tests': ['damp', 'tps']}, 06:52:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:52:11 INFO - 'tests': ['dromaeo_dom']}, 06:52:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:52:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:52:11 INFO - 'tests': ['basic_compositor_video']}, 06:52:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:52:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:52:11 INFO - 'tests': ['a11yr', 06:52:11 INFO - 'ts_paint', 06:52:11 INFO - 'tpaint', 06:52:11 INFO - 'sessionrestore', 06:52:11 INFO - 'sessionrestore_no_auto_restore', 06:52:11 INFO - 'tabpaint']}, 06:52:11 INFO - 'other-e10s': {'tests': ['a11yr', 06:52:11 INFO - 'ts_paint', 06:52:11 INFO - 'tpaint', 06:52:11 INFO - 'sessionrestore', 06:52:11 INFO - 'sessionrestore_no_auto_restore', 06:52:11 INFO - 'tabpaint']}, 06:52:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:52:11 INFO - 'ts_paint', 06:52:11 INFO - 'tpaint', 06:52:11 INFO - 'sessionrestore', 06:52:11 INFO - 'sessionrestore_no_auto_restore', 06:52:11 INFO - 'tabpaint']}, 06:52:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:52:11 INFO - 'ts_paint', 06:52:11 INFO - 'tpaint', 06:52:11 INFO - 'sessionrestore', 06:52:11 INFO - 'sessionrestore_no_auto_restore', 06:52:11 INFO - 'tabpaint']}, 06:52:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:52:11 INFO - 'tests': ['a11yr', 06:52:11 INFO - 'ts_paint', 06:52:11 INFO - 'tpaint', 06:52:11 INFO - 'sessionrestore', 06:52:11 INFO - 'sessionrestore_no_auto_restore', 06:52:11 INFO - 'tabpaint']}, 06:52:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:52:11 INFO - 'tests': ['a11yr', 06:52:11 INFO - 'ts_paint', 06:52:11 INFO - 'tpaint', 06:52:11 INFO - 'sessionrestore', 06:52:11 INFO - 'sessionrestore_no_auto_restore', 06:52:11 INFO - 'tabpaint']}, 06:52:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:52:11 INFO - 'tests': ['tsvgx', 06:52:11 INFO - 'tsvgr_opacity', 06:52:11 INFO - 'tart', 06:52:11 INFO - 'tscrollx', 06:52:11 INFO - 'cart', 06:52:11 INFO - 'tsvg_static']}, 06:52:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:52:11 INFO - 'tsvgr_opacity', 06:52:11 INFO - 'tart', 06:52:11 INFO - 'tscrollx', 06:52:11 INFO - 'cart', 06:52:11 INFO - 'tsvg_static']}, 06:52:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:52:11 INFO - 'talos_options': ['--disable-e10s'], 06:52:11 INFO - 'tests': ['tp5o']}, 06:52:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:52:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:52:11 INFO - 'talos_options': ['--disable-e10s', 06:52:11 INFO - '--xperf_path', 06:52:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:52:11 INFO - 'tests': ['tp5n']}, 06:52:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:52:11 INFO - 'talos_options': ['--xperf_path', 06:52:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:52:11 INFO - 'tests': ['tp5n']}}, 06:52:11 INFO - 'talos.zip': {'path': '', 06:52:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:52:11 INFO - Running post-action listener: _resource_record_post_action 06:52:11 INFO - [mozharness: 2017-03-20 13:52:11.395235Z] Finished populate-webroot step (success) 06:52:11 INFO - [mozharness: 2017-03-20 13:52:11.395352Z] Running create-virtualenv step. 06:52:11 INFO - Running pre-action listener: _resource_record_pre_action 06:52:11 INFO - Running main action method: create_virtualenv 06:52:11 INFO - Creating virtualenv /builds/slave/test/build/venv 06:52:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:52:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:52:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:52:11 INFO - Using real prefix '/tools/python27' 06:52:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:52:12 INFO - Installing distribute.............................................................................................................................................................................................done. 06:52:15 INFO - Installing pip.................done. 06:52:15 INFO - Return code: 0 06:52:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:52:15 INFO - Reading from file tmpfile_stdout 06:52:15 INFO - Output received: 06:52:15 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) 06:52:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:52: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')]} 06:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:16 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 0x101f58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d28ccdd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d36d30>, '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 0x101c5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d2bbe8>, '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.tD6dP4YpRU/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.6QAWnJk68A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:52:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tD6dP4YpRU/Render', 06:52:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:16 INFO - 'HOME': '/Users/cltbld', 06:52:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:16 INFO - 'LOGNAME': 'cltbld', 06:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:16 INFO - 'MOZ_NO_REMOTE': '1', 06:52:16 INFO - 'NO_EM_RESTART': '1', 06:52:16 INFO - 'PAGER': '/bin/cat', 06:52:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:16 INFO - 'PWD': '/builds/slave/test', 06:52:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:16 INFO - 'SHELL': '/bin/bash', 06:52:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6QAWnJk68A/Listeners', 06:52:16 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 06:52:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:16 INFO - 'USER': 'cltbld', 06:52:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:16 INFO - 'XPC_FLAGS': '0x0', 06:52:16 INFO - 'XPC_SERVICE_NAME': '0', 06:52:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:52:16 INFO - Cleaning up... 06:52:16 INFO - Return code: 0 06:52:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:16 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 0x101f58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d28ccdd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d36d30>, '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 0x101c5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d2bbe8>, '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.tD6dP4YpRU/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.6QAWnJk68A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:52:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tD6dP4YpRU/Render', 06:52:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:16 INFO - 'HOME': '/Users/cltbld', 06:52:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:16 INFO - 'LOGNAME': 'cltbld', 06:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:16 INFO - 'MOZ_NO_REMOTE': '1', 06:52:16 INFO - 'NO_EM_RESTART': '1', 06:52:16 INFO - 'PAGER': '/bin/cat', 06:52:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:16 INFO - 'PWD': '/builds/slave/test', 06:52:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:16 INFO - 'SHELL': '/bin/bash', 06:52:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6QAWnJk68A/Listeners', 06:52:16 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 06:52:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:16 INFO - 'USER': 'cltbld', 06:52:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:16 INFO - 'XPC_FLAGS': '0x0', 06:52:16 INFO - 'XPC_SERVICE_NAME': '0', 06:52:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:16 INFO - Downloading/unpacking psutil>=3.1.1 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52: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 06:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:52:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:52:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:52:20 INFO - Installing collected packages: psutil 06:52:20 INFO - Running setup.py install for psutil 06:52:20 INFO - building 'psutil._psutil_osx' extension 06:52:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:52:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:52:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:52:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:52:21 INFO - building 'psutil._psutil_posix' extension 06:52:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:52:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:52:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:52:21 INFO - ^ 06:52:21 INFO - 1 warning generated. 06:52:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:52:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:52:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:52:21 INFO - Successfully installed psutil 06:52:21 INFO - Cleaning up... 06:52:22 INFO - Return code: 0 06:52:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:22 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 0x101f58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d28ccdd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d36d30>, '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 0x101c5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d2bbe8>, '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.tD6dP4YpRU/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.6QAWnJk68A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:52:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tD6dP4YpRU/Render', 06:52:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:22 INFO - 'HOME': '/Users/cltbld', 06:52:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:22 INFO - 'LOGNAME': 'cltbld', 06:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:22 INFO - 'MOZ_NO_REMOTE': '1', 06:52:22 INFO - 'NO_EM_RESTART': '1', 06:52:22 INFO - 'PAGER': '/bin/cat', 06:52:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:22 INFO - 'PWD': '/builds/slave/test', 06:52:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:22 INFO - 'SHELL': '/bin/bash', 06:52:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6QAWnJk68A/Listeners', 06:52:22 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 06:52:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:22 INFO - 'USER': 'cltbld', 06:52:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:22 INFO - 'XPC_FLAGS': '0x0', 06:52:22 INFO - 'XPC_SERVICE_NAME': '0', 06:52:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:52:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:52:24 INFO - Installing collected packages: mozsystemmonitor 06:52:24 INFO - Running setup.py install for mozsystemmonitor 06:52:25 INFO - Successfully installed mozsystemmonitor 06:52:25 INFO - Cleaning up... 06:52:25 INFO - Return code: 0 06:52:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101f58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d28ccdd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d36d30>, '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 0x101c5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d2bbe8>, '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.tD6dP4YpRU/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.6QAWnJk68A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:52:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:52:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:52:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tD6dP4YpRU/Render', 06:52:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:25 INFO - 'HOME': '/Users/cltbld', 06:52:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:25 INFO - 'LOGNAME': 'cltbld', 06:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:25 INFO - 'MOZ_NO_REMOTE': '1', 06:52:25 INFO - 'NO_EM_RESTART': '1', 06:52:25 INFO - 'PAGER': '/bin/cat', 06:52:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:25 INFO - 'PWD': '/builds/slave/test', 06:52:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:25 INFO - 'SHELL': '/bin/bash', 06:52:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6QAWnJk68A/Listeners', 06:52:25 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 06:52:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:25 INFO - 'USER': 'cltbld', 06:52:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:25 INFO - 'XPC_FLAGS': '0x0', 06:52:25 INFO - 'XPC_SERVICE_NAME': '0', 06:52:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:25 INFO - Downloading/unpacking jsonschema==2.5.1 06:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:52:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:28 INFO - Downloading functools32-3.2.3-2.tar.gz 06:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:52:28 INFO - warning: no files found matching '*.txt' 06:52:28 INFO - no previously-included directories found matching 'build' 06:52:28 INFO - no previously-included directories found matching 'dist' 06:52:28 INFO - no previously-included directories found matching '.git*' 06:52:28 INFO - Installing collected packages: jsonschema, functools32 06:52:28 INFO - Running setup.py install for functools32 06:52:28 INFO - warning: no files found matching '*.txt' 06:52:28 INFO - no previously-included directories found matching 'build' 06:52:28 INFO - no previously-included directories found matching 'dist' 06:52:28 INFO - no previously-included directories found matching '.git*' 06:52:28 INFO - Successfully installed jsonschema functools32 06:52:28 INFO - Cleaning up... 06:52:28 INFO - Return code: 0 06:52:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:52: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')]} 06:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52: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')]} 06:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:28 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 0x101f58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d28ccdd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d36d30>, '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 0x101c5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d2bbe8>, '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.tD6dP4YpRU/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.6QAWnJk68A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:52:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tD6dP4YpRU/Render', 06:52:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:28 INFO - 'HOME': '/Users/cltbld', 06:52:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:28 INFO - 'LOGNAME': 'cltbld', 06:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:28 INFO - 'MOZ_NO_REMOTE': '1', 06:52:28 INFO - 'NO_EM_RESTART': '1', 06:52:28 INFO - 'PAGER': '/bin/cat', 06:52:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:28 INFO - 'PWD': '/builds/slave/test', 06:52:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:28 INFO - 'SHELL': '/bin/bash', 06:52:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6QAWnJk68A/Listeners', 06:52:28 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 06:52:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:28 INFO - 'USER': 'cltbld', 06:52:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:28 INFO - 'XPC_FLAGS': '0x0', 06:52:28 INFO - 'XPC_SERVICE_NAME': '0', 06:52:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:52:29 INFO - Cleaning up... 06:52:29 INFO - Return code: 0 06:52:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x101f58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d28ccdd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d36d30>, '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 0x101c5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d2bbe8>, '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.tD6dP4YpRU/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.6QAWnJk68A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:52:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:52: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 blobuploader==1.2.4 06:52:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tD6dP4YpRU/Render', 06:52:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:29 INFO - 'HOME': '/Users/cltbld', 06:52:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:29 INFO - 'LOGNAME': 'cltbld', 06:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:29 INFO - 'MOZ_NO_REMOTE': '1', 06:52:29 INFO - 'NO_EM_RESTART': '1', 06:52:29 INFO - 'PAGER': '/bin/cat', 06:52:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:29 INFO - 'PWD': '/builds/slave/test', 06:52:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:29 INFO - 'SHELL': '/bin/bash', 06:52:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6QAWnJk68A/Listeners', 06:52:29 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 06:52:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:29 INFO - 'USER': 'cltbld', 06:52:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:29 INFO - 'XPC_FLAGS': '0x0', 06:52:29 INFO - 'XPC_SERVICE_NAME': '0', 06:52:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:29 INFO - Downloading/unpacking blobuploader==1.2.4 06:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:31 INFO - Downloading blobuploader-1.2.4.tar.gz 06:52:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:52:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:52:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:33 INFO - Downloading docopt-0.6.1.tar.gz 06:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:52:33 INFO - Installing collected packages: blobuploader, requests, docopt 06:52:33 INFO - Running setup.py install for blobuploader 06:52:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:52:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:52:33 INFO - Running setup.py install for requests 06:52:33 INFO - Running setup.py install for docopt 06:52:34 INFO - Successfully installed blobuploader requests docopt 06:52:34 INFO - Cleaning up... 06:52:34 INFO - Return code: 0 06:52:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x101f58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d28ccdd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d36d30>, '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 0x101c5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d2bbe8>, '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.tD6dP4YpRU/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.6QAWnJk68A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:52:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:52:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tD6dP4YpRU/Render', 06:52:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:34 INFO - 'HOME': '/Users/cltbld', 06:52:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:34 INFO - 'LOGNAME': 'cltbld', 06:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:34 INFO - 'MOZ_NO_REMOTE': '1', 06:52:34 INFO - 'NO_EM_RESTART': '1', 06:52:34 INFO - 'PAGER': '/bin/cat', 06:52:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:34 INFO - 'PWD': '/builds/slave/test', 06:52:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:34 INFO - 'SHELL': '/bin/bash', 06:52:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6QAWnJk68A/Listeners', 06:52:34 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 06:52:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:34 INFO - 'USER': 'cltbld', 06:52:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:34 INFO - 'XPC_FLAGS': '0x0', 06:52:34 INFO - 'XPC_SERVICE_NAME': '0', 06:52:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:52:34 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-oKPwoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:52:34 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-mQlusU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:52:34 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-ZuDRsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:52:34 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-0O6Se5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:52:34 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-F80uWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:52:34 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-wWtQnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:52:35 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-v_bbIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:52:35 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-kx3JGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:52:35 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-j3qgwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:52:35 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-3eJ2Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:52:35 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-M5P9HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:52:35 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-AUZwN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:52:35 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-KW5DuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:52:35 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-q7BQLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:35 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-ggnvQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:52:36 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-xe2m8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:52:36 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-vV_Zl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:52:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:52:36 INFO - Running setup.py install for manifestparser 06:52:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:52:36 INFO - Running setup.py install for mozcrash 06:52:36 INFO - Running setup.py install for mozdebug 06:52:36 INFO - Running setup.py install for mozdevice 06:52:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:52:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:52:36 INFO - Running setup.py install for mozfile 06:52:36 INFO - Running setup.py install for mozhttpd 06:52:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:52:37 INFO - Running setup.py install for mozinfo 06:52:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:52:37 INFO - Running setup.py install for mozInstall 06:52:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:52:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:52:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:52:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:52:37 INFO - Running setup.py install for mozleak 06:52:37 INFO - Running setup.py install for mozlog 06:52:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:52:37 INFO - Running setup.py install for moznetwork 06:52:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:52:37 INFO - Running setup.py install for mozprocess 06:52:38 INFO - Running setup.py install for mozprofile 06:52:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:52:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:52:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:52:38 INFO - Running setup.py install for mozrunner 06:52:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:52:38 INFO - Running setup.py install for mozscreenshot 06:52:38 INFO - Running setup.py install for moztest 06:52:38 INFO - Running setup.py install for mozversion 06:52:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:52:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:52:38 INFO - Cleaning up... 06:52:38 INFO - Return code: 0 06:52:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:38 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 0x101f58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d28ccdd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d36d30>, '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 0x101c5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d2bbe8>, '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.tD6dP4YpRU/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.6QAWnJk68A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:52:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:52:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tD6dP4YpRU/Render', 06:52:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:38 INFO - 'HOME': '/Users/cltbld', 06:52:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:38 INFO - 'LOGNAME': 'cltbld', 06:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:38 INFO - 'MOZ_NO_REMOTE': '1', 06:52:38 INFO - 'NO_EM_RESTART': '1', 06:52:38 INFO - 'PAGER': '/bin/cat', 06:52:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:38 INFO - 'PWD': '/builds/slave/test', 06:52:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:38 INFO - 'SHELL': '/bin/bash', 06:52:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6QAWnJk68A/Listeners', 06:52:38 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 06:52:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:38 INFO - 'USER': 'cltbld', 06:52:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:38 INFO - 'XPC_FLAGS': '0x0', 06:52:38 INFO - 'XPC_SERVICE_NAME': '0', 06:52:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:52:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-WXnVUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:52:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-tAF1Zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:52:39 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)) 06:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:52:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-EVWGVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:52:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-9K41Cq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:52:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-E8Zqet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:52:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-TXLy2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:52:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-_XFEop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:52:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-rAD2yQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:52:39 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-4uKMHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:52:40 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-FF6Q08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:52:40 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-4gWwjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:52:40 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-80lQg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:52:40 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)) 06:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:52:40 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-rISC01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:52:40 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-41n52p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:52:40 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)) 06:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:40 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-X99r_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:52:40 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-jxp16d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:52:40 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)) 06:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:52:40 INFO - Running setup.py (path:/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/pip-OuSWFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:52:40 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)) 06:52:40 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)) 06:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:52:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:52:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:52:43 INFO - Downloading blessings-1.6.tar.gz 06:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:52:43 INFO - Installing collected packages: blessings 06:52:43 INFO - Running setup.py install for blessings 06:52:43 INFO - Successfully installed blessings 06:52:43 INFO - Cleaning up... 06:52:43 INFO - Return code: 0 06:52:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:52:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:52:44 INFO - Reading from file tmpfile_stdout 06:52:44 INFO - Current package versions: 06:52:44 INFO - blessings == 1.6 06:52:44 INFO - blobuploader == 1.2.4 06:52:44 INFO - docopt == 0.6.1 06:52:44 INFO - functools32 == 3.2.3-2 06:52:44 INFO - jsonschema == 2.5.1 06:52:44 INFO - manifestparser == 1.1 06:52:44 INFO - mozInstall == 1.12 06:52:44 INFO - mozcrash == 1.0 06:52:44 INFO - mozdebug == 0.1 06:52:44 INFO - mozdevice == 0.49 06:52:44 INFO - mozfile == 1.2 06:52:44 INFO - mozhttpd == 0.7 06:52:44 INFO - mozinfo == 0.9 06:52:44 INFO - mozleak == 0.1 06:52:44 INFO - mozlog == 3.4 06:52:44 INFO - moznetwork == 0.27 06:52:44 INFO - mozprocess == 0.25 06:52:44 INFO - mozprofile == 0.28 06:52:44 INFO - mozrunner == 6.13 06:52:44 INFO - mozscreenshot == 0.1 06:52:44 INFO - mozsystemmonitor == 0.3 06:52:44 INFO - moztest == 0.8 06:52:44 INFO - mozversion == 1.4 06:52:44 INFO - psutil == 3.1.1 06:52:44 INFO - requests == 1.2.3 06:52:44 INFO - wsgiref == 0.1.2 06:52:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:44 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 0x101f58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d28ccdd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d36d30>, '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 0x101c5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d2bbe8>, '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.tD6dP4YpRU/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.6QAWnJk68A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:52:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:52:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tD6dP4YpRU/Render', 06:52:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:44 INFO - 'HOME': '/Users/cltbld', 06:52:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:44 INFO - 'LOGNAME': 'cltbld', 06:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:44 INFO - 'MOZ_NO_REMOTE': '1', 06:52:44 INFO - 'NO_EM_RESTART': '1', 06:52:44 INFO - 'PAGER': '/bin/cat', 06:52:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:44 INFO - 'PWD': '/builds/slave/test', 06:52:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:44 INFO - 'SHELL': '/bin/bash', 06:52:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6QAWnJk68A/Listeners', 06:52:44 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 06:52:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:44 INFO - 'USER': 'cltbld', 06:52:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:44 INFO - 'XPC_FLAGS': '0x0', 06:52:44 INFO - 'XPC_SERVICE_NAME': '0', 06:52:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:52:44 INFO - Cleaning up... 06:52:44 INFO - Return code: 0 06:52:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:52:44 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 0x101f58b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d28ccdd60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d36d30>, '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 0x101c5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d2bbe8>, '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.tD6dP4YpRU/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.6QAWnJk68A/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:52:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:52:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tD6dP4YpRU/Render', 06:52:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:52:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:52:44 INFO - 'HOME': '/Users/cltbld', 06:52:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:52:44 INFO - 'LOGNAME': 'cltbld', 06:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:52:44 INFO - 'MOZ_NO_REMOTE': '1', 06:52:44 INFO - 'NO_EM_RESTART': '1', 06:52:44 INFO - 'PAGER': '/bin/cat', 06:52:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:52:44 INFO - 'PWD': '/builds/slave/test', 06:52:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:52:44 INFO - 'SHELL': '/bin/bash', 06:52:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6QAWnJk68A/Listeners', 06:52:44 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 06:52:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:52:44 INFO - 'USER': 'cltbld', 06:52:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:52:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:52:44 INFO - 'XPC_FLAGS': '0x0', 06:52:44 INFO - 'XPC_SERVICE_NAME': '0', 06:52:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:52:44 INFO - Cleaning up... 06:52:44 INFO - Return code: 0 06:52:44 INFO - Running post-action listener: _resource_record_post_action 06:52:44 INFO - Running post-action listener: _start_resource_monitoring 06:52:44 INFO - Starting resource monitoring. 06:52:44 INFO - [mozharness: 2017-03-20 13:52:44.795326Z] Finished create-virtualenv step (success) 06:52:44 INFO - [mozharness: 2017-03-20 13:52:44.796334Z] Running install step. 06:52:44 INFO - Running pre-action listener: _resource_record_pre_action 06:52:44 INFO - Running main action method: install 06:52:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:52:45 INFO - Reading from file tmpfile_stdout 06:52:45 INFO - Detecting whether we're running mozinstall >=1.0... 06:52:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:52:45 INFO - Reading from file tmpfile_stdout 06:52:45 INFO - Output received: 06:52:45 INFO - Usage: mozinstall [options] installer 06:52:45 INFO - Options: 06:52:45 INFO - -h, --help show this help message and exit 06:52:45 INFO - -d DEST, --destination=DEST 06:52:45 INFO - Directory to install application into. [default: 06:52:45 INFO - "/builds/slave/test"] 06:52:45 INFO - --app=APP Application being installed. [default: firefox] 06:52:45 INFO - mkdir: /builds/slave/test/build/application 06:52:45 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'] 06:52:45 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 06:53:05 INFO - Reading from file tmpfile_stdout 06:53:05 INFO - Output received: 06:53:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:53:05 INFO - Running post-action listener: _resource_record_post_action 06:53:05 INFO - [mozharness: 2017-03-20 13:53:05.693991Z] Finished install step (success) 06:53:05 INFO - [mozharness: 2017-03-20 13:53:05.694130Z] Running run-tests step. 06:53:05 INFO - Running pre-action listener: _resource_record_pre_action 06:53:05 INFO - Running main action method: run_tests 06:53:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:53:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:53:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:53:05 INFO - 2017-03-20 06:53:05.708 screenresolution[1626:7500] starting screenresolution argv=screenresolution get 06:53:05 INFO - 2017-03-20 06:53:05.711 screenresolution[1626:7500] Display 0: 1600x1200x32@60 06:53:05 INFO - 2017-03-20 06:53:05.717 screenresolution[1627:7502] starting screenresolution argv=screenresolution list 06:53:05 INFO - Available Modes on Display 0 06:53:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:53:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:53:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:53:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:53:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:53:05 INFO - Intel Iris: 06:53:05 INFO - Chipset Model: Intel Iris 06:53:05 INFO - Type: GPU 06:53:05 INFO - Bus: Built-In 06:53:05 INFO - VRAM (Dynamic, Max): 1536 MB 06:53:05 INFO - Vendor: Intel (0x8086) 06:53:05 INFO - Device ID: 0x0a2e 06:53:05 INFO - Revision ID: 0x0009 06:53:05 INFO - Displays: 06:53:05 INFO - Display: 06:53:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:53:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:53:05 INFO - Display Serial Number: 1600x1200 60 06:53:05 INFO - Main Display: Yes 06:53:05 INFO - Mirror: Off 06:53:05 INFO - Online: Yes 06:53:05 INFO - Rotation: Supported 06:53:05 INFO - Return code: 0 06:53:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:53:05 INFO - Python 2.7.3 06:53:05 INFO - Return code: 0 06:53:05 INFO - grabbing minidump binary from tooltool 06:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:53:05 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 0x101d36d30>, '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 0x101c5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101d2bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:53:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:53:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:53:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:53:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:53:06 INFO - Return code: 0 06:53:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:53:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:53:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:53:06 INFO - ENV: RUST_BACKTRACE is now 1 06:53:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:53:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:53:06 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0374', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:53:06 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0374 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:53:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tD6dP4YpRU/Render', 06:53:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:53:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:53:06 INFO - 'HOME': '/Users/cltbld', 06:53:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:53:06 INFO - 'LOGNAME': 'cltbld', 06:53:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:53:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:53:06 INFO - 'MOZ_NO_REMOTE': '1', 06:53:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:53:06 INFO - 'NO_EM_RESTART': '1', 06:53:06 INFO - 'PAGER': '/bin/cat', 06:53:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:53:06 INFO - 'PWD': '/builds/slave/test', 06:53:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:53:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:53:06 INFO - 'RUST_BACKTRACE': '1', 06:53:06 INFO - 'SHELL': '/bin/bash', 06:53:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6QAWnJk68A/Listeners', 06:53:06 INFO - 'TMPDIR': '/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/', 06:53:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:53:06 INFO - 'USER': 'cltbld', 06:53:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:53:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:53:06 INFO - 'XPC_FLAGS': '0x0', 06:53:06 INFO - 'XPC_SERVICE_NAME': '0', 06:53:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:53:06 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0374', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:53:06 INFO - mozversion application_buildid: 20170320050941 06:53:06 INFO - mozversion application_changeset: cb4e80abb488f37ec67c4760a128ae177697667b 06:53:06 INFO - mozversion application_display_name: Nightly 06:53:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:53:06 INFO - mozversion application_name: Firefox 06:53:06 INFO - mozversion application_remotingname: firefox 06:53:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:53:06 INFO - mozversion application_vendor: Mozilla 06:53:06 INFO - mozversion application_version: 55.0a1 06:53:06 INFO - mozversion platform_buildid: 20170320050941 06:53:06 INFO - mozversion platform_changeset: cb4e80abb488f37ec67c4760a128ae177697667b 06:53:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:53:06 INFO - mozversion platform_version: 55.0a1 06:53:06 INFO - using testdate: 1490017986 06:53:06 INFO - actual date: 1490017986 06:53:06 INFO - starting webserver on 'localhost:49241' 06:53:06 INFO - SUITE-START | Running 2 tests 06:53:06 INFO - TEST-START | dromaeo_css 06:53:06 INFO - operating with platform_type : mac_ 06:53:06 INFO - Initialising browser for dromaeo_css test... 06:53:06 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmpMvr3fb/profile http://localhost:49241/getInfo.html) 06:53:08 INFO - PID 1637 | __metrics Screen width/height:1600/1200 06:53:08 INFO - PID 1637 | colorDepth:24 06:53:08 INFO - PID 1637 | Browser inner width/height: 1024/689 06:53:08 INFO - PID 1637 | __metrics 06:53:08 INFO - PID 1637 | 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" 06:53:08 INFO - PID 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:53:09 INFO - TEST-INFO | 1637: exit 0 06:53:09 INFO - Browser initialized. 06:53:09 INFO - Running cycle 1/1 for dromaeo_css test... 06:53:09 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmpMvr3fb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:53:22 INFO - PID 1639 | RSS: Main: 233472000 06:53:22 INFO - PID 1639 | 06:56:27 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 06:56:28 INFO - PID 1639 | RSS: Main: 381009920 06:56:28 INFO - PID 1639 | 06:58:12 INFO - PID 1639 | ************************* 06:58:12 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 06:58:12 INFO - PID 1639 | 06:58:12 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:58:12 INFO - PID 1639 | Full stack: 06:58:12 INFO - PID 1639 | ************************* 06:59:32 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 06:59:32 INFO - PID 1639 | RSS: Main: 368779264 06:59:32 INFO - PID 1639 | 07:02:35 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 07:02:35 INFO - PID 1639 | RSS: Main: 353128448 07:02:35 INFO - PID 1639 | 07:05:38 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 07:05:38 INFO - PID 1639 | RSS: Main: 333680640 07:05:38 INFO - PID 1639 | 07:08:42 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 07:08:43 INFO - PID 1639 | RSS: Main: 344731648 07:08:43 INFO - PID 1639 | 07:11:47 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 07:11:47 INFO - PID 1639 | RSS: Main: 458051584 07:11:47 INFO - PID 1639 | 07:11:47 INFO - PID 1639 | __start_tp_report 07:11:47 INFO - PID 1639 | _x_x_mozilla_page_load 07:11:47 INFO - PID 1639 | _x_x_mozilla_page_load_details 07:11:47 INFO - PID 1639 | |i|pagename|runs| 07:11:47 INFO - PID 1639 | |0;dojo.html;3075.6463006754225;3338.3657105150037;3372.7639065265435;3376.172837654775;3396.8811091611797;5610.24261724667;5709.2292540507015;5719.914201286979;5773.82678519644;5774.884502309951;5646.18130371096;5717.2281741964825;5779.422057794229;5785.045467497868;5810;5091.134507133796;5134.383873935114;5141.305923700309;5162.974185129088;5172.741362931838;5231.163013917774;5264.341957255343;5269.552088072518;5281.287026251464;5332.840014799563;5058.924116138224;5125.103106956305;5127.846164615067;5155.484451554852;5239.947600524003;5139.871503212449;5175.741212939376;5179.766910489037;5182.844514664528;5186.662866913639;5082.2122571001555;5132.692038477703;5135.972805438927;5148.9959457905725;5153.484651534854;4567.725936443824;5650.7174641267775;5698.914516282259;5703.600747947646;5718.256626638552;6203.968980155116;6247.656378899159;6250.874982500324;6256;6316.715747791361;6256.5307601930035;6269.498440124779;6313.494920406357;6318.778842740528;6332.208473940757;5872.794452194153;5877.235959325303;5889.204957330706;5903.709392672955;5958.553108516879;5756.65460072397;6234.532410069263;6254.906176407358;6309.022101574264;6336.809895703136;5985.431384018511;6098.512119030467;6107.48086412651;6223.564350495421;6257.7184026718905;6202.596831205957;6303.716332765037;6339;6348.809535713936;6358.904616430757;6293.811185664437;6310.684465776784;6310.968445157745;6315.810525684236;6318.526110541728;6133.193602315525;6211.65835879031;6329.2721337045905;6330.145430366933;6340.809775706736;5002.674826136289;5027.723475208825;5067.011932673094;5105.132127538253;5111.488851114933;4452.888677783081;4458.219811532968;4469.843555475542;4480.462344518679;4524.660650451229;5873.823785286449;5915.645061296336;5934.910976335358;5939.792107276311;5959.106134079922;6150.108234306001;6224.159738435344;6241.251049874044;6266.968665156645;6308.022256550242;5791.0734282514595;5812.593118481665;5813.360530341659;5821.359650438449;5828.388019258002;5466.617336786387;5467.234587157801;5473.151661492475;5473.75368108436;5473.890522189614;6258.436740693177;6294.937050629526;6297.905531416941;6310.179676641916;6330.335314791881;6254.593451425642;6267.843303917439;6278.905816412666;6286.37136286386;6287.717052732546;5717.42825717425;6338.524610654312;6351.460125889351;6375.458086062737;6448.806535803933;6226.906596401148;6228.03465462854;6241.282252541016;6246.969250073687;6250.343713910156;6247.781327653511;6284.183056202664;6294.3076261612105;6297.905531416941;6304.243490781136;4993.975030124826;5871.500922421642;5921.496672782861;6113.1135985281;6144;5974.850628734316;6058.636481811105;6130.570860039755;6144.771045790949;6191.876162476815;5892.587518873637;6006.15913772081;6104.938950610437;6109.2974307955155;6117.418845209698;6000.81997540057;6177.351378105234;6183.659898705614;6186.938130618816;6189.257289125154;5113.565346945551;5816.302043754777;5941.732622031933;5981.252343457068;5989.3711160329285 07:11:47 INFO - PID 1639 | |1;ext.html;624.4442446222862;686.4371215603204;743.2678811370798;835.8411901738673;843.8059246373338;28319.575206371894;28620.14139575816;28705.28236794081;36945.815270923675;37533.81233093837;39660.20679586406;39930.00174995627;39959;40026.99932501689;40059.198816023665;8953.194212520872;9160.908390916105;9183;9292.070792920722;9304.952910359743;7231.746888858891;7355.190928997806;9166.54167291636;10718.464076796128;10958.506867190956;11035.172362072877;11064.612738554153;11123;11123.72190695231;11127.165462590337;10945.616903408381;11054.447277636167;11059.612913547988;11069.944650276777;11091.279066860709;7151.7854464366155;7315.268473152695;10427.635032773893;10616.628418005334;10800.297980631234;37841.81079094587;38408.42387364192;38437;38487.845364639106;38577.61422385768;3731.6641502264656;3741.345264578715;3788.677962373174;3793.8103094845424;3909.7849618270984;27252.31869203266;27642;27975.860120699468;28214.85892570524;28603.9988600398;2712.9457410851674;3030.4696678081245;3151.086185006345;3245.432049391347;3263.8694452221885;270824;273116;274130;274449;274465;49214.76963075952;49286.59274294319;49378.259326110136;49397.25904111441;49402.50597494051;52356;52541.737291314064;52614;52627;52659.47340526546;14822.555323340317;14953.626159345886;14986.250687465583;14987.625309367353;15000.549983500512;12083.818742718866;12097.455614497369;12116.39418029095;12118.969887559657;12133.21134126279;11701.94682478581;11819.645410637695;11828.822567661491;13374.665633359244;13563.254021028939;5510.283663123768;5837.737301821343;5864.266966629171;5895.29256489224;5911.674857882857;1048.7902419516126;1073.613499140309;1087.5486673030603;1125.1336470917347;1188.0911103006208;25779.484410312063;26579.734202658114;26634.733652663224;26642.86678566595;26705.866470667912;1123.662901129658;1127.616610352484;1174.7063234191453;1186;1190.2739329009298;11234.943825280821;12484.126111172312;14080;14369.856301437061;14530.491432800012;482831;487529;488036;488320.8431030477;488352;57953.4204657948;58450.707746461;58464.4153558459;58472.70763646239;58535.414645852994;1388.3960477192454;1435.8133442652388;1436.9712605747618;1445.7903603977365;1456.4465503108752;24700.752992469847;25640.871795640902;25677.35806604775;25768.09811656583;25893.223203303933;46808.76595617;47196.292055618505;47225.763871180425;47235;47296.76351618358;453682;455436;455436;456629;456792;34396;34859;35160.47259291061;35170.82414587911;35196.47205291872;30112.3977520444;41996.580034199265;42341.1531769369;42496.57503424926;45102.54897450984;32861.34277314488;35287.64712352843;36100.27799444049;36351.27297454089;36442.8177859109;34311;34392.31215375729;35115.82442087773;35554.28891422209;35938.28123437569;35594;36366.818165909004;36388.81805590955;36512;36656.45015324719;21031;29987.55018674678;31542.842285788425;31631;31644.367112657157;21763.347099587038;23945;24273.271801845975;24326;24328.878355608107 07:11:47 INFO - PID 1639 | |2;jquery.html;384.5615997762551;394.7098882321495;396.9503812023499;406.5710675237625;411.87643706887934;12476.750464990717;20039.998000099993;20564.971751412406;20917.11745942865;21649.891750541225;15417.306221220044;15719.528414147566;20521.794782052177;20752.377428677162;21364.57270854586;6568.507361947849;6921.446284297244;6923.515353925227;6926.480513961448;6941.375276225139;6496.350364963513;6709.228438729536;6752.93247067528;6775.1192344995325;6944.826379340507;6750.93249067508;6755.3582409671;6768.120144381223;6773.254941956381;6794.966025169867;6531.575447595891;6815.352541508573;6882.311768823128;6895;6898.517103802736;6546.050822630739;6613.008048792672;6682.866342673119;6685.164354455693;6691.698873550702;27016.59475107875;27189.86405067962;27222.591661125098;27250.863745681145;27518.587221191698;3262.0866157475944;3301.6698330167033;3336.899893003214;3344.66553344666;3429.8456569454434;16317.347306107742;16695.332186712516;16960.74558881618;17238.569035774082;17262.568435789206;1960.2649006622516;1993.9960339858494;1996.4010796761058;2048.6926960955975;2060.629086764382;139894;142369;144524.2914476394;145954;146479;16122.838771612369;16653.750193747102;21145.471363216042;21244.044018019227;21402.464938376666;34809.08245598254;34941.1264718379;34944.65055349465;34954.65045349514;35017.64982350144;8881.156290152425;9302.581383837743;9319.204238728355;10017;10129.822088251061;8267.338612910953;8420.8315833683;8455.534945578052;8462.153784621612;8576.271016963503;8208.507489550646;9891.258155638356;10035.799284014425;10117.595296188218;10127.189824813997;3482.6169121396624;4099.569545197771;4170.979145104255;4217.34631132175;4226.366045093199;1005.4821766790109;1009.6516701737888;1012.1700205831148;1014.3457469931852;1020.9744756381001;22143.778562214495;22603.773962260166;22659.886700566392;22693.773062269494;22744.886275568846;952.1953948913157;985.3595163143871;1003.3528374198601;1006.2201793610011;1058.899404556566;10957.232993690364;11793.646190614296;11829;11836.70408239801;11859.644210673694;691257;692940;694753;722931;725494;146117;146801.26599366934;150081.24959375133;151553;164395.3143045722;1197.9640610781692;1241.5778635264053;1264.5574049082747;1266.9239845609293;1302.8436587609358;17792;19948.703618690455;20440.378895803773;20544;21166.047527860974;41950.370744438245;55116;58729.119063213235;60645.39354606574;60897;59604.70197648984;69619.65190174017;77545.2245477538;84005;87912.5604371974;10155.441450720282;11054.668359949215;11437.885621143681;11698.590549330733;12038.879611204125;13024.47902083906;13169.53906613264;13204;13592;13624.114432561852;11250.268732532359;11307.547698091985;11487.942560287145;11489.655310340702;11540.480678369662;11122.666320010412;11215.887841121485;11353.148513861328;11691.240069395462;11714.062874970152;11341.546338146713;11463.31220126795;11651.766964660828;11768.82346764782;11894.583689570823;11501.194916355775;11555.711107222387;11896.76206475883;11908.76182476363;11943.761124777282;9330.580123894306;9745.12293893553;11113.888861111609;11673.941630291794;11893.940530297294 07:11:47 INFO - PID 1639 | |3;mootools.html;1537.7001484710486;1553.9145347005917;1581.3200323860735;1584.8573628373447;1642.4579888636747;10454.3204691695;10901.400422976743;10911.945440272808;10916.07213386861;10949.781004379918;10563.26057175998;10653;10962.835557466644;10975.06711929485;10989.670309890716;2345.753695861931;2392.95214095718;2393.1623931623967;2394.1979436888664;2395.6526303685955;1990.2636024670892;2319.5940710375617;2360.3391050505884;2363.7872591466767;2365.207655435431;1963.3815348165353;2282.892796993457;2309.642005489152;2318.976810231893;2323.3030090972725;2265.830062745284;2290.118304452781;2290.141197051106;2291.9312420627407;2295.8622482650926;2270.5572413379396;2353.3293011491814;2358.870262135582;2365.6569797379457;2366.2073205476186;11166.776664466746;11233.887661123366;11245.60640377591;11250.774984500264;11265.324080555192;4484.304932735431;5039.06777246207;5227.137522308814;5232.947670523322;5238.476152384769;3318.6847249511256;3364.444866597033;3440.122768693992;3662.285854258421;3673.651003154696;1132.3206076354204;1169.1465230381868;1184.946677399519;1218.0986070307908;1235.4008305971597;11461.828072578917;14326.785098223534;14375.065620734724;15529.611759706098;15540.766888496568;4169.2703776838935;4292.034292284211;4293.184294983943;4327.935080973788;4382.014046839436;11427.314361138358;11705.414729263503;11714.121440891968;11738.295702257892;11755.941220294015;5506.201600767866;5627.155926611041;5627.437256274422;5630.296212973379;5636.098224284095;4357.368181613649;5125.256837758504;5280.234366016906;5280.867978300496;5290.285811415487;2958.3787404644836;3475.9318205667587;3540.7344449166417;3755.3052685253315;3916.549596796405;1014.573878970834;1020.3061917895902;1045.811753884308;1048.9527971241312;1050.1779412718927;886.3972498700946;916.3768637326682;919.1635611593418;942.7266092833139;956.5265193729009;5625.521830644441;6572.010543973134;6787.864242715118;6826.863462730717;7001.194862590765;973.3624475968252;1017.7811770469384;1031.9587216511406;1036.3678156324636;1049.6955882794057;3614.746967712235;4099.262132816122;4225.809838557272;4378.255696531597;4383.6054755071555;13166.407511661999;13645.90832733379;13953.930230348784;13958.790618140736;13958.860411395755;13836.100653457494;13842.584722458343;13851;13861.514846980308;13889.513867014808;9574.952125239468;10008.39949603026;10044.497775111215;10047.045530674573;10112.230359687172;6528.510361722985;6579.2104947406615;6644.60132392058;6881.10545629065;6937.549059311129;11865.5847045353;12030.398480075786;12091.637250882488;12195.451204695988;12233.143679942319;11153;11158.218924675519;11714.414279286171;12283.508659653513;12438.129330946747;9036.81926361456;9102;9189.035151309283;9229.261659067124;9371.250299975849;10034.799304014025;10085.193184545366;10159.644412445528;10188.083072523508;10201.948990255001;9145.222656074307;9146.496942668216;9240.907590924005;9294.814103717752;9317.86023209639;8847.380683352361;9015.729528114167;9082.137196966278;9115.544222788702;9262.259019278306;7754.806129846574;7802.219778022152;7848.60756962161;7866.370690344645;7894.921050789419;5838.474537291664;5855.502282305882;5969;6040.486558642388;6057.515398768176;5041.420236672683;5447.855950250333;5871.680686129041;5911.320198177093;5925.466707996301 07:11:47 INFO - PID 1639 | |4;prototype.html;316.4272666473683;376.3846111607522;381.11771249557256;381.9980900095499;388.04540829559284;5054.494550544949;5295;5336.546393556548;5792.884142317151;5840.182374467568;5178.300929374534;5425.945740542594;5679.914801277974;5708.743106560204;5721.256236689224;3619.529461170044;4355.107203023373;4451.866444006669;4458.554144585548;4461.24158892989;3836.5012548368672;4435.800388982488;4453.9777301113445;4461.616898761378;4482.731036137842;3626.4560315952554;3947.9210415791667;4109.527404348508;4450.310201918692;4457.5096739358805;4213.557576454489;4422.739519237002;4589.128065667513;4868.342773725572;4880.170371036932;4636.4899861015265;4662.743549104798;4677.7193368398;4694.483606803249;4694.554017368345;5618.438156184389;5639.295088113986;5655.660660360391;5665.716714164317;5685.943140568624;4798.568128868418;5531.1426728857095;5758.7120643968055;5777.364489906107;5791.44981226787;5124.876421773737;6152.507799376084;6182.783602573888;6198.752049917998;6221.440070393686;4964.851054468336;5116.497482215626;5334.866628334284;5344.385395679507;5387.919181212285;4952.053528150745;6302.464290535356;6313.337099604567;6388.840278993016;6478.125453063823;5317.494837990384;5322.6580304666595;5479.287692599936;5490.478404551562;5494.2857428534035;4871.732054736953;5598.468145526169;5602.831915042555;5613.242212301368;5651.491365777018;5548.944510554843;5717.285339332583;5771.297467247088;5826.446487583673;5831.533477321804;5418.726599249173;6163.568550201443;6164.660943648142;6170.444659980623;6170.629762214281;1659.062629614264;1769.2480695704273;1880.8025157358554;1904.7333373327745;1911.9330823421392;1409.9929500352432;1501.527018989015;1534;1539.638185026518;1555.9066456012677;4896.290037944478;5359.490848369399;5574;5808.88382232353;5849.736761845727;5639.7180140993605;5807.274090738658;5843.357230704619;6160.969195153995;6376.872462550816;4917.65576409655;5033.270175824485;5151.6136289778415;5811.82564523065;5839.649621022752;2641.7226191249642;3210.5665735125926;3305.818180000123;3333.6499667535045;3339.148517128117;6124.5712800103565;6269.780557680459;6441.840468715676;6643.335666433415;6656.972531618398;6506.3493650634555;6544.345565443417;6563.474922006228;6565.409113179837;6616.081336412482;6085.665288409092;6333.746650134128;6665.800025999228;6701.5308928375525;6719.596824190564;5567.77728890856;6131.938680613315;6304.306526282197;6386.934271549775;6391;4925.2761533463;5226;5739.397363276963;6098.695065246809;6118.541109416722;6611.2727599963;6665.50008749336;6670.9332906670315;6678.666066696743;6697.53117281805;3953.3061580727795;4894.216925291937;4936.308916751729;4941.283513890394;4978.975105124451;4957.876053098701;6155.784547540815;6240.843978900382;6276.932921403463;6285.842853928689;5405.567554595545;5785.739641716217;6093.653943231976;6104.694765261808;6133.969330153321;4957.4794646561595;5826.970865145647;6107.404353149805;6109.327973922954;6123.203983482119;4979.053979743837;4987.600991920565;5220.504052115043;5978.701064946648;6058;5885.437736923385;5941.940580594139;5968.582199246011;6154.446099851035;6155;4700.858974230779;5160.225966105114;5181.864971692072;5968.4926781224085;5982 07:11:47 INFO - PID 1639 | |5;yui.html;759.5263895654596;783.1346362269692;803.336784263757;807.6809660184227;830.7383174300097;15061.472848450307;15518.30167642456;15523.379064837407;15523.611909702264;15528.068315901026;14474.638134046654;14564.563063108097;14583.125012499257;14592;15057.021293615908;922.8431166701644;923.3674932671125;944.9905500945006;948.8624149498319;951.172479942451;756.3759898084103;951.8477043673014;963.4652767713916;963.4845357733614;965.2953344058841;1005.6228914157191;1007.5516395204137;1009.2733232072895;1009.2884516415909;1009.6314845081566;998.6854140945579;1001.1340190735035;1001.8497225416173;1002;1002.2833673923144;749.5203070035182;750.2534977697171;750.4334227658084;752.9585872776995;753.88691696246;16196.352145914267;16388.590285242844;16651.33394664212;16743.83256167435;16855.410060647817;14518.274086295643;14654.920255618246;14719.70560588793;14888.776668349983;14925.850741492555;10461.320014199053;11721.472533736003;12021.278723276631;12027.579034733742;12255.080868934776;3665.6356649960894;3708.332500149999;3809.676177524914;3888.727789054767;3905.49228600283;89196;116298.41850790776;116963;117072;118959.81040189661;9303.488308143116;10833.295835770807;10901.509432075576;11210.943945280222;11364.94317528407;24727;25009;25027.249182524552;25032.87483562607;25069.749302507105;7873.881891771513;7888.566128862968;7954.880676789853;7987.640556174986;8036.316913062456;3917.373220284741;3991.261616600938;4010.2380547695843;4018.6383225509257;4038.192361527706;3348.8827891023698;3377.8817741378934;3443.741719371057;3447.1554469154717;3447.775894566895;610.541283628241;614.5390956782413;615.3108518459354;617.6448542088317;627.1220291591717;620.3238470067648;672.8284287506655;679.7111227728195;679.7440261149139;708.19619731605;9479;10210.183185345155;10294.330868493524;10301.896981030244;10454.947725261478;509.4803300633407;669.220358282605;704.2957042957042;723.601929605141;728.6320408193828;4645.976770116128;4898.828541001119;4962.553370196628;4971.130052240844;4971.577415919687;87857.12142878617;89120;104970;106327;109301;93750.5312473447;94039.05960940303;95965;96491;96759;66499;81725.36549268982;84178.73731894027;84218.73671894927;85189;10251.538680759235;10624.326374196553;10925.945370273097;10978.725531861768;11005.779884402427;45251.09497810091;45714.54285457236;47791.522084780096;47997;49897.50102498929;66579;67597.66201169159;68069.29826754371;68155;71650;13356.198628082346;13893.652658683613;14063.156210627396;14110.223937683115;14170.504032358818;14683.706325873636;14852.62868428298;14901.552953411416;15146.469873554373;15412.614684632974;13448.865511344762;13960.58118256454;14294.928525357722;14383.64040898944;14523.85476145225;13413.396397162347;13517.526886558922;13607.251601162032;13723.451061957809;15056.849431505545;13389.866101338863;13540.526081587097;13545.255010974492;13683;14124.152550846982;9695.62226453846;10384.844227336445;10974.286671366335;11920;11949.163558551165;9932.354396964174;10174;11216.66350009501;11492.712682183012;11555.4800033997 07:11:47 INFO - PID 1639 | __end_tp_report 07:11:47 INFO - PID 1639 | __start_cc_report 07:11:47 INFO - PID 1639 | _x_x_mozilla_cycle_collect,1585 07:11:47 INFO - PID 1639 | __end_cc_report 07:11:47 INFO - PID 1639 | __startTimestamp1490019107317__endTimestamp 07:11:47 INFO - PID 1639 | 07:11:47 INFO - PID 1639 | ------- Summary: start ------- 07:11:47 INFO - PID 1639 | Number of tests: 6 07:11:47 INFO - PID 1639 | 07:11:47 INFO - PID 1639 | [#0] dojo.html Cycles:165 Average:5756.51 Median:5958.55 stddev:661.71 (11.1%) stddev-sans-first:629.43 07:11:47 INFO - PID 1639 | Values: 3075.6 3338.4 3372.8 3376.2 3396.9 5610.2 5709.2 5719.9 5773.8 5774.9 5646.2 5717.2 5779.4 5785.0 5810.0 5091.1 5134.4 5141.3 5163.0 5172.7 5231.2 5264.3 5269.6 5281.3 5332.8 5058.9 5125.1 5127.8 5155.5 5239.9 5139.9 5175.7 5179.8 5182.8 5186.7 5082.2 5132.7 5136.0 5149.0 5153.5 4567.7 5650.7 5698.9 5703.6 5718.3 6204.0 6247.7 6250.9 6256.0 6316.7 6256.5 6269.5 6313.5 6318.8 6332.2 5872.8 5877.2 5889.2 5903.7 5958.6 5756.7 6234.5 6254.9 6309.0 6336.8 5985.4 6098.5 6107.5 6223.6 6257.7 6202.6 6303.7 6339.0 6348.8 6358.9 6293.8 6310.7 6311.0 6315.8 6318.5 6133.2 6211.7 6329.3 6330.1 6340.8 5002.7 5027.7 5067.0 5105.1 5111.5 4452.9 4458.2 4469.8 4480.5 4524.7 5873.8 5915.6 5934.9 5939.8 5959.1 6150.1 6224.2 6241.3 6267.0 6308.0 5791.1 5812.6 5813.4 5821.4 5828.4 5466.6 5467.2 5473.2 5473.8 5473.9 6258.4 6294.9 6297.9 6310.2 6330.3 6254.6 6267.8 6278.9 6286.4 6287.7 5717.4 6338.5 6351.5 6375.5 6448.8 6226.9 6228.0 6241.3 6247.0 6250.3 6247.8 6284.2 6294.3 6297.9 6304.2 4994.0 5871.5 5921.5 6113.1 6144.0 5974.9 6058.6 6130.6 6144.8 6191.9 5892.6 6006.2 6104.9 6109.3 6117.4 6000.8 6177.4 6183.7 6186.9 6189.3 5113.6 5816.3 5941.7 5981.3 5989.4 07:11:47 INFO - PID 1639 | 07:11:47 INFO - PID 1639 | [#1] ext.html Cycles:180 Average:54676.54 Median:34351.66 stddev:110653.11 (322.1%) stddev-sans-first:110889.10 07:11:47 INFO - PID 1639 | Values: 624.4 686.4 743.3 835.8 843.8 28319.6 28620.1 28705.3 36945.8 37533.8 39660.2 39930.0 39959.0 40027.0 40059.2 8953.2 9160.9 9183.0 9292.1 9305.0 7231.7 7355.2 9166.5 10718.5 10958.5 11035.2 11064.6 11123.0 11123.7 11127.2 10945.6 11054.4 11059.6 11069.9 11091.3 7151.8 7315.3 10427.6 10616.6 10800.3 37841.8 38408.4 38437.0 38487.8 38577.6 3731.7 3741.3 3788.7 3793.8 3909.8 27252.3 27642.0 27975.9 28214.9 28604.0 2712.9 3030.5 3151.1 3245.4 3263.9 270824.0 273116.0 274130.0 274449.0 274465.0 49214.8 49286.6 49378.3 49397.3 49402.5 52356.0 52541.7 52614.0 52627.0 52659.5 14822.6 14953.6 14986.3 14987.6 15000.5 12083.8 12097.5 12116.4 12119.0 12133.2 11701.9 11819.6 11828.8 13374.7 13563.3 5510.3 5837.7 5864.3 5895.3 5911.7 1048.8 1073.6 1087.5 1125.1 1188.1 25779.5 26579.7 26634.7 26642.9 26705.9 1123.7 1127.6 1174.7 1186.0 1190.3 11234.9 12484.1 14080.0 14369.9 14530.5 482831.0 487529.0 488036.0 488320.8 488352.0 57953.4 58450.7 58464.4 58472.7 58535.4 1388.4 1435.8 1437.0 1445.8 1456.4 24700.8 25640.9 25677.4 25768.1 25893.2 46808.8 47196.3 47225.8 47235.0 47296.8 453682.0 455436.0 455436.0 456629.0 456792.0 34396.0 34859.0 35160.5 35170.8 35196.5 30112.4 41996.6 42341.2 42496.6 45102.5 32861.3 35287.6 36100.3 36351.3 36442.8 34311.0 34392.3 35115.8 35554.3 35938.3 35594.0 36366.8 36388.8 36512.0 36656.5 21031.0 29987.6 31542.8 31631.0 31644.4 21763.3 23945.0 24273.3 24326.0 24328.9 07:11:47 INFO - PID 1639 | 07:11:47 INFO - PID 1639 | [#2] jquery.html Cycles:180 Average:41079.42 Median:21155.76 stddev:117683.93 (556.3%) stddev-sans-first:117974.40 07:11:47 INFO - PID 1639 | Values: 384.6 394.7 397.0 406.6 411.9 12476.8 20040.0 20565.0 20917.1 21649.9 15417.3 15719.5 20521.8 20752.4 21364.6 6568.5 6921.4 6923.5 6926.5 6941.4 6496.4 6709.2 6752.9 6775.1 6944.8 6750.9 6755.4 6768.1 6773.3 6795.0 6531.6 6815.4 6882.3 6895.0 6898.5 6546.1 6613.0 6682.9 6685.2 6691.7 27016.6 27189.9 27222.6 27250.9 27518.6 3262.1 3301.7 3336.9 3344.7 3429.8 16317.3 16695.3 16960.7 17238.6 17262.6 1960.3 1994.0 1996.4 2048.7 2060.6 139894.0 142369.0 144524.3 145954.0 146479.0 16122.8 16653.8 21145.5 21244.0 21402.5 34809.1 34941.1 34944.7 34954.7 35017.6 8881.2 9302.6 9319.2 10017.0 10129.8 8267.3 8420.8 8455.5 8462.2 8576.3 8208.5 9891.3 10035.8 10117.6 10127.2 3482.6 4099.6 4171.0 4217.3 4226.4 1005.5 1009.7 1012.2 1014.3 1021.0 22143.8 22603.8 22659.9 22693.8 22744.9 952.2 985.4 1003.4 1006.2 1058.9 10957.2 11793.6 11829.0 11836.7 11859.6 691257.0 692940.0 694753.0 722931.0 725494.0 146117.0 146801.3 150081.2 151553.0 164395.3 1198.0 1241.6 1264.6 1266.9 1302.8 17792.0 19948.7 20440.4 20544.0 21166.0 41950.4 55116.0 58729.1 60645.4 60897.0 59604.7 69619.7 77545.2 84005.0 87912.6 10155.4 11054.7 11437.9 11698.6 12038.9 13024.5 13169.5 13204.0 13592.0 13624.1 11250.3 11307.5 11487.9 11489.7 11540.5 11122.7 11215.9 11353.1 11691.2 11714.1 11341.5 11463.3 11651.8 11768.8 11894.6 11501.2 11555.7 11896.8 11908.8 11943.8 9330.6 9745.1 11113.9 11673.9 11893.9 07:11:47 INFO - PID 1639 | 07:11:47 INFO - PID 1639 | [#3] mootools.html Cycles:180 Average:6637.67 Median:2364.50 stddev:4190.41 (177.2%) stddev-sans-first:4184.65 07:11:47 INFO - PID 1639 | Values: 1537.7 1553.9 1581.3 1584.9 1642.5 10454.3 10901.4 10911.9 10916.1 10949.8 10563.3 10653.0 10962.8 10975.1 10989.7 2345.8 2393.0 2393.2 2394.2 2395.7 1990.3 2319.6 2360.3 2363.8 2365.2 1963.4 2282.9 2309.6 2319.0 2323.3 2265.8 2290.1 2290.1 2291.9 2295.9 2270.6 2353.3 2358.9 2365.7 2366.2 11166.8 11233.9 11245.6 11250.8 11265.3 4484.3 5039.1 5227.1 5232.9 5238.5 3318.7 3364.4 3440.1 3662.3 3673.7 1132.3 1169.1 1184.9 1218.1 1235.4 11461.8 14326.8 14375.1 15529.6 15540.8 4169.3 4292.0 4293.2 4327.9 4382.0 11427.3 11705.4 11714.1 11738.3 11755.9 5506.2 5627.2 5627.4 5630.3 5636.1 4357.4 5125.3 5280.2 5280.9 5290.3 2958.4 3475.9 3540.7 3755.3 3916.5 1014.6 1020.3 1045.8 1049.0 1050.2 886.4 916.4 919.2 942.7 956.5 5625.5 6572.0 6787.9 6826.9 7001.2 973.4 1017.8 1032.0 1036.4 1049.7 3614.7 4099.3 4225.8 4378.3 4383.6 13166.4 13645.9 13953.9 13958.8 13958.9 13836.1 13842.6 13851.0 13861.5 13889.5 9575.0 10008.4 10044.5 10047.0 10112.2 6528.5 6579.2 6644.6 6881.1 6937.5 11865.6 12030.4 12091.6 12195.5 12233.1 11153.0 11158.2 11714.4 12283.5 12438.1 9036.8 9102.0 9189.0 9229.3 9371.3 10034.8 10085.2 10159.6 10188.1 10201.9 9145.2 9146.5 9240.9 9294.8 9317.9 8847.4 9015.7 9082.1 9115.5 9262.3 7754.8 7802.2 7848.6 7866.4 7894.9 5838.5 5855.5 5969.0 6040.5 6057.5 5041.4 5447.9 5871.7 5911.3 5925.5 07:11:47 INFO - PID 1639 | 07:11:47 INFO - PID 1639 | [#4] prototype.html Cycles:180 Average:5140.28 Median:5600.65 stddev:1434.18 (25.6%) stddev-sans-first:1391.75 07:11:47 INFO - PID 1639 | Values: 316.4 376.4 381.1 382.0 388.0 5054.5 5295.0 5336.5 5792.9 5840.2 5178.3 5425.9 5679.9 5708.7 5721.3 3619.5 4355.1 4451.9 4458.6 4461.2 3836.5 4435.8 4454.0 4461.6 4482.7 3626.5 3947.9 4109.5 4450.3 4457.5 4213.6 4422.7 4589.1 4868.3 4880.2 4636.5 4662.7 4677.7 4694.5 4694.6 5618.4 5639.3 5655.7 5665.7 5685.9 4798.6 5531.1 5758.7 5777.4 5791.4 5124.9 6152.5 6182.8 6198.8 6221.4 4964.9 5116.5 5334.9 5344.4 5387.9 4952.1 6302.5 6313.3 6388.8 6478.1 5317.5 5322.7 5479.3 5490.5 5494.3 4871.7 5598.5 5602.8 5613.2 5651.5 5548.9 5717.3 5771.3 5826.4 5831.5 5418.7 6163.6 6164.7 6170.4 6170.6 1659.1 1769.2 1880.8 1904.7 1911.9 1410.0 1501.5 1534.0 1539.6 1555.9 4896.3 5359.5 5574.0 5808.9 5849.7 5639.7 5807.3 5843.4 6161.0 6376.9 4917.7 5033.3 5151.6 5811.8 5839.6 2641.7 3210.6 3305.8 3333.6 3339.1 6124.6 6269.8 6441.8 6643.3 6657.0 6506.3 6544.3 6563.5 6565.4 6616.1 6085.7 6333.7 6665.8 6701.5 6719.6 5567.8 6131.9 6304.3 6386.9 6391.0 4925.3 5226.0 5739.4 6098.7 6118.5 6611.3 6665.5 6670.9 6678.7 6697.5 3953.3 4894.2 4936.3 4941.3 4979.0 4957.9 6155.8 6240.8 6276.9 6285.8 5405.6 5785.7 6093.7 6104.7 6134.0 4957.5 5827.0 6107.4 6109.3 6123.2 4979.1 4987.6 5220.5 5978.7 6058.0 5885.4 5941.9 5968.6 6154.4 6155.0 4700.9 5160.2 5181.9 5968.5 5982.0 07:11:47 INFO - PID 1639 | 07:11:47 INFO - PID 1639 | [#5] yui.html Cycles:180 Average:21006.76 Median:25051.31 stddev:30201.13 (120.6%) stddev-sans-first:30247.58 07:11:47 INFO - PID 1639 | Values: 759.5 783.1 803.3 807.7 830.7 15061.5 15518.3 15523.4 15523.6 15528.1 14474.6 14564.6 14583.1 14592.0 15057.0 922.8 923.4 945.0 948.9 951.2 756.4 951.8 963.5 963.5 965.3 1005.6 1007.6 1009.3 1009.3 1009.6 998.7 1001.1 1001.8 1002.0 1002.3 749.5 750.3 750.4 753.0 753.9 16196.4 16388.6 16651.3 16743.8 16855.4 14518.3 14654.9 14719.7 14888.8 14925.9 10461.3 11721.5 12021.3 12027.6 12255.1 3665.6 3708.3 3809.7 3888.7 3905.5 89196.0 116298.4 116963.0 117072.0 118959.8 9303.5 10833.3 10901.5 11210.9 11364.9 24727.0 25009.0 25027.2 25032.9 25069.7 7873.9 7888.6 7954.9 7987.6 8036.3 3917.4 3991.3 4010.2 4018.6 4038.2 3348.9 3377.9 3443.7 3447.2 3447.8 610.5 614.5 615.3 617.6 627.1 620.3 672.8 679.7 679.7 708.2 9479.0 10210.2 10294.3 10301.9 10454.9 509.5 669.2 704.3 723.6 728.6 4646.0 4898.8 4962.6 4971.1 4971.6 87857.1 89120.0 104970.0 106327.0 109301.0 93750.5 94039.1 95965.0 96491.0 96759.0 66499.0 81725.4 84178.7 84218.7 85189.0 10251.5 10624.3 10925.9 10978.7 11005.8 45251.1 45714.5 47791.5 47997.0 49897.5 66579.0 67597.7 68069.3 68155.0 71650.0 13356.2 13893.7 14063.2 14110.2 14170.5 14683.7 14852.6 14901.6 15146.5 15412.6 13448.9 13960.6 14294.9 14383.6 14523.9 13413.4 13517.5 13607.3 13723.5 15056.8 13389.9 13540.5 13545.3 13683.0 14124.2 9695.6 10384.8 10974.3 11920.0 11949.2 9932.4 10174.0 11216.7 11492.7 11555.5 07:11:47 INFO - PID 1639 | -------- Summary: end -------- 07:11:47 INFO - PID 1639 | 07:11:48 INFO - TEST-INFO | 1639: exit 0 07:11:48 INFO - TEST-OK | dromaeo_css | took 1121836ms 07:11:48 INFO - TEST-START | kraken 07:11:48 INFO - operating with platform_type : mac_ 07:11:48 INFO - Initialising browser for kraken test... 07:11:48 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmpYGaP7n/profile http://localhost:49241/getInfo.html) 07:11:50 INFO - PID 1645 | __metrics Screen width/height:1600/1200 07:11:50 INFO - PID 1645 | colorDepth:24 07:11:50 INFO - PID 1645 | Browser inner width/height: 1024/689 07:11:50 INFO - PID 1645 | __metrics 07:11:50 INFO - PID 1645 | 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" 07:11:50 INFO - PID 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:11:51 INFO - TEST-INFO | 1645: exit 0 07:11:51 INFO - Browser initialized. 07:11:51 INFO - Running cycle 1/1 for kraken test... 07:11:51 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/T/tmpYGaP7n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:12:03 INFO - PID 1646 | RSS: Main: 234881024 07:12:03 INFO - PID 1646 | 07:12:06 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 07:12:07 INFO - PID 1646 | RSS: Main: 284815360 07:12:07 INFO - PID 1646 | 07:12:09 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 07:12:10 INFO - PID 1646 | RSS: Main: 286420992 07:12:10 INFO - PID 1646 | 07:12:13 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 07:12:14 INFO - PID 1646 | RSS: Main: 378265600 07:12:14 INFO - PID 1646 | 07:12:16 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 07:12:17 INFO - PID 1646 | RSS: Main: 282046464 07:12:17 INFO - PID 1646 | 07:12:19 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:12:19 INFO - PID 1646 | RSS: Main: 285474816 07:12:19 INFO - PID 1646 | 07:12:22 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 07:12:23 INFO - PID 1646 | RSS: Main: 327958528 07:12:23 INFO - PID 1646 | 07:12:26 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 07:12:27 INFO - PID 1646 | RSS: Main: 330809344 07:12:27 INFO - PID 1646 | 07:12:30 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 07:12:30 INFO - PID 1646 | RSS: Main: 330907648 07:12:30 INFO - PID 1646 | 07:12:32 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:12:33 INFO - PID 1646 | RSS: Main: 303702016 07:12:33 INFO - PID 1646 | 07:12:34 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:12:35 INFO - PID 1646 | RSS: Main: 306196480 07:12:35 INFO - PID 1646 | 07:12:37 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:12:38 INFO - PID 1646 | RSS: Main: 308838400 07:12:38 INFO - PID 1646 | 07:12:41 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:12:42 INFO - PID 1646 | RSS: Main: 321974272 07:12:42 INFO - PID 1646 | 07:12:45 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:12:46 INFO - PID 1646 | RSS: Main: 321064960 07:12:46 INFO - PID 1646 | 07:12:47 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 07:12:48 INFO - PID 1646 | RSS: Main: 382504960 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | __start_tp_report 07:12:48 INFO - PID 1646 | _x_x_mozilla_page_load 07:12:48 INFO - PID 1646 | _x_x_mozilla_page_load_details 07:12:48 INFO - PID 1646 | |i|pagename|runs| 07:12:48 INFO - PID 1646 | |0;ai-astar;114;115;116;115;114;116;115;115;115;115 07:12:48 INFO - PID 1646 | |1;audio-beat-detection;147;116;118;151;112;113;111;110;135;116 07:12:48 INFO - PID 1646 | |2;audio-dft;187;184;186;184;184;183;182;184;183;184 07:12:48 INFO - PID 1646 | |3;audio-fft;81;58;60;94;63;60;59;60;73;61 07:12:48 INFO - PID 1646 | |4;audio-oscillator;87;71;87;69;69;68;84;69;69;85 07:12:48 INFO - PID 1646 | |5;imaging-gaussian-blur;86;129;135;89;87;94;89;88;95;87 07:12:48 INFO - PID 1646 | |6;imaging-darkroom;94;94;94;95;132;97;94;94;93;94 07:12:48 INFO - PID 1646 | |7;imaging-desaturate;84;85;82;84;84;85;85;85;84;85 07:12:48 INFO - PID 1646 | |8;json-parse-financial;63;59;60;86;98;96;93;77;61;63 07:12:48 INFO - PID 1646 | |9;json-stringify-tinderbox;61;53;58;65;60;58;58;58;58;59 07:12:48 INFO - PID 1646 | |10;stanford-crypto-aes;84;83;82;83;84;82;83;82;80;80 07:12:48 INFO - PID 1646 | |11;stanford-crypto-ccm;147;141;147;135;142;162;151;147;248;198 07:12:48 INFO - PID 1646 | |12;stanford-crypto-pbkdf2;185;220;168;219;236;184;187;181;189;181 07:12:48 INFO - PID 1646 | |13;stanford-crypto-sha256-iterative;69;68;67;68;68;68;69;69;68;68 07:12:48 INFO - PID 1646 | __end_tp_report 07:12:48 INFO - PID 1646 | __start_cc_report 07:12:48 INFO - PID 1646 | _x_x_mozilla_cycle_collect,2220 07:12:48 INFO - PID 1646 | __end_cc_report 07:12:48 INFO - PID 1646 | __startTimestamp1490019168232__endTimestamp 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | ------- Summary: start ------- 07:12:48 INFO - PID 1646 | Number of tests: 14 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 07:12:48 INFO - PID 1646 | Values: 114.0 115.0 116.0 115.0 114.0 116.0 115.0 115.0 115.0 115.0 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | [#1] audio-beat-detection Cycles:10 Average:122.90 Median:117.00 stddev:15.50 (13.2%) stddev-sans-first:13.76 07:12:48 INFO - PID 1646 | Values: 147.0 116.0 118.0 151.0 112.0 113.0 111.0 110.0 135.0 116.0 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.00 stddev:1.45 (0.8%) stddev-sans-first:1.09 07:12:48 INFO - PID 1646 | Values: 187.0 184.0 186.0 184.0 184.0 183.0 182.0 184.0 183.0 184.0 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | [#3] audio-fft Cycles:10 Average:66.90 Median:62.00 stddev:12.04 (19.4%) stddev-sans-first:11.64 07:12:48 INFO - PID 1646 | Values: 81.0 58.0 60.0 94.0 63.0 60.0 59.0 60.0 73.0 61.0 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | [#4] audio-oscillator Cycles:10 Average:75.80 Median:77.50 stddev:8.64 (11.1%) stddev-sans-first:8.16 07:12:48 INFO - PID 1646 | Values: 87.0 71.0 87.0 69.0 69.0 68.0 84.0 69.0 69.0 85.0 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:97.90 Median:88.50 stddev:18.27 (20.6%) stddev-sans-first:18.86 07:12:48 INFO - PID 1646 | Values: 86.0 129.0 135.0 89.0 87.0 94.0 89.0 88.0 95.0 87.0 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | [#6] imaging-darkroom Cycles:10 Average:98.10 Median:94.00 stddev:11.96 (12.7%) stddev-sans-first:12.59 07:12:48 INFO - PID 1646 | Values: 94.0 94.0 94.0 95.0 132.0 97.0 94.0 94.0 93.0 94.0 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:85.00 stddev:0.95 (1.1%) stddev-sans-first:1.00 07:12:48 INFO - PID 1646 | Values: 84.0 85.0 82.0 84.0 84.0 85.0 85.0 85.0 84.0 85.0 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | [#8] json-parse-financial Cycles:10 Average:75.60 Median:81.50 stddev:16.26 (20.0%) stddev-sans-first:16.60 07:12:48 INFO - PID 1646 | Values: 63.0 59.0 60.0 86.0 98.0 96.0 93.0 77.0 61.0 63.0 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:58.50 stddev:3.01 (5.1%) stddev-sans-first:3.09 07:12:48 INFO - PID 1646 | Values: 61.0 53.0 58.0 65.0 60.0 58.0 58.0 58.0 58.0 59.0 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.00 stddev:1.42 (1.7%) stddev-sans-first:1.36 07:12:48 INFO - PID 1646 | Values: 84.0 83.0 82.0 83.0 84.0 82.0 83.0 82.0 80.0 80.0 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:161.80 Median:149.00 stddev:35.05 (23.5%) stddev-sans-first:36.77 07:12:48 INFO - PID 1646 | Values: 147.0 141.0 147.0 135.0 142.0 162.0 151.0 147.0 248.0 198.0 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.00 Median:188.00 stddev:21.92 (11.7%) stddev-sans-first:22.95 07:12:48 INFO - PID 1646 | Values: 185.0 220.0 168.0 219.0 236.0 184.0 187.0 181.0 189.0 181.0 07:12:48 INFO - PID 1646 | 07:12:48 INFO - PID 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 07:12:48 INFO - PID 1646 | Values: 69.0 68.0 67.0 68.0 68.0 68.0 69.0 69.0 68.0 68.0 07:12:48 INFO - PID 1646 | -------- Summary: end -------- 07:12:48 INFO - PID 1646 | 07:12:49 INFO - TEST-INFO | 1646: exit 0 07:12:49 INFO - TEST-OK | kraken | took 61013ms 07:12:49 INFO - SUITE-END | took 1182s 07:12:49 INFO - Completed test suite (00:19:43) 07:12:49 INFO - javascript benchmark 07:12:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7802.3557281674575, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.6463006754225, 3338.3657105150037, 3372.7639065265435, 3376.172837654775, 3396.8811091611797, 5610.24261724667, 5709.2292540507015, 5719.914201286979, 5773.82678519644, 5774.884502309951, 5646.18130371096, 5717.2281741964825, 5779.422057794229, 5785.045467497868, 5810.0, 5091.134507133796, 5134.383873935114, 5141.305923700309, 5162.974185129088, 5172.741362931838, 5231.163013917774, 5264.341957255343, 5269.552088072518, 5281.287026251464, 5332.840014799563, 5058.924116138224, 5125.103106956305, 5127.846164615067, 5155.484451554852, 5239.947600524003, 5139.871503212449, 5175.741212939376, 5179.766910489037, 5182.844514664528, 5186.662866913639, 5082.2122571001555, 5132.692038477703, 5135.972805438927, 5148.9959457905725, 5153.484651534854, 4567.725936443824, 5650.7174641267775, 5698.914516282259, 5703.600747947646, 5718.256626638552, 6203.968980155116, 6247.656378899159, 6250.874982500324, 6256.0, 6316.715747791361, 6256.5307601930035, 6269.498440124779, 6313.494920406357, 6318.778842740528, 6332.208473940757, 5872.794452194153, 5877.235959325303, 5889.204957330706, 5903.709392672955, 5958.553108516879, 5756.65460072397, 6234.532410069263, 6254.906176407358, 6309.022101574264, 6336.809895703136, 5985.431384018511, 6098.512119030467, 6107.48086412651, 6223.564350495421, 6257.7184026718905, 6202.596831205957, 6303.716332765037, 6339.0, 6348.809535713936, 6358.904616430757, 6293.811185664437, 6310.684465776784, 6310.968445157745, 6315.810525684236, 6318.526110541728, 6133.193602315525, 6211.65835879031, 6329.2721337045905, 6330.145430366933, 6340.809775706736, 5002.674826136289, 5027.723475208825, 5067.011932673094, 5105.132127538253, 5111.488851114933, 4452.888677783081, 4458.219811532968, 4469.843555475542, 4480.462344518679, 4524.660650451229, 5873.823785286449, 5915.645061296336, 5934.910976335358, 5939.792107276311, 5959.106134079922, 6150.108234306001, 6224.159738435344, 6241.251049874044, 6266.968665156645, 6308.022256550242, 5791.0734282514595, 5812.593118481665, 5813.360530341659, 5821.359650438449, 5828.388019258002, 5466.617336786387, 5467.234587157801, 5473.151661492475, 5473.75368108436, 5473.890522189614, 6258.436740693177, 6294.937050629526, 6297.905531416941, 6310.179676641916, 6330.335314791881, 6254.593451425642, 6267.843303917439, 6278.905816412666, 6286.37136286386, 6287.717052732546, 5717.42825717425, 6338.524610654312, 6351.460125889351, 6375.458086062737, 6448.806535803933, 6226.906596401148, 6228.03465462854, 6241.282252541016, 6246.969250073687, 6250.343713910156, 6247.781327653511, 6284.183056202664, 6294.3076261612105, 6297.905531416941, 6304.243490781136, 4993.975030124826, 5871.500922421642, 5921.496672782861, 6113.1135985281, 6144.0, 5974.850628734316, 6058.636481811105, 6130.570860039755, 6144.771045790949, 6191.876162476815, 5892.587518873637, 6006.15913772081, 6104.938950610437, 6109.2974307955155, 6117.418845209698, 6000.81997540057, 6177.351378105234, 6183.659898705614, 6186.938130618816, 6189.257289125154, 5113.565346945551, 5816.302043754777, 5941.732622031933, 5981.252343457068, 5989.3711160329285], "value": 5713.343361160026, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.4442446222862, 686.4371215603204, 743.2678811370798, 835.8411901738673, 843.8059246373338, 28319.575206371894, 28620.14139575816, 28705.28236794081, 36945.815270923675, 37533.81233093837, 39660.20679586406, 39930.00174995627, 39959.0, 40026.99932501689, 40059.198816023665, 8953.194212520872, 9160.908390916105, 9183.0, 9292.070792920722, 9304.952910359743, 7231.746888858891, 7355.190928997806, 9166.54167291636, 10718.464076796128, 10958.506867190956, 11035.172362072877, 11064.612738554153, 11123.0, 11123.72190695231, 11127.165462590337, 10945.616903408381, 11054.447277636167, 11059.612913547988, 11069.944650276777, 11091.279066860709, 7151.7854464366155, 7315.268473152695, 10427.635032773893, 10616.628418005334, 10800.297980631234, 37841.81079094587, 38408.42387364192, 38437.0, 38487.845364639106, 38577.61422385768, 3731.6641502264656, 3741.345264578715, 3788.677962373174, 3793.8103094845424, 3909.7849618270984, 27252.31869203266, 27642.0, 27975.860120699468, 28214.85892570524, 28603.9988600398, 2712.9457410851674, 3030.4696678081245, 3151.086185006345, 3245.432049391347, 3263.8694452221885, 270824.0, 273116.0, 274130.0, 274449.0, 274465.0, 49214.76963075952, 49286.59274294319, 49378.259326110136, 49397.25904111441, 49402.50597494051, 52356.0, 52541.737291314064, 52614.0, 52627.0, 52659.47340526546, 14822.555323340317, 14953.626159345886, 14986.250687465583, 14987.625309367353, 15000.549983500512, 12083.818742718866, 12097.455614497369, 12116.39418029095, 12118.969887559657, 12133.21134126279, 11701.94682478581, 11819.645410637695, 11828.822567661491, 13374.665633359244, 13563.254021028939, 5510.283663123768, 5837.737301821343, 5864.266966629171, 5895.29256489224, 5911.674857882857, 1048.7902419516126, 1073.613499140309, 1087.5486673030603, 1125.1336470917347, 1188.0911103006208, 25779.484410312063, 26579.734202658114, 26634.733652663224, 26642.86678566595, 26705.866470667912, 1123.662901129658, 1127.616610352484, 1174.7063234191453, 1186.0, 1190.2739329009298, 11234.943825280821, 12484.126111172312, 14080.0, 14369.856301437061, 14530.491432800012, 482831.0, 487529.0, 488036.0, 488320.8431030477, 488352.0, 57953.4204657948, 58450.707746461, 58464.4153558459, 58472.70763646239, 58535.414645852994, 1388.3960477192454, 1435.8133442652388, 1436.9712605747618, 1445.7903603977365, 1456.4465503108752, 24700.752992469847, 25640.871795640902, 25677.35806604775, 25768.09811656583, 25893.223203303933, 46808.76595617, 47196.292055618505, 47225.763871180425, 47235.0, 47296.76351618358, 453682.0, 455436.0, 455436.0, 456629.0, 456792.0, 34396.0, 34859.0, 35160.47259291061, 35170.82414587911, 35196.47205291872, 30112.3977520444, 41996.580034199265, 42341.1531769369, 42496.57503424926, 45102.54897450984, 32861.34277314488, 35287.64712352843, 36100.27799444049, 36351.27297454089, 36442.8177859109, 34311.0, 34392.31215375729, 35115.82442087773, 35554.28891422209, 35938.28123437569, 35594.0, 36366.818165909004, 36388.81805590955, 36512.0, 36656.45015324719, 21031.0, 29987.55018674678, 31542.842285788425, 31631.0, 31644.367112657157, 21763.347099587038, 23945.0, 24273.271801845975, 24326.0, 24328.878355608107], "value": 18563.656177915396, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.5615997762551, 394.7098882321495, 396.9503812023499, 406.5710675237625, 411.87643706887934, 12476.750464990717, 20039.998000099993, 20564.971751412406, 20917.11745942865, 21649.891750541225, 15417.306221220044, 15719.528414147566, 20521.794782052177, 20752.377428677162, 21364.57270854586, 6568.507361947849, 6921.446284297244, 6923.515353925227, 6926.480513961448, 6941.375276225139, 6496.350364963513, 6709.228438729536, 6752.93247067528, 6775.1192344995325, 6944.826379340507, 6750.93249067508, 6755.3582409671, 6768.120144381223, 6773.254941956381, 6794.966025169867, 6531.575447595891, 6815.352541508573, 6882.311768823128, 6895.0, 6898.517103802736, 6546.050822630739, 6613.008048792672, 6682.866342673119, 6685.164354455693, 6691.698873550702, 27016.59475107875, 27189.86405067962, 27222.591661125098, 27250.863745681145, 27518.587221191698, 3262.0866157475944, 3301.6698330167033, 3336.899893003214, 3344.66553344666, 3429.8456569454434, 16317.347306107742, 16695.332186712516, 16960.74558881618, 17238.569035774082, 17262.568435789206, 1960.2649006622516, 1993.9960339858494, 1996.4010796761058, 2048.6926960955975, 2060.629086764382, 139894.0, 142369.0, 144524.2914476394, 145954.0, 146479.0, 16122.838771612369, 16653.750193747102, 21145.471363216042, 21244.044018019227, 21402.464938376666, 34809.08245598254, 34941.1264718379, 34944.65055349465, 34954.65045349514, 35017.64982350144, 8881.156290152425, 9302.581383837743, 9319.204238728355, 10017.0, 10129.822088251061, 8267.338612910953, 8420.8315833683, 8455.534945578052, 8462.153784621612, 8576.271016963503, 8208.507489550646, 9891.258155638356, 10035.799284014425, 10117.595296188218, 10127.189824813997, 3482.6169121396624, 4099.569545197771, 4170.979145104255, 4217.34631132175, 4226.366045093199, 1005.4821766790109, 1009.6516701737888, 1012.1700205831148, 1014.3457469931852, 1020.9744756381001, 22143.778562214495, 22603.773962260166, 22659.886700566392, 22693.773062269494, 22744.886275568846, 952.1953948913157, 985.3595163143871, 1003.3528374198601, 1006.2201793610011, 1058.899404556566, 10957.232993690364, 11793.646190614296, 11829.0, 11836.70408239801, 11859.644210673694, 691257.0, 692940.0, 694753.0, 722931.0, 725494.0, 146117.0, 146801.26599366934, 150081.24959375133, 151553.0, 164395.3143045722, 1197.9640610781692, 1241.5778635264053, 1264.5574049082747, 1266.9239845609293, 1302.8436587609358, 17792.0, 19948.703618690455, 20440.378895803773, 20544.0, 21166.047527860974, 41950.370744438245, 55116.0, 58729.119063213235, 60645.39354606574, 60897.0, 59604.70197648984, 69619.65190174017, 77545.2245477538, 84005.0, 87912.5604371974, 10155.441450720282, 11054.668359949215, 11437.885621143681, 11698.590549330733, 12038.879611204125, 13024.47902083906, 13169.53906613264, 13204.0, 13592.0, 13624.114432561852, 11250.268732532359, 11307.547698091985, 11487.942560287145, 11489.655310340702, 11540.480678369662, 11122.666320010412, 11215.887841121485, 11353.148513861328, 11691.240069395462, 11714.062874970152, 11341.546338146713, 11463.31220126795, 11651.766964660828, 11768.82346764782, 11894.583689570823, 11501.194916355775, 11555.711107222387, 11896.76206475883, 11908.76182476363, 11943.761124777282, 9330.580123894306, 9745.12293893553, 11113.888861111609, 11673.941630291794, 11893.940530297294], "value": 11525.352760117488, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.7001484710486, 1553.9145347005917, 1581.3200323860735, 1584.8573628373447, 1642.4579888636747, 10454.3204691695, 10901.400422976743, 10911.945440272808, 10916.07213386861, 10949.781004379918, 10563.26057175998, 10653.0, 10962.835557466644, 10975.06711929485, 10989.670309890716, 2345.753695861931, 2392.95214095718, 2393.1623931623967, 2394.1979436888664, 2395.6526303685955, 1990.2636024670892, 2319.5940710375617, 2360.3391050505884, 2363.7872591466767, 2365.207655435431, 1963.3815348165353, 2282.892796993457, 2309.642005489152, 2318.976810231893, 2323.3030090972725, 2265.830062745284, 2290.118304452781, 2290.141197051106, 2291.9312420627407, 2295.8622482650926, 2270.5572413379396, 2353.3293011491814, 2358.870262135582, 2365.6569797379457, 2366.2073205476186, 11166.776664466746, 11233.887661123366, 11245.60640377591, 11250.774984500264, 11265.324080555192, 4484.304932735431, 5039.06777246207, 5227.137522308814, 5232.947670523322, 5238.476152384769, 3318.6847249511256, 3364.444866597033, 3440.122768693992, 3662.285854258421, 3673.651003154696, 1132.3206076354204, 1169.1465230381868, 1184.946677399519, 1218.0986070307908, 1235.4008305971597, 11461.828072578917, 14326.785098223534, 14375.065620734724, 15529.611759706098, 15540.766888496568, 4169.2703776838935, 4292.034292284211, 4293.184294983943, 4327.935080973788, 4382.014046839436, 11427.314361138358, 11705.414729263503, 11714.121440891968, 11738.295702257892, 11755.941220294015, 5506.201600767866, 5627.155926611041, 5627.437256274422, 5630.296212973379, 5636.098224284095, 4357.368181613649, 5125.256837758504, 5280.234366016906, 5280.867978300496, 5290.285811415487, 2958.3787404644836, 3475.9318205667587, 3540.7344449166417, 3755.3052685253315, 3916.549596796405, 1014.573878970834, 1020.3061917895902, 1045.811753884308, 1048.9527971241312, 1050.1779412718927, 886.3972498700946, 916.3768637326682, 919.1635611593418, 942.7266092833139, 956.5265193729009, 5625.521830644441, 6572.010543973134, 6787.864242715118, 6826.863462730717, 7001.194862590765, 973.3624475968252, 1017.7811770469384, 1031.9587216511406, 1036.3678156324636, 1049.6955882794057, 3614.746967712235, 4099.262132816122, 4225.809838557272, 4378.255696531597, 4383.6054755071555, 13166.407511661999, 13645.90832733379, 13953.930230348784, 13958.790618140736, 13958.860411395755, 13836.100653457494, 13842.584722458343, 13851.0, 13861.514846980308, 13889.513867014808, 9574.952125239468, 10008.39949603026, 10044.497775111215, 10047.045530674573, 10112.230359687172, 6528.510361722985, 6579.2104947406615, 6644.60132392058, 6881.10545629065, 6937.549059311129, 11865.5847045353, 12030.398480075786, 12091.637250882488, 12195.451204695988, 12233.143679942319, 11153.0, 11158.218924675519, 11714.414279286171, 12283.508659653513, 12438.129330946747, 9036.81926361456, 9102.0, 9189.035151309283, 9229.261659067124, 9371.250299975849, 10034.799304014025, 10085.193184545366, 10159.644412445528, 10188.083072523508, 10201.948990255001, 9145.222656074307, 9146.496942668216, 9240.907590924005, 9294.814103717752, 9317.86023209639, 8847.380683352361, 9015.729528114167, 9082.137196966278, 9115.544222788702, 9262.259019278306, 7754.806129846574, 7802.219778022152, 7848.60756962161, 7866.370690344645, 7894.921050789419, 5838.474537291664, 5855.502282305882, 5969.0, 6040.486558642388, 6057.515398768176, 5041.420236672683, 5447.855950250333, 5871.680686129041, 5911.320198177093, 5925.466707996301], "value": 5044.673295128979, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.4272666473683, 376.3846111607522, 381.11771249557256, 381.9980900095499, 388.04540829559284, 5054.494550544949, 5295.0, 5336.546393556548, 5792.884142317151, 5840.182374467568, 5178.300929374534, 5425.945740542594, 5679.914801277974, 5708.743106560204, 5721.256236689224, 3619.529461170044, 4355.107203023373, 4451.866444006669, 4458.554144585548, 4461.24158892989, 3836.5012548368672, 4435.800388982488, 4453.9777301113445, 4461.616898761378, 4482.731036137842, 3626.4560315952554, 3947.9210415791667, 4109.527404348508, 4450.310201918692, 4457.5096739358805, 4213.557576454489, 4422.739519237002, 4589.128065667513, 4868.342773725572, 4880.170371036932, 4636.4899861015265, 4662.743549104798, 4677.7193368398, 4694.483606803249, 4694.554017368345, 5618.438156184389, 5639.295088113986, 5655.660660360391, 5665.716714164317, 5685.943140568624, 4798.568128868418, 5531.1426728857095, 5758.7120643968055, 5777.364489906107, 5791.44981226787, 5124.876421773737, 6152.507799376084, 6182.783602573888, 6198.752049917998, 6221.440070393686, 4964.851054468336, 5116.497482215626, 5334.866628334284, 5344.385395679507, 5387.919181212285, 4952.053528150745, 6302.464290535356, 6313.337099604567, 6388.840278993016, 6478.125453063823, 5317.494837990384, 5322.6580304666595, 5479.287692599936, 5490.478404551562, 5494.2857428534035, 4871.732054736953, 5598.468145526169, 5602.831915042555, 5613.242212301368, 5651.491365777018, 5548.944510554843, 5717.285339332583, 5771.297467247088, 5826.446487583673, 5831.533477321804, 5418.726599249173, 6163.568550201443, 6164.660943648142, 6170.444659980623, 6170.629762214281, 1659.062629614264, 1769.2480695704273, 1880.8025157358554, 1904.7333373327745, 1911.9330823421392, 1409.9929500352432, 1501.527018989015, 1534.0, 1539.638185026518, 1555.9066456012677, 4896.290037944478, 5359.490848369399, 5574.0, 5808.88382232353, 5849.736761845727, 5639.7180140993605, 5807.274090738658, 5843.357230704619, 6160.969195153995, 6376.872462550816, 4917.65576409655, 5033.270175824485, 5151.6136289778415, 5811.82564523065, 5839.649621022752, 2641.7226191249642, 3210.5665735125926, 3305.818180000123, 3333.6499667535045, 3339.148517128117, 6124.5712800103565, 6269.780557680459, 6441.840468715676, 6643.335666433415, 6656.972531618398, 6506.3493650634555, 6544.345565443417, 6563.474922006228, 6565.409113179837, 6616.081336412482, 6085.665288409092, 6333.746650134128, 6665.800025999228, 6701.5308928375525, 6719.596824190564, 5567.77728890856, 6131.938680613315, 6304.306526282197, 6386.934271549775, 6391.0, 4925.2761533463, 5226.0, 5739.397363276963, 6098.695065246809, 6118.541109416722, 6611.2727599963, 6665.50008749336, 6670.9332906670315, 6678.666066696743, 6697.53117281805, 3953.3061580727795, 4894.216925291937, 4936.308916751729, 4941.283513890394, 4978.975105124451, 4957.876053098701, 6155.784547540815, 6240.843978900382, 6276.932921403463, 6285.842853928689, 5405.567554595545, 5785.739641716217, 6093.653943231976, 6104.694765261808, 6133.969330153321, 4957.4794646561595, 5826.970865145647, 6107.404353149805, 6109.327973922954, 6123.203983482119, 4979.053979743837, 4987.600991920565, 5220.504052115043, 5978.701064946648, 6058.0, 5885.437736923385, 5941.940580594139, 5968.582199246011, 6154.446099851035, 6155.0, 4700.858974230779, 5160.225966105114, 5181.864971692072, 5968.4926781224085, 5982.0], "value": 4722.473325333515, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.5263895654596, 783.1346362269692, 803.336784263757, 807.6809660184227, 830.7383174300097, 15061.472848450307, 15518.30167642456, 15523.379064837407, 15523.611909702264, 15528.068315901026, 14474.638134046654, 14564.563063108097, 14583.125012499257, 14592.0, 15057.021293615908, 922.8431166701644, 923.3674932671125, 944.9905500945006, 948.8624149498319, 951.172479942451, 756.3759898084103, 951.8477043673014, 963.4652767713916, 963.4845357733614, 965.2953344058841, 1005.6228914157191, 1007.5516395204137, 1009.2733232072895, 1009.2884516415909, 1009.6314845081566, 998.6854140945579, 1001.1340190735035, 1001.8497225416173, 1002.0, 1002.2833673923144, 749.5203070035182, 750.2534977697171, 750.4334227658084, 752.9585872776995, 753.88691696246, 16196.352145914267, 16388.590285242844, 16651.33394664212, 16743.83256167435, 16855.410060647817, 14518.274086295643, 14654.920255618246, 14719.70560588793, 14888.776668349983, 14925.850741492555, 10461.320014199053, 11721.472533736003, 12021.278723276631, 12027.579034733742, 12255.080868934776, 3665.6356649960894, 3708.332500149999, 3809.676177524914, 3888.727789054767, 3905.49228600283, 89196.0, 116298.41850790776, 116963.0, 117072.0, 118959.81040189661, 9303.488308143116, 10833.295835770807, 10901.509432075576, 11210.943945280222, 11364.94317528407, 24727.0, 25009.0, 25027.249182524552, 25032.87483562607, 25069.749302507105, 7873.881891771513, 7888.566128862968, 7954.880676789853, 7987.640556174986, 8036.316913062456, 3917.373220284741, 3991.261616600938, 4010.2380547695843, 4018.6383225509257, 4038.192361527706, 3348.8827891023698, 3377.8817741378934, 3443.741719371057, 3447.1554469154717, 3447.775894566895, 610.541283628241, 614.5390956782413, 615.3108518459354, 617.6448542088317, 627.1220291591717, 620.3238470067648, 672.8284287506655, 679.7111227728195, 679.7440261149139, 708.19619731605, 9479.0, 10210.183185345155, 10294.330868493524, 10301.896981030244, 10454.947725261478, 509.4803300633407, 669.220358282605, 704.2957042957042, 723.601929605141, 728.6320408193828, 4645.976770116128, 4898.828541001119, 4962.553370196628, 4971.130052240844, 4971.577415919687, 87857.12142878617, 89120.0, 104970.0, 106327.0, 109301.0, 93750.5312473447, 94039.05960940303, 95965.0, 96491.0, 96759.0, 66499.0, 81725.36549268982, 84178.73731894027, 84218.73671894927, 85189.0, 10251.538680759235, 10624.326374196553, 10925.945370273097, 10978.725531861768, 11005.779884402427, 45251.09497810091, 45714.54285457236, 47791.522084780096, 47997.0, 49897.50102498929, 66579.0, 67597.66201169159, 68069.29826754371, 68155.0, 71650.0, 13356.198628082346, 13893.652658683613, 14063.156210627396, 14110.223937683115, 14170.504032358818, 14683.706325873636, 14852.62868428298, 14901.552953411416, 15146.469873554373, 15412.614684632974, 13448.865511344762, 13960.58118256454, 14294.928525357722, 14383.64040898944, 14523.85476145225, 13413.396397162347, 13517.526886558922, 13607.251601162032, 13723.451061957809, 15056.849431505545, 13389.866101338863, 13540.526081587097, 13545.255010974492, 13683.0, 14124.152550846982, 9695.62226453846, 10384.844227336445, 10974.286671366335, 11920.0, 11949.163558551165, 9932.354396964174, 10174.0, 11216.66350009501, 11492.712682183012, 11555.4800033997], "value": 7746.519686766145, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1486.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 116.0, 115.0, 114.0, 116.0, 115.0, 115.0, 115.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 118.0, 151.0, 112.0, 113.0, 111.0, 110.0, 135.0, 116.0], "value": 122.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 186.0, 184.0, 184.0, 183.0, 182.0, 184.0, 183.0, 184.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 60.0, 94.0, 63.0, 60.0, 59.0, 60.0, 73.0, 61.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 87.0, 69.0, 69.0, 68.0, 84.0, 69.0, 69.0, 85.0], "value": 75.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 129.0, 135.0, 89.0, 87.0, 94.0, 89.0, 88.0, 95.0, 87.0], "value": 97.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 132.0, 97.0, 94.0, 94.0, 93.0, 94.0], "value": 98.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 82.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 60.0, 86.0, 98.0, 96.0, 93.0, 77.0, 61.0, 63.0], "value": 75.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 53.0, 58.0, 65.0, 60.0, 58.0, 58.0, 58.0, 58.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 83.0, 84.0, 82.0, 83.0, 82.0, 80.0, 80.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 141.0, 147.0, 135.0, 142.0, 162.0, 151.0, 147.0, 248.0, 198.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 220.0, 168.0, 219.0, 236.0, 184.0, 187.0, 181.0, 189.0, 181.0], "value": 195.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0], "value": 68.2, "unit": "score"}]}]} 07:12:49 INFO - Return code: 0 07:12:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:12:49 ERROR - # TBPL SUCCESS # 07:12:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:12:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:12:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:12:49 INFO - 2017-03-20 07:12:49.539 screenresolution[1650:9802] starting screenresolution argv=screenresolution get 07:12:49 INFO - 2017-03-20 07:12:49.544 screenresolution[1650:9802] Display 0: 1600x1200x32@60 07:12:49 INFO - 2017-03-20 07:12:49.550 screenresolution[1651:9805] starting screenresolution argv=screenresolution list 07:12:49 INFO - Available Modes on Display 0 07:12:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:12:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:12:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:12:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:12:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:12:49 INFO - Intel Iris: 07:12:49 INFO - Chipset Model: Intel Iris 07:12:49 INFO - Type: GPU 07:12:49 INFO - Bus: Built-In 07:12:49 INFO - VRAM (Dynamic, Max): 1536 MB 07:12:49 INFO - Vendor: Intel (0x8086) 07:12:49 INFO - Device ID: 0x0a2e 07:12:49 INFO - Revision ID: 0x0009 07:12:49 INFO - Displays: 07:12:49 INFO - Display: 07:12:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:12:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:12:49 INFO - Display Serial Number: 1600x1200 60 07:12:49 INFO - Main Display: Yes 07:12:49 INFO - Mirror: Off 07:12:49 INFO - Online: Yes 07:12:49 INFO - Rotation: Supported 07:12:49 INFO - Return code: 0 07:12:49 INFO - Running post-action listener: _resource_record_post_action 07:12:49 INFO - [mozharness: 2017-03-20 14:12:49.788987Z] Finished run-tests step (success) 07:12:49 INFO - Running post-run listener: _resource_record_post_run 07:12:49 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 37893120; Write bytes: 512552960; Read time: 252; Write time: 1564 07:12:49 INFO - TinderboxPrint: CPU usage
53.3% 07:12:49 INFO - TinderboxPrint: I/O read bytes / time
37,893,120 / 252 07:12:49 INFO - TinderboxPrint: I/O write bytes / time
512,552,960 / 1,564 07:12:49 INFO - TinderboxPrint: CPU idle
2,248.8 (46.7%) 07:12:49 INFO - TinderboxPrint: CPU system
957.8 (19.9%) 07:12:49 INFO - TinderboxPrint: CPU user
1,611.1 (33.4%) 07:12:49 INFO - TinderboxPrint: Swap in / out
247,455,744 / 0 07:12:49 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 206004224; Write bytes: 201351168; Read time: 15450; Write time: 412 07:12:49 INFO - run-tests - Wall time: 1184s; CPU: 53.0%; Read bytes: 31636480; Write bytes: 301244416; Read time: 190; Write time: 1119 07:12:50 INFO - Running post-run listener: _upload_blobber_files 07:12:50 INFO - Blob upload gear active. 07:12:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:12:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:12:50 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'] 07:12:50 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 07:12:50 INFO - (blobuploader) - INFO - Open directory for files ... 07:12:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:12:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:12:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:52 INFO - (blobuploader) - INFO - Done attempting. 07:12:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:12:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:12:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:52 INFO - (blobuploader) - INFO - Done attempting. 07:12:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:12:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:12:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:53 INFO - (blobuploader) - INFO - Done attempting. 07:12:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:12:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:12:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:12:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:12:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:12:56 INFO - (blobuploader) - INFO - Done attempting. 07:12:56 INFO - (blobuploader) - INFO - Iteration through files over. 07:12:56 INFO - Return code: 0 07:12:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:12:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:12:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98ccec96ffd99f2b1362917dfdc3672716d491e8642abaede44a771b58377c41fa22f130dd15dc4a9acc45c96e6f55bfdd7a4d13ff100ec10477bb3a538f701b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8c9e64695f39420d9d1004953336ed016e342a8c1bbf79299f73ce041e4c72991ad2efff992acad45a834a7497d5e14e861341bc0fbb66a72d2dabc1cf08ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3331dabc5632e34a282803a9109dba51d8c194278dc7832de02f4fdb8c5bde891ebd7a7ec6b575bf5aa1da8c07d5ec1690fb1c918a1b72ba90ac3042a1347b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66893693f4ae5cec1c1d331e423f9f09a26e3fc05157a359c23f2c705a48fedf95255516ad79a1cdeb45c0695018e0bd8b964cc8cd81d0ced7ae8236d92157bb"} 07:12:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:12:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:12:56 INFO - Contents: 07:12:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98ccec96ffd99f2b1362917dfdc3672716d491e8642abaede44a771b58377c41fa22f130dd15dc4a9acc45c96e6f55bfdd7a4d13ff100ec10477bb3a538f701b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8c9e64695f39420d9d1004953336ed016e342a8c1bbf79299f73ce041e4c72991ad2efff992acad45a834a7497d5e14e861341bc0fbb66a72d2dabc1cf08ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3331dabc5632e34a282803a9109dba51d8c194278dc7832de02f4fdb8c5bde891ebd7a7ec6b575bf5aa1da8c07d5ec1690fb1c918a1b72ba90ac3042a1347b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66893693f4ae5cec1c1d331e423f9f09a26e3fc05157a359c23f2c705a48fedf95255516ad79a1cdeb45c0695018e0bd8b964cc8cd81d0ced7ae8236d92157bb"} 07:12:56 INFO - Running post-run listener: copy_logs_to_upload_dir 07:12:56 INFO - Copying logs to upload dir... 07:12:56 INFO - mkdir: /builds/slave/test/build/upload/logs 07:12:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.636207 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-20 07:12:56.310954) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 07:12:56.314173) ========= 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.tD6dP4YpRU/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.6QAWnJk68A/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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/98ccec96ffd99f2b1362917dfdc3672716d491e8642abaede44a771b58377c41fa22f130dd15dc4a9acc45c96e6f55bfdd7a4d13ff100ec10477bb3a538f701b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8c9e64695f39420d9d1004953336ed016e342a8c1bbf79299f73ce041e4c72991ad2efff992acad45a834a7497d5e14e861341bc0fbb66a72d2dabc1cf08ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3331dabc5632e34a282803a9109dba51d8c194278dc7832de02f4fdb8c5bde891ebd7a7ec6b575bf5aa1da8c07d5ec1690fb1c918a1b72ba90ac3042a1347b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66893693f4ae5cec1c1d331e423f9f09a26e3fc05157a359c23f2c705a48fedf95255516ad79a1cdeb45c0695018e0bd8b964cc8cd81d0ced7ae8236d92157bb"} build_url:https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010763 build_url: 'https://queue.taskcluster.net/v1/task/XtmM43fGSC6xnOXI8chh7Q/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/98ccec96ffd99f2b1362917dfdc3672716d491e8642abaede44a771b58377c41fa22f130dd15dc4a9acc45c96e6f55bfdd7a4d13ff100ec10477bb3a538f701b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb8c9e64695f39420d9d1004953336ed016e342a8c1bbf79299f73ce041e4c72991ad2efff992acad45a834a7497d5e14e861341bc0fbb66a72d2dabc1cf08ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3331dabc5632e34a282803a9109dba51d8c194278dc7832de02f4fdb8c5bde891ebd7a7ec6b575bf5aa1da8c07d5ec1690fb1c918a1b72ba90ac3042a1347b3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66893693f4ae5cec1c1d331e423f9f09a26e3fc05157a359c23f2c705a48fedf95255516ad79a1cdeb45c0695018e0bd8b964cc8cd81d0ced7ae8236d92157bb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 07:12:56.348065) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 07:12:56.348384) ========= 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.tD6dP4YpRU/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.6QAWnJk68A/Listeners TMPDIR=/var/folders/v2/kpd6f83x6g5fhqcys8fl7zs800000w/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.005162 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 07:12:56.396677) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 07:12:56.396995) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 07:12:56.397315) ========= ========= Total master_lag: 1.74 =========