builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0025 starttime: 1485295749.02 results: success (0) buildid: 20170124115247 builduid: f755760a0ab94887a934f184a129b61e revision: 3412c1e7dde3aa95a9680f7137fea9a6b12a5c46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 14:09:09.022398) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 14:09:09.022860) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 14:09:09.023181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 14:09:09.050246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 14:09:09.050574) ========= 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.Ak10q3OUsD/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.SEWf7KIX7b/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-24 14:09:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.7M=0.001s 2017-01-24 14:09:09 (15.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.158444 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 14:09:09.233499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 14:09:09.233848) ========= 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.Ak10q3OUsD/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.SEWf7KIX7b/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.026698 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 14:09:09.283175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 14:09:09.283540) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3412c1e7dde3aa95a9680f7137fea9a6b12a5c46 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3412c1e7dde3aa95a9680f7137fea9a6b12a5c46 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ak10q3OUsD/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.SEWf7KIX7b/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-24 14:09:09,384 truncating revision to first 12 chars 2017-01-24 14:09:09,384 Setting DEBUG logging. 2017-01-24 14:09:09,384 attempt 1/10 2017-01-24 14:09:09,385 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3412c1e7dde3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 14:09:10,471 unpacking tar archive at: mozilla-beta-3412c1e7dde3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.355201 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 14:09:10.665185) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 14:09:10.665609) ========= script_repo_revision: 3412c1e7dde3aa95a9680f7137fea9a6b12a5c46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 14:09:10.666131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 14:09:10.666469) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 14:09:10.690009) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-24 14:09:10.690446) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ak10q3OUsD/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.SEWf7KIX7b/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 14:09:10 INFO - MultiFileLogger online at 20170124 14:09:10 in /builds/slave/test 14:09:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:09:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:09:10 INFO - {'append_to_log': False, 14:09:10 INFO - 'base_work_dir': '/builds/slave/test', 14:09:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:09:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:09:10 INFO - 'branch': 'Mozilla-Beta', 14:09:10 INFO - 'buildbot_json_path': 'buildprops.json', 14:09:10 INFO - 'config_files': ('talos/mac_config.py',), 14:09:10 INFO - 'default_actions': ('clobber', 14:09:10 INFO - 'read-buildbot-config', 14:09:10 INFO - 'download-and-extract', 14:09:10 INFO - 'populate-webroot', 14:09:10 INFO - 'create-virtualenv', 14:09:10 INFO - 'install', 14:09:10 INFO - 'run-tests'), 14:09:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:09:10 INFO - 'download_minidump_stackwalk': True, 14:09:10 INFO - 'download_symbols': 'ondemand', 14:09:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:09:10 INFO - 'tooltool.py': '/tools/tooltool.py', 14:09:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:09:10 INFO - '/tools/misc-python/virtualenv.py')}, 14:09:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:09:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:09:10 INFO - 'installer_path': 'installer.exe', 14:09:10 INFO - 'log_level': 'info', 14:09:10 INFO - 'log_name': 'talos', 14:09:10 INFO - 'log_to_console': True, 14:09:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:09:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:09:10 INFO - 'opt_config_files': (), 14:09:10 INFO - 'pip_index': False, 14:09:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:09:10 INFO - 'cmd': ('bash', 14:09:10 INFO - '-c', 14:09:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:09:10 INFO - 'enabled': True, 14:09:10 INFO - 'halt_on_failure': False, 14:09:10 INFO - 'name': 'check_screen_resolution'},), 14:09:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:09:10 INFO - 'cmd': ('bash', 14:09:10 INFO - '-c', 14:09:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:09:10 INFO - 'enabled': True, 14:09:10 INFO - 'halt_on_failure': False, 14:09:10 INFO - 'name': 'check_screen_resolution'},), 14:09:10 INFO - 'run_cmd_checks_enabled': True, 14:09:10 INFO - 'sps_profile': False, 14:09:10 INFO - 'sps_profile_interval': 0, 14:09:10 INFO - 'suite': 'dromaeojs', 14:09:10 INFO - 'system_bits': '32', 14:09:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:09:10 INFO - 'title': 't-yosemite-r7-0025', 14:09:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:09:10 INFO - 'use_talos_json': True, 14:09:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:09:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:09:10 INFO - 'work_dir': 'build'} 14:09:10 INFO - [mozharness: 2017-01-24 22:09:10.899524Z] Running clobber step. 14:09:10 INFO - Running pre-action listener: _resource_record_pre_action 14:09:10 INFO - Running main action method: clobber 14:09:10 INFO - rmtree: /builds/slave/test/build 14:09:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:09:13 INFO - Running post-action listener: _resource_record_post_action 14:09:13 INFO - [mozharness: 2017-01-24 22:09:13.317457Z] Finished clobber step (success) 14:09:13 INFO - [mozharness: 2017-01-24 22:09:13.317617Z] Running read-buildbot-config step. 14:09:13 INFO - Running pre-action listener: _resource_record_pre_action 14:09:13 INFO - Running main action method: read_buildbot_config 14:09:13 INFO - Using buildbot properties: 14:09:13 INFO - { 14:09:13 INFO - "project": "", 14:09:13 INFO - "product": "firefox", 14:09:13 INFO - "script_repo_revision": "production", 14:09:13 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:09:13 INFO - "repository": "", 14:09:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:09:13 INFO - "buildid": "20170124115247", 14:09:13 INFO - "pgo_build": "False", 14:09:13 INFO - "basedir": "/builds/slave/test", 14:09:13 INFO - "buildnumber": 15, 14:09:13 INFO - "slavename": "t-yosemite-r7-0025", 14:09:13 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 14:09:13 INFO - "platform": "yosemite_r7", 14:09:13 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:09:13 INFO - "branch": "mozilla-beta", 14:09:13 INFO - "repo_path": "releases/mozilla-beta", 14:09:13 INFO - "revision": "3412c1e7dde3aa95a9680f7137fea9a6b12a5c46", 14:09:13 INFO - "stage_platform": "macosx64", 14:09:13 INFO - "builduid": "f755760a0ab94887a934f184a129b61e", 14:09:13 INFO - "slavebuilddir": "test" 14:09:13 INFO - } 14:09:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 14:09:13 INFO - Running post-action listener: _resource_record_post_action 14:09:13 INFO - [mozharness: 2017-01-24 22:09:13.321043Z] Finished read-buildbot-config step (success) 14:09:13 INFO - [mozharness: 2017-01-24 22:09:13.321162Z] Running download-and-extract step. 14:09:13 INFO - Running pre-action listener: _resource_record_pre_action 14:09:13 INFO - Running main action method: download_and_extract 14:09:13 INFO - mkdir: /builds/slave/test/build/tests 14:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:13 INFO - trying https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 14:09:13 INFO - Downloading https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 14:09:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 14:09:14 INFO - Downloaded 1165 bytes. 14:09:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 14:09:14 INFO - Using the following test package requirements: 14:09:14 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 14:09:14 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:09:14 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 14:09:14 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:09:14 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 14:09:14 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:09:14 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:09:14 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 14:09:14 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 14:09:14 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:09:14 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 14:09:14 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:09:14 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 14:09:14 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:09:14 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 14:09:14 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:09:14 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 14:09:14 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 14:09:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 14:09:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 14:09:14 INFO - Fetch https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 14:09:15 INFO - Http code: 200 14:09:15 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 14:09:15 INFO - x-amz-cf-id: LyI4fVxBA_C6WrctGpFUmdTPZrJlzlUtP60Cz-OmvVT4LnXn5qhYTg== 14:09:15 INFO - x-amz-version-id: GiTcsDU.dCGsrBSOJFfNdb2arYWgWtjy 14:09:15 INFO - Expected file size: 16086066 14:09:15 INFO - Obtained file size: 16086066 14:09:22 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:09:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 14:09:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 14:09:22 INFO - Fetch https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 14:09:22 INFO - Http code: 200 14:09:22 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 14:09:22 INFO - x-amz-cf-id: L3R8X9ydgf5L-IbjT7Fvhimxb4TL9Lykbo54NJYQr65KTkWwl10-Mw== 14:09:22 INFO - x-amz-version-id: GiTcsDU.dCGsrBSOJFfNdb2arYWgWtjy 14:09:23 INFO - Expected file size: 16086066 14:09:23 INFO - Obtained file size: 16086066 14:09:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 14:09:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 14:09:29 INFO - Fetch https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 14:09:30 INFO - Http code: 200 14:09:30 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 14:09:30 INFO - x-amz-cf-id: thm6MpR51kvErFM3T4d7T_8hGm-GuAAzBdCVi8mSpLmP7_TDprI6Rg== 14:09:30 INFO - x-amz-version-id: MIHJJJQxdnOQM_T78YKB90VespNdIo4d 14:09:31 INFO - Expected file size: 14402992 14:09:31 INFO - Obtained file size: 14402992 14:09: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')]} 14:09:31 INFO - trying https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:09:31 INFO - Downloading https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 14:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 14:09:33 INFO - Downloaded 82125794 bytes. 14:09:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:09:33 INFO - mkdir: /builds/slave/test/properties 14:09:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:09:33 INFO - Writing to file /builds/slave/test/properties/build_url 14:09:33 INFO - Contents: 14:09:33 INFO - build_url:https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:09:34 INFO - Running post-action listener: _resource_record_post_action 14:09:34 INFO - Running post-action listener: set_extra_try_arguments 14:09:34 INFO - [mozharness: 2017-01-24 22:09:34.477667Z] Finished download-and-extract step (success) 14:09:34 INFO - [mozharness: 2017-01-24 22:09:34.477797Z] Running populate-webroot step. 14:09:34 INFO - Running pre-action listener: _resource_record_pre_action 14:09:34 INFO - Running main action method: populate_webroot 14:09:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:09:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:09:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:09:34 INFO - '--tppagecycles', 14:09:34 INFO - '7'], 14:09:34 INFO - 'tests': ['tsvgm']}}, 14:09:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:09:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:09:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:09:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:09:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:09:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:09:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:34 INFO - 'talos_options': ['--disable-e10s'], 14:09:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:34 INFO - 'talos_options': ['--disable-e10s'], 14:09:34 INFO - 'tests': ['damp', 'tps']}, 14:09:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:34 INFO - 'tests': ['damp', 'tps']}, 14:09:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:09:34 INFO - 'tests': ['dromaeo_dom']}, 14:09:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:09:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:09:34 INFO - 'tests': ['basic_compositor_video']}, 14:09:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:09:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:09:34 INFO - 'tests': ['a11yr', 14:09:34 INFO - 'ts_paint', 14:09:34 INFO - 'tpaint', 14:09:34 INFO - 'sessionrestore', 14:09:34 INFO - 'sessionrestore_no_auto_restore', 14:09:34 INFO - 'tabpaint']}, 14:09:34 INFO - 'other-e10s': {'tests': ['a11yr', 14:09:34 INFO - 'ts_paint', 14:09:34 INFO - 'tpaint', 14:09:34 INFO - 'sessionrestore', 14:09:34 INFO - 'sessionrestore_no_auto_restore', 14:09:34 INFO - 'tabpaint']}, 14:09:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:09:34 INFO - 'ts_paint', 14:09:34 INFO - 'tpaint', 14:09:34 INFO - 'sessionrestore', 14:09:34 INFO - 'sessionrestore_no_auto_restore', 14:09:34 INFO - 'tabpaint']}, 14:09:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:09:34 INFO - 'ts_paint', 14:09:34 INFO - 'tpaint', 14:09:34 INFO - 'sessionrestore', 14:09:34 INFO - 'sessionrestore_no_auto_restore', 14:09:34 INFO - 'tabpaint']}, 14:09:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:09:34 INFO - 'tests': ['a11yr', 14:09:34 INFO - 'ts_paint', 14:09:34 INFO - 'tpaint', 14:09:34 INFO - 'sessionrestore', 14:09:34 INFO - 'sessionrestore_no_auto_restore', 14:09:34 INFO - 'tabpaint']}, 14:09:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:09:34 INFO - 'tests': ['a11yr', 14:09:34 INFO - 'ts_paint', 14:09:34 INFO - 'tpaint', 14:09:34 INFO - 'sessionrestore', 14:09:34 INFO - 'sessionrestore_no_auto_restore', 14:09:34 INFO - 'tabpaint']}, 14:09:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:09:34 INFO - 'tests': ['tsvgx', 14:09:34 INFO - 'tsvgr_opacity', 14:09:34 INFO - 'tart', 14:09:34 INFO - 'tscrollx', 14:09:34 INFO - 'cart']}, 14:09:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:09:34 INFO - 'tsvgr_opacity', 14:09:34 INFO - 'tart', 14:09:34 INFO - 'tscrollx', 14:09:34 INFO - 'cart']}, 14:09:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:34 INFO - 'talos_options': ['--disable-e10s'], 14:09:34 INFO - 'tests': ['tp5o']}, 14:09:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:34 INFO - 'tests': ['tp5o']}, 14:09:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:34 INFO - 'talos_options': ['--disable-e10s', 14:09:34 INFO - '--xperf_path', 14:09:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:34 INFO - 'tests': ['tp5n']}, 14:09:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:34 INFO - 'talos_options': ['--xperf_path', 14:09:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:34 INFO - 'tests': ['tp5n']}}, 14:09:34 INFO - 'talos.zip': {'path': '', 14:09:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:09:34 INFO - Running post-action listener: _resource_record_post_action 14:09:34 INFO - [mozharness: 2017-01-24 22:09:34.496355Z] Finished populate-webroot step (success) 14:09:34 INFO - [mozharness: 2017-01-24 22:09:34.496488Z] Running create-virtualenv step. 14:09:34 INFO - Running pre-action listener: _resource_record_pre_action 14:09:34 INFO - Running main action method: create_virtualenv 14:09:34 INFO - Creating virtualenv /builds/slave/test/build/venv 14:09:34 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 14:09:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:09:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:09:34 INFO - Using real prefix '/tools/python27' 14:09:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:09:35 INFO - Installing distribute.............................................................................................................................................................................................done. 14:09:38 INFO - Installing pip.................done. 14:09:38 INFO - Return code: 0 14:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:09:38 INFO - Reading from file tmpfile_stdout 14:09:38 INFO - Output received: 14:09:38 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) 14:09:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aced490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff63249d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab01d30>, '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 0x10a967db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf9b20>, '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.Ak10q3OUsD/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.SEWf7KIX7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 14:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:09:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ak10q3OUsD/Render', 14:09:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:38 INFO - 'HOME': '/Users/cltbld', 14:09:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:38 INFO - 'LOGNAME': 'cltbld', 14:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:38 INFO - 'MOZ_NO_REMOTE': '1', 14:09:38 INFO - 'NO_EM_RESTART': '1', 14:09:38 INFO - 'PAGER': '/bin/cat', 14:09:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:38 INFO - 'PWD': '/builds/slave/test', 14:09:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:38 INFO - 'SHELL': '/bin/bash', 14:09:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEWf7KIX7b/Listeners', 14:09:38 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 14:09:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:38 INFO - 'USER': 'cltbld', 14:09:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:38 INFO - 'XPC_FLAGS': '0x0', 14:09:38 INFO - 'XPC_SERVICE_NAME': '0', 14:09:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:38 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 14:09:38 INFO - Cleaning up... 14:09:38 INFO - Return code: 0 14:09:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10aced490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff63249d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab01d30>, '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 0x10a967db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf9b20>, '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.Ak10q3OUsD/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.SEWf7KIX7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 14:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:09:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ak10q3OUsD/Render', 14:09:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:38 INFO - 'HOME': '/Users/cltbld', 14:09:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:38 INFO - 'LOGNAME': 'cltbld', 14:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:38 INFO - 'MOZ_NO_REMOTE': '1', 14:09:38 INFO - 'NO_EM_RESTART': '1', 14:09:38 INFO - 'PAGER': '/bin/cat', 14:09:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:38 INFO - 'PWD': '/builds/slave/test', 14:09:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:38 INFO - 'SHELL': '/bin/bash', 14:09:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEWf7KIX7b/Listeners', 14:09:38 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 14:09:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:38 INFO - 'USER': 'cltbld', 14:09:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:38 INFO - 'XPC_FLAGS': '0x0', 14:09:38 INFO - 'XPC_SERVICE_NAME': '0', 14:09:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:39 INFO - Downloading/unpacking psutil>=3.1.1 14:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:09:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:42 INFO - Installing collected packages: psutil 14:09:42 INFO - Running setup.py install for psutil 14:09:42 INFO - building 'psutil._psutil_osx' extension 14:09:42 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 14:09:43 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 14:09:43 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 14:09:43 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 14:09:43 INFO - building 'psutil._psutil_posix' extension 14:09:43 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 14:09:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:09:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:09:43 INFO - ^ 14:09:43 INFO - 1 warning generated. 14:09:43 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 14:09:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:43 INFO - Successfully installed psutil 14:09:43 INFO - Cleaning up... 14:09:43 INFO - Return code: 0 14:09:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:09:43 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')]} 14:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:43 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')]} 14:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:43 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 0x10aced490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff63249d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab01d30>, '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 0x10a967db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf9b20>, '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.Ak10q3OUsD/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.SEWf7KIX7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 14:09:43 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 14:09:43 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 14:09:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ak10q3OUsD/Render', 14:09:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:43 INFO - 'HOME': '/Users/cltbld', 14:09:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:43 INFO - 'LOGNAME': 'cltbld', 14:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:43 INFO - 'MOZ_NO_REMOTE': '1', 14:09:43 INFO - 'NO_EM_RESTART': '1', 14:09:43 INFO - 'PAGER': '/bin/cat', 14:09:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:43 INFO - 'PWD': '/builds/slave/test', 14:09:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:43 INFO - 'SHELL': '/bin/bash', 14:09:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEWf7KIX7b/Listeners', 14:09:43 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 14:09:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:43 INFO - 'USER': 'cltbld', 14:09:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:43 INFO - 'XPC_FLAGS': '0x0', 14:09:43 INFO - 'XPC_SERVICE_NAME': '0', 14:09:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:09:44 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 14:09:44 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 14:09:44 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 14:09:44 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 14:09:44 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 14:09:44 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 14:09:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:09:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:09:46 INFO - Installing collected packages: mozsystemmonitor 14:09:46 INFO - Running setup.py install for mozsystemmonitor 14:09:46 INFO - Successfully installed mozsystemmonitor 14:09:46 INFO - Cleaning up... 14:09:46 INFO - Return code: 0 14:09:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:09:46 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')]} 14:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:46 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')]} 14:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:46 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 0x10aced490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff63249d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab01d30>, '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 0x10a967db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf9b20>, '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.Ak10q3OUsD/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.SEWf7KIX7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 14:09:46 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 14:09:46 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 14:09:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ak10q3OUsD/Render', 14:09:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:46 INFO - 'HOME': '/Users/cltbld', 14:09:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:46 INFO - 'LOGNAME': 'cltbld', 14:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:46 INFO - 'MOZ_NO_REMOTE': '1', 14:09:46 INFO - 'NO_EM_RESTART': '1', 14:09:46 INFO - 'PAGER': '/bin/cat', 14:09:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:46 INFO - 'PWD': '/builds/slave/test', 14:09:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:46 INFO - 'SHELL': '/bin/bash', 14:09:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEWf7KIX7b/Listeners', 14:09:46 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 14:09:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:46 INFO - 'USER': 'cltbld', 14:09:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:46 INFO - 'XPC_FLAGS': '0x0', 14:09:46 INFO - 'XPC_SERVICE_NAME': '0', 14:09:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:47 INFO - Downloading/unpacking jsonschema==2.5.1 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 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 14:09:47 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 14:09:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:09:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:09:49 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 14:09:49 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 14:09:49 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 14:09:49 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 14:09:49 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 14:09:49 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 14:09:50 INFO - Downloading functools32-3.2.3-2.tar.gz 14:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:09:50 INFO - warning: no files found matching '*.txt' 14:09:50 INFO - no previously-included directories found matching 'build' 14:09:50 INFO - no previously-included directories found matching 'dist' 14:09:50 INFO - no previously-included directories found matching '.git*' 14:09:50 INFO - Installing collected packages: jsonschema, functools32 14:09:50 INFO - Running setup.py install for functools32 14:09:50 INFO - warning: no files found matching '*.txt' 14:09:50 INFO - no previously-included directories found matching 'build' 14:09:50 INFO - no previously-included directories found matching 'dist' 14:09:50 INFO - no previously-included directories found matching '.git*' 14:09:50 INFO - Successfully installed jsonschema functools32 14:09:50 INFO - Cleaning up... 14:09:50 INFO - Return code: 0 14:09:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:09:50 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')]} 14:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:50 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')]} 14:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:50 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 0x10aced490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff63249d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab01d30>, '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 0x10a967db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf9b20>, '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.Ak10q3OUsD/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.SEWf7KIX7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 14:09:50 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 14:09:50 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 14:09:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ak10q3OUsD/Render', 14:09:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:50 INFO - 'HOME': '/Users/cltbld', 14:09:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:50 INFO - 'LOGNAME': 'cltbld', 14:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:50 INFO - 'MOZ_NO_REMOTE': '1', 14:09:50 INFO - 'NO_EM_RESTART': '1', 14:09:50 INFO - 'PAGER': '/bin/cat', 14:09:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:50 INFO - 'PWD': '/builds/slave/test', 14:09:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:50 INFO - 'SHELL': '/bin/bash', 14:09:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEWf7KIX7b/Listeners', 14:09:50 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 14:09:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:50 INFO - 'USER': 'cltbld', 14:09:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:50 INFO - 'XPC_FLAGS': '0x0', 14:09:50 INFO - 'XPC_SERVICE_NAME': '0', 14:09:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:09:50 INFO - Cleaning up... 14:09:50 INFO - Return code: 0 14:09:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:09:50 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')]} 14:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:50 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')]} 14:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:50 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 0x10aced490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff63249d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab01d30>, '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 0x10a967db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf9b20>, '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.Ak10q3OUsD/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.SEWf7KIX7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 14:09:50 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 14:09:50 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 14:09:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ak10q3OUsD/Render', 14:09:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:50 INFO - 'HOME': '/Users/cltbld', 14:09:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:50 INFO - 'LOGNAME': 'cltbld', 14:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:50 INFO - 'MOZ_NO_REMOTE': '1', 14:09:50 INFO - 'NO_EM_RESTART': '1', 14:09:50 INFO - 'PAGER': '/bin/cat', 14:09:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:50 INFO - 'PWD': '/builds/slave/test', 14:09:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:50 INFO - 'SHELL': '/bin/bash', 14:09:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEWf7KIX7b/Listeners', 14:09:50 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 14:09:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:50 INFO - 'USER': 'cltbld', 14:09:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:50 INFO - 'XPC_FLAGS': '0x0', 14:09:50 INFO - 'XPC_SERVICE_NAME': '0', 14:09:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:51 INFO - Downloading/unpacking blobuploader==1.2.4 14:09:51 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 14:09:51 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 14:09:51 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 14:09:51 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 14:09:51 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 14:09:51 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 14:09:53 INFO - Downloading blobuploader-1.2.4.tar.gz 14:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:09:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:09:53 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 14:09:53 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 14:09:53 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 14:09:53 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 14:09:53 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 14:09:53 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 14:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:09:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:54 INFO - Downloading docopt-0.6.1.tar.gz 14:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:09:55 INFO - Installing collected packages: blobuploader, requests, docopt 14:09:55 INFO - Running setup.py install for blobuploader 14:09:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:09:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:09:55 INFO - Running setup.py install for requests 14:09:55 INFO - Running setup.py install for docopt 14:09:55 INFO - Successfully installed blobuploader requests docopt 14:09:55 INFO - Cleaning up... 14:09:55 INFO - Return code: 0 14:09:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:55 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')]} 14:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:55 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')]} 14:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:55 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 0x10aced490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff63249d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab01d30>, '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 0x10a967db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf9b20>, '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.Ak10q3OUsD/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.SEWf7KIX7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 14:09:55 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 14:09:55 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 14:09:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ak10q3OUsD/Render', 14:09:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:09:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:09:55 INFO - 'HOME': '/Users/cltbld', 14:09:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:09:55 INFO - 'LOGNAME': 'cltbld', 14:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:55 INFO - 'MOZ_NO_REMOTE': '1', 14:09:55 INFO - 'NO_EM_RESTART': '1', 14:09:55 INFO - 'PAGER': '/bin/cat', 14:09:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:55 INFO - 'PWD': '/builds/slave/test', 14:09:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:09:55 INFO - 'SHELL': '/bin/bash', 14:09:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEWf7KIX7b/Listeners', 14:09:55 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 14:09:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:09:55 INFO - 'USER': 'cltbld', 14:09:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:09:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:55 INFO - 'XPC_FLAGS': '0x0', 14:09:55 INFO - 'XPC_SERVICE_NAME': '0', 14:09:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:56 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-iR7uKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:56 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-hJ_ECZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:56 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-IbvsX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:56 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-R49XRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:56 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-GUqoxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:56 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-uvHxhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:56 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-n6rdwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:56 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-N0oXoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:57 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-HFOcSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:57 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-xoG8ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:57 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-jGoT7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:57 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-1LoX0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:57 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-KIRbul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:57 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-sB9O8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:57 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-fndCg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:57 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-x3NaQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:57 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-K78yGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:09:58 INFO - Running setup.py install for manifestparser 14:09:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:09:58 INFO - Running setup.py install for mozcrash 14:09:58 INFO - Running setup.py install for mozdebug 14:09:58 INFO - Running setup.py install for mozdevice 14:09:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:09:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:09:58 INFO - Running setup.py install for mozfile 14:09:58 INFO - Running setup.py install for mozhttpd 14:09:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:09:58 INFO - Running setup.py install for mozinfo 14:09:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:09:59 INFO - Running setup.py install for mozInstall 14:09:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:09:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:09:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:09:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:09:59 INFO - Running setup.py install for mozleak 14:09:59 INFO - Running setup.py install for mozlog 14:09:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:09:59 INFO - Running setup.py install for moznetwork 14:09:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:09:59 INFO - Running setup.py install for mozprocess 14:09:59 INFO - Running setup.py install for mozprofile 14:09:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:09:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:09:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:09:59 INFO - Running setup.py install for mozrunner 14:10:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:10:00 INFO - Running setup.py install for mozscreenshot 14:10:00 INFO - Running setup.py install for moztest 14:10:00 INFO - Running setup.py install for mozversion 14:10:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:10:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:10:00 INFO - Cleaning up... 14:10:00 INFO - Return code: 0 14:10:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:00 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 0x10aced490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff63249d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab01d30>, '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 0x10a967db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf9b20>, '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.Ak10q3OUsD/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.SEWf7KIX7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 14:10:00 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 14:10:00 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 14:10:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ak10q3OUsD/Render', 14:10:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:00 INFO - 'HOME': '/Users/cltbld', 14:10:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:00 INFO - 'LOGNAME': 'cltbld', 14:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:00 INFO - 'MOZ_NO_REMOTE': '1', 14:10:00 INFO - 'NO_EM_RESTART': '1', 14:10:00 INFO - 'PAGER': '/bin/cat', 14:10:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:00 INFO - 'PWD': '/builds/slave/test', 14:10:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:00 INFO - 'SHELL': '/bin/bash', 14:10:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEWf7KIX7b/Listeners', 14:10:00 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 14:10:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:00 INFO - 'USER': 'cltbld', 14:10:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:00 INFO - 'XPC_FLAGS': '0x0', 14:10:00 INFO - 'XPC_SERVICE_NAME': '0', 14:10:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:00 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Z8EFt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:01 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)) 14:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:01 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-xX5o59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:01 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)) 14:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:01 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-wJZy0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:01 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)) 14:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:01 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-1y2eUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:01 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-NUcPWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:01 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)) 14:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:01 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-edCPbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:01 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)) 14:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:01 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-zwk4F3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:01 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)) 14:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:01 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-d_8QJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:01 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)) 14:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:01 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-FmrY8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:01 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)) 14:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:01 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-zWEqtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:01 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)) 14:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:01 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-qE7kV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:02 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)) 14:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:02 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-eCGlza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:02 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-5CKm0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:02 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)) 14:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:02 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Ivda9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:02 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)) 14:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:02 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Bj7LSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:02 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)) 14:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:02 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-8desPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:02 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)) 14:10:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:02 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Ird2t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:02 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)) 14:10:02 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)) 14:10:02 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)) 14:10:02 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)) 14:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:10:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:10:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:10:02 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 14:10:02 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 14:10:02 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 14:10:02 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 14:10:02 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 14:10:02 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 14:10:05 INFO - Downloading blessings-1.6.tar.gz 14:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:10:05 INFO - Installing collected packages: blessings 14:10:05 INFO - Running setup.py install for blessings 14:10:05 INFO - Successfully installed blessings 14:10:05 INFO - Cleaning up... 14:10:05 INFO - Return code: 0 14:10:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:10:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:05 INFO - Reading from file tmpfile_stdout 14:10:05 INFO - Current package versions: 14:10:05 INFO - blessings == 1.6 14:10:05 INFO - blobuploader == 1.2.4 14:10:05 INFO - docopt == 0.6.1 14:10:05 INFO - functools32 == 3.2.3-2 14:10:05 INFO - jsonschema == 2.5.1 14:10:05 INFO - manifestparser == 1.1 14:10:05 INFO - mozInstall == 1.12 14:10:05 INFO - mozcrash == 1.0 14:10:05 INFO - mozdebug == 0.1 14:10:05 INFO - mozdevice == 0.48 14:10:05 INFO - mozfile == 1.2 14:10:05 INFO - mozhttpd == 0.7 14:10:05 INFO - mozinfo == 0.9 14:10:05 INFO - mozleak == 0.1 14:10:05 INFO - mozlog == 3.4 14:10:05 INFO - moznetwork == 0.27 14:10:05 INFO - mozprocess == 0.23 14:10:05 INFO - mozprofile == 0.28 14:10:05 INFO - mozrunner == 6.13 14:10:05 INFO - mozscreenshot == 0.1 14:10:05 INFO - mozsystemmonitor == 0.3 14:10:05 INFO - moztest == 0.8 14:10:05 INFO - mozversion == 1.4 14:10:05 INFO - psutil == 3.1.1 14:10:05 INFO - requests == 1.2.3 14:10:05 INFO - wsgiref == 0.1.2 14:10:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:06 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')]} 14:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:06 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 0x10aced490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff63249d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab01d30>, '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 0x10a967db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf9b20>, '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.Ak10q3OUsD/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.SEWf7KIX7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 14:10:06 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 14:10:06 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 14:10:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ak10q3OUsD/Render', 14:10:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:06 INFO - 'HOME': '/Users/cltbld', 14:10:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:06 INFO - 'LOGNAME': 'cltbld', 14:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:06 INFO - 'MOZ_NO_REMOTE': '1', 14:10:06 INFO - 'NO_EM_RESTART': '1', 14:10:06 INFO - 'PAGER': '/bin/cat', 14:10:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:06 INFO - 'PWD': '/builds/slave/test', 14:10:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:06 INFO - 'SHELL': '/bin/bash', 14:10:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEWf7KIX7b/Listeners', 14:10:06 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 14:10:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:06 INFO - 'USER': 'cltbld', 14:10:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:06 INFO - 'XPC_FLAGS': '0x0', 14:10:06 INFO - 'XPC_SERVICE_NAME': '0', 14:10:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:06 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)) 14:10:06 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)) 14:10:06 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)) 14:10:06 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)) 14:10:06 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)) 14:10:06 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)) 14:10:06 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)) 14:10:06 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)) 14:10:06 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)) 14:10:06 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)) 14:10:06 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)) 14:10:06 INFO - Cleaning up... 14:10:06 INFO - Return code: 0 14:10:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:10:06 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')]} 14:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:06 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')]} 14:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:07 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 0x10aced490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac63570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff63249d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab01d30>, '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 0x10a967db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf9b20>, '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.Ak10q3OUsD/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.SEWf7KIX7b/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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 14:10:07 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 14:10:07 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 14:10:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ak10q3OUsD/Render', 14:10:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:07 INFO - 'HOME': '/Users/cltbld', 14:10:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:07 INFO - 'LOGNAME': 'cltbld', 14:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:07 INFO - 'MOZ_NO_REMOTE': '1', 14:10:07 INFO - 'NO_EM_RESTART': '1', 14:10:07 INFO - 'PAGER': '/bin/cat', 14:10:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:07 INFO - 'PWD': '/builds/slave/test', 14:10:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:07 INFO - 'SHELL': '/bin/bash', 14:10:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEWf7KIX7b/Listeners', 14:10:07 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 14:10:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:07 INFO - 'USER': 'cltbld', 14:10:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:07 INFO - 'XPC_FLAGS': '0x0', 14:10:07 INFO - 'XPC_SERVICE_NAME': '0', 14:10:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:10:07 INFO - Cleaning up... 14:10:07 INFO - Return code: 0 14:10:07 INFO - Running post-action listener: _resource_record_post_action 14:10:07 INFO - Running post-action listener: _start_resource_monitoring 14:10:07 INFO - Starting resource monitoring. 14:10:07 INFO - [mozharness: 2017-01-24 22:10:07.478556Z] Finished create-virtualenv step (success) 14:10:07 INFO - [mozharness: 2017-01-24 22:10:07.479498Z] Running install step. 14:10:07 INFO - Running pre-action listener: _resource_record_pre_action 14:10:07 INFO - Running main action method: install 14:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:07 INFO - Reading from file tmpfile_stdout 14:10:07 INFO - Detecting whether we're running mozinstall >=1.0... 14:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:10:07 INFO - Reading from file tmpfile_stdout 14:10:07 INFO - Output received: 14:10:07 INFO - Usage: mozinstall [options] installer 14:10:07 INFO - Options: 14:10:07 INFO - -h, --help show this help message and exit 14:10:07 INFO - -d DEST, --destination=DEST 14:10:07 INFO - Directory to install application into. [default: 14:10:07 INFO - "/builds/slave/test"] 14:10:07 INFO - --app=APP Application being installed. [default: firefox] 14:10:07 INFO - mkdir: /builds/slave/test/build/application 14:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:10:29 INFO - Reading from file tmpfile_stdout 14:10:29 INFO - Output received: 14:10:29 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:10:29 INFO - Running post-action listener: _resource_record_post_action 14:10:29 INFO - [mozharness: 2017-01-24 22:10:29.288161Z] Finished install step (success) 14:10:29 INFO - [mozharness: 2017-01-24 22:10:29.288300Z] Running run-tests step. 14:10:29 INFO - Running pre-action listener: _resource_record_pre_action 14:10:29 INFO - Running main action method: run_tests 14:10:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:10:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:10:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:10:29 INFO - 2017-01-24 14:10:29.303 screenresolution[1617:7214] starting screenresolution argv=screenresolution get 14:10:29 INFO - 2017-01-24 14:10:29.305 screenresolution[1617:7214] Display 0: 1600x1200x32@60 14:10:29 INFO - 2017-01-24 14:10:29.311 screenresolution[1618:7216] starting screenresolution argv=screenresolution list 14:10:29 INFO - Available Modes on Display 0 14:10:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:10:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:10:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:10:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:10:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:10:29 INFO - Intel Iris: 14:10:29 INFO - Chipset Model: Intel Iris 14:10:29 INFO - Type: GPU 14:10:29 INFO - Bus: Built-In 14:10:29 INFO - VRAM (Dynamic, Max): 1536 MB 14:10:29 INFO - Vendor: Intel (0x8086) 14:10:29 INFO - Device ID: 0x0a2e 14:10:29 INFO - Revision ID: 0x0009 14:10:29 INFO - Displays: 14:10:29 INFO - Display: 14:10:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:10:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:10:29 INFO - Display Serial Number: 1600x1200 60 14:10:29 INFO - Main Display: Yes 14:10:29 INFO - Mirror: Off 14:10:29 INFO - Online: Yes 14:10:29 INFO - Rotation: Supported 14:10:29 INFO - Return code: 0 14:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:10:29 INFO - Python 2.7.3 14:10:29 INFO - Return code: 0 14:10:29 INFO - grabbing minidump binary from tooltool 14:10: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')]} 14:10:29 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 0x10ab01d30>, '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 0x10a967db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:10:29 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 14:10:29 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 14:10:29 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 14:10:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:10:29 INFO - Return code: 0 14:10:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:10:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:10:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:10:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:10:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--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 14:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0025 --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 14:10:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ak10q3OUsD/Render', 14:10:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:10:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:10:29 INFO - 'HOME': '/Users/cltbld', 14:10:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:10:29 INFO - 'LOGNAME': 'cltbld', 14:10:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:10:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:29 INFO - 'MOZ_NO_REMOTE': '1', 14:10:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:10:29 INFO - 'NO_EM_RESTART': '1', 14:10:29 INFO - 'PAGER': '/bin/cat', 14:10:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:29 INFO - 'PWD': '/builds/slave/test', 14:10:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:10:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:10:29 INFO - 'SHELL': '/bin/bash', 14:10:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SEWf7KIX7b/Listeners', 14:10:29 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 14:10:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:10:29 INFO - 'USER': 'cltbld', 14:10:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:10:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:29 INFO - 'XPC_FLAGS': '0x0', 14:10:29 INFO - 'XPC_SERVICE_NAME': '0', 14:10:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:10:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--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 14:10:29 INFO - mozversion application_buildid: 20170124115247 14:10:29 INFO - mozversion application_changeset: 3412c1e7dde3aa95a9680f7137fea9a6b12a5c46 14:10:29 INFO - mozversion application_display_name: Firefox 14:10:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:10:29 INFO - mozversion application_name: Firefox 14:10:29 INFO - mozversion application_remotingname: firefox 14:10:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:10:29 INFO - mozversion application_vendor: Mozilla 14:10:29 INFO - mozversion application_version: 52.0 14:10:29 INFO - mozversion platform_buildid: 20170124115247 14:10:29 INFO - mozversion platform_changeset: 3412c1e7dde3aa95a9680f7137fea9a6b12a5c46 14:10:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:10:29 INFO - mozversion platform_version: 52.0 14:10:29 INFO - using testdate: 1485295829 14:10:29 INFO - actual date: 1485295829 14:10:29 INFO - starting webserver on 'localhost:49235' 14:10:29 INFO - SUITE-START | Running 2 tests 14:10:29 INFO - TEST-START | dromaeo_css 14:10:29 INFO - operating with platform_type : mac_ 14:10:29 INFO - Initialising browser for dromaeo_css test... 14:10:29 INFO - TEST-INFO | started process 1628 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpDDJLqI/profile http://localhost:49235/getInfo.html) 14:10:32 INFO - PROCESS | 1628 | __metrics Screen width/height:1600/1200 14:10:32 INFO - PROCESS | 1628 | colorDepth:24 14:10:32 INFO - PROCESS | 1628 | Browser inner width/height: 1024/689 14:10:32 INFO - PROCESS | 1628 | __metrics 14:10:33 INFO - PROCESS | 1628 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:10:33 INFO - PROCESS | 1628 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:10:34 INFO - TEST-INFO | 1628: exit 0 14:10:34 INFO - Browser initialized. 14:10:34 INFO - Running cycle 1/1 for dromaeo_css test... 14:10:34 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpDDJLqI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:46 INFO - PROCESS | 1632 | RSS: Main: 171991040 14:10:46 INFO - PROCESS | 1632 | 14:13:49 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 14:13:51 INFO - PROCESS | 1632 | RSS: Main: 297218048 14:13:51 INFO - PROCESS | 1632 | 14:16:54 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 14:16:54 INFO - PROCESS | 1632 | RSS: Main: 299646976 14:16:54 INFO - PROCESS | 1632 | 14:19:57 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 14:19:57 INFO - PROCESS | 1632 | RSS: Main: 268070912 14:19:57 INFO - PROCESS | 1632 | 14:22:59 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 14:23:00 INFO - PROCESS | 1632 | RSS: Main: 285143040 14:23:00 INFO - PROCESS | 1632 | 14:26:03 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 14:26:03 INFO - PROCESS | 1632 | RSS: Main: 259821568 14:26:03 INFO - PROCESS | 1632 | 14:29:06 INFO - PROCESS | 1632 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 14:29:07 INFO - PROCESS | 1632 | RSS: Main: 330383360 14:29:07 INFO - PROCESS | 1632 | 14:29:07 INFO - PROCESS | 1632 | __start_tp_report 14:29:07 INFO - PROCESS | 1632 | _x_x_mozilla_page_load 14:29:07 INFO - PROCESS | 1632 | _x_x_mozilla_page_load_details 14:29:07 INFO - PROCESS | 1632 | |i|pagename|runs| 14:29:07 INFO - PROCESS | 1632 | |0;dojo.html;3440.7247420206386;3447.9482807757886;3451.2579795344004;3462.5844898612154;3509.368313703534;5696.943030569693;5708.8858222835515;5749.080147176453;5813.622114562556;5828.242328497295;5795.565332600051;5875.941240587593;5878.853028674285;5886;5892.941070589292;5178.974105129479;5203.765830537616;5222.138347172712;5264.499872512105;5303.867403314929;5157.48425157485;5166.121759300909;5172.09488339541;5306.92039619406;5312.893742125155;5186.351706036746;5238.947610523903;5244.318238628973;5247.16045432729;5263.894722105575;4509.751963641998;5221.686698798066;5237.895242095136;5262.60530460217;5284.2866213061125;5068.645194836363;5133.563647090002;5237.3453318335205;5255.185446255837;5385.649932754398;5623.465770751772;5664.745086471119;5671.801486947978;5740.799072032459;5770;6065.302490213638;6091.02543593023;6108.602940808878;6122.846928826771;6146.508279337642;6199.504039676815;6201.286852011986;6206.348333425016;6212.502999760009;6215.409536094064;5795.275590551181;5806.854828629318;5821.330546987151;5893.14549390336;5961.850953726148;6243.43809057178;6276.874462510724;6285.277193122849;6295.811125666238;6300.873982520324;6158.692065396713;6172.506199504029;6173.969130154321;6175.413335733098;6181.320054793969;6072.149899014142;6097.481714054266;6140.508759299245;6219.40915613016;6228.159198508234;6124.142620033199;6137.193127861533;6158.353372895782;6186.907196392058;6194.256689197326;6115.357887421846;6168.383161683796;6174.073888916609;6199.628022318675;6215.12988181655;4941.65408421407;4988.102141614471;5002.424721157041;5010.473900240495;5014.34813474246;4426.822927082881;4443.00032492693;4450.955490445054;4454.309582014793;4491.258942274488;5720.742566584514;5888.735006924699;5910.940890591125;5923.4668879800165;5967.104934259809;6171.84570385744;6189.535784816157;6222.657753823492;6227.750889964442;6228;5721.77112915487;5782.971085144632;5793.594448388572;5823.82528524145;5896.115582662635;5388.892222155613;5408.810691625774;5423.240746295522;5428;5436.429174936654;6211.627302361872;6240.500759939194;6242.937570624235;6264.561480696308;6325.399087086719;5146.665466744649;6166.414190651881;6198.690065496798;6202.193714817045;6228.4705800007505;6266.404691554295;6271.560990730605;6277.18396608438;6280;6281.96859015702;6070.362611925861;6114.327782088646;6145.047517634774;6150.661713605795;6248.437640612185;6180.752769889334;6189.535784816067;6217.689115544114;6224.346443623354;6232.968835155795;6005.7297421617;6010.54920880927;6059.520254802358;6205.968970155121;6229.314775374796;5744.195812586325;6054.727537260922;6075.544334174866;6198.535109866868;6200.131981522681;4916.385451818523;5732.681483258791;6055.940210463239;6071.908921366271;6093.268807743099;6144.271063764375;6183.628982261079;6186.226721659793;6187.350328215653;6191.9690401547705;5843.532517398513;5942.64344139353;6069.937760891915;6089.451949324582;6100.481459075851 14:29:07 INFO - PROCESS | 1632 | |1;ext.html;496.5158970004246;502.3118327890789;516.6564234783868;533.9038972984864;540.7080176704579;31750;33628.66371336286;42267.577324226746;43111.56888431115;43321.56678433215;45112.3233151503;45340;45411;45494.090118197615;45620;9688.757781055478;9876.358036727626;9879.20966322696;9880.654177103803;9897.554610042529;8931.464112153291;9138.268938484905;11654.300741955467;11881.227720198203;11886.643400697993;11840.940795296012;11867.821982670266;11917.046636269077;11926.940365298162;11939.940300298485;11936.98535624473;12008.69978250542;12025.879741202563;12026.579069732605;12036.63890083299;11803.940980295129;11865.466054027504;11873.584424545186;11898.643040708706;11905.464254108585;31529.842350788327;39031;41535.584644153474;41950.37074443886;41961.58038419607;3320.8671653133847;3350.8157051362164;3431.8455669494683;3438.948415773765;4156.688248381353;30448;30562.235944101354;30613.540796888065;31510.89711860074;32763;3291.53918451417;3315.1380641033506;3327.7504187185814;3388.3731509670542;3439.6216416194197;510417;513390;514615;515359;519604.40197798767;35049.474257886155;65652;65812.67093664501;65895;65919.67040164865;36296.81851590778;37297.627023729416;37317.44023839645;37374.43938340927;37392.626073739455;15146.16696081704;15295.15876626774;15319.080855148726;15321;15327;11067.169962252703;12882.80675789864;13012.958963282914;13040.739185216433;13058.34708264583;7731.613419329011;8110.878336824952;8272.793180170544;8272.958635206785;8288.668453261922;3365.057783820534;3385.950355389837;3390.2710917152435;3390.5253264542985;3407.30150319184;860.4321148042262;909.1953621045423;987.6000219910948;1001.9129244769507;1004.6684594083935;29643.55534666982;30381.392372152433;30441.39117217643;30705.315551654352;31047;1061.527620209015;1123.6179698902413;1145.4158379226653;1162.8139497680331;1208.879112088784;15824.525264242091;16063.678726425405;16087.758683619755;16313.417473593645;16387;696989;704994;705377.4731126414;706747;708108.4594577097;62816;62897;63217.68391158015;63231.367686323465;63292;1276.5213045108085;1311.3639884655743;1369.397465115346;1372.8901687864748;1391.2487256881373;28952.855235723688;29785.5532167022;31594.684053159173;32152.35695286128;32204.83897580497;53260.73369633127;53853;53876.19185712139;53950.460495394545;54010;515172;518317;519705;520000;520283;27367.863160684068;28532.42935141327;28560.85719571389;28575.857120715096;28640.849506554678;48552;49241.340959643705;49596.50403495919;49724;50164.24753628625;36368;39199.41200882046;39561.60438395695;40195.99510012273;42061.1587768249;38879;40809.59190408058;40926.59073409228;41440;41653.79173104115;38142.8092859545;38522.6147738519;38588.8776117305;39139.804300978314;39559.208815822945;33683.831580841936;35037.47443788396;35912.82043589765;36061.81969090138;36169.63830361663;26103.608445873706;26154.476910461304;26242.60636090422;26311.07911223098;26959.32601684895 14:29:07 INFO - PROCESS | 1632 | |2;jquery.html;390.66598058659844;391.4500127321115;391.6455607675054;399.6902400639504;421.7532743345143;14568.417263309482;19866.304679336226;20904.163833446644;21001.15995360186;21046;16405.42581009665;19258.325958591453;20791.792082079173;20905.37283881486;20990.475238119056;5809.302883653967;6134.631922084667;6138.754449822001;6148.538859585527;6149.016157414814;5756.856078598027;5964.761409543635;5994.220751302325;6033.668148251844;6079.179310793031;5974.283086029683;5976.820695379146;5978.491828194608;5983.072623743326;5985.371535988724;5197.558207552363;5743.138529220609;5944.375840536746;5963.135345374918;6001.3098493672915;5245.501677340647;5248.895022099537;5255.684658920439;5256.211568264791;5257.8159764408065;25347.366315842253;26259.343516412053;26469.205923822316;26487;26604.60093098605;2167.8916054197225;2477;2873.209867286513;3159.289159939018;3192.4732419150814;13364.465421383133;15671.608209794733;15735.527934161993;15796.894217404786;16277.186140692918;1907.6661584222707;1946.3577019583504;1987.205117952816;1989.5821877405763;2020.7575090989176;122195;126069.36965315207;126777;129483.35258323743;135398.32300838432;10916.508757105948;11383.88616113845;11676.883231167749;11690.123240756808;11888.34614096233;15116.697666046617;15117.941744077809;15133.848661513244;15138.016028958082;15140.697186056217;7527.548347099191;7552.471327007167;8006.559639219899;8380.198257374572;8518.190771876662;8433;8451.535165565952;8573.957130214434;8694.347923905732;8710.520921349387;4666.346711460398;4668.929966050512;4674.11191873543;4687.179743544866;4751.382320298339;1762.8649905731713;1950.9512262193275;2009.6936990955996;2011.7384739984002;2014.476236178604;800.4956877167464;888.6889588643922;897.9461232326081;964.3876138651866;1017.4251547875426;20677.379678609665;21318;21544.922753862244;21560.0297986591;21732;859.9723330619975;948.7390967483997;967.6344668811457;1048.8096011027387;1076.7631121153333;9267.536623168815;10880.455977201109;11252.606158784403;11377.488013039432;11388.487518061707;591008;593658;596156;609069.954650224;609178;117169;137674.62325376619;137708.18021369405;142142.57857421294;144849.55150448572;978.608556577389;1020.4999550220339;1032.7056788815153;1032.9173666106694;1034.8602938603342;18340.991245481626;18756.718649220544;19119.808801911804;19187.232510699414;19486.415407537796;46344.42506708503;55458;57002.42997570137;58490.4150958502;58940;80459.98850028796;84454.57772711097;84629.57685211535;85647.1435285664;86423.56788216019;8068.314193293401;8100.541902457614;8247;8637.093105223861;8638.049814520273;9276.07239276094;12540.686482838002;13205.735885282049;13243.933780331037;13895.166290022631;11526.596569120376;11791.410429478321;11795.11536634773;11834.763304733684;11842.76314473723;9194.816103678022;11187.16096292765;11235.71910702239;11636.185467017227;11862.644120676394;11499.022583080532;11750;11751.588694395656;11867.050635949276;12002.699932501757;7348.889766653611;8135.959320203361;8498.532580707873;8604.698835540727;8785.341099417441;9681.612735490784;11268.887311126784;11628.709282268012;11886.821697674715;11948.163628546266 14:29:07 INFO - PROCESS | 1632 | |3;mootools.html;1532.8733380964989;1566.451741890338;1731.7229243321071;1851.7037274036156;1873.304659283349;8109.31070858977;8527.786805329853;8535.615897284622;8537.359698022643;8547.914520854789;7644.46488745788;7872.0947091084545;7885.881711774328;8130.55281959492;8400.075991640915;2365.124903785602;2404.0744313439363;2409.0484258717797;2411.867347295898;2417.0815090265764;2391.988040059797;2422;2432.7932125769244;2437.987810060947;2439.4389290463205;2383.2611890314056;2387.200287903546;2410.4576470294132;2412.4813165169485;2417.153996101368;2363.031157225529;2370.1230544698487;2386.997461066356;2389.6415537669313;2391.641253811916;2398.1486572266945;2416.311351264881;2422.551827911824;2425.4300239443714;2426.6602675625427;8184;8361.498310101413;8379.413441059129;8379.49723016615;8380.748577542683;5087.440381558025;5248.950209958024;5253.52718255355;5260.631755777097;5267;3284.5237440571223;3431.828408579586;3529.4882242074755;3602.3342726382552;3604.1530240393486;1030.953607087683;1042.687193841852;1078.3044936016304;1090.2967585907045;1096.703889949717;10737.83893241602;10889.891101088966;10907.127429805596;10919.344839309666;10925.180611454094;4506.616937560344;4646.95353046472;4735.83424580138;4739.004808990082;4784.61246238587;9460.668876589423;9462.621495140254;9470.715878523517;9490.620375185053;9496.192823609932;5274.26160337553;5282.735863206901;5293.470652934753;5297.735113244323;5299;4312.870613881589;4606.585407313358;4853.490383509751;4883.755812209375;4886.951130488721;3853.537575490959;3873.0511024798543;3904.355781296111;3953.4069889516804;3977.4033894915992;1096.276457538021;1107.3909349857547;1281.0712233630543;1282.236924229185;1294.7022184897337;784.2510402565537;787.5078076202374;888.493558671551;928.8049509602924;948.2698322291797;5644.435556444323;5645.520130788929;5669.489745922887;5869.178315035899;5928.288605367384;454.9181147393435;455.15795777810786;461.16989419045586;469.1438125421052;471.067286772193;3822.980885095557;3832.0419895026243;3879.437481565157;3932.036651020518;3963.841446342114;8563.828723425497;9753.21974242059;10130.24023198263;10209.183265338756;10209.693709188736;10162.644307449204;10165.135963443043;10167.4916254187;10184.032516910882;10198.235132365102;7513.39892808574;7779.533228006338;7891.960540197262;7902.802429939297;7931.325837303779;5412.350517937715;5594.13290939905;5607.579431542569;5617.522510586646;5679.381376307732;7867.685292588461;9253.907460925573;9269.86095208559;9339.57971891253;9395.81208375815;9405.858912116188;9417.623295068395;9531.52342382892;9550.90449095528;9586.760330991781;6656.201255849329;6872;6879.380855723009;7139.643017849191;7258.0927384076995;7439.702411903463;7633.732819351296;7935.880961785462;7939.6030198491;8030.799230019296;6329.49364050884;7122.145342558926;7238.27617238272;7256.346928776225;7266.237045110399;7070.823229419306;7089.893651595127;7129.572225666477;7133.857322853618;7210.675519601736;6726.831829204309;6774.424173945073;6782.593044417351;6786.558873673195;6796.76211332601;4943.184374578298;4948.851534453972;4951.5048495150195;4957.876053098701;4981.975090124672;4802.968460111318;4895.877603059952;4925.433575138905;5022.748862556785;5073.239014147907 14:29:07 INFO - PROCESS | 1632 | |4;prototype.html;264.82521535786384;293.2200347076776;295.17645768306426;304.4489474051965;312.0731427659852;4487.439070116236;5064.468230835764;5301.363836339639;5370.91943620846;5424.864378390542;4681.464621379077;4981;5145.691258524491;5260.631755777097;5281.128613778731;3418.3421040795192;4030.334994725881;4064.9593504065024;4074.2258970795456;4082.2856000199995;3730.3844865597143;4068.5524592294823;4075.49056367954;4087.3460246360587;4087.5912408759036;3386.4920261960656;3687.8567644030436;3750.9812450937707;4053.5946405359523;4087;3526.3778661815595;4008.8997775055564;4071.7149799514045;4087.264292427362;4112.134593482117;2815.4932112219794;2907.037749519066;3535.8585656573705;3537.8231088445473;3541.7166626669805;5211.322528071327;5221.242919776649;5243.318368612094;5244.632875698702;5246.580273578104;4130.483689538808;4160.771157586331;4567.908641827178;4599.379083823675;4638.814447422099;4801.975990120062;4883.923128429103;5482.095454250044;5610.214569960209;5617.269754931874;3840.5007349044727;3850.9807450962844;3854.5759966403675;3860.6332398422105;3869.2454971280613;5620.241267428926;5781.53747700183;5797.768089276424;5847.649141051551;5862.736176872008;3663.7618554793853;3838.6353296436796;3842.3083844908183;3845.4616353710503;3857.286402015636;3849.9990002599525;3864.8840534784003;3921.274564205631;3922.8231530540725;3950.644442000234;4405.7797110144365;4572.7942242599165;4579.335996280521;4589.770511474413;4599.378354337995;4805.207140821795;5269.894602108013;5449.073657478239;5601.383847776741;5602.154136671749;1097.720081379243;1257.8239046533492;1269.3462866623697;1269.819068266521;1276.3853725037834;772.0773675457887;810.9837803243902;830.4560512864084;864.5374724522476;868.6785889221029;4052.63526282636;4396.3625274335045;4455.331700244924;4813.7352445615825;4911.410630724265;4851.369321988119;4985.4017517897355;5385.973070134624;5452.427495113036;5468.824202796418;4065.4105154752397;4295.591918767712;4629.519387228617;5036.773345199402;5104.846854594368;2460.286516910112;2500.6996361891715;2846.957295640567;2870.8708108135183;2908.2874695699265;5357.410534941599;5641.971790141105;5654.105874532078;5658.74535645897;5671.716414179275;4992.375953005874;5339.599530035263;5463.344398672185;5613.943860561342;5622.493975542139;4945.727984960789;5544.91682624761;5618.494335509742;5637.210790489335;5643.855334972684;4634.381574410448;5422.240886275846;5428.592855535771;5477.945220547744;5543.196236545759;4434.866953991385;4976.502349765139;5039.823606173766;5110.770015349392;5380.623356365173;4680;5080.695158290514;5110.105731497048;5334.186376631964;5564.666120032811;3395.8249037150345;3412.1640198151613;3422.383970885165;3652.3060618482405;3659.6157403472253;4873.9025219496125;5344.3853956795465;5396.298481197419;5733.569982251264;5789.478946894799;5070.721110338966;5531.3362396512675;5595.692236927008;5597.440255974533;5607.43925607436;4723.338732577373;5552.5008247773685;5610.691411972218;5625.690587017753;5688.345840228261;5215.114739519083;5439.700816455133;5484.8354549363585;5492.505674489315;5521.4539928819995;4505.459344878635;4846.757662116809;4962.602991760723;5545.861353466195;5656.745446454837;4956.083124621957;5275.393329767126;5485.61600687948;5495.6153069286365;5517.393086760373 14:29:07 INFO - PROCESS | 1632 | |5;yui.html;696.3350000749282;724.2467833453208;724.9891251631225;747.2116916652928;756.5196100476196;14701.1914344711;15179.544613661608;15515.844841551581;15720.213989300531;15740.606484837885;14185.432582696705;14282.857171428283;14377.78433323501;14380;14407.711845763104;850.6809946270149;852.7058164933119;854.4360721923532;862.3187681731424;881.7751473374296;698.8218004408868;726.4370113162289;729.773770131261;732.2238427267114;858.3476557816042;762.2149186338081;766.9271419215165;898.7977705016384;928.6517555916531;942.3874481586955;929.9953500232456;930.0652843891879;931.855562387831;932.2541966426832;932.4545141092469;692.5429216716942;692.6052150274346;693.0055370543287;693.0747452151384;693.1647364925253;14087.506937257249;14105.2242126683;14459.493917712934;14500.057496262709;14508.202048887308;13065.608031758968;13528.120672156278;13847.930760346235;13856.30718464083;14141.787873181911;12508.124431289812;12725.681857953532;12809.61571152867;12876.163049401759;12953.417096230693;4520.773961301955;4830.082284365959;4844.66087373884;4889.511048895118;4900;89891;91715.54142229246;93373;94432.52783736175;96116.51941740247;9909.009099090033;10714.46427678613;10824.621138260123;10919.290246133976;11031.724206894893;17917.7312340315;20201.898990504953;20243.696344554843;20271.797282027284;20322.593548128956;7921.405894557931;8039.316658084012;8087.636056377477;8327.167283271625;8389.119142490074;4372.890677733082;4467.977660111678;4476.574725401082;4519.88700282489;4667.066586682677;3368.040108569046;3401;3428.708559772397;3461.5153878457036;3484.52958850557;663.6747993483159;668.7726173101169;670.5473805181483;677.4411110833582;682.8975653651992;551.503646717949;662.4123095812198;688.9315621721177;695.5652717051843;720.9495335326582;9357.953210234042;9452.19656329206;9492.839409969274;9514.571844267024;9853.75365615851;595.6098755315276;644.3427703742251;669.9162604674416;680.5066326912948;700.5936556797045;4346.174226896879;4615.16926953145;4629.490756016903;4697.694649847749;4746.667733258639;114806;119220;121282;123212.38393807973;127219;101223;103495.4825225869;103716;106493.40259896108;109697;70064;92415;92551.97249958938;94527.10945781184;95667.52166239124;8259.710910118118;8462.619182136696;8932.910670893209;9160.770980725536;9253.907460925573;59484.70257648684;60431.69784151051;60628.78742425215;61525;62419.43951401251;72317;82742;84090;87291.56354218189;87751;11340.149488788209;11698.2981021139;11765.294082355085;11874.346910919638;11903.642890713292;11934.940325298317;12677.619671409873;14078.554979994286;14836;15441.613959651098;14010.43958241659;14090.78863817023;14264.643383915485;14840.925795370955;14912.179830109015;14128.858711413166;14151.080179788281;14529.491467798576;14840.628984275048;14929.552113436614;13345.532906348231;13518.662033449242;13869.167849929037;14454;14473.203973781543;10690;11082.833757493483;11398.145139114766;11718.531258749554;11872.703182420162;11229.606963756556;11393.943030284796;11508.884911151115;11565.595204167814;11585.04737980962 14:29:07 INFO - PROCESS | 1632 | __end_tp_report 14:29:07 INFO - PROCESS | 1632 | __start_cc_report 14:29:07 INFO - PROCESS | 1632 | _x_x_mozilla_cycle_collect,1316 14:29:07 INFO - PROCESS | 1632 | __end_cc_report 14:29:07 INFO - PROCESS | 1632 | __startTimestamp1485296947207__endTimestamp 14:29:07 INFO - PROCESS | 1632 | 14:29:07 INFO - PROCESS | 1632 | ------- Summary: start ------- 14:29:07 INFO - PROCESS | 1632 | Number of tests: 6 14:29:07 INFO - PROCESS | 1632 | 14:29:07 INFO - PROCESS | 1632 | [#0] dojo.html Cycles:165 Average:5747.08 Median:6010.55 stddev:621.55 (10.3%) stddev-sans-first:596.55 14:29:07 INFO - PROCESS | 1632 | Values: 3440.7 3447.9 3451.3 3462.6 3509.4 5696.9 5708.9 5749.1 5813.6 5828.2 5795.6 5875.9 5878.9 5886.0 5892.9 5179.0 5203.8 5222.1 5264.5 5303.9 5157.5 5166.1 5172.1 5306.9 5312.9 5186.4 5238.9 5244.3 5247.2 5263.9 4509.8 5221.7 5237.9 5262.6 5284.3 5068.6 5133.6 5237.3 5255.2 5385.6 5623.5 5664.7 5671.8 5740.8 5770.0 6065.3 6091.0 6108.6 6122.8 6146.5 6199.5 6201.3 6206.3 6212.5 6215.4 5795.3 5806.9 5821.3 5893.1 5961.9 6243.4 6276.9 6285.3 6295.8 6300.9 6158.7 6172.5 6174.0 6175.4 6181.3 6072.1 6097.5 6140.5 6219.4 6228.2 6124.1 6137.2 6158.4 6186.9 6194.3 6115.4 6168.4 6174.1 6199.6 6215.1 4941.7 4988.1 5002.4 5010.5 5014.3 4426.8 4443.0 4451.0 4454.3 4491.3 5720.7 5888.7 5910.9 5923.5 5967.1 6171.8 6189.5 6222.7 6227.8 6228.0 5721.8 5783.0 5793.6 5823.8 5896.1 5388.9 5408.8 5423.2 5428.0 5436.4 6211.6 6240.5 6242.9 6264.6 6325.4 5146.7 6166.4 6198.7 6202.2 6228.5 6266.4 6271.6 6277.2 6280.0 6282.0 6070.4 6114.3 6145.0 6150.7 6248.4 6180.8 6189.5 6217.7 6224.3 6233.0 6005.7 6010.5 6059.5 6206.0 6229.3 5744.2 6054.7 6075.5 6198.5 6200.1 4916.4 5732.7 6055.9 6071.9 6093.3 6144.3 6183.6 6186.2 6187.4 6192.0 5843.5 5942.6 6069.9 6089.5 6100.5 14:29:07 INFO - PROCESS | 1632 | 14:29:07 INFO - PROCESS | 1632 | [#1] ext.html Cycles:180 Average:70797.75 Median:35987.32 stddev:156877.16 (435.9%) stddev-sans-first:157228.44 14:29:07 INFO - PROCESS | 1632 | Values: 496.5 502.3 516.7 533.9 540.7 31750.0 33628.7 42267.6 43111.6 43321.6 45112.3 45340.0 45411.0 45494.1 45620.0 9688.8 9876.4 9879.2 9880.7 9897.6 8931.5 9138.3 11654.3 11881.2 11886.6 11840.9 11867.8 11917.0 11926.9 11939.9 11937.0 12008.7 12025.9 12026.6 12036.6 11803.9 11865.5 11873.6 11898.6 11905.5 31529.8 39031.0 41535.6 41950.4 41961.6 3320.9 3350.8 3431.8 3438.9 4156.7 30448.0 30562.2 30613.5 31510.9 32763.0 3291.5 3315.1 3327.8 3388.4 3439.6 510417.0 513390.0 514615.0 515359.0 519604.4 35049.5 65652.0 65812.7 65895.0 65919.7 36296.8 37297.6 37317.4 37374.4 37392.6 15146.2 15295.2 15319.1 15321.0 15327.0 11067.2 12882.8 13013.0 13040.7 13058.3 7731.6 8110.9 8272.8 8273.0 8288.7 3365.1 3386.0 3390.3 3390.5 3407.3 860.4 909.2 987.6 1001.9 1004.7 29643.6 30381.4 30441.4 30705.3 31047.0 1061.5 1123.6 1145.4 1162.8 1208.9 15824.5 16063.7 16087.8 16313.4 16387.0 696989.0 704994.0 705377.5 706747.0 708108.5 62816.0 62897.0 63217.7 63231.4 63292.0 1276.5 1311.4 1369.4 1372.9 1391.2 28952.9 29785.6 31594.7 32152.4 32204.8 53260.7 53853.0 53876.2 53950.5 54010.0 515172.0 518317.0 519705.0 520000.0 520283.0 27367.9 28532.4 28560.9 28575.9 28640.8 48552.0 49241.3 49596.5 49724.0 50164.2 36368.0 39199.4 39561.6 40196.0 42061.2 38879.0 40809.6 40926.6 41440.0 41653.8 38142.8 38522.6 38588.9 39139.8 39559.2 33683.8 35037.5 35912.8 36061.8 36169.6 26103.6 26154.5 26242.6 26311.1 26959.3 14:29:07 INFO - PROCESS | 1632 | 14:29:07 INFO - PROCESS | 1632 | [#2] jquery.html Cycles:180 Average:36028.90 Median:25803.35 stddev:100616.57 (389.9%) stddev-sans-first:100863.24 14:29:07 INFO - PROCESS | 1632 | Values: 390.7 391.5 391.6 399.7 421.8 14568.4 19866.3 20904.2 21001.2 21046.0 16405.4 19258.3 20791.8 20905.4 20990.5 5809.3 6134.6 6138.8 6148.5 6149.0 5756.9 5964.8 5994.2 6033.7 6079.2 5974.3 5976.8 5978.5 5983.1 5985.4 5197.6 5743.1 5944.4 5963.1 6001.3 5245.5 5248.9 5255.7 5256.2 5257.8 25347.4 26259.3 26469.2 26487.0 26604.6 2167.9 2477.0 2873.2 3159.3 3192.5 13364.5 15671.6 15735.5 15796.9 16277.2 1907.7 1946.4 1987.2 1989.6 2020.8 122195.0 126069.4 126777.0 129483.4 135398.3 10916.5 11383.9 11676.9 11690.1 11888.3 15116.7 15117.9 15133.8 15138.0 15140.7 7527.5 7552.5 8006.6 8380.2 8518.2 8433.0 8451.5 8574.0 8694.3 8710.5 4666.3 4668.9 4674.1 4687.2 4751.4 1762.9 1951.0 2009.7 2011.7 2014.5 800.5 888.7 897.9 964.4 1017.4 20677.4 21318.0 21544.9 21560.0 21732.0 860.0 948.7 967.6 1048.8 1076.8 9267.5 10880.5 11252.6 11377.5 11388.5 591008.0 593658.0 596156.0 609070.0 609178.0 117169.0 137674.6 137708.2 142142.6 144849.6 978.6 1020.5 1032.7 1032.9 1034.9 18341.0 18756.7 19119.8 19187.2 19486.4 46344.4 55458.0 57002.4 58490.4 58940.0 80460.0 84454.6 84629.6 85647.1 86423.6 8068.3 8100.5 8247.0 8637.1 8638.0 9276.1 12540.7 13205.7 13243.9 13895.2 11526.6 11791.4 11795.1 11834.8 11842.8 9194.8 11187.2 11235.7 11636.2 11862.6 11499.0 11750.0 11751.6 11867.1 12002.7 7348.9 8136.0 8498.5 8604.7 8785.3 9681.6 11268.9 11628.7 11886.8 11948.2 14:29:07 INFO - PROCESS | 1632 | 14:29:07 INFO - PROCESS | 1632 | [#3] mootools.html Cycles:180 Average:5468.85 Median:5002.36 stddev:2966.89 (59.3%) stddev-sans-first:2960.47 14:29:07 INFO - PROCESS | 1632 | Values: 1532.9 1566.5 1731.7 1851.7 1873.3 8109.3 8527.8 8535.6 8537.4 8547.9 7644.5 7872.1 7885.9 8130.6 8400.1 2365.1 2404.1 2409.0 2411.9 2417.1 2392.0 2422.0 2432.8 2438.0 2439.4 2383.3 2387.2 2410.5 2412.5 2417.2 2363.0 2370.1 2387.0 2389.6 2391.6 2398.1 2416.3 2422.6 2425.4 2426.7 8184.0 8361.5 8379.4 8379.5 8380.7 5087.4 5249.0 5253.5 5260.6 5267.0 3284.5 3431.8 3529.5 3602.3 3604.2 1031.0 1042.7 1078.3 1090.3 1096.7 10737.8 10889.9 10907.1 10919.3 10925.2 4506.6 4647.0 4735.8 4739.0 4784.6 9460.7 9462.6 9470.7 9490.6 9496.2 5274.3 5282.7 5293.5 5297.7 5299.0 4312.9 4606.6 4853.5 4883.8 4887.0 3853.5 3873.1 3904.4 3953.4 3977.4 1096.3 1107.4 1281.1 1282.2 1294.7 784.3 787.5 888.5 928.8 948.3 5644.4 5645.5 5669.5 5869.2 5928.3 454.9 455.2 461.2 469.1 471.1 3823.0 3832.0 3879.4 3932.0 3963.8 8563.8 9753.2 10130.2 10209.2 10209.7 10162.6 10165.1 10167.5 10184.0 10198.2 7513.4 7779.5 7892.0 7902.8 7931.3 5412.4 5594.1 5607.6 5617.5 5679.4 7867.7 9253.9 9269.9 9339.6 9395.8 9405.9 9417.6 9531.5 9550.9 9586.8 6656.2 6872.0 6879.4 7139.6 7258.1 7439.7 7633.7 7935.9 7939.6 8030.8 6329.5 7122.1 7238.3 7256.3 7266.2 7070.8 7089.9 7129.6 7133.9 7210.7 6726.8 6774.4 6782.6 6786.6 6796.8 4943.2 4948.9 4951.5 4957.9 4982.0 4803.0 4895.9 4925.4 5022.7 5073.2 14:29:07 INFO - PROCESS | 1632 | 14:29:07 INFO - PROCESS | 1632 | [#4] prototype.html Cycles:180 Average:4401.64 Median:4928.57 stddev:1353.67 (27.5%) stddev-sans-first:1321.38 14:29:07 INFO - PROCESS | 1632 | Values: 264.8 293.2 295.2 304.4 312.1 4487.4 5064.5 5301.4 5370.9 5424.9 4681.5 4981.0 5145.7 5260.6 5281.1 3418.3 4030.3 4065.0 4074.2 4082.3 3730.4 4068.6 4075.5 4087.3 4087.6 3386.5 3687.9 3751.0 4053.6 4087.0 3526.4 4008.9 4071.7 4087.3 4112.1 2815.5 2907.0 3535.9 3537.8 3541.7 5211.3 5221.2 5243.3 5244.6 5246.6 4130.5 4160.8 4567.9 4599.4 4638.8 4802.0 4883.9 5482.1 5610.2 5617.3 3840.5 3851.0 3854.6 3860.6 3869.2 5620.2 5781.5 5797.8 5847.6 5862.7 3663.8 3838.6 3842.3 3845.5 3857.3 3850.0 3864.9 3921.3 3922.8 3950.6 4405.8 4572.8 4579.3 4589.8 4599.4 4805.2 5269.9 5449.1 5601.4 5602.2 1097.7 1257.8 1269.3 1269.8 1276.4 772.1 811.0 830.5 864.5 868.7 4052.6 4396.4 4455.3 4813.7 4911.4 4851.4 4985.4 5386.0 5452.4 5468.8 4065.4 4295.6 4629.5 5036.8 5104.8 2460.3 2500.7 2847.0 2870.9 2908.3 5357.4 5642.0 5654.1 5658.7 5671.7 4992.4 5339.6 5463.3 5613.9 5622.5 4945.7 5544.9 5618.5 5637.2 5643.9 4634.4 5422.2 5428.6 5477.9 5543.2 4434.9 4976.5 5039.8 5110.8 5380.6 4680.0 5080.7 5110.1 5334.2 5564.7 3395.8 3412.2 3422.4 3652.3 3659.6 4873.9 5344.4 5396.3 5733.6 5789.5 5070.7 5531.3 5595.7 5597.4 5607.4 4723.3 5552.5 5610.7 5625.7 5688.3 5215.1 5439.7 5484.8 5492.5 5521.5 4505.5 4846.8 4962.6 5545.9 5656.7 4956.1 5275.4 5485.6 5495.6 5517.4 14:29:07 INFO - PROCESS | 1632 | 14:29:07 INFO - PROCESS | 1632 | [#5] yui.html Cycles:180 Average:22076.89 Median:4622.33 stddev:32788.00 (709.3%) stddev-sans-first:32840.68 14:29:07 INFO - PROCESS | 1632 | Values: 696.3 724.2 725.0 747.2 756.5 14701.2 15179.5 15515.8 15720.2 15740.6 14185.4 14282.9 14377.8 14380.0 14407.7 850.7 852.7 854.4 862.3 881.8 698.8 726.4 729.8 732.2 858.3 762.2 766.9 898.8 928.7 942.4 930.0 930.1 931.9 932.3 932.5 692.5 692.6 693.0 693.1 693.2 14087.5 14105.2 14459.5 14500.1 14508.2 13065.6 13528.1 13847.9 13856.3 14141.8 12508.1 12725.7 12809.6 12876.2 12953.4 4520.8 4830.1 4844.7 4889.5 4900.0 89891.0 91715.5 93373.0 94432.5 96116.5 9909.0 10714.5 10824.6 10919.3 11031.7 17917.7 20201.9 20243.7 20271.8 20322.6 7921.4 8039.3 8087.6 8327.2 8389.1 4372.9 4468.0 4476.6 4519.9 4667.1 3368.0 3401.0 3428.7 3461.5 3484.5 663.7 668.8 670.5 677.4 682.9 551.5 662.4 688.9 695.6 720.9 9358.0 9452.2 9492.8 9514.6 9853.8 595.6 644.3 669.9 680.5 700.6 4346.2 4615.2 4629.5 4697.7 4746.7 114806.0 119220.0 121282.0 123212.4 127219.0 101223.0 103495.5 103716.0 106493.4 109697.0 70064.0 92415.0 92552.0 94527.1 95667.5 8259.7 8462.6 8932.9 9160.8 9253.9 59484.7 60431.7 60628.8 61525.0 62419.4 72317.0 82742.0 84090.0 87291.6 87751.0 11340.1 11698.3 11765.3 11874.3 11903.6 11934.9 12677.6 14078.6 14836.0 15441.6 14010.4 14090.8 14264.6 14840.9 14912.2 14128.9 14151.1 14529.5 14840.6 14929.6 13345.5 13518.7 13869.2 14454.0 14473.2 10690.0 11082.8 11398.1 11718.5 11872.7 11229.6 11393.9 11508.9 11565.6 11585.0 14:29:07 INFO - PROCESS | 1632 | -------- Summary: end -------- 14:29:07 INFO - PROCESS | 1632 | 14:29:07 INFO - TEST-INFO | 1632: exit 0 14:29:07 INFO - TEST-OK | dromaeo_css | took 1117888ms 14:29:07 INFO - TEST-START | kraken 14:29:07 INFO - operating with platform_type : mac_ 14:29:07 INFO - Initialising browser for kraken test... 14:29:07 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmp5Dc56l/profile http://localhost:49235/getInfo.html) 14:29:10 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 14:29:10 INFO - PROCESS | 1639 | colorDepth:24 14:29:10 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 14:29:10 INFO - PROCESS | 1639 | __metrics 14:29:10 INFO - PROCESS | 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:29:10 INFO - PROCESS | 1639 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:29:11 INFO - TEST-INFO | 1639: exit 0 14:29:11 INFO - Browser initialized. 14:29:11 INFO - Running cycle 1/1 for kraken test... 14:29:11 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmp5Dc56l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:23 INFO - PROCESS | 1641 | RSS: Main: 172077056 14:29:23 INFO - PROCESS | 1641 | 14:29:26 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 14:29:27 INFO - PROCESS | 1641 | RSS: Main: 221843456 14:29:27 INFO - PROCESS | 1641 | 14:29:29 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 14:29:30 INFO - PROCESS | 1641 | RSS: Main: 234733568 14:29:30 INFO - PROCESS | 1641 | 14:29:33 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 14:29:34 INFO - PROCESS | 1641 | RSS: Main: 331436032 14:29:34 INFO - PROCESS | 1641 | 14:29:36 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 14:29:36 INFO - PROCESS | 1641 | RSS: Main: 234676224 14:29:36 INFO - PROCESS | 1641 | 14:29:38 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:29:39 INFO - PROCESS | 1641 | RSS: Main: 235446272 14:29:39 INFO - PROCESS | 1641 | 14:29:42 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 14:29:42 INFO - PROCESS | 1641 | RSS: Main: 275824640 14:29:42 INFO - PROCESS | 1641 | 14:29:45 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 14:29:46 INFO - PROCESS | 1641 | RSS: Main: 276045824 14:29:46 INFO - PROCESS | 1641 | 14:29:48 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 14:29:49 INFO - PROCESS | 1641 | RSS: Main: 274333696 14:29:49 INFO - PROCESS | 1641 | 14:29:51 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:29:51 INFO - PROCESS | 1641 | RSS: Main: 249843712 14:29:51 INFO - PROCESS | 1641 | 14:29:53 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:29:54 INFO - PROCESS | 1641 | RSS: Main: 250757120 14:29:54 INFO - PROCESS | 1641 | 14:29:56 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:29:56 INFO - PROCESS | 1641 | RSS: Main: 253276160 14:29:56 INFO - PROCESS | 1641 | 14:29:59 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:30:00 INFO - PROCESS | 1641 | RSS: Main: 265961472 14:30:00 INFO - PROCESS | 1641 | 14:30:03 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:30:03 INFO - PROCESS | 1641 | RSS: Main: 266223616 14:30:03 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 14:30:05 INFO - PROCESS | 1641 | RSS: Main: 310231040 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | __start_tp_report 14:30:05 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 14:30:05 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 14:30:05 INFO - PROCESS | 1641 | |i|pagename|runs| 14:30:05 INFO - PROCESS | 1641 | |0;ai-astar;116;115;115;116;115;114;114;115;114;116 14:30:05 INFO - PROCESS | 1641 | |1;audio-beat-detection;143;112;109;138;112;105;107;106;137;107 14:30:05 INFO - PROCESS | 1641 | |2;audio-dft;183;181;184;182;181;181;183;182;185;185 14:30:05 INFO - PROCESS | 1641 | |3;audio-fft;83;49;49;78;76;73;50;71;98;76 14:30:05 INFO - PROCESS | 1641 | |4;audio-oscillator;84;69;93;69;67;70;87;66;68;90 14:30:05 INFO - PROCESS | 1641 | |5;imaging-gaussian-blur;88;126;86;86;87;84;89;86;113;114 14:30:05 INFO - PROCESS | 1641 | |6;imaging-darkroom;94;94;95;94;94;95;94;94;94;94 14:30:05 INFO - PROCESS | 1641 | |7;imaging-desaturate;83;81;82;79;81;84;83;84;81;80 14:30:05 INFO - PROCESS | 1641 | |8;json-parse-financial;54;49;53;51;56;56;57;57;56;56 14:30:05 INFO - PROCESS | 1641 | |9;json-stringify-tinderbox;64;68;74;75;71;68;67;69;68;70 14:30:05 INFO - PROCESS | 1641 | |10;stanford-crypto-aes;83;81;82;82;81;79;80;81;82;81 14:30:05 INFO - PROCESS | 1641 | |11;stanford-crypto-ccm;137;138;142;147;136;140;151;154;189;137 14:30:05 INFO - PROCESS | 1641 | |12;stanford-crypto-pbkdf2;161;161;163;162;162;163;160;159;161;157 14:30:05 INFO - PROCESS | 1641 | |13;stanford-crypto-sha256-iterative;65;65;63;66;66;64;67;65;67;65 14:30:05 INFO - PROCESS | 1641 | __end_tp_report 14:30:05 INFO - PROCESS | 1641 | __start_cc_report 14:30:05 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,1874 14:30:05 INFO - PROCESS | 1641 | __end_cc_report 14:30:05 INFO - PROCESS | 1641 | __startTimestamp1485297005813__endTimestamp 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | ------- Summary: start ------- 14:30:05 INFO - PROCESS | 1641 | Number of tests: 14 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 14:30:05 INFO - PROCESS | 1641 | Values: 116.0 115.0 115.0 116.0 115.0 114.0 114.0 115.0 114.0 116.0 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | [#1] audio-beat-detection Cycles:10 Average:117.60 Median:112.00 stddev:15.25 (13.6%) stddev-sans-first:13.11 14:30:05 INFO - PROCESS | 1641 | Values: 143.0 112.0 109.0 138.0 112.0 105.0 107.0 106.0 137.0 107.0 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.57 (0.9%) stddev-sans-first:1.66 14:30:05 INFO - PROCESS | 1641 | Values: 183.0 181.0 184.0 182.0 181.0 181.0 183.0 182.0 185.0 185.0 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | [#3] audio-fft Cycles:10 Average:70.30 Median:76.00 stddev:16.26 (21.4%) stddev-sans-first:16.59 14:30:05 INFO - PROCESS | 1641 | Values: 83.0 49.0 49.0 78.0 76.0 73.0 50.0 71.0 98.0 76.0 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | [#4] audio-oscillator Cycles:10 Average:76.30 Median:77.00 stddev:10.79 (14.0%) stddev-sans-first:11.08 14:30:05 INFO - PROCESS | 1641 | Values: 84.0 69.0 93.0 69.0 67.0 70.0 87.0 66.0 68.0 90.0 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | [#5] imaging-gaussian-blur Cycles:10 Average:95.90 Median:86.00 stddev:15.46 (18.0%) stddev-sans-first:16.13 14:30:05 INFO - PROCESS | 1641 | Values: 88.0 126.0 86.0 86.0 87.0 84.0 89.0 86.0 113.0 114.0 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:30:05 INFO - PROCESS | 1641 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | [#7] imaging-desaturate Cycles:10 Average:81.80 Median:82.50 stddev:1.69 (2.0%) stddev-sans-first:1.73 14:30:05 INFO - PROCESS | 1641 | Values: 83.0 81.0 82.0 79.0 81.0 84.0 83.0 84.0 81.0 80.0 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:56.00 stddev:2.72 (4.9%) stddev-sans-first:2.88 14:30:05 INFO - PROCESS | 1641 | Values: 54.0 49.0 53.0 51.0 56.0 56.0 57.0 57.0 56.0 56.0 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:3.27 (4.7%) stddev-sans-first:2.83 14:30:05 INFO - PROCESS | 1641 | Values: 64.0 68.0 74.0 75.0 71.0 68.0 67.0 69.0 68.0 70.0 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.50 stddev:1.14 (1.4%) stddev-sans-first:1.00 14:30:05 INFO - PROCESS | 1641 | Values: 83.0 81.0 82.0 82.0 81.0 79.0 80.0 81.0 82.0 81.0 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:144.50 stddev:16.00 (11.1%) stddev-sans-first:16.55 14:30:05 INFO - PROCESS | 1641 | Values: 137.0 138.0 142.0 147.0 136.0 140.0 151.0 154.0 189.0 137.0 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.50 stddev:1.85 (1.1%) stddev-sans-first:1.96 14:30:05 INFO - PROCESS | 1641 | Values: 161.0 161.0 163.0 162.0 162.0 163.0 160.0 159.0 161.0 157.0 14:30:05 INFO - PROCESS | 1641 | 14:30:05 INFO - PROCESS | 1641 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:1.25 (1.9%) stddev-sans-first:1.32 14:30:05 INFO - PROCESS | 1641 | Values: 65.0 65.0 63.0 66.0 66.0 64.0 67.0 65.0 67.0 65.0 14:30:05 INFO - PROCESS | 1641 | -------- Summary: end -------- 14:30:05 INFO - PROCESS | 1641 | 14:30:06 INFO - TEST-INFO | 1641: exit 0 14:30:06 INFO - TEST-OK | kraken | took 59020ms 14:30:06 INFO - SUITE-END | took 1176s 14:30:06 INFO - Completed test suite (00:19:37) 14:30:06 INFO - javascript benchmark 14:30:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3440.7247420206386, 3447.9482807757886, 3451.2579795344004, 3462.5844898612154, 3509.368313703534, 5696.943030569693, 5708.8858222835515, 5749.080147176453, 5813.622114562556, 5828.242328497295, 5795.565332600051, 5875.941240587593, 5878.853028674285, 5886.0, 5892.941070589292, 5178.974105129479, 5203.765830537616, 5222.138347172712, 5264.499872512105, 5303.867403314929, 5157.48425157485, 5166.121759300909, 5172.09488339541, 5306.92039619406, 5312.893742125155, 5186.351706036746, 5238.947610523903, 5244.318238628973, 5247.16045432729, 5263.894722105575, 4509.751963641998, 5221.686698798066, 5237.895242095136, 5262.60530460217, 5284.2866213061125, 5068.645194836363, 5133.563647090002, 5237.3453318335205, 5255.185446255837, 5385.649932754398, 5623.465770751772, 5664.745086471119, 5671.801486947978, 5740.799072032459, 5770.0, 6065.302490213638, 6091.02543593023, 6108.602940808878, 6122.846928826771, 6146.508279337642, 6199.504039676815, 6201.286852011986, 6206.348333425016, 6212.502999760009, 6215.409536094064, 5795.275590551181, 5806.854828629318, 5821.330546987151, 5893.14549390336, 5961.850953726148, 6243.43809057178, 6276.874462510724, 6285.277193122849, 6295.811125666238, 6300.873982520324, 6158.692065396713, 6172.506199504029, 6173.969130154321, 6175.413335733098, 6181.320054793969, 6072.149899014142, 6097.481714054266, 6140.508759299245, 6219.40915613016, 6228.159198508234, 6124.142620033199, 6137.193127861533, 6158.353372895782, 6186.907196392058, 6194.256689197326, 6115.357887421846, 6168.383161683796, 6174.073888916609, 6199.628022318675, 6215.12988181655, 4941.65408421407, 4988.102141614471, 5002.424721157041, 5010.473900240495, 5014.34813474246, 4426.822927082881, 4443.00032492693, 4450.955490445054, 4454.309582014793, 4491.258942274488, 5720.742566584514, 5888.735006924699, 5910.940890591125, 5923.4668879800165, 5967.104934259809, 6171.84570385744, 6189.535784816157, 6222.657753823492, 6227.750889964442, 6228.0, 5721.77112915487, 5782.971085144632, 5793.594448388572, 5823.82528524145, 5896.115582662635, 5388.892222155613, 5408.810691625774, 5423.240746295522, 5428.0, 5436.429174936654, 6211.627302361872, 6240.500759939194, 6242.937570624235, 6264.561480696308, 6325.399087086719, 5146.665466744649, 6166.414190651881, 6198.690065496798, 6202.193714817045, 6228.4705800007505, 6266.404691554295, 6271.560990730605, 6277.18396608438, 6280.0, 6281.96859015702, 6070.362611925861, 6114.327782088646, 6145.047517634774, 6150.661713605795, 6248.437640612185, 6180.752769889334, 6189.535784816067, 6217.689115544114, 6224.346443623354, 6232.968835155795, 6005.7297421617, 6010.54920880927, 6059.520254802358, 6205.968970155121, 6229.314775374796, 5744.195812586325, 6054.727537260922, 6075.544334174866, 6198.535109866868, 6200.131981522681, 4916.385451818523, 5732.681483258791, 6055.940210463239, 6071.908921366271, 6093.268807743099, 6144.271063764375, 6183.628982261079, 6186.226721659793, 6187.350328215653, 6191.9690401547705, 5843.532517398513, 5942.64344139353, 6069.937760891915, 6089.451949324582, 6100.481459075851], "value": 5709.207443989456, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.5158970004246, 502.3118327890789, 516.6564234783868, 533.9038972984864, 540.7080176704579, 31750.0, 33628.66371336286, 42267.577324226746, 43111.56888431115, 43321.56678433215, 45112.3233151503, 45340.0, 45411.0, 45494.090118197615, 45620.0, 9688.757781055478, 9876.358036727626, 9879.20966322696, 9880.654177103803, 9897.554610042529, 8931.464112153291, 9138.268938484905, 11654.300741955467, 11881.227720198203, 11886.643400697993, 11840.940795296012, 11867.821982670266, 11917.046636269077, 11926.940365298162, 11939.940300298485, 11936.98535624473, 12008.69978250542, 12025.879741202563, 12026.579069732605, 12036.63890083299, 11803.940980295129, 11865.466054027504, 11873.584424545186, 11898.643040708706, 11905.464254108585, 31529.842350788327, 39031.0, 41535.584644153474, 41950.37074443886, 41961.58038419607, 3320.8671653133847, 3350.8157051362164, 3431.8455669494683, 3438.948415773765, 4156.688248381353, 30448.0, 30562.235944101354, 30613.540796888065, 31510.89711860074, 32763.0, 3291.53918451417, 3315.1380641033506, 3327.7504187185814, 3388.3731509670542, 3439.6216416194197, 510417.0, 513390.0, 514615.0, 515359.0, 519604.40197798767, 35049.474257886155, 65652.0, 65812.67093664501, 65895.0, 65919.67040164865, 36296.81851590778, 37297.627023729416, 37317.44023839645, 37374.43938340927, 37392.626073739455, 15146.16696081704, 15295.15876626774, 15319.080855148726, 15321.0, 15327.0, 11067.169962252703, 12882.80675789864, 13012.958963282914, 13040.739185216433, 13058.34708264583, 7731.613419329011, 8110.878336824952, 8272.793180170544, 8272.958635206785, 8288.668453261922, 3365.057783820534, 3385.950355389837, 3390.2710917152435, 3390.5253264542985, 3407.30150319184, 860.4321148042262, 909.1953621045423, 987.6000219910948, 1001.9129244769507, 1004.6684594083935, 29643.55534666982, 30381.392372152433, 30441.39117217643, 30705.315551654352, 31047.0, 1061.527620209015, 1123.6179698902413, 1145.4158379226653, 1162.8139497680331, 1208.879112088784, 15824.525264242091, 16063.678726425405, 16087.758683619755, 16313.417473593645, 16387.0, 696989.0, 704994.0, 705377.4731126414, 706747.0, 708108.4594577097, 62816.0, 62897.0, 63217.68391158015, 63231.367686323465, 63292.0, 1276.5213045108085, 1311.3639884655743, 1369.397465115346, 1372.8901687864748, 1391.2487256881373, 28952.855235723688, 29785.5532167022, 31594.684053159173, 32152.35695286128, 32204.83897580497, 53260.73369633127, 53853.0, 53876.19185712139, 53950.460495394545, 54010.0, 515172.0, 518317.0, 519705.0, 520000.0, 520283.0, 27367.863160684068, 28532.42935141327, 28560.85719571389, 28575.857120715096, 28640.849506554678, 48552.0, 49241.340959643705, 49596.50403495919, 49724.0, 50164.24753628625, 36368.0, 39199.41200882046, 39561.60438395695, 40195.99510012273, 42061.1587768249, 38879.0, 40809.59190408058, 40926.59073409228, 41440.0, 41653.79173104115, 38142.8092859545, 38522.6147738519, 38588.8776117305, 39139.804300978314, 39559.208815822945, 33683.831580841936, 35037.47443788396, 35912.82043589765, 36061.81969090138, 36169.63830361663, 26103.608445873706, 26154.476910461304, 26242.60636090422, 26311.07911223098, 26959.32601684895], "value": 19584.84260251819, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.66598058659844, 391.4500127321115, 391.6455607675054, 399.6902400639504, 421.7532743345143, 14568.417263309482, 19866.304679336226, 20904.163833446644, 21001.15995360186, 21046.0, 16405.42581009665, 19258.325958591453, 20791.792082079173, 20905.37283881486, 20990.475238119056, 5809.302883653967, 6134.631922084667, 6138.754449822001, 6148.538859585527, 6149.016157414814, 5756.856078598027, 5964.761409543635, 5994.220751302325, 6033.668148251844, 6079.179310793031, 5974.283086029683, 5976.820695379146, 5978.491828194608, 5983.072623743326, 5985.371535988724, 5197.558207552363, 5743.138529220609, 5944.375840536746, 5963.135345374918, 6001.3098493672915, 5245.501677340647, 5248.895022099537, 5255.684658920439, 5256.211568264791, 5257.8159764408065, 25347.366315842253, 26259.343516412053, 26469.205923822316, 26487.0, 26604.60093098605, 2167.8916054197225, 2477.0, 2873.209867286513, 3159.289159939018, 3192.4732419150814, 13364.465421383133, 15671.608209794733, 15735.527934161993, 15796.894217404786, 16277.186140692918, 1907.6661584222707, 1946.3577019583504, 1987.205117952816, 1989.5821877405763, 2020.7575090989176, 122195.0, 126069.36965315207, 126777.0, 129483.35258323743, 135398.32300838432, 10916.508757105948, 11383.88616113845, 11676.883231167749, 11690.123240756808, 11888.34614096233, 15116.697666046617, 15117.941744077809, 15133.848661513244, 15138.016028958082, 15140.697186056217, 7527.548347099191, 7552.471327007167, 8006.559639219899, 8380.198257374572, 8518.190771876662, 8433.0, 8451.535165565952, 8573.957130214434, 8694.347923905732, 8710.520921349387, 4666.346711460398, 4668.929966050512, 4674.11191873543, 4687.179743544866, 4751.382320298339, 1762.8649905731713, 1950.9512262193275, 2009.6936990955996, 2011.7384739984002, 2014.476236178604, 800.4956877167464, 888.6889588643922, 897.9461232326081, 964.3876138651866, 1017.4251547875426, 20677.379678609665, 21318.0, 21544.922753862244, 21560.0297986591, 21732.0, 859.9723330619975, 948.7390967483997, 967.6344668811457, 1048.8096011027387, 1076.7631121153333, 9267.536623168815, 10880.455977201109, 11252.606158784403, 11377.488013039432, 11388.487518061707, 591008.0, 593658.0, 596156.0, 609069.954650224, 609178.0, 117169.0, 137674.62325376619, 137708.18021369405, 142142.57857421294, 144849.55150448572, 978.608556577389, 1020.4999550220339, 1032.7056788815153, 1032.9173666106694, 1034.8602938603342, 18340.991245481626, 18756.718649220544, 19119.808801911804, 19187.232510699414, 19486.415407537796, 46344.42506708503, 55458.0, 57002.42997570137, 58490.4150958502, 58940.0, 80459.98850028796, 84454.57772711097, 84629.57685211535, 85647.1435285664, 86423.56788216019, 8068.314193293401, 8100.541902457614, 8247.0, 8637.093105223861, 8638.049814520273, 9276.07239276094, 12540.686482838002, 13205.735885282049, 13243.933780331037, 13895.166290022631, 11526.596569120376, 11791.410429478321, 11795.11536634773, 11834.763304733684, 11842.76314473723, 9194.816103678022, 11187.16096292765, 11235.71910702239, 11636.185467017227, 11862.644120676394, 11499.022583080532, 11750.0, 11751.588694395656, 11867.050635949276, 12002.699932501757, 7348.889766653611, 8135.959320203361, 8498.532580707873, 8604.698835540727, 8785.341099417441, 9681.612735490784, 11268.887311126784, 11628.709282268012, 11886.821697674715, 11948.163628546266], "value": 9901.564820602998, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1532.8733380964989, 1566.451741890338, 1731.7229243321071, 1851.7037274036156, 1873.304659283349, 8109.31070858977, 8527.786805329853, 8535.615897284622, 8537.359698022643, 8547.914520854789, 7644.46488745788, 7872.0947091084545, 7885.881711774328, 8130.55281959492, 8400.075991640915, 2365.124903785602, 2404.0744313439363, 2409.0484258717797, 2411.867347295898, 2417.0815090265764, 2391.988040059797, 2422.0, 2432.7932125769244, 2437.987810060947, 2439.4389290463205, 2383.2611890314056, 2387.200287903546, 2410.4576470294132, 2412.4813165169485, 2417.153996101368, 2363.031157225529, 2370.1230544698487, 2386.997461066356, 2389.6415537669313, 2391.641253811916, 2398.1486572266945, 2416.311351264881, 2422.551827911824, 2425.4300239443714, 2426.6602675625427, 8184.0, 8361.498310101413, 8379.413441059129, 8379.49723016615, 8380.748577542683, 5087.440381558025, 5248.950209958024, 5253.52718255355, 5260.631755777097, 5267.0, 3284.5237440571223, 3431.828408579586, 3529.4882242074755, 3602.3342726382552, 3604.1530240393486, 1030.953607087683, 1042.687193841852, 1078.3044936016304, 1090.2967585907045, 1096.703889949717, 10737.83893241602, 10889.891101088966, 10907.127429805596, 10919.344839309666, 10925.180611454094, 4506.616937560344, 4646.95353046472, 4735.83424580138, 4739.004808990082, 4784.61246238587, 9460.668876589423, 9462.621495140254, 9470.715878523517, 9490.620375185053, 9496.192823609932, 5274.26160337553, 5282.735863206901, 5293.470652934753, 5297.735113244323, 5299.0, 4312.870613881589, 4606.585407313358, 4853.490383509751, 4883.755812209375, 4886.951130488721, 3853.537575490959, 3873.0511024798543, 3904.355781296111, 3953.4069889516804, 3977.4033894915992, 1096.276457538021, 1107.3909349857547, 1281.0712233630543, 1282.236924229185, 1294.7022184897337, 784.2510402565537, 787.5078076202374, 888.493558671551, 928.8049509602924, 948.2698322291797, 5644.435556444323, 5645.520130788929, 5669.489745922887, 5869.178315035899, 5928.288605367384, 454.9181147393435, 455.15795777810786, 461.16989419045586, 469.1438125421052, 471.067286772193, 3822.980885095557, 3832.0419895026243, 3879.437481565157, 3932.036651020518, 3963.841446342114, 8563.828723425497, 9753.21974242059, 10130.24023198263, 10209.183265338756, 10209.693709188736, 10162.644307449204, 10165.135963443043, 10167.4916254187, 10184.032516910882, 10198.235132365102, 7513.39892808574, 7779.533228006338, 7891.960540197262, 7902.802429939297, 7931.325837303779, 5412.350517937715, 5594.13290939905, 5607.579431542569, 5617.522510586646, 5679.381376307732, 7867.685292588461, 9253.907460925573, 9269.86095208559, 9339.57971891253, 9395.81208375815, 9405.858912116188, 9417.623295068395, 9531.52342382892, 9550.90449095528, 9586.760330991781, 6656.201255849329, 6872.0, 6879.380855723009, 7139.643017849191, 7258.0927384076995, 7439.702411903463, 7633.732819351296, 7935.880961785462, 7939.6030198491, 8030.799230019296, 6329.49364050884, 7122.145342558926, 7238.27617238272, 7256.346928776225, 7266.237045110399, 7070.823229419306, 7089.893651595127, 7129.572225666477, 7133.857322853618, 7210.675519601736, 6726.831829204309, 6774.424173945073, 6782.593044417351, 6786.558873673195, 6796.76211332601, 4943.184374578298, 4948.851534453972, 4951.5048495150195, 4957.876053098701, 4981.975090124672, 4802.968460111318, 4895.877603059952, 4925.433575138905, 5022.748862556785, 5073.239014147907], "value": 4385.826063485275, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.82521535786384, 293.2200347076776, 295.17645768306426, 304.4489474051965, 312.0731427659852, 4487.439070116236, 5064.468230835764, 5301.363836339639, 5370.91943620846, 5424.864378390542, 4681.464621379077, 4981.0, 5145.691258524491, 5260.631755777097, 5281.128613778731, 3418.3421040795192, 4030.334994725881, 4064.9593504065024, 4074.2258970795456, 4082.2856000199995, 3730.3844865597143, 4068.5524592294823, 4075.49056367954, 4087.3460246360587, 4087.5912408759036, 3386.4920261960656, 3687.8567644030436, 3750.9812450937707, 4053.5946405359523, 4087.0, 3526.3778661815595, 4008.8997775055564, 4071.7149799514045, 4087.264292427362, 4112.134593482117, 2815.4932112219794, 2907.037749519066, 3535.8585656573705, 3537.8231088445473, 3541.7166626669805, 5211.322528071327, 5221.242919776649, 5243.318368612094, 5244.632875698702, 5246.580273578104, 4130.483689538808, 4160.771157586331, 4567.908641827178, 4599.379083823675, 4638.814447422099, 4801.975990120062, 4883.923128429103, 5482.095454250044, 5610.214569960209, 5617.269754931874, 3840.5007349044727, 3850.9807450962844, 3854.5759966403675, 3860.6332398422105, 3869.2454971280613, 5620.241267428926, 5781.53747700183, 5797.768089276424, 5847.649141051551, 5862.736176872008, 3663.7618554793853, 3838.6353296436796, 3842.3083844908183, 3845.4616353710503, 3857.286402015636, 3849.9990002599525, 3864.8840534784003, 3921.274564205631, 3922.8231530540725, 3950.644442000234, 4405.7797110144365, 4572.7942242599165, 4579.335996280521, 4589.770511474413, 4599.378354337995, 4805.207140821795, 5269.894602108013, 5449.073657478239, 5601.383847776741, 5602.154136671749, 1097.720081379243, 1257.8239046533492, 1269.3462866623697, 1269.819068266521, 1276.3853725037834, 772.0773675457887, 810.9837803243902, 830.4560512864084, 864.5374724522476, 868.6785889221029, 4052.63526282636, 4396.3625274335045, 4455.331700244924, 4813.7352445615825, 4911.410630724265, 4851.369321988119, 4985.4017517897355, 5385.973070134624, 5452.427495113036, 5468.824202796418, 4065.4105154752397, 4295.591918767712, 4629.519387228617, 5036.773345199402, 5104.846854594368, 2460.286516910112, 2500.6996361891715, 2846.957295640567, 2870.8708108135183, 2908.2874695699265, 5357.410534941599, 5641.971790141105, 5654.105874532078, 5658.74535645897, 5671.716414179275, 4992.375953005874, 5339.599530035263, 5463.344398672185, 5613.943860561342, 5622.493975542139, 4945.727984960789, 5544.91682624761, 5618.494335509742, 5637.210790489335, 5643.855334972684, 4634.381574410448, 5422.240886275846, 5428.592855535771, 5477.945220547744, 5543.196236545759, 4434.866953991385, 4976.502349765139, 5039.823606173766, 5110.770015349392, 5380.623356365173, 4680.0, 5080.695158290514, 5110.105731497048, 5334.186376631964, 5564.666120032811, 3395.8249037150345, 3412.1640198151613, 3422.383970885165, 3652.3060618482405, 3659.6157403472253, 4873.9025219496125, 5344.3853956795465, 5396.298481197419, 5733.569982251264, 5789.478946894799, 5070.721110338966, 5531.3362396512675, 5595.692236927008, 5597.440255974533, 5607.43925607436, 4723.338732577373, 5552.5008247773685, 5610.691411972218, 5625.690587017753, 5688.345840228261, 5215.114739519083, 5439.700816455133, 5484.8354549363585, 5492.505674489315, 5521.4539928819995, 4505.459344878635, 4846.757662116809, 4962.602991760723, 5545.861353466195, 5656.745446454837, 4956.083124621957, 5275.393329767126, 5485.61600687948, 5495.6153069286365, 5517.393086760373], "value": 3963.1305245536887, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.3350000749282, 724.2467833453208, 724.9891251631225, 747.2116916652928, 756.5196100476196, 14701.1914344711, 15179.544613661608, 15515.844841551581, 15720.213989300531, 15740.606484837885, 14185.432582696705, 14282.857171428283, 14377.78433323501, 14380.0, 14407.711845763104, 850.6809946270149, 852.7058164933119, 854.4360721923532, 862.3187681731424, 881.7751473374296, 698.8218004408868, 726.4370113162289, 729.773770131261, 732.2238427267114, 858.3476557816042, 762.2149186338081, 766.9271419215165, 898.7977705016384, 928.6517555916531, 942.3874481586955, 929.9953500232456, 930.0652843891879, 931.855562387831, 932.2541966426832, 932.4545141092469, 692.5429216716942, 692.6052150274346, 693.0055370543287, 693.0747452151384, 693.1647364925253, 14087.506937257249, 14105.2242126683, 14459.493917712934, 14500.057496262709, 14508.202048887308, 13065.608031758968, 13528.120672156278, 13847.930760346235, 13856.30718464083, 14141.787873181911, 12508.124431289812, 12725.681857953532, 12809.61571152867, 12876.163049401759, 12953.417096230693, 4520.773961301955, 4830.082284365959, 4844.66087373884, 4889.511048895118, 4900.0, 89891.0, 91715.54142229246, 93373.0, 94432.52783736175, 96116.51941740247, 9909.009099090033, 10714.46427678613, 10824.621138260123, 10919.290246133976, 11031.724206894893, 17917.7312340315, 20201.898990504953, 20243.696344554843, 20271.797282027284, 20322.593548128956, 7921.405894557931, 8039.316658084012, 8087.636056377477, 8327.167283271625, 8389.119142490074, 4372.890677733082, 4467.977660111678, 4476.574725401082, 4519.88700282489, 4667.066586682677, 3368.040108569046, 3401.0, 3428.708559772397, 3461.5153878457036, 3484.52958850557, 663.6747993483159, 668.7726173101169, 670.5473805181483, 677.4411110833582, 682.8975653651992, 551.503646717949, 662.4123095812198, 688.9315621721177, 695.5652717051843, 720.9495335326582, 9357.953210234042, 9452.19656329206, 9492.839409969274, 9514.571844267024, 9853.75365615851, 595.6098755315276, 644.3427703742251, 669.9162604674416, 680.5066326912948, 700.5936556797045, 4346.174226896879, 4615.16926953145, 4629.490756016903, 4697.694649847749, 4746.667733258639, 114806.0, 119220.0, 121282.0, 123212.38393807973, 127219.0, 101223.0, 103495.4825225869, 103716.0, 106493.40259896108, 109697.0, 70064.0, 92415.0, 92551.97249958938, 94527.10945781184, 95667.52166239124, 8259.710910118118, 8462.619182136696, 8932.910670893209, 9160.770980725536, 9253.907460925573, 59484.70257648684, 60431.69784151051, 60628.78742425215, 61525.0, 62419.43951401251, 72317.0, 82742.0, 84090.0, 87291.56354218189, 87751.0, 11340.149488788209, 11698.2981021139, 11765.294082355085, 11874.346910919638, 11903.642890713292, 11934.940325298317, 12677.619671409873, 14078.554979994286, 14836.0, 15441.613959651098, 14010.43958241659, 14090.78863817023, 14264.643383915485, 14840.925795370955, 14912.179830109015, 14128.858711413166, 14151.080179788281, 14529.491467798576, 14840.628984275048, 14929.552113436614, 13345.532906348231, 13518.662033449242, 13869.167849929037, 14454.0, 14473.203973781543, 10690.0, 11082.833757493483, 11398.145139114766, 11718.531258749554, 11872.703182420162, 11229.606963756556, 11393.943030284796, 11508.884911151115, 11565.595204167814, 11585.04737980962], "value": 7662.7200946930725, "unit": "score"}], "name": "dromaeo_css", "value": 7268.646715240275, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 116.0, 115.0, 114.0, 114.0, 115.0, 114.0, 116.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 112.0, 109.0, 138.0, 112.0, 105.0, 107.0, 106.0, 137.0, 107.0], "value": 117.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 181.0, 184.0, 182.0, 181.0, 181.0, 183.0, 182.0, 185.0, 185.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 49.0, 49.0, 78.0, 76.0, 73.0, 50.0, 71.0, 98.0, 76.0], "value": 70.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 93.0, 69.0, 67.0, 70.0, 87.0, 66.0, 68.0, 90.0], "value": 76.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 126.0, 86.0, 86.0, 87.0, 84.0, 89.0, 86.0, 113.0, 114.0], "value": 95.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 82.0, 79.0, 81.0, 84.0, 83.0, 84.0, 81.0, 80.0], "value": 81.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 49.0, 53.0, 51.0, 56.0, 56.0, 57.0, 57.0, 56.0, 56.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 74.0, 75.0, 71.0, 68.0, 67.0, 69.0, 68.0, 70.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 82.0, 82.0, 81.0, 79.0, 80.0, 81.0, 82.0, 81.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 142.0, 147.0, 136.0, 140.0, 151.0, 154.0, 189.0, 137.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 162.0, 162.0, 163.0, 160.0, 159.0, 161.0, 157.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 66.0, 66.0, 64.0, 67.0, 65.0, 67.0, 65.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1412.1999999999998, "alertThreshold": 2.0}]} 14:30:07 INFO - Return code: 0 14:30:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:30:07 INFO - # TBPL SUCCESS # 14:30:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:30:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:30:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:30:07 INFO - 2017-01-24 14:30:07.124 screenresolution[1646:9540] starting screenresolution argv=screenresolution get 14:30:07 INFO - 2017-01-24 14:30:07.127 screenresolution[1646:9540] Display 0: 1600x1200x32@60 14:30:07 INFO - 2017-01-24 14:30:07.132 screenresolution[1647:9543] starting screenresolution argv=screenresolution list 14:30:07 INFO - Available Modes on Display 0 14:30:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:30:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:30:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:30:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:30:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:30:07 INFO - Intel Iris: 14:30:07 INFO - Chipset Model: Intel Iris 14:30:07 INFO - Type: GPU 14:30:07 INFO - Bus: Built-In 14:30:07 INFO - VRAM (Dynamic, Max): 1536 MB 14:30:07 INFO - Vendor: Intel (0x8086) 14:30:07 INFO - Device ID: 0x0a2e 14:30:07 INFO - Revision ID: 0x0009 14:30:07 INFO - Displays: 14:30:07 INFO - Display: 14:30:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:30:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:30:07 INFO - Display Serial Number: 1600x1200 60 14:30:07 INFO - Main Display: Yes 14:30:07 INFO - Mirror: Off 14:30:07 INFO - Online: Yes 14:30:07 INFO - Rotation: Supported 14:30:07 INFO - Return code: 0 14:30:07 INFO - Running post-action listener: _resource_record_post_action 14:30:07 INFO - [mozharness: 2017-01-24 22:30:07.380989Z] Finished run-tests step (success) 14:30:07 INFO - Running post-run listener: _resource_record_post_run 14:30:07 INFO - Total resource usage - Wall time: 1199s; CPU: 53.0%; Read bytes: 40025600; Write bytes: 502393344; Read time: 375; Write time: 1877 14:30:07 INFO - TinderboxPrint: CPU usage
53.4% 14:30:07 INFO - TinderboxPrint: I/O read bytes / time
40,025,600 / 375 14:30:07 INFO - TinderboxPrint: I/O write bytes / time
502,393,344 / 1,877 14:30:07 INFO - TinderboxPrint: CPU idle
2,235.8 (46.6%) 14:30:07 INFO - TinderboxPrint: CPU system
958.9 (20.0%) 14:30:07 INFO - TinderboxPrint: CPU user
1,603.0 (33.4%) 14:30:07 INFO - TinderboxPrint: Swap in / out
234,930,176 / 0 14:30:07 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 181107200; Write bytes: 177305088; Read time: 16583; Write time: 428 14:30:07 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 39034368; Write bytes: 307356672; Read time: 360; Write time: 1396 14:30:07 INFO - Running post-run listener: _upload_blobber_files 14:30:07 INFO - Blob upload gear active. 14:30:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:30:07 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 14:30:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:30:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:30:08 INFO - (blobuploader) - INFO - Open directory for files ... 14:30:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:30:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:30:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:08 INFO - (blobuploader) - INFO - Done attempting. 14:30:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:30:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:30:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:09 INFO - (blobuploader) - INFO - Done attempting. 14:30:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:30:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:30:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:11 INFO - (blobuploader) - INFO - Done attempting. 14:30:11 INFO - (blobuploader) - INFO - Iteration through files over. 14:30:11 INFO - Return code: 0 14:30:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:30:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:30:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2107aaf2bdc9dcf3a4b77166672b1fa0acd991dc54358ec49a62e2a2c332c8e9eb5147aa2fc8298fef59db81f5d65067f993d657c0236f73d4d559543ca3f5fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7edb9df9b3db180467a5e9da301423f0626fb0bd2d4bcdfb594d61be877789b733722d2b473bf3df528adb283ba7f8d1b47527bc2a511896e461d4e904a096d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1eba7939e052160121165b1ce3171cde3385ff2ef4ddd187403a55ce209a44823d8813490de4d15f6d8ff35744d44682f628c8cdabe0e3104bec6fc20ad5b813"} 14:30:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:30:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:30:11 INFO - Contents: 14:30:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2107aaf2bdc9dcf3a4b77166672b1fa0acd991dc54358ec49a62e2a2c332c8e9eb5147aa2fc8298fef59db81f5d65067f993d657c0236f73d4d559543ca3f5fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7edb9df9b3db180467a5e9da301423f0626fb0bd2d4bcdfb594d61be877789b733722d2b473bf3df528adb283ba7f8d1b47527bc2a511896e461d4e904a096d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1eba7939e052160121165b1ce3171cde3385ff2ef4ddd187403a55ce209a44823d8813490de4d15f6d8ff35744d44682f628c8cdabe0e3104bec6fc20ad5b813"} 14:30:11 INFO - Running post-run listener: copy_logs_to_upload_dir 14:30:11 INFO - Copying logs to upload dir... 14:30:11 INFO - mkdir: /builds/slave/test/build/upload/logs 14:30:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.246403 ========= master_lag: 0.32 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-24 14:30:12.254239) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 14:30:12.256771) ========= 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.Ak10q3OUsD/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.SEWf7KIX7b/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2107aaf2bdc9dcf3a4b77166672b1fa0acd991dc54358ec49a62e2a2c332c8e9eb5147aa2fc8298fef59db81f5d65067f993d657c0236f73d4d559543ca3f5fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7edb9df9b3db180467a5e9da301423f0626fb0bd2d4bcdfb594d61be877789b733722d2b473bf3df528adb283ba7f8d1b47527bc2a511896e461d4e904a096d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1eba7939e052160121165b1ce3171cde3385ff2ef4ddd187403a55ce209a44823d8813490de4d15f6d8ff35744d44682f628c8cdabe0e3104bec6fc20ad5b813"} build_url:https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/dlqAP2kbT4KexOSWd7XzRA/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2107aaf2bdc9dcf3a4b77166672b1fa0acd991dc54358ec49a62e2a2c332c8e9eb5147aa2fc8298fef59db81f5d65067f993d657c0236f73d4d559543ca3f5fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7edb9df9b3db180467a5e9da301423f0626fb0bd2d4bcdfb594d61be877789b733722d2b473bf3df528adb283ba7f8d1b47527bc2a511896e461d4e904a096d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1eba7939e052160121165b1ce3171cde3385ff2ef4ddd187403a55ce209a44823d8813490de4d15f6d8ff35744d44682f628c8cdabe0e3104bec6fc20ad5b813"}' ========= master_lag: 0.56 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 14:30:12.825735) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2017-01-24 14:30:12.826067) ========= 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.Ak10q3OUsD/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.SEWf7KIX7b/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.005094 ========= master_lag: 5.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2017-01-24 14:30:17.947023) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 14:30:17.947358) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 14:30:17.953164) ========= ========= Total master_lag: 6.06 =========