builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0198 starttime: 1486947300.68 results: success (0) buildid: 20170212153046 builduid: 248dc26b89ee4d7daf4637c3fd68932c revision: 00d16f03506b7f9f754b01a0a458c05445ac6dba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-12 16:55:00.684735) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-12 16:55:00.685123) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-12 16:55:00.685389) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-12 16:55:00.854161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-12 16:55:00.854413) ========= 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.LBjD4jZRuh/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.tDFyAF7ivd/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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-02-12 16:55:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 23.3M=0s 2017-02-12 16:55:01 (23.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.520383 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-12 16:55:01.410295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-12 16:55:01.410568) ========= 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.LBjD4jZRuh/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.tDFyAF7ivd/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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.033059 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-12 16:55:01.466629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-12 16:55:01.467165) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 00d16f03506b7f9f754b01a0a458c05445ac6dba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 00d16f03506b7f9f754b01a0a458c05445ac6dba --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LBjD4jZRuh/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.tDFyAF7ivd/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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-02-12 16:55:01,533 truncating revision to first 12 chars 2017-02-12 16:55:01,533 Setting DEBUG logging. 2017-02-12 16:55:01,533 attempt 1/10 2017-02-12 16:55:01,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/00d16f03506b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-12 16:55:03,352 unpacking tar archive at: mozilla-central-00d16f03506b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.087957 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-12 16:55:03.578564) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-12 16:55:03.578920) ========= script_repo_revision: 00d16f03506b7f9f754b01a0a458c05445ac6dba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-12 16:55:03.579329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-12 16:55:03.579586) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-12 16:55:03.601976) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-02-12 16:55:03.602254) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LBjD4jZRuh/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.tDFyAF7ivd/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 16:55:03 INFO - MultiFileLogger online at 20170212 16:55:03 in /builds/slave/test 16:55:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:55:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:55:03 INFO - {'append_to_log': False, 16:55:03 INFO - 'base_work_dir': '/builds/slave/test', 16:55:03 INFO - 'blob_upload_branch': 'Firefox', 16:55:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:55:03 INFO - 'branch': 'Firefox', 16:55:03 INFO - 'buildbot_json_path': 'buildprops.json', 16:55:03 INFO - 'config_files': ('talos/mac_config.py',), 16:55:03 INFO - 'default_actions': ('clobber', 16:55:03 INFO - 'read-buildbot-config', 16:55:03 INFO - 'download-and-extract', 16:55:03 INFO - 'populate-webroot', 16:55:03 INFO - 'create-virtualenv', 16:55:03 INFO - 'install', 16:55:03 INFO - 'run-tests'), 16:55:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:55:03 INFO - 'download_minidump_stackwalk': True, 16:55:03 INFO - 'download_symbols': 'ondemand', 16:55:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:55:03 INFO - 'tooltool.py': '/tools/tooltool.py', 16:55:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:55:03 INFO - '/tools/misc-python/virtualenv.py')}, 16:55:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:55:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:55:03 INFO - 'installer_path': 'installer.exe', 16:55:03 INFO - 'log_level': 'info', 16:55:03 INFO - 'log_name': 'talos', 16:55:03 INFO - 'log_to_console': True, 16:55:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:55:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:55:03 INFO - 'opt_config_files': (), 16:55:03 INFO - 'pip_index': False, 16:55:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:55:03 INFO - 'cmd': ('bash', 16:55:03 INFO - '-c', 16:55:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:55:03 INFO - 'enabled': True, 16:55:03 INFO - 'halt_on_failure': False, 16:55:03 INFO - 'name': 'check_screen_resolution'},), 16:55:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:55:03 INFO - 'cmd': ('bash', 16:55:03 INFO - '-c', 16:55:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:55:03 INFO - 'enabled': True, 16:55:03 INFO - 'halt_on_failure': False, 16:55:03 INFO - 'name': 'check_screen_resolution'},), 16:55:03 INFO - 'run_cmd_checks_enabled': True, 16:55:03 INFO - 'sps_profile': False, 16:55:03 INFO - 'sps_profile_interval': 0, 16:55:03 INFO - 'suite': 'dromaeojs', 16:55:03 INFO - 'system_bits': '32', 16:55:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:55:03 INFO - 'title': 't-yosemite-r7-0198', 16:55:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:55:03 INFO - 'use_talos_json': True, 16:55:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:55:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:55:03 INFO - 'work_dir': 'build'} 16:55:03 INFO - [mozharness: 2017-02-13 00:55:03.782047Z] Running clobber step. 16:55:03 INFO - Running pre-action listener: _resource_record_pre_action 16:55:03 INFO - Running main action method: clobber 16:55:03 INFO - rmtree: /builds/slave/test/build 16:55:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:55:08 INFO - Running post-action listener: _resource_record_post_action 16:55:08 INFO - [mozharness: 2017-02-13 00:55:08.292354Z] Finished clobber step (success) 16:55:08 INFO - [mozharness: 2017-02-13 00:55:08.292508Z] Running read-buildbot-config step. 16:55:08 INFO - Running pre-action listener: _resource_record_pre_action 16:55:08 INFO - Running main action method: read_buildbot_config 16:55:08 INFO - Using buildbot properties: 16:55:08 INFO - { 16:55:08 INFO - "project": "", 16:55:08 INFO - "product": "firefox", 16:55:08 INFO - "script_repo_revision": "production", 16:55:08 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:55:08 INFO - "repository": "", 16:55:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:55:08 INFO - "buildid": "20170212153046", 16:55:08 INFO - "pgo_build": "False", 16:55:08 INFO - "basedir": "/builds/slave/test", 16:55:08 INFO - "buildnumber": 87, 16:55:08 INFO - "slavename": "t-yosemite-r7-0198", 16:55:08 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:55:08 INFO - "platform": "yosemite_r7", 16:55:08 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:55:08 INFO - "branch": "mozilla-central", 16:55:08 INFO - "repo_path": "mozilla-central", 16:55:08 INFO - "revision": "00d16f03506b7f9f754b01a0a458c05445ac6dba", 16:55:08 INFO - "stage_platform": "macosx64", 16:55:08 INFO - "builduid": "248dc26b89ee4d7daf4637c3fd68932c", 16:55:08 INFO - "slavebuilddir": "test" 16:55:08 INFO - } 16:55:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 16:55:08 INFO - Running post-action listener: _resource_record_post_action 16:55:08 INFO - [mozharness: 2017-02-13 00:55:08.295859Z] Finished read-buildbot-config step (success) 16:55:08 INFO - [mozharness: 2017-02-13 00:55:08.295981Z] Running download-and-extract step. 16:55:08 INFO - Running pre-action listener: _resource_record_pre_action 16:55:08 INFO - Running main action method: download_and_extract 16:55:08 INFO - mkdir: /builds/slave/test/build/tests 16:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:08 INFO - trying https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 16:55:08 INFO - Downloading https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 16:55:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 16:55:09 INFO - Downloaded 1199 bytes. 16:55:09 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 16:55:09 INFO - Using the following test package requirements: 16:55:09 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 16:55:09 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:55:09 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 16:55:09 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:55:09 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 16:55:09 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:55:09 INFO - u'jsshell-mac.zip'], 16:55:09 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:55:09 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 16:55:09 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 16:55:09 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:55:09 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 16:55:09 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:55:09 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 16:55:09 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:55:09 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 16:55:09 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 16:55:09 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 16:55:09 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:55:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 16:55:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:55:09 INFO - Fetch https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 16:55:11 INFO - Expected file size: 51504400 16:55:11 INFO - Obtained file size: 51504400 16:55:27 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:55:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 16:55:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:55:27 INFO - Fetch https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 16:55:29 INFO - Expected file size: 51504400 16:55:29 INFO - Obtained file size: 51504400 16:55:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 16:55:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:55:44 INFO - Fetch https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 16:55:45 INFO - Expected file size: 14403647 16:55:45 INFO - Obtained file size: 14403647 16:55:45 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')]} 16:55:45 INFO - trying https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 16:55:45 INFO - Downloading https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 16:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 16:55:47 INFO - Downloaded 70460271 bytes. 16:55:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 16:55:47 INFO - mkdir: /builds/slave/test/properties 16:55:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:55:47 INFO - Writing to file /builds/slave/test/properties/build_url 16:55:47 INFO - Contents: 16:55:47 INFO - build_url:https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 16:55:48 INFO - Running post-action listener: _resource_record_post_action 16:55:48 INFO - Running post-action listener: set_extra_try_arguments 16:55:48 INFO - [mozharness: 2017-02-13 00:55:48.584894Z] Finished download-and-extract step (success) 16:55:48 INFO - [mozharness: 2017-02-13 00:55:48.585019Z] Running populate-webroot step. 16:55:48 INFO - Running pre-action listener: _resource_record_pre_action 16:55:48 INFO - Running main action method: populate_webroot 16:55:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:55:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:55:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:55:48 INFO - '--tppagecycles', 16:55:48 INFO - '7'], 16:55:48 INFO - 'tests': ['tsvgm']}}, 16:55:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:55:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:55:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:55:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:55:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:55:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:55:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:55:48 INFO - 'talos_options': ['--disable-e10s'], 16:55:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:55:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:55:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:55:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:55:48 INFO - 'talos_options': ['--disable-e10s'], 16:55:48 INFO - 'tests': ['damp', 'tps']}, 16:55:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:55:48 INFO - 'tests': ['damp', 'tps']}, 16:55:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:55:48 INFO - 'tests': ['dromaeo_dom']}, 16:55:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:55:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:55:48 INFO - 'tests': ['basic_compositor_video']}, 16:55:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:55:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:55:48 INFO - 'tests': ['a11yr', 16:55:48 INFO - 'ts_paint', 16:55:48 INFO - 'tpaint', 16:55:48 INFO - 'sessionrestore', 16:55:48 INFO - 'sessionrestore_no_auto_restore', 16:55:48 INFO - 'tabpaint']}, 16:55:48 INFO - 'other-e10s': {'tests': ['a11yr', 16:55:48 INFO - 'ts_paint', 16:55:48 INFO - 'tpaint', 16:55:48 INFO - 'sessionrestore', 16:55:48 INFO - 'sessionrestore_no_auto_restore', 16:55:48 INFO - 'tabpaint']}, 16:55:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:55:48 INFO - 'ts_paint', 16:55:48 INFO - 'tpaint', 16:55:48 INFO - 'sessionrestore', 16:55:48 INFO - 'sessionrestore_no_auto_restore', 16:55:48 INFO - 'tabpaint']}, 16:55:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:55:48 INFO - 'ts_paint', 16:55:48 INFO - 'tpaint', 16:55:48 INFO - 'sessionrestore', 16:55:48 INFO - 'sessionrestore_no_auto_restore', 16:55:48 INFO - 'tabpaint']}, 16:55:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:55:48 INFO - 'tests': ['a11yr', 16:55:48 INFO - 'ts_paint', 16:55:48 INFO - 'tpaint', 16:55:48 INFO - 'sessionrestore', 16:55:48 INFO - 'sessionrestore_no_auto_restore', 16:55:48 INFO - 'tabpaint']}, 16:55:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:55:48 INFO - 'tests': ['a11yr', 16:55:48 INFO - 'ts_paint', 16:55:48 INFO - 'tpaint', 16:55:48 INFO - 'sessionrestore', 16:55:48 INFO - 'sessionrestore_no_auto_restore', 16:55:48 INFO - 'tabpaint']}, 16:55:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:55:48 INFO - 'tests': ['tsvgx', 16:55:48 INFO - 'tsvgr_opacity', 16:55:48 INFO - 'tart', 16:55:48 INFO - 'tscrollx', 16:55:48 INFO - 'cart', 16:55:48 INFO - 'tsvg_static']}, 16:55:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:55:48 INFO - 'tsvgr_opacity', 16:55:48 INFO - 'tart', 16:55:48 INFO - 'tscrollx', 16:55:48 INFO - 'cart', 16:55:48 INFO - 'tsvg_static']}, 16:55:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:55:48 INFO - 'talos_options': ['--disable-e10s'], 16:55:48 INFO - 'tests': ['tp5o']}, 16:55:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:55:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:55:48 INFO - 'talos_options': ['--disable-e10s', 16:55:48 INFO - '--xperf_path', 16:55:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:55:48 INFO - 'tests': ['tp5n']}, 16:55:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:55:48 INFO - 'talos_options': ['--xperf_path', 16:55:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:55:48 INFO - 'tests': ['tp5n']}}, 16:55:48 INFO - 'talos.zip': {'path': '', 16:55:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:55:48 INFO - Running post-action listener: _resource_record_post_action 16:55:48 INFO - [mozharness: 2017-02-13 00:55:48.603486Z] Finished populate-webroot step (success) 16:55:48 INFO - [mozharness: 2017-02-13 00:55:48.603622Z] Running create-virtualenv step. 16:55:48 INFO - Running pre-action listener: _resource_record_pre_action 16:55:48 INFO - Running main action method: create_virtualenv 16:55:48 INFO - Creating virtualenv /builds/slave/test/build/venv 16:55:48 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 16:55:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:55:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:55:48 INFO - Using real prefix '/tools/python27' 16:55:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:55:49 INFO - Installing distribute.............................................................................................................................................................................................done. 16:55:52 INFO - Installing pip.................done. 16:55:52 INFO - Return code: 0 16:55:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:55:52 INFO - Reading from file tmpfile_stdout 16:55:52 INFO - Output received: 16:55:52 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) 16:55:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:52 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 0x10a47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab12d605b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25ad30>, '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 0x10a181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a24fbe8>, '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.LBjD4jZRuh/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.tDFyAF7ivd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 16:55:52 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 16:55:52 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 16:55:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LBjD4jZRuh/Render', 16:55:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:52 INFO - 'HOME': '/Users/cltbld', 16:55:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:52 INFO - 'LOGNAME': 'cltbld', 16:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:52 INFO - 'MOZ_NO_REMOTE': '1', 16:55:52 INFO - 'NO_EM_RESTART': '1', 16:55:52 INFO - 'PAGER': '/bin/cat', 16:55:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:52 INFO - 'PWD': '/builds/slave/test', 16:55:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:52 INFO - 'SHELL': '/bin/bash', 16:55:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDFyAF7ivd/Listeners', 16:55:52 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 16:55:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:52 INFO - 'USER': 'cltbld', 16:55:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:52 INFO - 'XPC_FLAGS': '0x0', 16:55:52 INFO - 'XPC_SERVICE_NAME': '0', 16:55:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:52 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 16:55:52 INFO - Cleaning up... 16:55:52 INFO - Return code: 0 16:55:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:52 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 0x10a47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab12d605b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25ad30>, '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 0x10a181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a24fbe8>, '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.LBjD4jZRuh/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.tDFyAF7ivd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 16:55:52 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 16:55:52 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 16:55:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LBjD4jZRuh/Render', 16:55:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:52 INFO - 'HOME': '/Users/cltbld', 16:55:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:52 INFO - 'LOGNAME': 'cltbld', 16:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:52 INFO - 'MOZ_NO_REMOTE': '1', 16:55:52 INFO - 'NO_EM_RESTART': '1', 16:55:52 INFO - 'PAGER': '/bin/cat', 16:55:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:52 INFO - 'PWD': '/builds/slave/test', 16:55:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:52 INFO - 'SHELL': '/bin/bash', 16:55:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDFyAF7ivd/Listeners', 16:55:52 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 16:55:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:52 INFO - 'USER': 'cltbld', 16:55:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:52 INFO - 'XPC_FLAGS': '0x0', 16:55:52 INFO - 'XPC_SERVICE_NAME': '0', 16:55:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:53 INFO - Downloading/unpacking psutil>=3.1.1 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55: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 16:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:55:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:56 INFO - Installing collected packages: psutil 16:55:56 INFO - Running setup.py install for psutil 16:55:56 INFO - building 'psutil._psutil_osx' extension 16:55:56 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 16:55:57 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 16:55:57 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 16:55:57 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 16:55:57 INFO - building 'psutil._psutil_posix' extension 16:55:57 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 16:55:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:55:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:55:57 INFO - ^ 16:55:57 INFO - 1 warning generated. 16:55:57 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 16:55:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:58 INFO - Successfully installed psutil 16:55:58 INFO - Cleaning up... 16:55:58 INFO - Return code: 0 16:55:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:55:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab12d605b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25ad30>, '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 0x10a181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a24fbe8>, '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.LBjD4jZRuh/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.tDFyAF7ivd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 16:55:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:55:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:55:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LBjD4jZRuh/Render', 16:55:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:58 INFO - 'HOME': '/Users/cltbld', 16:55:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:58 INFO - 'LOGNAME': 'cltbld', 16:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:58 INFO - 'MOZ_NO_REMOTE': '1', 16:55:58 INFO - 'NO_EM_RESTART': '1', 16:55:58 INFO - 'PAGER': '/bin/cat', 16:55:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:58 INFO - 'PWD': '/builds/slave/test', 16:55:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:58 INFO - 'SHELL': '/bin/bash', 16:55:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDFyAF7ivd/Listeners', 16:55:58 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 16:55:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:58 INFO - 'USER': 'cltbld', 16:55:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:58 INFO - 'XPC_FLAGS': '0x0', 16:55:58 INFO - 'XPC_SERVICE_NAME': '0', 16:55:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:55:58 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 16:55:58 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 16:55:58 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 16:55:58 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 16:55:58 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 16:55:58 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 16:56:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:56:01 INFO - Installing collected packages: mozsystemmonitor 16:56:01 INFO - Running setup.py install for mozsystemmonitor 16:56:01 INFO - Successfully installed mozsystemmonitor 16:56:01 INFO - Cleaning up... 16:56:01 INFO - Return code: 0 16:56:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:56:01 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')]} 16:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:01 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')]} 16:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:01 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 0x10a47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab12d605b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25ad30>, '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 0x10a181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a24fbe8>, '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.LBjD4jZRuh/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.tDFyAF7ivd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 16:56:01 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 16:56:01 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 16:56:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LBjD4jZRuh/Render', 16:56:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:56:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:56:01 INFO - 'HOME': '/Users/cltbld', 16:56:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:56:01 INFO - 'LOGNAME': 'cltbld', 16:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:01 INFO - 'MOZ_NO_REMOTE': '1', 16:56:01 INFO - 'NO_EM_RESTART': '1', 16:56:01 INFO - 'PAGER': '/bin/cat', 16:56:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:01 INFO - 'PWD': '/builds/slave/test', 16:56:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:56:01 INFO - 'SHELL': '/bin/bash', 16:56:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDFyAF7ivd/Listeners', 16:56:01 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 16:56:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:56:01 INFO - 'USER': 'cltbld', 16:56:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:56:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:01 INFO - 'XPC_FLAGS': '0x0', 16:56:01 INFO - 'XPC_SERVICE_NAME': '0', 16:56:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:01 INFO - Downloading/unpacking jsonschema==2.5.1 16:56:01 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 16:56:01 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 16:56:01 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 16:56:01 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 16:56:01 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 16:56:01 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 16:56:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:56:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:56:04 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 16:56:04 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 16:56:04 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 16:56:04 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 16:56:04 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 16:56:04 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 16:56:04 INFO - Downloading functools32-3.2.3-2.tar.gz 16:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:56:04 INFO - warning: no files found matching '*.txt' 16:56:04 INFO - no previously-included directories found matching 'build' 16:56:04 INFO - no previously-included directories found matching 'dist' 16:56:04 INFO - no previously-included directories found matching '.git*' 16:56:04 INFO - Installing collected packages: jsonschema, functools32 16:56:04 INFO - Running setup.py install for functools32 16:56:04 INFO - warning: no files found matching '*.txt' 16:56:04 INFO - no previously-included directories found matching 'build' 16:56:04 INFO - no previously-included directories found matching 'dist' 16:56:04 INFO - no previously-included directories found matching '.git*' 16:56:04 INFO - Successfully installed jsonschema functools32 16:56:04 INFO - Cleaning up... 16:56:04 INFO - Return code: 0 16:56:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:04 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 0x10a47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab12d605b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25ad30>, '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 0x10a181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a24fbe8>, '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.LBjD4jZRuh/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.tDFyAF7ivd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 16:56:04 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 16:56:04 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 16:56:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LBjD4jZRuh/Render', 16:56:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:56:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:56:05 INFO - 'HOME': '/Users/cltbld', 16:56:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:56:05 INFO - 'LOGNAME': 'cltbld', 16:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:05 INFO - 'MOZ_NO_REMOTE': '1', 16:56:05 INFO - 'NO_EM_RESTART': '1', 16:56:05 INFO - 'PAGER': '/bin/cat', 16:56:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:05 INFO - 'PWD': '/builds/slave/test', 16:56:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:56:05 INFO - 'SHELL': '/bin/bash', 16:56:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDFyAF7ivd/Listeners', 16:56:05 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 16:56:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:56:05 INFO - 'USER': 'cltbld', 16:56:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:56:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:05 INFO - 'XPC_FLAGS': '0x0', 16:56:05 INFO - 'XPC_SERVICE_NAME': '0', 16:56:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:56:05 INFO - Cleaning up... 16:56:05 INFO - Return code: 0 16:56:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab12d605b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25ad30>, '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 0x10a181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a24fbe8>, '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.LBjD4jZRuh/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.tDFyAF7ivd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 16:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:56:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LBjD4jZRuh/Render', 16:56:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:56:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:56:05 INFO - 'HOME': '/Users/cltbld', 16:56:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:56:05 INFO - 'LOGNAME': 'cltbld', 16:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:05 INFO - 'MOZ_NO_REMOTE': '1', 16:56:05 INFO - 'NO_EM_RESTART': '1', 16:56:05 INFO - 'PAGER': '/bin/cat', 16:56:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:05 INFO - 'PWD': '/builds/slave/test', 16:56:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:56:05 INFO - 'SHELL': '/bin/bash', 16:56:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDFyAF7ivd/Listeners', 16:56:05 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 16:56:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:56:05 INFO - 'USER': 'cltbld', 16:56:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:56:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:05 INFO - 'XPC_FLAGS': '0x0', 16:56:05 INFO - 'XPC_SERVICE_NAME': '0', 16:56:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:05 INFO - Downloading/unpacking blobuploader==1.2.4 16:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:08 INFO - Downloading blobuploader-1.2.4.tar.gz 16:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:56:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:56:08 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 16:56:08 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 16:56:08 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 16:56:08 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 16:56:08 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 16:56:08 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 16:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:56:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:56:08 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 16:56:08 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 16:56:08 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 16:56:08 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 16:56:08 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 16:56:08 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 16:56:09 INFO - Downloading docopt-0.6.1.tar.gz 16:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:56:09 INFO - Installing collected packages: blobuploader, requests, docopt 16:56:09 INFO - Running setup.py install for blobuploader 16:56:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:56:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:56:09 INFO - Running setup.py install for requests 16:56:10 INFO - Running setup.py install for docopt 16:56:10 INFO - Successfully installed blobuploader requests docopt 16:56:10 INFO - Cleaning up... 16:56:10 INFO - Return code: 0 16:56:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:10 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')]} 16:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:10 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')]} 16:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:10 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 0x10a47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab12d605b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25ad30>, '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 0x10a181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a24fbe8>, '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.LBjD4jZRuh/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.tDFyAF7ivd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 16:56:10 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 16:56:10 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 16:56:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LBjD4jZRuh/Render', 16:56:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:56:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:56:10 INFO - 'HOME': '/Users/cltbld', 16:56:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:56:10 INFO - 'LOGNAME': 'cltbld', 16:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:10 INFO - 'MOZ_NO_REMOTE': '1', 16:56:10 INFO - 'NO_EM_RESTART': '1', 16:56:10 INFO - 'PAGER': '/bin/cat', 16:56:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:10 INFO - 'PWD': '/builds/slave/test', 16:56:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:56:10 INFO - 'SHELL': '/bin/bash', 16:56:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDFyAF7ivd/Listeners', 16:56:10 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 16:56:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:56:10 INFO - 'USER': 'cltbld', 16:56:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:56:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:10 INFO - 'XPC_FLAGS': '0x0', 16:56:10 INFO - 'XPC_SERVICE_NAME': '0', 16:56:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:10 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-QraRie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:10 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-ini7oR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:10 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-PlWbtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:10 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-h6fGx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:11 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-XA_CCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:11 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-YYreGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:11 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-mZlIw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:11 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-Krui6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:11 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-QLEIa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:11 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-Y4hjXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:11 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-nJVEmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:11 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-H7R7j0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:11 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-QHoBpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:11 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-_fe6uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:12 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-nc0fXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:12 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-QuH8kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:12 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-dsQc_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:56:12 INFO - Running setup.py install for manifestparser 16:56:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:56:12 INFO - Running setup.py install for mozcrash 16:56:12 INFO - Running setup.py install for mozdebug 16:56:12 INFO - Running setup.py install for mozdevice 16:56:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:56:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:56:12 INFO - Running setup.py install for mozfile 16:56:13 INFO - Running setup.py install for mozhttpd 16:56:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Running setup.py install for mozinfo 16:56:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Running setup.py install for mozInstall 16:56:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Running setup.py install for mozleak 16:56:13 INFO - Running setup.py install for mozlog 16:56:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:56:13 INFO - Running setup.py install for moznetwork 16:56:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:56:14 INFO - Running setup.py install for mozprocess 16:56:14 INFO - Running setup.py install for mozprofile 16:56:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:56:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:56:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:56:14 INFO - Running setup.py install for mozrunner 16:56:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:56:14 INFO - Running setup.py install for mozscreenshot 16:56:14 INFO - Running setup.py install for moztest 16:56:14 INFO - Running setup.py install for mozversion 16:56:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:56:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:56:14 INFO - Cleaning up... 16:56:14 INFO - Return code: 0 16:56:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:14 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')]} 16:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:14 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')]} 16:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:14 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 0x10a47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab12d605b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25ad30>, '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 0x10a181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a24fbe8>, '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.LBjD4jZRuh/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.tDFyAF7ivd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 16:56:14 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 16:56:14 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 16:56:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LBjD4jZRuh/Render', 16:56:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:56:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:56:14 INFO - 'HOME': '/Users/cltbld', 16:56:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:56:14 INFO - 'LOGNAME': 'cltbld', 16:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:14 INFO - 'MOZ_NO_REMOTE': '1', 16:56:14 INFO - 'NO_EM_RESTART': '1', 16:56:14 INFO - 'PAGER': '/bin/cat', 16:56:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:14 INFO - 'PWD': '/builds/slave/test', 16:56:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:56:14 INFO - 'SHELL': '/bin/bash', 16:56:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDFyAF7ivd/Listeners', 16:56:14 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 16:56:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:56:14 INFO - 'USER': 'cltbld', 16:56:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:56:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:14 INFO - 'XPC_FLAGS': '0x0', 16:56:14 INFO - 'XPC_SERVICE_NAME': '0', 16:56:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:15 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-btQjsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:15 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-NKjoeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:15 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-B2jttv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:15 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-J0awfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:15 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-qUapNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:15 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-jNBQUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:15 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-9TEBTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:15 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)) 16:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:15 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-0xF6aT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:16 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)) 16:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:16 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-PTOiCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:16 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)) 16:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:16 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-LmKdRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:16 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)) 16:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:16 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-ua023h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:16 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)) 16:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:16 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-bcHLTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:16 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-45HOG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:16 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)) 16:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:16 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-MMXQ9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:16 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)) 16:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:16 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-eus50P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:16 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)) 16:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:16 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-Y9xgYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:16 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)) 16:56:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:16 INFO - Running setup.py (path:/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/pip-obXbE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:17 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)) 16:56:17 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)) 16:56:17 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)) 16:56:17 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)) 16:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:56:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:19 INFO - Downloading blessings-1.6.tar.gz 16:56:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:56:19 INFO - Installing collected packages: blessings 16:56:19 INFO - Running setup.py install for blessings 16:56:19 INFO - Successfully installed blessings 16:56:19 INFO - Cleaning up... 16:56:20 INFO - Return code: 0 16:56:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:56:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:20 INFO - Reading from file tmpfile_stdout 16:56:20 INFO - Current package versions: 16:56:20 INFO - blessings == 1.6 16:56:20 INFO - blobuploader == 1.2.4 16:56:20 INFO - docopt == 0.6.1 16:56:20 INFO - functools32 == 3.2.3-2 16:56:20 INFO - jsonschema == 2.5.1 16:56:20 INFO - manifestparser == 1.1 16:56:20 INFO - mozInstall == 1.12 16:56:20 INFO - mozcrash == 1.0 16:56:20 INFO - mozdebug == 0.1 16:56:20 INFO - mozdevice == 0.49 16:56:20 INFO - mozfile == 1.2 16:56:20 INFO - mozhttpd == 0.7 16:56:20 INFO - mozinfo == 0.9 16:56:20 INFO - mozleak == 0.1 16:56:20 INFO - mozlog == 3.4 16:56:20 INFO - moznetwork == 0.27 16:56:20 INFO - mozprocess == 0.24 16:56:20 INFO - mozprofile == 0.28 16:56:20 INFO - mozrunner == 6.13 16:56:20 INFO - mozscreenshot == 0.1 16:56:20 INFO - mozsystemmonitor == 0.3 16:56:20 INFO - moztest == 0.8 16:56:20 INFO - mozversion == 1.4 16:56:20 INFO - psutil == 3.1.1 16:56:20 INFO - requests == 1.2.3 16:56:20 INFO - wsgiref == 0.1.2 16:56:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:20 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 0x10a47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab12d605b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25ad30>, '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 0x10a181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a24fbe8>, '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.LBjD4jZRuh/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.tDFyAF7ivd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 16:56:20 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 16:56:20 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 16:56:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LBjD4jZRuh/Render', 16:56:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:56:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:56:20 INFO - 'HOME': '/Users/cltbld', 16:56:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:56:20 INFO - 'LOGNAME': 'cltbld', 16:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:20 INFO - 'MOZ_NO_REMOTE': '1', 16:56:20 INFO - 'NO_EM_RESTART': '1', 16:56:20 INFO - 'PAGER': '/bin/cat', 16:56:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:20 INFO - 'PWD': '/builds/slave/test', 16:56:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:56:20 INFO - 'SHELL': '/bin/bash', 16:56:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDFyAF7ivd/Listeners', 16:56:20 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 16:56:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:56:20 INFO - 'USER': 'cltbld', 16:56:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:56:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:20 INFO - 'XPC_FLAGS': '0x0', 16:56:20 INFO - 'XPC_SERVICE_NAME': '0', 16:56:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:20 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)) 16:56:20 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)) 16:56:20 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)) 16:56:20 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)) 16:56:20 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)) 16:56:20 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)) 16:56:20 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)) 16:56:20 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)) 16:56:20 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)) 16:56:20 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)) 16:56:20 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)) 16:56:20 INFO - Cleaning up... 16:56:20 INFO - Return code: 0 16:56:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:56:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a47cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a47f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab12d605b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a25ad30>, '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 0x10a181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a24fbe8>, '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.LBjD4jZRuh/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.tDFyAF7ivd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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 16:56:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:56:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LBjD4jZRuh/Render', 16:56:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:56:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:56:20 INFO - 'HOME': '/Users/cltbld', 16:56:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:56:20 INFO - 'LOGNAME': 'cltbld', 16:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:20 INFO - 'MOZ_NO_REMOTE': '1', 16:56:20 INFO - 'NO_EM_RESTART': '1', 16:56:20 INFO - 'PAGER': '/bin/cat', 16:56:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:20 INFO - 'PWD': '/builds/slave/test', 16:56:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:56:20 INFO - 'SHELL': '/bin/bash', 16:56:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDFyAF7ivd/Listeners', 16:56:20 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 16:56:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:56:20 INFO - 'USER': 'cltbld', 16:56:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:56:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:20 INFO - 'XPC_FLAGS': '0x0', 16:56:20 INFO - 'XPC_SERVICE_NAME': '0', 16:56:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:56:20 INFO - Cleaning up... 16:56:20 INFO - Return code: 0 16:56:20 INFO - Running post-action listener: _resource_record_post_action 16:56:20 INFO - Running post-action listener: _start_resource_monitoring 16:56:20 INFO - Starting resource monitoring. 16:56:20 INFO - [mozharness: 2017-02-13 00:56:20.925755Z] Finished create-virtualenv step (success) 16:56:20 INFO - [mozharness: 2017-02-13 00:56:20.926706Z] Running install step. 16:56:20 INFO - Running pre-action listener: _resource_record_pre_action 16:56:20 INFO - Running main action method: install 16:56:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:21 INFO - Reading from file tmpfile_stdout 16:56:21 INFO - Detecting whether we're running mozinstall >=1.0... 16:56:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:56:21 INFO - Reading from file tmpfile_stdout 16:56:21 INFO - Output received: 16:56:21 INFO - Usage: mozinstall [options] installer 16:56:21 INFO - Options: 16:56:21 INFO - -h, --help show this help message and exit 16:56:21 INFO - -d DEST, --destination=DEST 16:56:21 INFO - Directory to install application into. [default: 16:56:21 INFO - "/builds/slave/test"] 16:56:21 INFO - --app=APP Application being installed. [default: firefox] 16:56:21 INFO - mkdir: /builds/slave/test/build/application 16:56:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:56:43 INFO - Reading from file tmpfile_stdout 16:56:43 INFO - Output received: 16:56:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:56:43 INFO - Running post-action listener: _resource_record_post_action 16:56:43 INFO - [mozharness: 2017-02-13 00:56:43.248942Z] Finished install step (success) 16:56:43 INFO - [mozharness: 2017-02-13 00:56:43.249056Z] Running run-tests step. 16:56:43 INFO - Running pre-action listener: _resource_record_pre_action 16:56:43 INFO - Running main action method: run_tests 16:56:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:56:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:56:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:56:43 INFO - 2017-02-12 16:56:43.263 screenresolution[1635:8680] starting screenresolution argv=screenresolution get 16:56:43 INFO - 2017-02-12 16:56:43.266 screenresolution[1635:8680] Display 0: 1600x1200x32@60 16:56:43 INFO - 2017-02-12 16:56:43.271 screenresolution[1636:8682] starting screenresolution argv=screenresolution list 16:56:43 INFO - Available Modes on Display 0 16:56:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:56:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:56:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:56:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:56:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:56:43 INFO - Intel Iris: 16:56:43 INFO - Chipset Model: Intel Iris 16:56:43 INFO - Type: GPU 16:56:43 INFO - Bus: Built-In 16:56:43 INFO - VRAM (Dynamic, Max): 1536 MB 16:56:43 INFO - Vendor: Intel (0x8086) 16:56:43 INFO - Device ID: 0x0a2e 16:56:43 INFO - Revision ID: 0x0009 16:56:43 INFO - Displays: 16:56:43 INFO - Display: 16:56:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:56:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:56:43 INFO - Display Serial Number: 1600x1200 60 16:56:43 INFO - Main Display: Yes 16:56:43 INFO - Mirror: Off 16:56:43 INFO - Online: Yes 16:56:43 INFO - Rotation: Supported 16:56:43 INFO - Return code: 0 16:56:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:56:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:56:43 INFO - Python 2.7.3 16:56:43 INFO - Return code: 0 16:56:43 INFO - grabbing minidump binary from tooltool 16:56: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')]} 16:56:43 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 0x10a25ad30>, '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 0x10a181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a24fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:56:43 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 16:56:43 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 16:56:43 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 16:56:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:56:43 INFO - Return code: 0 16:56:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:56:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:56:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:56:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:56:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:56:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0198', '--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 16:56:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0198 --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 16:56:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LBjD4jZRuh/Render', 16:56:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:56:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:56:43 INFO - 'HOME': '/Users/cltbld', 16:56:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:56:43 INFO - 'LOGNAME': 'cltbld', 16:56:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:56:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:43 INFO - 'MOZ_NO_REMOTE': '1', 16:56:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:56:43 INFO - 'NO_EM_RESTART': '1', 16:56:43 INFO - 'PAGER': '/bin/cat', 16:56:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:43 INFO - 'PWD': '/builds/slave/test', 16:56:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:56:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:56:43 INFO - 'SHELL': '/bin/bash', 16:56:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tDFyAF7ivd/Listeners', 16:56:43 INFO - 'TMPDIR': '/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/', 16:56:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:56:43 INFO - 'USER': 'cltbld', 16:56:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:56:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:43 INFO - 'XPC_FLAGS': '0x0', 16:56:43 INFO - 'XPC_SERVICE_NAME': '0', 16:56:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:56:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0198', '--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 16:56:43 INFO - mozversion application_buildid: 20170212153046 16:56:43 INFO - mozversion application_changeset: 00d16f03506b7f9f754b01a0a458c05445ac6dba 16:56:43 INFO - mozversion application_display_name: Nightly 16:56:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:56:43 INFO - mozversion application_name: Firefox 16:56:43 INFO - mozversion application_remotingname: firefox 16:56:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:56:43 INFO - mozversion application_vendor: Mozilla 16:56:43 INFO - mozversion application_version: 54.0a1 16:56:43 INFO - mozversion platform_buildid: 20170212153046 16:56:43 INFO - mozversion platform_changeset: 00d16f03506b7f9f754b01a0a458c05445ac6dba 16:56:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:56:43 INFO - mozversion platform_version: 54.0a1 16:56:43 INFO - using testdate: 1486947403 16:56:43 INFO - actual date: 1486947403 16:56:43 INFO - starting webserver on 'localhost:49249' 16:56:43 INFO - SUITE-START | Running 2 tests 16:56:43 INFO - TEST-START | dromaeo_css 16:56:43 INFO - operating with platform_type : mac_ 16:56:43 INFO - Initialising browser for dromaeo_css test... 16:56:43 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmpQDzT9k/profile http://localhost:49249/getInfo.html) 16:56:46 INFO - PROCESS | 1646 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 16:56:46 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 16:56:46 INFO - PROCESS | 1646 | colorDepth:24 16:56:46 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 16:56:46 INFO - PROCESS | 1646 | __metrics 16:56:46 INFO - PROCESS | 1646 | 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" 16:56:46 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:56:47 INFO - TEST-INFO | 1646: exit 0 16:56:47 INFO - Browser initialized. 16:56:47 INFO - Running cycle 1/1 for dromaeo_css test... 16:56:47 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmpQDzT9k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:59 INFO - PROCESS | 1649 | RSS: Main: 228651008 16:56:59 INFO - PROCESS | 1649 | 17:00:03 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 17:00:04 INFO - PROCESS | 1649 | RSS: Main: 386449408 17:00:04 INFO - PROCESS | 1649 | 17:01:48 INFO - PROCESS | 1649 | ************************* 17:01:48 INFO - PROCESS | 1649 | A coding exception was thrown and uncaught in a Task. 17:01:48 INFO - PROCESS | 1649 | 17:01:48 ERROR - PROCESS | 1649 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:01:48 INFO - PROCESS | 1649 | Full stack: 17:01:48 INFO - PROCESS | 1649 | ************************* 17:03:07 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 17:03:08 INFO - PROCESS | 1649 | RSS: Main: 377024512 17:03:08 INFO - PROCESS | 1649 | 17:06:10 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 17:06:11 INFO - PROCESS | 1649 | RSS: Main: 366776320 17:06:11 INFO - PROCESS | 1649 | 17:09:14 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 17:09:14 INFO - PROCESS | 1649 | RSS: Main: 349241344 17:09:14 INFO - PROCESS | 1649 | 17:12:17 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 17:12:18 INFO - PROCESS | 1649 | RSS: Main: 330203136 17:12:18 INFO - PROCESS | 1649 | 17:15:21 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 17:15:22 INFO - PROCESS | 1649 | RSS: Main: 522821632 17:15:22 INFO - PROCESS | 1649 | 17:15:22 INFO - PROCESS | 1649 | __start_tp_report 17:15:22 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 17:15:22 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 17:15:22 INFO - PROCESS | 1649 | |i|pagename|runs| 17:15:22 INFO - PROCESS | 1649 | |0;dojo.html;3240.384326977874;3276.1482014676194;3281.4749640057594;3294.423475891718;3336.1826352543617;5467.781288748455;5534.584906132046;5547.362053363864;5583.944160558388;5596.832095037145;5520.613557051008;5570.749316280767;5577.079781835992;5584.636998595089;5597.944020559793;5073.086844368022;5085;5109.182530795074;5147.124988751922;5177.818776342829;5125.461826508219;5174.560162386202;5175.974120129394;5179.171332586787;5195;5141.717205553712;5162.096633089213;5163.870903227431;5165.251038599401;5166.741662916858;5171.276021357013;5174.094533456649;5175.249588809602;5179.533841954242;5186.040582492214;5008.348914641109;5116.462771409023;5128.205128205134;5131.897362052775;5150.407703114152;5736.426357364272;5742.856428589277;5747.080467125282;5759.884802303973;5773.769049238025;5968.4031596840405;6152.6308421494405;6153.138560601519;6171;6191.81424557264;6023.939760602381;6063.242094738158;6088.208532890741;6092.786752463642;6095.512359011313;4189.287821070395;5725.427457254283;5746.88506229873;5761.279840019997;5807.941920580824;6267.780627678009;6282.591631543935;6306.49548036156;6316.968415157987;6329.3354197809485;5805.506531944748;6050.6369617823075;6058.000429929012;6071.848203794941;6098.573099883054;5997.310309314397;6057.151998720183;6091.63450192981;6113.602615829956;6124.849245980674;6122.968113281882;6125.7040322982075;6126.864481135799;6141.486007784275;6152.846178845564;6109.026308435427;6169.876602467925;6182.752689892354;6187.969060154671;6191.380861913773;4795.784189711401;4846.297286893451;4847.95152048475;4900.215965445583;4976.825811096594;4390.385346051556;4416.933745993812;4430.490493593214;4447.666425018137;4461.263891457938;5746.396628354046;5749.913751293734;5754.395788442237;5763;5798.420157984252;5921.555883308769;6030.7889223876955;6287.308396076428;6300.086487459384;6317.936820631827;5570.08093664549;5654.4062873398525;5717.171010203498;5725.828225153252;5777.335606405317;5400.1899715043055;5425.484578965071;5430.782768689287;5431.83704488866;5433.1035379161995;5211.1922651989;6271.686415679106;6296.748130074746;6298.401651843067;6301.684915754286;5951.7619295227705;5979.910301345571;6116.396640261158;6163.753449861955;6170.722317495633;6261.655608941552;6261.68691565429;6262.185915830913;6267.341929097379;6275.592086514362;5984.790532331347;6076.756929722938;6083.66539840313;6104.664243466652;6114.449699527064;5807.796727114531;5900.940990590039;6115.422885572139;6117.188044311343;6172.259328880563;5550.500454959073;5620.594851287178;6020.729067191899;6043.3050199227655;6050.546209034252;5698.601097923106;5730.71346432685;5744.712764361849;6061.484773794277;6066.757329706938;5658.151277308437;5702.173184888085;5714.457126572969;5750.338711048115;5807.216025836458;5996.520278377807;6005.489533389711;6010.068439391901;6019.909701354396;6049.274087109399;5734.08254679266;5785.537157027344;5788.855278618068;5799.681017543907;5816.156657284755 17:15:22 INFO - PROCESS | 1649 | |1;ext.html;487.45648601808983;493.501563420945;513.5480776916314;516.7183884782793;531.1634176172529;27657.032003879867;37355.43966840499;39049.2190156197;39054.414183787194;41050.38424423636;38850.22299554007;39145.60854391455;39169;39178.608213917854;39185.60814391855;8750.781230469225;8945.15021072997;8948.821023579525;8956.32827537934;8967.46195228285;7575.204603516634;7710.421718371116;7712.421568382394;7809.336206422433;7814.179511151333;10505.2646314758;10655.147588192925;10667;10763.62327318544;10823.945880270587;10615.46922653868;10702.357858528514;10702.571897124106;10709.518071686793;10736.78526429475;7444.8883266751045;10447.47762611874;10526.78946421075;10533.157347412265;10545.736356591147;27754.722452775415;28506;28550.143495695163;28552.714472855212;37661;3604.9098772530633;3610.981945090284;3731.365667836474;3776.9244615107546;3795.1840354323954;26517.867410663017;27015.45969080627;27069.052583159693;27210.63946802672;27658.893644254207;2996.4007198560157;3025.4251692178636;3054.5876306698533;3060.8469576521306;3080.152957936563;441509;442041;445446;445711.77144114394;446297;31502.36995260082;51534.48465515372;51887;51922;51974.96050078977;28758.281042973675;30045.549316760265;30637.38725225483;31979.84010079935;33335.83332083324;11785;11945.88054119465;11950.521979120911;12434;12654.746905062031;10749.62376316825;10793;10808.97314755097;10813.405262710468;10818.134549236041;7594.088709354913;7624.618769061524;7676.155622881479;7703.229677032252;7713.730019449293;3204.214967333018;3258.4949332853444;3263.902082937516;3266.6570010149067;3294.390537750524;803.9236272554098;845.5898889038812;848.0967769325648;858.3133493205411;864.3646919514152;23403.414914627272;27860.30349241285;28345.716542834307;29113.272168195963;29215.85392073026;929.0709290709291;1004.2869562610482;1008.5461542305992;1036.5905467340358;1195.5755706724162;13156.342182891009;14445.422183112558;14509.85490145106;14679.339429725687;14914.17972011528;228909;229665.85167074058;229864;229950;231478;53058;53402.19896701552;53467;53536.46463535315;53540.73229633827;1281.6795801049739;1338.0098726941992;1342.4361768057245;1344.2405041151717;1344.7444985452732;21013.789862101796;27111;27261.318467038484;27548.035818746248;27740.751666175474;47155.292670609284;47619.76190119027;47670;47696.523034770595;47759.80600485016;499417;559869;564132.8693704576;572388.2761172502;584367;25054.874725626254;25340.873295633402;25384.238472845846;25417.364565885262;25563.872180638977;40910.41929811573;41823.58176418197;41828.33377488721;42327.788361057996;42425.78787106045;31724;33024.834875825465;34055.48916766201;34183.80356687504;35647.28705425929;26255.510997086014;31174.532382013833;33850.66149338475;34037.149071273416;36500.269994599425;32968.505472417455;34186;34208.486872697424;34238.97283081512;34270.82864585761;25733.871330643975;26901.830216316503;30353.24116897095;30491.932782353397;30499.390012199186;21601.407831060373;22865.771342286364;23078.653820193045;23370.883145584165;23495 17:15:22 INFO - PROCESS | 1649 | |2;jquery.html;343.4041937238891;356.43860919052497;381.32695791927233;396.5736832904627;412.3093817855092;13554.932225338871;13898.861011389896;14592.197429141406;17002.979821210734;18987.33544325949;19790.30733924313;20248.39254822354;20824.89587552064;20885.37343879686;21135.682964755542;5648.350439699436;5896.056630939051;5907.6750778707155;5915.497182739472;5919;4400.603945644892;6474.579152355105;6541.509386795986;6547.869042619169;6642.667866606675;6290;6452.741890324405;6587.176602924635;6591.143151390313;6609.140811694473;6395.584287021329;6462.289148193695;6479.157709497782;6511.93488065118;6532.216134063943;5099.311592934981;5362.544183744387;5411.242426060316;5497.505224529811;5691.6585004899425;13138.080334376598;13355.53255636048;13386.933065334708;21765.129394824187;24312.513749724905;2197.0662468450846;2447.155731272708;2483;2536.1377131775284;2546.9363265918314;9321.813563728756;10036.849447258297;10164.949175254076;12344.012479001749;14174.362153703109;1742.0495401545388;1755.3592938577456;1756.7628370169991;1776.9733453998201;1777.3956854669345;126373;134832.6291842702;136376;137314.3134284332;137768.31115844456;9582.808343833085;10976.780464390828;11600;11632.185746997799;11893.253625108064;13411.463541458428;14615.123092614476;14656.193909334876;14969.850301497063;15035.774463382839;6278;6383.234011918599;7484.738034168778;8215.671373145007;8403.327733781283;7824.921750782533;7861.567613781297;7874.291313781787;8004.399670024772;8052.758417247492;4293.926518370407;4681.297805329228;4693.178693728584;4718.366857519759;4783.402074740658;1865.5429419792238;2022.1608032666572;2030.116899148875;2035.2090160658527;2036.8472364572717;886.5079880666163;962.6919385796477;970.4274478057838;1005.9748506287401;1014.7315855181024;20487.69268460974;21764.564708706053;22930.885345573166;23778.40553986164;23828.761712383002;928.7167413938813;935.9859602105973;953.3183773601769;967.8790151231096;968.6803354893009;5861.70691465425;6104.001878769413;6146.938530614726;6167;6222.719977601018;550864;556010.2199489058;559623;667864;694757;151832.24083879509;155155.67266491012;157056;161598.57602135977;164525.17737411236;1035.425338936882;1035.6841163445222;1082.9350238985687;1087.3910610058392;1094.682542062793;18597.884126952427;18968.956707381225;19216.71174932349;19263.133159008157;19283.421497355102;56274.718626406604;56985.715071426035;60241;60381;61048;73611.52776944538;86052.56973715342;87840;89672.10327896637;89794;7340.449466289942;7378.631068446663;7611.162772095176;7853.057633084067;8257.256846883809;11876.584319548774;12824.038197135065;13317.933410332886;13654.86345136536;13705.657358566115;9694.806103877741;11273.492692828679;11687.590934317599;11768.293902365886;11777.52889884395;9722.80554388894;10115.39307641544;11262.324260544394;11451.198416111125;11702.70743231426;10247.077763001365;10314.885448483194;10466.267361284637;10587.100096491884;10601.25791194609;7485.7754267372065;7637.809054773675;7703.499272547267;7847.568383738949;7855.135935047026;10869.782604348027;11155.219134660496;11272.887271127513;11373.829392559284;11444.313341199555 17:15:22 INFO - PROCESS | 1649 | |3;mootools.html;1299.3827931732421;1305.5495853930397;1401.5655146904453;1424.2309153057347;1433.8351089624691;7339.486235963484;7670.117936437311;8049.315808156306;8122.796930076736;8350.290225330855;8199.95900020499;8224.83550328993;8271.214234647714;8295.792605184859;8302.792430189249;2231.0852550454315;2261.4007288068674;2269.4099534121165;2271.3526644906206;2271.5002699406105;1949.561348696546;2023.4637820977453;2028.8275496582808;2029.4723371923333;2040.7142999980015;1982.2269314967175;2181.7818218178136;2249.5613355395703;2263.1400067974146;2264.626336654458;2179.531400748831;2190.1020581561643;2219.1899956515917;2248.516568937678;2248.808851247646;2209.2267706302828;2263.943401414978;2268.3875353654585;2268.6710426987993;2270.14869423966;7392.334689877936;8372.623231954576;8432.53621050842;8444.944381952257;8460.830783384297;4985.102681517325;5135.255387968724;5140.228965655182;5141.305923700327;5155.432902380735;3172.9682703173135;3256.9185770355693;3430.9656903430896;3445.603755568117;3470.410030294856;1234.4444999750149;1253.3294687342227;1660.9418670346602;1703.949929625968;1740.4430582213697;10779.67660970172;10899.29154604956;10908.018278354986;10909.07272881806;10924.344539327665;4374.431323927869;4424.292113261927;4670.276107203389;4679.532046795362;4684.95315046852;8763.342749293828;8805.119488051143;8824.470531768115;8825.823483530294;8829.955850220707;4418.779061046935;4427.933580996288;5065.594752419797;5067.391912970467;5075.87310317245;4580.816767329269;4650.906981860344;4679.883002924954;4736.100140973273;4741.0991911537385;3334.0997930559097;3437.7937323760652;3504.5969713483278;3538.221591249921;3629.8911032668534;1043.7077618266896;1111.2054880760295;1145.9140564457698;1147.9827802582968;1148.8563929508812;717.7918403662879;722.4725950056488;723.8697034533834;745.9254074592498;781.8749000159947;5161.870953226125;5350.545203657655;5507.834764957058;5517.972410137923;5596.356419011784;926.0090804769799;933.7385532051037;939.3189937295542;1025.825609646362;1030.9381437113798;2984.7910646254554;3576.8390422431053;3618.5295911531334;3675.5221821163077;3701.3892707702926;9369.922458917312;9509.90490095104;9746.902530974741;10116.74708132288;10123.797524049625;9306.441613503212;9711.902880971242;9987;10066.798664026679;10080.143187829117;7582.431317651088;7810.218978102258;7812.570308632966;7819.68721251155;7823.295903368724;5251.553617942518;5486.341639003185;5552.333719953632;5559.305086864142;5595.272614560244;8848.867266991128;9342;9348.766280843034;9361.765955851159;9362.95318523403;8345.958270208854;9233.399829011092;9256;9395.436273823592;9406.717798466058;7068.6112263823925;7221;7227.205007449282;7234.963825181051;7259.673314700956;6603.834904127435;7729.149793522821;7740.14858365568;7804.921950780419;7813.453058285865;6683.131192944886;6768.323167683192;6893.551919125241;6923.342282483156;6969.2682268361095;5914.34942156371;6761.729530818712;6763.256041835296;6795.728170873307;6810.523263371517;6310.274318453253;6315.652639104894;6324.051392291193;6370.872582548231;6380.393862583047;4788.928166077442;4901.828436004723;4943.505649435172;4946.8763280918265;5133.307003554472;4552.7495987720995;4745.549172828576;4783.832565860178;4885.87785305356;4925.532074452921 17:15:22 INFO - PROCESS | 1649 | |4;prototype.html;345.7286030466083;348.9947650785238;358.62702789099336;364.3587286375977;367.18668150047637;4525.275955847061;4912.557869791718;5129.102407078765;5175.499105259475;5191.273221748954;4990.5009499050075;5009.874753131174;5032.421271553772;5057.747112644372;5087.643864929457;3567.020303731428;3617.2765446910594;3876.468794826042;3898.7660740355527;3946.1910308386855;3887.688984881217;3895.4156876468473;3896.844126234947;3921.725479216456;3924.038610540422;3190.9840450797715;3740.9625903740884;3847.3267178243836;3860.1700634363606;3905.6680182184405;3241.6434192238835;3318.883839065621;3574.303010912873;3683.373826449483;3866.8979340887995;3072.9104209137777;3312.807389339836;3349.614794298638;3366.9663303366897;3373.6120346160014;4800.423949126127;4970.6520543561965;4987.47631498691;5001.424836143854;5014.448410674823;3610.2129445924174;4058.411530328086;4401.339799030139;4402.151096539461;4421.789105447277;5130.333056702642;5348.946510534884;5356.35723713153;5385.946140538584;5388.946110538923;3202.503611940153;3386.6114892894043;3707.2400157967554;3711.5731690855628;3712.2575484903127;5038.622103342227;5278.762455689503;5390.001547130057;5524.017030803401;5605.467480589337;3679.2089700714473;3714.5728241252064;3741.8129093545213;3751.868684596026;3754.0239537719845;3609.9458508122398;3631.0014745945077;3839.9232015359535;3853.8398513219454;3857.4599556062176;4086.427900093989;4372.540883207217;4436.157130145327;4469;4479.641628669699;5426.825307195335;5432.533216031649;5437.987944460575;5448.09671295837;5454.400015998237;1150.4822829726656;1151.1654050813092;1220.6155061155707;1238.4984081447028;1242.372601836067;738.8226825561826;792.4888446951799;839.2446797881955;851.535912927456;851.8168593752249;4776.928346074812;4780.976095119572;4793.688410253322;4818.626691392936;4824.855254342376;4489.169503641837;4660.904687398459;5234.685918844882;5266.973665131726;5288.603354748332;4088.4889388826396;4215.578442155821;4464.665150113689;4530.818767249339;4811.133995880775;2245;2649.483350746586;2758.758558648616;2783.262435454606;2785.899569669969;4553.954460455353;4642.798267567857;4900.583450406755;5471.893321071416;5481.369642491085;4991.627302491771;5257.057207094679;5276.153346328754;5342.839714808562;5381.919271210935;4427.955720442818;5372.328458942632;5426.864328391743;5707.400722924033;5718.714064296852;4750.216214324598;5175.482451754794;5530.308711411074;5537.280153580009;5553.251555200143;4605.424321959755;4611.515790841913;5001.499550135018;5258.291055407085;5382.3442722044365;4893.6085113191575;5135.894283343811;5328.149440049555;5391.757370918396;5737.08206686928;3605.549306336708;3664.798436085934;3698.150924537731;3702.352088384576;3719.497867787814;4569.29175977724;4754.4532378776885;4757.52516719818;5055.494450554915;5494.835154945358;4589.036302376405;5264.657797243167;5374.328208973879;5375.4087050425205;5397.8380648580605;5384.219288203267;5387.515123638891;5393.164059570773;5396.64921780083;5404.32445944257;4485.161083955562;4525;5239.921401178909;5309.973450132725;5334.493223143795;4484.372187893632;4661.533846615312;4865.756712164449;5417.720001199009;5476.09644408684;4578.9771051144535;4861.611071114373;5312.203169524602;5321.813736519203;5422.593305502024 17:15:22 INFO - PROCESS | 1649 | |5;yui.html;688.5937296994772;700.3696672994307;704.7842471736259;752.2515097478007;799.54425977193;13873.861261387396;14273.214973176471;14444.277786110692;14871.256437178125;14875.033122847035;13647.11293765907;13774.655633609165;13831.723365532709;15086.09483430995;15362.69274614507;853.3898262742138;874.1913729799942;874.2263097158997;874.5233847553067;875.1991927386434;852.5311078906576;873.0483772687801;873.3275377958968;874.1957399192758;878.2271600991119;908.609298001859;908.8682141089538;909.7771046093716;910.4036855859423;911.1344222988155;906.1572737354257;907.9182873541347;908.5139450394007;909.0455022226669;910.41733290694;668.2849351194224;669.6517810738388;669.6685140855259;670.5239280111078;671.2750229751905;14447.566573002827;14685.77971330431;14691;14701.044432111985;14938.477153299582;13567.597815160205;13580.660483487893;13801.240931748749;13829.79255311171;13951.720965580631;11128.276662016942;11310;11442.54229830814;11828.34944078084;11834.822477662841;3570.6429357064344;3585.229175727231;3586.7130629549574;3604.6395360463744;3722.181120153589;76463.61768191123;96268.51865740697;97020;97321.99999999929;97652;10247.84628230577;10275.7431064224;10289.794204115875;10408.427536485415;10830.296030758132;21619;21641.35075947724;21685.349439516838;21729.782702172775;21787.346379608636;7314.232005639437;7343.795090205339;7362.190159082496;7440.441966852508;7603.695852165962;4036.6972477064337;4044.9797751011056;4153.563875792998;4174.519930208005;4273.081287523198;3518.2611651552947;3594.155373487228;3621.6378362163573;3691.90770230741;3932.606739326102;709.2481969112654;718.2350796401815;726.6548389514938;739.3973911262304;741.529129003087;629.276332217953;640.7308930249307;647.7894684227645;665.4942243894578;677.881370760115;7183.60490173035;8067.919320806717;9808.460534670661;9959.153471954965;9962.900370996342;645.3836586060302;675.8679212319346;677.5697432130632;693.743314973463;696.895465680152;4435.82256709728;4840.685355451885;4843.564079232886;4870.707757534559;4878.95121048792;85711;89029.55485222532;90179;91490;91738.62392064124;82304;82869.17130828735;83662.58168709118;84082;85655.14344856597;70220.64889675518;70543;70944.64527677328;70989.64505177338;72339.91490127653;9155.954220228856;9176.26589872822;9197.678081267124;9245.537723113952;9321.533923303943;45364.77317613391;45765.44475520337;48931.266031008854;49561.172459720474;50050.74974625104;42515;67290;67532.66233668997;68200;69308.6534567324;8396.958015209884;10871.29336593119;10890.78218435611;11217.326960382403;11542.018928390846;11923.701907452036;11994.280343179436;12110.878891210976;12197.207181533173;12389.380530973596;10061.295709300279;11433.485269483712;11573.768524629291;11671.183017188716;11717.648470545897;11331.660050198507;11957.282563046245;12107.33409662477;12124.515019399125;12250.019998400285;10992.670219893416;11510.251833630788;11536.192466527262;11902.047836172913;11922.4038798058;9492.857607136037;9569.952150239204;9606.615735370786;9633.9036609633;10169.237307201842;8478.279346255636;8490.872636910575;10117;10121.595136194765;10345.4310012947 17:15:22 INFO - PROCESS | 1649 | __end_tp_report 17:15:22 INFO - PROCESS | 1649 | __start_cc_report 17:15:22 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1522 17:15:22 INFO - PROCESS | 1649 | __end_cc_report 17:15:22 INFO - PROCESS | 1649 | __startTimestamp1486948522152__endTimestamp 17:15:22 INFO - PROCESS | 1649 | 17:15:22 INFO - PROCESS | 1649 | ------- Summary: start ------- 17:15:22 INFO - PROCESS | 1649 | Number of tests: 6 17:15:22 INFO - PROCESS | 1649 | 17:15:22 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5646.62 Median:5773.77 stddev:631.44 (10.9%) stddev-sans-first:604.50 17:15:22 INFO - PROCESS | 1649 | Values: 3240.4 3276.1 3281.5 3294.4 3336.2 5467.8 5534.6 5547.4 5583.9 5596.8 5520.6 5570.7 5577.1 5584.6 5597.9 5073.1 5085.0 5109.2 5147.1 5177.8 5125.5 5174.6 5176.0 5179.2 5195.0 5141.7 5162.1 5163.9 5165.3 5166.7 5171.3 5174.1 5175.2 5179.5 5186.0 5008.3 5116.5 5128.2 5131.9 5150.4 5736.4 5742.9 5747.1 5759.9 5773.8 5968.4 6152.6 6153.1 6171.0 6191.8 6023.9 6063.2 6088.2 6092.8 6095.5 4189.3 5725.4 5746.9 5761.3 5807.9 6267.8 6282.6 6306.5 6317.0 6329.3 5805.5 6050.6 6058.0 6071.8 6098.6 5997.3 6057.2 6091.6 6113.6 6124.8 6123.0 6125.7 6126.9 6141.5 6152.8 6109.0 6169.9 6182.8 6188.0 6191.4 4795.8 4846.3 4848.0 4900.2 4976.8 4390.4 4416.9 4430.5 4447.7 4461.3 5746.4 5749.9 5754.4 5763.0 5798.4 5921.6 6030.8 6287.3 6300.1 6317.9 5570.1 5654.4 5717.2 5725.8 5777.3 5400.2 5425.5 5430.8 5431.8 5433.1 5211.2 6271.7 6296.7 6298.4 6301.7 5951.8 5979.9 6116.4 6163.8 6170.7 6261.7 6261.7 6262.2 6267.3 6275.6 5984.8 6076.8 6083.7 6104.7 6114.4 5807.8 5900.9 6115.4 6117.2 6172.3 5550.5 5620.6 6020.7 6043.3 6050.5 5698.6 5730.7 5744.7 6061.5 6066.8 5658.2 5702.2 5714.5 5750.3 5807.2 5996.5 6005.5 6010.1 6019.9 6049.3 5734.1 5785.5 5788.9 5799.7 5816.2 17:15:22 INFO - PROCESS | 1649 | 17:15:22 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:53400.46 Median:17592.03 stddev:115814.22 (658.3%) stddev-sans-first:116070.97 17:15:22 INFO - PROCESS | 1649 | Values: 487.5 493.5 513.5 516.7 531.2 27657.0 37355.4 39049.2 39054.4 41050.4 38850.2 39145.6 39169.0 39178.6 39185.6 8750.8 8945.2 8948.8 8956.3 8967.5 7575.2 7710.4 7712.4 7809.3 7814.2 10505.3 10655.1 10667.0 10763.6 10823.9 10615.5 10702.4 10702.6 10709.5 10736.8 7444.9 10447.5 10526.8 10533.2 10545.7 27754.7 28506.0 28550.1 28552.7 37661.0 3604.9 3611.0 3731.4 3776.9 3795.2 26517.9 27015.5 27069.1 27210.6 27658.9 2996.4 3025.4 3054.6 3060.8 3080.2 441509.0 442041.0 445446.0 445711.8 446297.0 31502.4 51534.5 51887.0 51922.0 51975.0 28758.3 30045.5 30637.4 31979.8 33335.8 11785.0 11945.9 11950.5 12434.0 12654.7 10749.6 10793.0 10809.0 10813.4 10818.1 7594.1 7624.6 7676.2 7703.2 7713.7 3204.2 3258.5 3263.9 3266.7 3294.4 803.9 845.6 848.1 858.3 864.4 23403.4 27860.3 28345.7 29113.3 29215.9 929.1 1004.3 1008.5 1036.6 1195.6 13156.3 14445.4 14509.9 14679.3 14914.2 228909.0 229665.9 229864.0 229950.0 231478.0 53058.0 53402.2 53467.0 53536.5 53540.7 1281.7 1338.0 1342.4 1344.2 1344.7 21013.8 27111.0 27261.3 27548.0 27740.8 47155.3 47619.8 47670.0 47696.5 47759.8 499417.0 559869.0 564132.9 572388.3 584367.0 25054.9 25340.9 25384.2 25417.4 25563.9 40910.4 41823.6 41828.3 42327.8 42425.8 31724.0 33024.8 34055.5 34183.8 35647.3 26255.5 31174.5 33850.7 34037.1 36500.3 32968.5 34186.0 34208.5 34239.0 34270.8 25733.9 26901.8 30353.2 30491.9 30499.4 21601.4 22865.8 23078.7 23370.9 23495.0 17:15:22 INFO - PROCESS | 1649 | 17:15:22 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:36467.54 Median:2509.57 stddev:103084.87 (4107.7%) stddev-sans-first:103338.36 17:15:22 INFO - PROCESS | 1649 | Values: 343.4 356.4 381.3 396.6 412.3 13554.9 13898.9 14592.2 17003.0 18987.3 19790.3 20248.4 20824.9 20885.4 21135.7 5648.4 5896.1 5907.7 5915.5 5919.0 4400.6 6474.6 6541.5 6547.9 6642.7 6290.0 6452.7 6587.2 6591.1 6609.1 6395.6 6462.3 6479.2 6511.9 6532.2 5099.3 5362.5 5411.2 5497.5 5691.7 13138.1 13355.5 13386.9 21765.1 24312.5 2197.1 2447.2 2483.0 2536.1 2546.9 9321.8 10036.8 10164.9 12344.0 14174.4 1742.0 1755.4 1756.8 1777.0 1777.4 126373.0 134832.6 136376.0 137314.3 137768.3 9582.8 10976.8 11600.0 11632.2 11893.3 13411.5 14615.1 14656.2 14969.9 15035.8 6278.0 6383.2 7484.7 8215.7 8403.3 7824.9 7861.6 7874.3 8004.4 8052.8 4293.9 4681.3 4693.2 4718.4 4783.4 1865.5 2022.2 2030.1 2035.2 2036.8 886.5 962.7 970.4 1006.0 1014.7 20487.7 21764.6 22930.9 23778.4 23828.8 928.7 936.0 953.3 967.9 968.7 5861.7 6104.0 6146.9 6167.0 6222.7 550864.0 556010.2 559623.0 667864.0 694757.0 151832.2 155155.7 157056.0 161598.6 164525.2 1035.4 1035.7 1082.9 1087.4 1094.7 18597.9 18969.0 19216.7 19263.1 19283.4 56274.7 56985.7 60241.0 60381.0 61048.0 73611.5 86052.6 87840.0 89672.1 89794.0 7340.4 7378.6 7611.2 7853.1 8257.3 11876.6 12824.0 13317.9 13654.9 13705.7 9694.8 11273.5 11687.6 11768.3 11777.5 9722.8 10115.4 11262.3 11451.2 11702.7 10247.1 10314.9 10466.3 10587.1 10601.3 7485.8 7637.8 7703.5 7847.6 7855.1 10869.8 11155.2 11272.9 11373.8 11444.3 17:15:22 INFO - PROCESS | 1649 | 17:15:22 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5310.80 Median:5104.59 stddev:2927.70 (57.4%) stddev-sans-first:2920.39 17:15:22 INFO - PROCESS | 1649 | Values: 1299.4 1305.5 1401.6 1424.2 1433.8 7339.5 7670.1 8049.3 8122.8 8350.3 8200.0 8224.8 8271.2 8295.8 8302.8 2231.1 2261.4 2269.4 2271.4 2271.5 1949.6 2023.5 2028.8 2029.5 2040.7 1982.2 2181.8 2249.6 2263.1 2264.6 2179.5 2190.1 2219.2 2248.5 2248.8 2209.2 2263.9 2268.4 2268.7 2270.1 7392.3 8372.6 8432.5 8444.9 8460.8 4985.1 5135.3 5140.2 5141.3 5155.4 3173.0 3256.9 3431.0 3445.6 3470.4 1234.4 1253.3 1660.9 1703.9 1740.4 10779.7 10899.3 10908.0 10909.1 10924.3 4374.4 4424.3 4670.3 4679.5 4685.0 8763.3 8805.1 8824.5 8825.8 8830.0 4418.8 4427.9 5065.6 5067.4 5075.9 4580.8 4650.9 4679.9 4736.1 4741.1 3334.1 3437.8 3504.6 3538.2 3629.9 1043.7 1111.2 1145.9 1148.0 1148.9 717.8 722.5 723.9 745.9 781.9 5161.9 5350.5 5507.8 5518.0 5596.4 926.0 933.7 939.3 1025.8 1030.9 2984.8 3576.8 3618.5 3675.5 3701.4 9369.9 9509.9 9746.9 10116.7 10123.8 9306.4 9711.9 9987.0 10066.8 10080.1 7582.4 7810.2 7812.6 7819.7 7823.3 5251.6 5486.3 5552.3 5559.3 5595.3 8848.9 9342.0 9348.8 9361.8 9363.0 8346.0 9233.4 9256.0 9395.4 9406.7 7068.6 7221.0 7227.2 7235.0 7259.7 6603.8 7729.1 7740.1 7804.9 7813.5 6683.1 6768.3 6893.6 6923.3 6969.3 5914.3 6761.7 6763.3 6795.7 6810.5 6310.3 6315.7 6324.1 6370.9 6380.4 4788.9 4901.8 4943.5 4946.9 5133.3 4552.7 4745.5 4783.8 4885.9 4925.5 17:15:22 INFO - PROCESS | 1649 | 17:15:22 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4265.69 Median:4755.99 stddev:1300.04 (27.3%) stddev-sans-first:1269.95 17:15:22 INFO - PROCESS | 1649 | Values: 345.7 349.0 358.6 364.4 367.2 4525.3 4912.6 5129.1 5175.5 5191.3 4990.5 5009.9 5032.4 5057.7 5087.6 3567.0 3617.3 3876.5 3898.8 3946.2 3887.7 3895.4 3896.8 3921.7 3924.0 3191.0 3741.0 3847.3 3860.2 3905.7 3241.6 3318.9 3574.3 3683.4 3866.9 3072.9 3312.8 3349.6 3367.0 3373.6 4800.4 4970.7 4987.5 5001.4 5014.4 3610.2 4058.4 4401.3 4402.2 4421.8 5130.3 5348.9 5356.4 5385.9 5388.9 3202.5 3386.6 3707.2 3711.6 3712.3 5038.6 5278.8 5390.0 5524.0 5605.5 3679.2 3714.6 3741.8 3751.9 3754.0 3609.9 3631.0 3839.9 3853.8 3857.5 4086.4 4372.5 4436.2 4469.0 4479.6 5426.8 5432.5 5438.0 5448.1 5454.4 1150.5 1151.2 1220.6 1238.5 1242.4 738.8 792.5 839.2 851.5 851.8 4776.9 4781.0 4793.7 4818.6 4824.9 4489.2 4660.9 5234.7 5267.0 5288.6 4088.5 4215.6 4464.7 4530.8 4811.1 2245.0 2649.5 2758.8 2783.3 2785.9 4554.0 4642.8 4900.6 5471.9 5481.4 4991.6 5257.1 5276.2 5342.8 5381.9 4428.0 5372.3 5426.9 5707.4 5718.7 4750.2 5175.5 5530.3 5537.3 5553.3 4605.4 4611.5 5001.5 5258.3 5382.3 4893.6 5135.9 5328.1 5391.8 5737.1 3605.5 3664.8 3698.2 3702.4 3719.5 4569.3 4754.5 4757.5 5055.5 5494.8 4589.0 5264.7 5374.3 5375.4 5397.8 5384.2 5387.5 5393.2 5396.6 5404.3 4485.2 4525.0 5239.9 5310.0 5334.5 4484.4 4661.5 4865.8 5417.7 5476.1 4579.0 4861.6 5312.2 5321.8 5422.6 17:15:22 INFO - PROCESS | 1649 | 17:15:22 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:18739.71 Median:643.06 stddev:26533.13 (4126.1%) stddev-sans-first:26572.94 17:15:22 INFO - PROCESS | 1649 | Values: 688.6 700.4 704.8 752.3 799.5 13873.9 14273.2 14444.3 14871.3 14875.0 13647.1 13774.7 13831.7 15086.1 15362.7 853.4 874.2 874.2 874.5 875.2 852.5 873.0 873.3 874.2 878.2 908.6 908.9 909.8 910.4 911.1 906.2 907.9 908.5 909.0 910.4 668.3 669.7 669.7 670.5 671.3 14447.6 14685.8 14691.0 14701.0 14938.5 13567.6 13580.7 13801.2 13829.8 13951.7 11128.3 11310.0 11442.5 11828.3 11834.8 3570.6 3585.2 3586.7 3604.6 3722.2 76463.6 96268.5 97020.0 97322.0 97652.0 10247.8 10275.7 10289.8 10408.4 10830.3 21619.0 21641.4 21685.3 21729.8 21787.3 7314.2 7343.8 7362.2 7440.4 7603.7 4036.7 4045.0 4153.6 4174.5 4273.1 3518.3 3594.2 3621.6 3691.9 3932.6 709.2 718.2 726.7 739.4 741.5 629.3 640.7 647.8 665.5 677.9 7183.6 8067.9 9808.5 9959.2 9962.9 645.4 675.9 677.6 693.7 696.9 4435.8 4840.7 4843.6 4870.7 4879.0 85711.0 89029.6 90179.0 91490.0 91738.6 82304.0 82869.2 83662.6 84082.0 85655.1 70220.6 70543.0 70944.6 70989.6 72339.9 9156.0 9176.3 9197.7 9245.5 9321.5 45364.8 45765.4 48931.3 49561.2 50050.7 42515.0 67290.0 67532.7 68200.0 69308.7 8397.0 10871.3 10890.8 11217.3 11542.0 11923.7 11994.3 12110.9 12197.2 12389.4 10061.3 11433.5 11573.8 11671.2 11717.6 11331.7 11957.3 12107.3 12124.5 12250.0 10992.7 11510.3 11536.2 11902.0 11922.4 9492.9 9570.0 9606.6 9633.9 10169.2 8478.3 8490.9 10117.0 10121.6 10345.4 17:15:22 INFO - PROCESS | 1649 | -------- Summary: end -------- 17:15:22 INFO - PROCESS | 1649 | 17:15:22 INFO - TEST-INFO | 1649: exit 0 17:15:22 INFO - TEST-OK | dromaeo_css | took 1119010ms 17:15:22 INFO - TEST-START | kraken 17:15:22 INFO - operating with platform_type : mac_ 17:15:22 INFO - Initialising browser for kraken test... 17:15:22 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmpnDNOgs/profile http://localhost:49249/getInfo.html) 17:15:24 INFO - PROCESS | 1655 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:15:25 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 17:15:25 INFO - PROCESS | 1655 | colorDepth:24 17:15:25 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 17:15:25 INFO - PROCESS | 1655 | __metrics 17:15:25 INFO - PROCESS | 1655 | 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" 17:15:25 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:15:26 INFO - TEST-INFO | 1655: exit 0 17:15:26 INFO - Browser initialized. 17:15:26 INFO - Running cycle 1/1 for kraken test... 17:15:26 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/tmpnDNOgs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:38 INFO - PROCESS | 1656 | RSS: Main: 236883968 17:15:38 INFO - PROCESS | 1656 | 17:15:40 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 17:15:41 INFO - PROCESS | 1656 | RSS: Main: 288415744 17:15:41 INFO - PROCESS | 1656 | 17:15:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 17:15:45 INFO - PROCESS | 1656 | RSS: Main: 290078720 17:15:45 INFO - PROCESS | 1656 | 17:15:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 17:15:48 INFO - PROCESS | 1656 | RSS: Main: 379170816 17:15:48 INFO - PROCESS | 1656 | 17:15:50 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 17:15:51 INFO - PROCESS | 1656 | RSS: Main: 283353088 17:15:51 INFO - PROCESS | 1656 | 17:15:53 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:15:54 INFO - PROCESS | 1656 | RSS: Main: 286400512 17:15:54 INFO - PROCESS | 1656 | 17:15:57 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 17:15:57 INFO - PROCESS | 1656 | RSS: Main: 328142848 17:15:57 INFO - PROCESS | 1656 | 17:16:00 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 17:16:01 INFO - PROCESS | 1656 | RSS: Main: 331595776 17:16:01 INFO - PROCESS | 1656 | 17:16:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 17:16:04 INFO - PROCESS | 1656 | RSS: Main: 328114176 17:16:04 INFO - PROCESS | 1656 | 17:16:06 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:16:07 INFO - PROCESS | 1656 | RSS: Main: 304988160 17:16:07 INFO - PROCESS | 1656 | 17:16:09 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:16:09 INFO - PROCESS | 1656 | RSS: Main: 310050816 17:16:09 INFO - PROCESS | 1656 | 17:16:11 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:16:12 INFO - PROCESS | 1656 | RSS: Main: 310964224 17:16:12 INFO - PROCESS | 1656 | 17:16:15 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:16:16 INFO - PROCESS | 1656 | RSS: Main: 329748480 17:16:16 INFO - PROCESS | 1656 | 17:16:19 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:16:19 INFO - PROCESS | 1656 | RSS: Main: 323297280 17:16:19 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 17:16:21 INFO - PROCESS | 1656 | RSS: Main: 368627712 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | __start_tp_report 17:16:21 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 17:16:21 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 17:16:21 INFO - PROCESS | 1656 | |i|pagename|runs| 17:16:21 INFO - PROCESS | 1656 | |0;ai-astar;113;114;114;115;114;115;114;115;114;116 17:16:21 INFO - PROCESS | 1656 | |1;audio-beat-detection;142;112;110;149;112;112;109;113;130;113 17:16:21 INFO - PROCESS | 1656 | |2;audio-dft;187;184;182;186;186;187;184;183;185;188 17:16:21 INFO - PROCESS | 1656 | |3;audio-fft;81;59;60;90;63;71;58;59;76;60 17:16:21 INFO - PROCESS | 1656 | |4;audio-oscillator;90;73;88;69;70;69;85;67;67;85 17:16:21 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;88;90;89;89;89;89;91;89;89;88 17:16:21 INFO - PROCESS | 1656 | |6;imaging-darkroom;97;97;97;102;125;96;95;97;96;98 17:16:21 INFO - PROCESS | 1656 | |7;imaging-desaturate;88;84;84;86;68;126;130;90;93;87 17:16:21 INFO - PROCESS | 1656 | |8;json-parse-financial;63;57;57;58;59;59;58;59;60;58 17:16:21 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;64;84;74;77;73;71;71;71;71;71 17:16:21 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;90;90;96;86;89;89;87;91;87;89 17:16:21 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;145;143;167;149;136;139;143;146;182;163 17:16:21 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;173;170;174;174;173;174;172;173;172;173 17:16:21 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;68;67;67;68;67;66;68;66;66;66 17:16:21 INFO - PROCESS | 1656 | __end_tp_report 17:16:21 INFO - PROCESS | 1656 | __start_cc_report 17:16:21 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2146 17:16:21 INFO - PROCESS | 1656 | __end_cc_report 17:16:21 INFO - PROCESS | 1656 | __startTimestamp1486948581840__endTimestamp 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | ------- Summary: start ------- 17:16:21 INFO - PROCESS | 1656 | Number of tests: 14 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.50 stddev:0.84 (0.7%) stddev-sans-first:0.73 17:16:21 INFO - PROCESS | 1656 | Values: 113.0 114.0 114.0 115.0 114.0 115.0 114.0 115.0 114.0 116.0 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:120.20 Median:113.00 stddev:14.67 (13.0%) stddev-sans-first:13.26 17:16:21 INFO - PROCESS | 1656 | Values: 142.0 112.0 110.0 149.0 112.0 112.0 109.0 113.0 130.0 113.0 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:185.20 Median:186.00 stddev:1.93 (1.0%) stddev-sans-first:1.94 17:16:21 INFO - PROCESS | 1656 | Values: 187.0 184.0 182.0 186.0 186.0 187.0 184.0 183.0 185.0 188.0 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:67.70 Median:67.00 stddev:11.26 (16.8%) stddev-sans-first:10.86 17:16:21 INFO - PROCESS | 1656 | Values: 81.0 59.0 60.0 90.0 63.0 71.0 58.0 59.0 76.0 60.0 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:76.30 Median:79.00 stddev:9.46 (12.0%) stddev-sans-first:8.64 17:16:21 INFO - PROCESS | 1656 | Values: 90.0 73.0 88.0 69.0 70.0 69.0 85.0 67.0 67.0 85.0 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:89.10 Median:89.00 stddev:0.88 (1.0%) stddev-sans-first:0.83 17:16:21 INFO - PROCESS | 1656 | Values: 88.0 90.0 89.0 89.0 89.0 89.0 91.0 89.0 89.0 88.0 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:100.00 Median:97.00 stddev:8.98 (9.3%) stddev-sans-first:9.46 17:16:21 INFO - PROCESS | 1656 | Values: 97.0 97.0 97.0 102.0 125.0 96.0 95.0 97.0 96.0 98.0 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:86.50 stddev:19.32 (22.3%) stddev-sans-first:20.39 17:16:21 INFO - PROCESS | 1656 | Values: 88.0 84.0 84.0 86.0 68.0 126.0 130.0 90.0 93.0 87.0 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:59.00 stddev:1.75 (3.0%) stddev-sans-first:1.00 17:16:21 INFO - PROCESS | 1656 | Values: 63.0 57.0 57.0 58.0 59.0 59.0 58.0 59.0 60.0 58.0 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:72.70 Median:72.00 stddev:5.14 (7.1%) stddev-sans-first:4.39 17:16:21 INFO - PROCESS | 1656 | Values: 64.0 84.0 74.0 77.0 73.0 71.0 71.0 71.0 71.0 71.0 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:89.50 stddev:2.80 (3.1%) stddev-sans-first:2.96 17:16:21 INFO - PROCESS | 1656 | Values: 90.0 90.0 96.0 86.0 89.0 89.0 87.0 91.0 87.0 89.0 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:151.30 Median:147.50 stddev:14.61 (9.9%) stddev-sans-first:15.32 17:16:21 INFO - PROCESS | 1656 | Values: 145.0 143.0 167.0 149.0 136.0 139.0 143.0 146.0 182.0 163.0 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:173.00 stddev:1.23 (0.7%) stddev-sans-first:1.30 17:16:21 INFO - PROCESS | 1656 | Values: 173.0 170.0 174.0 174.0 173.0 174.0 172.0 173.0 172.0 173.0 17:16:21 INFO - PROCESS | 1656 | 17:16:21 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 17:16:21 INFO - PROCESS | 1656 | Values: 68.0 67.0 67.0 68.0 67.0 66.0 68.0 66.0 66.0 66.0 17:16:21 INFO - PROCESS | 1656 | -------- Summary: end -------- 17:16:21 INFO - PROCESS | 1656 | 17:16:22 INFO - TEST-INFO | 1656: exit 0 17:16:22 INFO - TEST-OK | kraken | took 59934ms 17:16:22 INFO - SUITE-END | took 1178s 17:16:23 INFO - Completed test suite (00:19:39) 17:16:23 INFO - javascript benchmark 17:16:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6869.401543828397, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3240.384326977874, 3276.1482014676194, 3281.4749640057594, 3294.423475891718, 3336.1826352543617, 5467.781288748455, 5534.584906132046, 5547.362053363864, 5583.944160558388, 5596.832095037145, 5520.613557051008, 5570.749316280767, 5577.079781835992, 5584.636998595089, 5597.944020559793, 5073.086844368022, 5085.0, 5109.182530795074, 5147.124988751922, 5177.818776342829, 5125.461826508219, 5174.560162386202, 5175.974120129394, 5179.171332586787, 5195.0, 5141.717205553712, 5162.096633089213, 5163.870903227431, 5165.251038599401, 5166.741662916858, 5171.276021357013, 5174.094533456649, 5175.249588809602, 5179.533841954242, 5186.040582492214, 5008.348914641109, 5116.462771409023, 5128.205128205134, 5131.897362052775, 5150.407703114152, 5736.426357364272, 5742.856428589277, 5747.080467125282, 5759.884802303973, 5773.769049238025, 5968.4031596840405, 6152.6308421494405, 6153.138560601519, 6171.0, 6191.81424557264, 6023.939760602381, 6063.242094738158, 6088.208532890741, 6092.786752463642, 6095.512359011313, 4189.287821070395, 5725.427457254283, 5746.88506229873, 5761.279840019997, 5807.941920580824, 6267.780627678009, 6282.591631543935, 6306.49548036156, 6316.968415157987, 6329.3354197809485, 5805.506531944748, 6050.6369617823075, 6058.000429929012, 6071.848203794941, 6098.573099883054, 5997.310309314397, 6057.151998720183, 6091.63450192981, 6113.602615829956, 6124.849245980674, 6122.968113281882, 6125.7040322982075, 6126.864481135799, 6141.486007784275, 6152.846178845564, 6109.026308435427, 6169.876602467925, 6182.752689892354, 6187.969060154671, 6191.380861913773, 4795.784189711401, 4846.297286893451, 4847.95152048475, 4900.215965445583, 4976.825811096594, 4390.385346051556, 4416.933745993812, 4430.490493593214, 4447.666425018137, 4461.263891457938, 5746.396628354046, 5749.913751293734, 5754.395788442237, 5763.0, 5798.420157984252, 5921.555883308769, 6030.7889223876955, 6287.308396076428, 6300.086487459384, 6317.936820631827, 5570.08093664549, 5654.4062873398525, 5717.171010203498, 5725.828225153252, 5777.335606405317, 5400.1899715043055, 5425.484578965071, 5430.782768689287, 5431.83704488866, 5433.1035379161995, 5211.1922651989, 6271.686415679106, 6296.748130074746, 6298.401651843067, 6301.684915754286, 5951.7619295227705, 5979.910301345571, 6116.396640261158, 6163.753449861955, 6170.722317495633, 6261.655608941552, 6261.68691565429, 6262.185915830913, 6267.341929097379, 6275.592086514362, 5984.790532331347, 6076.756929722938, 6083.66539840313, 6104.664243466652, 6114.449699527064, 5807.796727114531, 5900.940990590039, 6115.422885572139, 6117.188044311343, 6172.259328880563, 5550.500454959073, 5620.594851287178, 6020.729067191899, 6043.3050199227655, 6050.546209034252, 5698.601097923106, 5730.71346432685, 5744.712764361849, 6061.484773794277, 6066.757329706938, 5658.151277308437, 5702.173184888085, 5714.457126572969, 5750.338711048115, 5807.216025836458, 5996.520278377807, 6005.489533389711, 6010.068439391901, 6019.909701354396, 6049.274087109399, 5734.08254679266, 5785.537157027344, 5788.855278618068, 5799.681017543907, 5816.156657284755], "value": 5606.981686271881, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.45648601808983, 493.501563420945, 513.5480776916314, 516.7183884782793, 531.1634176172529, 27657.032003879867, 37355.43966840499, 39049.2190156197, 39054.414183787194, 41050.38424423636, 38850.22299554007, 39145.60854391455, 39169.0, 39178.608213917854, 39185.60814391855, 8750.781230469225, 8945.15021072997, 8948.821023579525, 8956.32827537934, 8967.46195228285, 7575.204603516634, 7710.421718371116, 7712.421568382394, 7809.336206422433, 7814.179511151333, 10505.2646314758, 10655.147588192925, 10667.0, 10763.62327318544, 10823.945880270587, 10615.46922653868, 10702.357858528514, 10702.571897124106, 10709.518071686793, 10736.78526429475, 7444.8883266751045, 10447.47762611874, 10526.78946421075, 10533.157347412265, 10545.736356591147, 27754.722452775415, 28506.0, 28550.143495695163, 28552.714472855212, 37661.0, 3604.9098772530633, 3610.981945090284, 3731.365667836474, 3776.9244615107546, 3795.1840354323954, 26517.867410663017, 27015.45969080627, 27069.052583159693, 27210.63946802672, 27658.893644254207, 2996.4007198560157, 3025.4251692178636, 3054.5876306698533, 3060.8469576521306, 3080.152957936563, 441509.0, 442041.0, 445446.0, 445711.77144114394, 446297.0, 31502.36995260082, 51534.48465515372, 51887.0, 51922.0, 51974.96050078977, 28758.281042973675, 30045.549316760265, 30637.38725225483, 31979.84010079935, 33335.83332083324, 11785.0, 11945.88054119465, 11950.521979120911, 12434.0, 12654.746905062031, 10749.62376316825, 10793.0, 10808.97314755097, 10813.405262710468, 10818.134549236041, 7594.088709354913, 7624.618769061524, 7676.155622881479, 7703.229677032252, 7713.730019449293, 3204.214967333018, 3258.4949332853444, 3263.902082937516, 3266.6570010149067, 3294.390537750524, 803.9236272554098, 845.5898889038812, 848.0967769325648, 858.3133493205411, 864.3646919514152, 23403.414914627272, 27860.30349241285, 28345.716542834307, 29113.272168195963, 29215.85392073026, 929.0709290709291, 1004.2869562610482, 1008.5461542305992, 1036.5905467340358, 1195.5755706724162, 13156.342182891009, 14445.422183112558, 14509.85490145106, 14679.339429725687, 14914.17972011528, 228909.0, 229665.85167074058, 229864.0, 229950.0, 231478.0, 53058.0, 53402.19896701552, 53467.0, 53536.46463535315, 53540.73229633827, 1281.6795801049739, 1338.0098726941992, 1342.4361768057245, 1344.2405041151717, 1344.7444985452732, 21013.789862101796, 27111.0, 27261.318467038484, 27548.035818746248, 27740.751666175474, 47155.292670609284, 47619.76190119027, 47670.0, 47696.523034770595, 47759.80600485016, 499417.0, 559869.0, 564132.8693704576, 572388.2761172502, 584367.0, 25054.874725626254, 25340.873295633402, 25384.238472845846, 25417.364565885262, 25563.872180638977, 40910.41929811573, 41823.58176418197, 41828.33377488721, 42327.788361057996, 42425.78787106045, 31724.0, 33024.834875825465, 34055.48916766201, 34183.80356687504, 35647.28705425929, 26255.510997086014, 31174.532382013833, 33850.66149338475, 34037.149071273416, 36500.269994599425, 32968.505472417455, 34186.0, 34208.486872697424, 34238.97283081512, 34270.82864585761, 25733.871330643975, 26901.830216316503, 30353.24116897095, 30491.932782353397, 30499.390012199186, 21601.407831060373, 22865.771342286364, 23078.653820193045, 23370.883145584165, 23495.0], "value": 16746.431209069833, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.4041937238891, 356.43860919052497, 381.32695791927233, 396.5736832904627, 412.3093817855092, 13554.932225338871, 13898.861011389896, 14592.197429141406, 17002.979821210734, 18987.33544325949, 19790.30733924313, 20248.39254822354, 20824.89587552064, 20885.37343879686, 21135.682964755542, 5648.350439699436, 5896.056630939051, 5907.6750778707155, 5915.497182739472, 5919.0, 4400.603945644892, 6474.579152355105, 6541.509386795986, 6547.869042619169, 6642.667866606675, 6290.0, 6452.741890324405, 6587.176602924635, 6591.143151390313, 6609.140811694473, 6395.584287021329, 6462.289148193695, 6479.157709497782, 6511.93488065118, 6532.216134063943, 5099.311592934981, 5362.544183744387, 5411.242426060316, 5497.505224529811, 5691.6585004899425, 13138.080334376598, 13355.53255636048, 13386.933065334708, 21765.129394824187, 24312.513749724905, 2197.0662468450846, 2447.155731272708, 2483.0, 2536.1377131775284, 2546.9363265918314, 9321.813563728756, 10036.849447258297, 10164.949175254076, 12344.012479001749, 14174.362153703109, 1742.0495401545388, 1755.3592938577456, 1756.7628370169991, 1776.9733453998201, 1777.3956854669345, 126373.0, 134832.6291842702, 136376.0, 137314.3134284332, 137768.31115844456, 9582.808343833085, 10976.780464390828, 11600.0, 11632.185746997799, 11893.253625108064, 13411.463541458428, 14615.123092614476, 14656.193909334876, 14969.850301497063, 15035.774463382839, 6278.0, 6383.234011918599, 7484.738034168778, 8215.671373145007, 8403.327733781283, 7824.921750782533, 7861.567613781297, 7874.291313781787, 8004.399670024772, 8052.758417247492, 4293.926518370407, 4681.297805329228, 4693.178693728584, 4718.366857519759, 4783.402074740658, 1865.5429419792238, 2022.1608032666572, 2030.116899148875, 2035.2090160658527, 2036.8472364572717, 886.5079880666163, 962.6919385796477, 970.4274478057838, 1005.9748506287401, 1014.7315855181024, 20487.69268460974, 21764.564708706053, 22930.885345573166, 23778.40553986164, 23828.761712383002, 928.7167413938813, 935.9859602105973, 953.3183773601769, 967.8790151231096, 968.6803354893009, 5861.70691465425, 6104.001878769413, 6146.938530614726, 6167.0, 6222.719977601018, 550864.0, 556010.2199489058, 559623.0, 667864.0, 694757.0, 151832.24083879509, 155155.67266491012, 157056.0, 161598.57602135977, 164525.17737411236, 1035.425338936882, 1035.6841163445222, 1082.9350238985687, 1087.3910610058392, 1094.682542062793, 18597.884126952427, 18968.956707381225, 19216.71174932349, 19263.133159008157, 19283.421497355102, 56274.718626406604, 56985.715071426035, 60241.0, 60381.0, 61048.0, 73611.52776944538, 86052.56973715342, 87840.0, 89672.10327896637, 89794.0, 7340.449466289942, 7378.631068446663, 7611.162772095176, 7853.057633084067, 8257.256846883809, 11876.584319548774, 12824.038197135065, 13317.933410332886, 13654.86345136536, 13705.657358566115, 9694.806103877741, 11273.492692828679, 11687.590934317599, 11768.293902365886, 11777.52889884395, 9722.80554388894, 10115.39307641544, 11262.324260544394, 11451.198416111125, 11702.70743231426, 10247.077763001365, 10314.885448483194, 10466.267361284637, 10587.100096491884, 10601.25791194609, 7485.7754267372065, 7637.809054773675, 7703.499272547267, 7847.568383738949, 7855.135935047026, 10869.782604348027, 11155.219134660496, 11272.887271127513, 11373.829392559284, 11444.313341199555], "value": 9456.820451326654, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.3827931732421, 1305.5495853930397, 1401.5655146904453, 1424.2309153057347, 1433.8351089624691, 7339.486235963484, 7670.117936437311, 8049.315808156306, 8122.796930076736, 8350.290225330855, 8199.95900020499, 8224.83550328993, 8271.214234647714, 8295.792605184859, 8302.792430189249, 2231.0852550454315, 2261.4007288068674, 2269.4099534121165, 2271.3526644906206, 2271.5002699406105, 1949.561348696546, 2023.4637820977453, 2028.8275496582808, 2029.4723371923333, 2040.7142999980015, 1982.2269314967175, 2181.7818218178136, 2249.5613355395703, 2263.1400067974146, 2264.626336654458, 2179.531400748831, 2190.1020581561643, 2219.1899956515917, 2248.516568937678, 2248.808851247646, 2209.2267706302828, 2263.943401414978, 2268.3875353654585, 2268.6710426987993, 2270.14869423966, 7392.334689877936, 8372.623231954576, 8432.53621050842, 8444.944381952257, 8460.830783384297, 4985.102681517325, 5135.255387968724, 5140.228965655182, 5141.305923700327, 5155.432902380735, 3172.9682703173135, 3256.9185770355693, 3430.9656903430896, 3445.603755568117, 3470.410030294856, 1234.4444999750149, 1253.3294687342227, 1660.9418670346602, 1703.949929625968, 1740.4430582213697, 10779.67660970172, 10899.29154604956, 10908.018278354986, 10909.07272881806, 10924.344539327665, 4374.431323927869, 4424.292113261927, 4670.276107203389, 4679.532046795362, 4684.95315046852, 8763.342749293828, 8805.119488051143, 8824.470531768115, 8825.823483530294, 8829.955850220707, 4418.779061046935, 4427.933580996288, 5065.594752419797, 5067.391912970467, 5075.87310317245, 4580.816767329269, 4650.906981860344, 4679.883002924954, 4736.100140973273, 4741.0991911537385, 3334.0997930559097, 3437.7937323760652, 3504.5969713483278, 3538.221591249921, 3629.8911032668534, 1043.7077618266896, 1111.2054880760295, 1145.9140564457698, 1147.9827802582968, 1148.8563929508812, 717.7918403662879, 722.4725950056488, 723.8697034533834, 745.9254074592498, 781.8749000159947, 5161.870953226125, 5350.545203657655, 5507.834764957058, 5517.972410137923, 5596.356419011784, 926.0090804769799, 933.7385532051037, 939.3189937295542, 1025.825609646362, 1030.9381437113798, 2984.7910646254554, 3576.8390422431053, 3618.5295911531334, 3675.5221821163077, 3701.3892707702926, 9369.922458917312, 9509.90490095104, 9746.902530974741, 10116.74708132288, 10123.797524049625, 9306.441613503212, 9711.902880971242, 9987.0, 10066.798664026679, 10080.143187829117, 7582.431317651088, 7810.218978102258, 7812.570308632966, 7819.68721251155, 7823.295903368724, 5251.553617942518, 5486.341639003185, 5552.333719953632, 5559.305086864142, 5595.272614560244, 8848.867266991128, 9342.0, 9348.766280843034, 9361.765955851159, 9362.95318523403, 8345.958270208854, 9233.399829011092, 9256.0, 9395.436273823592, 9406.717798466058, 7068.6112263823925, 7221.0, 7227.205007449282, 7234.963825181051, 7259.673314700956, 6603.834904127435, 7729.149793522821, 7740.14858365568, 7804.921950780419, 7813.453058285865, 6683.131192944886, 6768.323167683192, 6893.551919125241, 6923.342282483156, 6969.2682268361095, 5914.34942156371, 6761.729530818712, 6763.256041835296, 6795.728170873307, 6810.523263371517, 6310.274318453253, 6315.652639104894, 6324.051392291193, 6370.872582548231, 6380.393862583047, 4788.928166077442, 4901.828436004723, 4943.505649435172, 4946.8763280918265, 5133.307003554472, 4552.7495987720995, 4745.549172828576, 4783.832565860178, 4885.87785305356, 4925.532074452921], "value": 4300.889652803406, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.7286030466083, 348.9947650785238, 358.62702789099336, 364.3587286375977, 367.18668150047637, 4525.275955847061, 4912.557869791718, 5129.102407078765, 5175.499105259475, 5191.273221748954, 4990.5009499050075, 5009.874753131174, 5032.421271553772, 5057.747112644372, 5087.643864929457, 3567.020303731428, 3617.2765446910594, 3876.468794826042, 3898.7660740355527, 3946.1910308386855, 3887.688984881217, 3895.4156876468473, 3896.844126234947, 3921.725479216456, 3924.038610540422, 3190.9840450797715, 3740.9625903740884, 3847.3267178243836, 3860.1700634363606, 3905.6680182184405, 3241.6434192238835, 3318.883839065621, 3574.303010912873, 3683.373826449483, 3866.8979340887995, 3072.9104209137777, 3312.807389339836, 3349.614794298638, 3366.9663303366897, 3373.6120346160014, 4800.423949126127, 4970.6520543561965, 4987.47631498691, 5001.424836143854, 5014.448410674823, 3610.2129445924174, 4058.411530328086, 4401.339799030139, 4402.151096539461, 4421.789105447277, 5130.333056702642, 5348.946510534884, 5356.35723713153, 5385.946140538584, 5388.946110538923, 3202.503611940153, 3386.6114892894043, 3707.2400157967554, 3711.5731690855628, 3712.2575484903127, 5038.622103342227, 5278.762455689503, 5390.001547130057, 5524.017030803401, 5605.467480589337, 3679.2089700714473, 3714.5728241252064, 3741.8129093545213, 3751.868684596026, 3754.0239537719845, 3609.9458508122398, 3631.0014745945077, 3839.9232015359535, 3853.8398513219454, 3857.4599556062176, 4086.427900093989, 4372.540883207217, 4436.157130145327, 4469.0, 4479.641628669699, 5426.825307195335, 5432.533216031649, 5437.987944460575, 5448.09671295837, 5454.400015998237, 1150.4822829726656, 1151.1654050813092, 1220.6155061155707, 1238.4984081447028, 1242.372601836067, 738.8226825561826, 792.4888446951799, 839.2446797881955, 851.535912927456, 851.8168593752249, 4776.928346074812, 4780.976095119572, 4793.688410253322, 4818.626691392936, 4824.855254342376, 4489.169503641837, 4660.904687398459, 5234.685918844882, 5266.973665131726, 5288.603354748332, 4088.4889388826396, 4215.578442155821, 4464.665150113689, 4530.818767249339, 4811.133995880775, 2245.0, 2649.483350746586, 2758.758558648616, 2783.262435454606, 2785.899569669969, 4553.954460455353, 4642.798267567857, 4900.583450406755, 5471.893321071416, 5481.369642491085, 4991.627302491771, 5257.057207094679, 5276.153346328754, 5342.839714808562, 5381.919271210935, 4427.955720442818, 5372.328458942632, 5426.864328391743, 5707.400722924033, 5718.714064296852, 4750.216214324598, 5175.482451754794, 5530.308711411074, 5537.280153580009, 5553.251555200143, 4605.424321959755, 4611.515790841913, 5001.499550135018, 5258.291055407085, 5382.3442722044365, 4893.6085113191575, 5135.894283343811, 5328.149440049555, 5391.757370918396, 5737.08206686928, 3605.549306336708, 3664.798436085934, 3698.150924537731, 3702.352088384576, 3719.497867787814, 4569.29175977724, 4754.4532378776885, 4757.52516719818, 5055.494450554915, 5494.835154945358, 4589.036302376405, 5264.657797243167, 5374.328208973879, 5375.4087050425205, 5397.8380648580605, 5384.219288203267, 5387.515123638891, 5393.164059570773, 5396.64921780083, 5404.32445944257, 4485.161083955562, 4525.0, 5239.921401178909, 5309.973450132725, 5334.493223143795, 4484.372187893632, 4661.533846615312, 4865.756712164449, 5417.720001199009, 5476.09644408684, 4578.9771051144535, 4861.611071114373, 5312.203169524602, 5321.813736519203, 5422.593305502024], "value": 3865.8037546963155, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.5937296994772, 700.3696672994307, 704.7842471736259, 752.2515097478007, 799.54425977193, 13873.861261387396, 14273.214973176471, 14444.277786110692, 14871.256437178125, 14875.033122847035, 13647.11293765907, 13774.655633609165, 13831.723365532709, 15086.09483430995, 15362.69274614507, 853.3898262742138, 874.1913729799942, 874.2263097158997, 874.5233847553067, 875.1991927386434, 852.5311078906576, 873.0483772687801, 873.3275377958968, 874.1957399192758, 878.2271600991119, 908.609298001859, 908.8682141089538, 909.7771046093716, 910.4036855859423, 911.1344222988155, 906.1572737354257, 907.9182873541347, 908.5139450394007, 909.0455022226669, 910.41733290694, 668.2849351194224, 669.6517810738388, 669.6685140855259, 670.5239280111078, 671.2750229751905, 14447.566573002827, 14685.77971330431, 14691.0, 14701.044432111985, 14938.477153299582, 13567.597815160205, 13580.660483487893, 13801.240931748749, 13829.79255311171, 13951.720965580631, 11128.276662016942, 11310.0, 11442.54229830814, 11828.34944078084, 11834.822477662841, 3570.6429357064344, 3585.229175727231, 3586.7130629549574, 3604.6395360463744, 3722.181120153589, 76463.61768191123, 96268.51865740697, 97020.0, 97321.99999999929, 97652.0, 10247.84628230577, 10275.7431064224, 10289.794204115875, 10408.427536485415, 10830.296030758132, 21619.0, 21641.35075947724, 21685.349439516838, 21729.782702172775, 21787.346379608636, 7314.232005639437, 7343.795090205339, 7362.190159082496, 7440.441966852508, 7603.695852165962, 4036.6972477064337, 4044.9797751011056, 4153.563875792998, 4174.519930208005, 4273.081287523198, 3518.2611651552947, 3594.155373487228, 3621.6378362163573, 3691.90770230741, 3932.606739326102, 709.2481969112654, 718.2350796401815, 726.6548389514938, 739.3973911262304, 741.529129003087, 629.276332217953, 640.7308930249307, 647.7894684227645, 665.4942243894578, 677.881370760115, 7183.60490173035, 8067.919320806717, 9808.460534670661, 9959.153471954965, 9962.900370996342, 645.3836586060302, 675.8679212319346, 677.5697432130632, 693.743314973463, 696.895465680152, 4435.82256709728, 4840.685355451885, 4843.564079232886, 4870.707757534559, 4878.95121048792, 85711.0, 89029.55485222532, 90179.0, 91490.0, 91738.62392064124, 82304.0, 82869.17130828735, 83662.58168709118, 84082.0, 85655.14344856597, 70220.64889675518, 70543.0, 70944.64527677328, 70989.64505177338, 72339.91490127653, 9155.954220228856, 9176.26589872822, 9197.678081267124, 9245.537723113952, 9321.533923303943, 45364.77317613391, 45765.44475520337, 48931.266031008854, 49561.172459720474, 50050.74974625104, 42515.0, 67290.0, 67532.66233668997, 68200.0, 69308.6534567324, 8396.958015209884, 10871.29336593119, 10890.78218435611, 11217.326960382403, 11542.018928390846, 11923.701907452036, 11994.280343179436, 12110.878891210976, 12197.207181533173, 12389.380530973596, 10061.295709300279, 11433.485269483712, 11573.768524629291, 11671.183017188716, 11717.648470545897, 11331.660050198507, 11957.282563046245, 12107.33409662477, 12124.515019399125, 12250.019998400285, 10992.670219893416, 11510.251833630788, 11536.192466527262, 11902.047836172913, 11922.4038798058, 9492.857607136037, 9569.952150239204, 9606.615735370786, 9633.9036609633, 10169.237307201842, 8478.279346255636, 8490.872636910575, 10117.0, 10121.595136194765, 10345.4310012947], "value": 7116.631014226637, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 115.0, 114.0, 115.0, 114.0, 115.0, 114.0, 116.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 112.0, 110.0, 149.0, 112.0, 112.0, 109.0, 113.0, 130.0, 113.0], "value": 120.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 184.0, 182.0, 186.0, 186.0, 187.0, 184.0, 183.0, 185.0, 188.0], "value": 185.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 90.0, 63.0, 71.0, 58.0, 59.0, 76.0, 60.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 73.0, 88.0, 69.0, 70.0, 69.0, 85.0, 67.0, 67.0, 85.0], "value": 76.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 89.0, 89.0, 89.0, 89.0, 91.0, 89.0, 89.0, 88.0], "value": 89.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 102.0, 125.0, 96.0, 95.0, 97.0, 96.0, 98.0], "value": 100.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 84.0, 86.0, 68.0, 126.0, 130.0, 90.0, 93.0, 87.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 57.0, 57.0, 58.0, 59.0, 59.0, 58.0, 59.0, 60.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 84.0, 74.0, 77.0, 73.0, 71.0, 71.0, 71.0, 71.0, 71.0], "value": 72.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 96.0, 86.0, 89.0, 89.0, 87.0, 91.0, 87.0, 89.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 143.0, 167.0, 149.0, 136.0, 139.0, 143.0, 146.0, 182.0, 163.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 174.0, 174.0, 173.0, 174.0, 172.0, 173.0, 172.0, 173.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 67.0, 66.0, 68.0, 66.0, 66.0, 66.0], "value": 66.9, "unit": "score"}]}]} 17:16:23 INFO - Return code: 0 17:16:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:16:23 ERROR - # TBPL SUCCESS # 17:16:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:16:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:16:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:16:23 INFO - 2017-02-12 17:16:23.180 screenresolution[1660:11156] starting screenresolution argv=screenresolution get 17:16:23 INFO - 2017-02-12 17:16:23.182 screenresolution[1660:11156] Display 0: 1600x1200x32@60 17:16:23 INFO - 2017-02-12 17:16:23.189 screenresolution[1661:11160] starting screenresolution argv=screenresolution list 17:16:23 INFO - Available Modes on Display 0 17:16:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:16:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:16:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:16:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:16:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:16:23 INFO - Intel Iris: 17:16:23 INFO - Chipset Model: Intel Iris 17:16:23 INFO - Type: GPU 17:16:23 INFO - Bus: Built-In 17:16:23 INFO - VRAM (Dynamic, Max): 1536 MB 17:16:23 INFO - Vendor: Intel (0x8086) 17:16:23 INFO - Device ID: 0x0a2e 17:16:23 INFO - Revision ID: 0x0009 17:16:23 INFO - Displays: 17:16:23 INFO - Display: 17:16:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:16:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:16:23 INFO - Display Serial Number: 1600x1200 60 17:16:23 INFO - Main Display: Yes 17:16:23 INFO - Mirror: Off 17:16:23 INFO - Online: Yes 17:16:23 INFO - Rotation: Supported 17:16:23 INFO - Return code: 0 17:16:23 INFO - Running post-action listener: _resource_record_post_action 17:16:23 INFO - [mozharness: 2017-02-13 01:16:23.425926Z] Finished run-tests step (success) 17:16:23 INFO - Running post-run listener: _resource_record_post_run 17:16:23 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 33242112; Write bytes: 556773376; Read time: 306; Write time: 1865 17:16:23 INFO - TinderboxPrint: CPU usage
54.1% 17:16:23 INFO - TinderboxPrint: I/O read bytes / time
33,242,112 / 306 17:16:23 INFO - TinderboxPrint: I/O write bytes / time
556,773,376 / 1,865 17:16:23 INFO - TinderboxPrint: CPU idle
2,208.2 (45.9%) 17:16:23 INFO - TinderboxPrint: CPU system
967.4 (20.1%) 17:16:23 INFO - TinderboxPrint: CPU user
1,633.8 (34.0%) 17:16:23 INFO - TinderboxPrint: Swap in / out
281,911,296 / 0 17:16:23 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249227776; Write bytes: 245356544; Read time: 17942; Write time: 513 17:16:23 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 31169536; Write bytes: 298055680; Read time: 283; Write time: 1317 17:16:23 INFO - Running post-run listener: _upload_blobber_files 17:16:23 INFO - Blob upload gear active. 17:16:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:16:23 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 17:16:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:16:24 INFO - (blobuploader) - INFO - Open directory for files ... 17:16:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:16:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:16:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:25 INFO - (blobuploader) - INFO - Done attempting. 17:16:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:16:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:16:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:25 INFO - (blobuploader) - INFO - Done attempting. 17:16:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:16:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:16:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:26 INFO - (blobuploader) - INFO - Done attempting. 17:16:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:16:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:16:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:29 INFO - (blobuploader) - INFO - Done attempting. 17:16:29 INFO - (blobuploader) - INFO - Iteration through files over. 17:16:29 INFO - Return code: 0 17:16:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:16:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:16:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5be98ac7c90fbcdaa86ab431782a2a8c471d46b576dffda0c26c7c0b65f20d15c5c3f3dc4a8a8328e2f3c3a2a95ce6ce5f0fd12dad314ed8d551d3e93eca2fd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dc630c53043e49ac80fb31b57c458ad9df2221aa8bf4cf2c166f1eecc98bce62d5b2e7d0f09c182783ca2300b1b42f2538571c9cea9b52732821c6fd87c72fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d25c349ff819809d18f4967a07a4a01f2798bff710c94b8b00567e2236c28d06e3ce2f59ff98d221544b589a4d5b05b98f88bf2b88c3786a39dc75200ddaa703", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1205e2e3abe448d84b9bc2a051f2f104c6288ffcddce12d6bd7f92cbe37c5b1f646250610831b1c4c1c0d965c1dfdbe157f7406cecfaab0ddc4303836ed8284f"} 17:16:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:16:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:16:29 INFO - Contents: 17:16:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5be98ac7c90fbcdaa86ab431782a2a8c471d46b576dffda0c26c7c0b65f20d15c5c3f3dc4a8a8328e2f3c3a2a95ce6ce5f0fd12dad314ed8d551d3e93eca2fd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dc630c53043e49ac80fb31b57c458ad9df2221aa8bf4cf2c166f1eecc98bce62d5b2e7d0f09c182783ca2300b1b42f2538571c9cea9b52732821c6fd87c72fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d25c349ff819809d18f4967a07a4a01f2798bff710c94b8b00567e2236c28d06e3ce2f59ff98d221544b589a4d5b05b98f88bf2b88c3786a39dc75200ddaa703", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1205e2e3abe448d84b9bc2a051f2f104c6288ffcddce12d6bd7f92cbe37c5b1f646250610831b1c4c1c0d965c1dfdbe157f7406cecfaab0ddc4303836ed8284f"} 17:16:29 INFO - Running post-run listener: copy_logs_to_upload_dir 17:16:29 INFO - Copying logs to upload dir... 17:16:29 INFO - mkdir: /builds/slave/test/build/upload/logs 17:16:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.713784 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-02-12 17:16:29.350675) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-12 17:16:29.354472) ========= 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.LBjD4jZRuh/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.tDFyAF7ivd/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5be98ac7c90fbcdaa86ab431782a2a8c471d46b576dffda0c26c7c0b65f20d15c5c3f3dc4a8a8328e2f3c3a2a95ce6ce5f0fd12dad314ed8d551d3e93eca2fd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dc630c53043e49ac80fb31b57c458ad9df2221aa8bf4cf2c166f1eecc98bce62d5b2e7d0f09c182783ca2300b1b42f2538571c9cea9b52732821c6fd87c72fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d25c349ff819809d18f4967a07a4a01f2798bff710c94b8b00567e2236c28d06e3ce2f59ff98d221544b589a4d5b05b98f88bf2b88c3786a39dc75200ddaa703", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1205e2e3abe448d84b9bc2a051f2f104c6288ffcddce12d6bd7f92cbe37c5b1f646250610831b1c4c1c0d965c1dfdbe157f7406cecfaab0ddc4303836ed8284f"} build_url:https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010971 build_url: 'https://queue.taskcluster.net/v1/task/VB5DdR24SJePshyGi7Mmlg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5be98ac7c90fbcdaa86ab431782a2a8c471d46b576dffda0c26c7c0b65f20d15c5c3f3dc4a8a8328e2f3c3a2a95ce6ce5f0fd12dad314ed8d551d3e93eca2fd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7dc630c53043e49ac80fb31b57c458ad9df2221aa8bf4cf2c166f1eecc98bce62d5b2e7d0f09c182783ca2300b1b42f2538571c9cea9b52732821c6fd87c72fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d25c349ff819809d18f4967a07a4a01f2798bff710c94b8b00567e2236c28d06e3ce2f59ff98d221544b589a4d5b05b98f88bf2b88c3786a39dc75200ddaa703", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1205e2e3abe448d84b9bc2a051f2f104c6288ffcddce12d6bd7f92cbe37c5b1f646250610831b1c4c1c0d965c1dfdbe157f7406cecfaab0ddc4303836ed8284f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-12 17:16:29.388151) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-12 17:16:29.388520) ========= 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.LBjD4jZRuh/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.tDFyAF7ivd/Listeners TMPDIR=/var/folders/gq/1pvmf4y17k5ggl2p3mlg6gxh00000w/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.005143 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-12 17:16:29.437033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-12 17:16:29.437380) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-12 17:16:29.437816) ========= ========= Total master_lag: 0.18 =========