builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0264 starttime: 1493975602.84 results: success (0) buildid: 20170505004016 builduid: 0cf7884f24f14e02a812f697e7f55992 revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 02:13:22.835606) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 02:13:22.836082) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 02:13:22.836369) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 02:13:22.863411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 02:13:22.863776) ========= 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.Z4ZpnJChsa/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.yuvMTuAblb/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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-05-05 02:13:22-- 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% 161M=0s 2017-05-05 02:13:23 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138051 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 02:13:23.026598) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 02:13:23.026911) ========= 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.Z4ZpnJChsa/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.yuvMTuAblb/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.026697 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 02:13:23.076242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 02:13:23.076590) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z4ZpnJChsa/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.yuvMTuAblb/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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-05-05 02:13:23,174 truncating revision to first 12 chars 2017-05-05 02:13:23,174 Setting DEBUG logging. 2017-05-05 02:13:23,174 attempt 1/10 2017-05-05 02:13:23,174 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/94b7e538af7d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 02:13:24,491 unpacking tar archive at: mozilla-aurora-94b7e538af7d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.589920 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 02:13:24.731610) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 02:13:24.732059) ========= script_repo_revision: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 02:13:24.732465) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 02:13:24.732809) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 02:13:24.753767) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-05-05 02:13:24.754162) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z4ZpnJChsa/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.yuvMTuAblb/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 02:13:24 INFO - MultiFileLogger online at 20170505 02:13:24 in /builds/slave/test 02:13:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:13:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:13:24 INFO - {'append_to_log': False, 02:13:24 INFO - 'base_work_dir': '/builds/slave/test', 02:13:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:13:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:13:24 INFO - 'branch': 'Mozilla-Aurora', 02:13:24 INFO - 'buildbot_json_path': 'buildprops.json', 02:13:24 INFO - 'config_files': ('talos/mac_config.py',), 02:13:24 INFO - 'default_actions': ('clobber', 02:13:24 INFO - 'read-buildbot-config', 02:13:24 INFO - 'download-and-extract', 02:13:24 INFO - 'populate-webroot', 02:13:24 INFO - 'create-virtualenv', 02:13:24 INFO - 'install', 02:13:24 INFO - 'run-tests'), 02:13:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:13:24 INFO - 'download_minidump_stackwalk': True, 02:13:24 INFO - 'download_symbols': 'ondemand', 02:13:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:13:24 INFO - 'tooltool.py': '/tools/tooltool.py', 02:13:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:13:24 INFO - '/tools/misc-python/virtualenv.py')}, 02:13:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:13:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:13:24 INFO - 'gecko_profile': False, 02:13:24 INFO - 'gecko_profile_interval': 0, 02:13:24 INFO - 'installer_path': 'installer.exe', 02:13:24 INFO - 'log_level': 'info', 02:13:24 INFO - 'log_name': 'talos', 02:13:24 INFO - 'log_to_console': True, 02:13:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:13:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:13:24 INFO - 'opt_config_files': (), 02:13:24 INFO - 'pip_index': False, 02:13:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:13:24 INFO - 'cmd': ('bash', 02:13:24 INFO - '-c', 02:13:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:13:24 INFO - 'enabled': True, 02:13:24 INFO - 'halt_on_failure': False, 02:13:24 INFO - 'name': 'check_screen_resolution'},), 02:13:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:13:24 INFO - 'cmd': ('bash', 02:13:24 INFO - '-c', 02:13:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:13:24 INFO - 'enabled': True, 02:13:24 INFO - 'halt_on_failure': False, 02:13:24 INFO - 'name': 'check_screen_resolution'},), 02:13:24 INFO - 'run_cmd_checks_enabled': True, 02:13:24 INFO - 'suite': 'dromaeojs', 02:13:24 INFO - 'system_bits': '32', 02:13:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:13:24 INFO - 'title': 't-yosemite-r7-0264', 02:13:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:13:24 INFO - 'use_talos_json': True, 02:13:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:13:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:13:24 INFO - 'work_dir': 'build'} 02:13:24 INFO - [mozharness: 2017-05-05 09:13:24.962431Z] Running clobber step. 02:13:24 INFO - Running pre-action listener: _resource_record_pre_action 02:13:24 INFO - Running main action method: clobber 02:13:24 INFO - rmtree: /builds/slave/test/build 02:13:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:13:27 INFO - Running post-action listener: _resource_record_post_action 02:13:27 INFO - [mozharness: 2017-05-05 09:13:27.439629Z] Finished clobber step (success) 02:13:27 INFO - [mozharness: 2017-05-05 09:13:27.439755Z] Running read-buildbot-config step. 02:13:27 INFO - Running pre-action listener: _resource_record_pre_action 02:13:27 INFO - Running main action method: read_buildbot_config 02:13:27 INFO - Using buildbot properties: 02:13:27 INFO - { 02:13:27 INFO - "project": "", 02:13:27 INFO - "product": "firefox", 02:13:27 INFO - "script_repo_revision": "production", 02:13:27 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:13:27 INFO - "repository": "", 02:13:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:13:27 INFO - "buildid": "20170505004016", 02:13:27 INFO - "stage_platform": "macosx64", 02:13:27 INFO - "basedir": "/builds/slave/test", 02:13:27 INFO - "nightly_build": "True", 02:13:27 INFO - "buildnumber": 0, 02:13:27 INFO - "slavename": "t-yosemite-r7-0264", 02:13:27 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:13:27 INFO - "platform": "yosemite_r7", 02:13:27 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:13:27 INFO - "branch": "mozilla-aurora", 02:13:27 INFO - "repo_path": "releases/mozilla-aurora", 02:13:27 INFO - "revision": "94b7e538af7dbb9a6567cad9125c2f5411e7fb80", 02:13:27 INFO - "pgo_build": "False", 02:13:27 INFO - "builduid": "0cf7884f24f14e02a812f697e7f55992", 02:13:27 INFO - "slavebuilddir": "test" 02:13:27 INFO - } 02:13:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:13:27 INFO - Running post-action listener: _resource_record_post_action 02:13:27 INFO - [mozharness: 2017-05-05 09:13:27.443030Z] Finished read-buildbot-config step (success) 02:13:27 INFO - [mozharness: 2017-05-05 09:13:27.443158Z] Running download-and-extract step. 02:13:27 INFO - Running pre-action listener: _resource_record_pre_action 02:13:27 INFO - Running main action method: download_and_extract 02:13:27 INFO - mkdir: /builds/slave/test/build/tests 02:13:27 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')]} 02:13:27 INFO - trying https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:13:27 INFO - Downloading https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:13:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:13:28 INFO - Downloaded 1199 bytes. 02:13:28 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:13:28 INFO - Using the following test package requirements: 02:13:28 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:13:28 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:13:28 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:13:28 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:13:28 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:13:28 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:13:28 INFO - u'jsshell-mac.zip'], 02:13:28 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:13:28 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:13:28 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:13:28 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:13:28 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:13:28 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:13:28 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:13:28 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:13:28 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:13:28 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:13:28 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:13:28 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:13:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:13:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:13:28 INFO - Fetch https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:13:30 INFO - Expected file size: 51791059 02:13:30 INFO - Obtained file size: 51791059 02:13:46 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:13:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:13:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:13:46 INFO - Fetch https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:13:48 INFO - Expected file size: 51791059 02:13:48 INFO - Obtained file size: 51791059 02:14:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:14:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:14:04 INFO - Fetch https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:14:04 INFO - Expected file size: 14404424 02:14:04 INFO - Obtained file size: 14404424 02:14: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')]} 02:14:05 INFO - trying https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:14:05 INFO - Downloading https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:14:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:14:07 INFO - Downloaded 74781785 bytes. 02:14:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:14:07 INFO - mkdir: /builds/slave/test/properties 02:14:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:14:07 INFO - Writing to file /builds/slave/test/properties/build_url 02:14:07 INFO - Contents: 02:14:07 INFO - build_url:https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:14:08 INFO - Running post-action listener: _resource_record_post_action 02:14:08 INFO - Running post-action listener: set_extra_try_arguments 02:14:08 INFO - [mozharness: 2017-05-05 09:14:08.192595Z] Finished download-and-extract step (success) 02:14:08 INFO - [mozharness: 2017-05-05 09:14:08.192745Z] Running populate-webroot step. 02:14:08 INFO - Running pre-action listener: _resource_record_pre_action 02:14:08 INFO - Running main action method: populate_webroot 02:14:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:14:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:14:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:14:08 INFO - '--tppagecycles', 02:14:08 INFO - '7'], 02:14:08 INFO - 'tests': ['tsvgm']}}, 02:14:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:14:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:14:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:14:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:14:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:14:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:14:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:14:08 INFO - 'talos_options': ['--disable-e10s'], 02:14:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:14:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:14:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:14:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:14:08 INFO - 'talos_options': ['--disable-e10s'], 02:14:08 INFO - 'tests': ['damp', 'tps']}, 02:14:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:14:08 INFO - 'tests': ['damp', 'tps']}, 02:14:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:14:08 INFO - 'tests': ['dromaeo_dom']}, 02:14:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:14:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:14:08 INFO - 'tests': ['basic_compositor_video']}, 02:14:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:14:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:14:08 INFO - 'tests': ['a11yr', 02:14:08 INFO - 'ts_paint', 02:14:08 INFO - 'tpaint', 02:14:08 INFO - 'sessionrestore', 02:14:08 INFO - 'sessionrestore_no_auto_restore', 02:14:08 INFO - 'tabpaint']}, 02:14:08 INFO - 'other-e10s': {'tests': ['a11yr', 02:14:08 INFO - 'ts_paint', 02:14:08 INFO - 'tpaint', 02:14:08 INFO - 'sessionrestore', 02:14:08 INFO - 'sessionrestore_no_auto_restore', 02:14:08 INFO - 'tabpaint']}, 02:14:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:14:08 INFO - 'ts_paint', 02:14:08 INFO - 'tpaint', 02:14:08 INFO - 'sessionrestore', 02:14:08 INFO - 'sessionrestore_no_auto_restore', 02:14:08 INFO - 'tabpaint']}, 02:14:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:14:08 INFO - 'ts_paint', 02:14:08 INFO - 'tpaint', 02:14:08 INFO - 'sessionrestore', 02:14:08 INFO - 'sessionrestore_no_auto_restore', 02:14:08 INFO - 'tabpaint']}, 02:14:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:14:08 INFO - 'tests': ['a11yr', 02:14:08 INFO - 'ts_paint', 02:14:08 INFO - 'tpaint', 02:14:08 INFO - 'sessionrestore', 02:14:08 INFO - 'sessionrestore_no_auto_restore', 02:14:08 INFO - 'tabpaint']}, 02:14:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:14:08 INFO - 'tests': ['a11yr', 02:14:08 INFO - 'ts_paint', 02:14:08 INFO - 'tpaint', 02:14:08 INFO - 'sessionrestore', 02:14:08 INFO - 'sessionrestore_no_auto_restore', 02:14:08 INFO - 'tabpaint']}, 02:14:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:14:08 INFO - 'tests': ['tsvgx', 02:14:08 INFO - 'tsvgr_opacity', 02:14:08 INFO - 'tart', 02:14:08 INFO - 'tscrollx', 02:14:08 INFO - 'cart', 02:14:08 INFO - 'tsvg_static']}, 02:14:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:14:08 INFO - 'tsvgr_opacity', 02:14:08 INFO - 'tart', 02:14:08 INFO - 'tscrollx', 02:14:08 INFO - 'cart', 02:14:08 INFO - 'tsvg_static']}, 02:14:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:14:08 INFO - 'talos_options': ['--disable-e10s'], 02:14:08 INFO - 'tests': ['tp5o']}, 02:14:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:14:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:14:08 INFO - 'talos_options': ['--disable-e10s', 02:14:08 INFO - '--xperf_path', 02:14:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:14:08 INFO - 'tests': ['tp5n']}, 02:14:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:14:08 INFO - 'talos_options': ['--xperf_path', 02:14:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:14:08 INFO - 'tests': ['tp5n']}}, 02:14:08 INFO - 'talos.zip': {'path': '', 02:14:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:14:08 INFO - Running post-action listener: _resource_record_post_action 02:14:08 INFO - [mozharness: 2017-05-05 09:14:08.211204Z] Finished populate-webroot step (success) 02:14:08 INFO - [mozharness: 2017-05-05 09:14:08.211339Z] Running create-virtualenv step. 02:14:08 INFO - Running pre-action listener: _resource_record_pre_action 02:14:08 INFO - Running main action method: create_virtualenv 02:14:08 INFO - Creating virtualenv /builds/slave/test/build/venv 02:14:08 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 02:14:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:14:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:14:08 INFO - Using real prefix '/tools/python27' 02:14:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:14:09 INFO - Installing distribute.............................................................................................................................................................................................done. 02:14:11 INFO - Installing pip.................done. 02:14:11 INFO - Return code: 0 02:14:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:14:12 INFO - Reading from file tmpfile_stdout 02:14:12 INFO - Output received: 02:14:12 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) 02:14:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:14:12 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')]} 02:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:12 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')]} 02:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:12 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 0x102035b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102038768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b134d9d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e13d30>, '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 0x101d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e08be8>, '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.Z4ZpnJChsa/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.yuvMTuAblb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 02:14:12 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 02:14:12 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 02:14:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4ZpnJChsa/Render', 02:14:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:12 INFO - 'HOME': '/Users/cltbld', 02:14:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:12 INFO - 'LOGNAME': 'cltbld', 02:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:12 INFO - 'MOZ_NO_REMOTE': '1', 02:14:12 INFO - 'NO_EM_RESTART': '1', 02:14:12 INFO - 'PAGER': '/bin/cat', 02:14:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:12 INFO - 'PWD': '/builds/slave/test', 02:14:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:12 INFO - 'SHELL': '/bin/bash', 02:14:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuvMTuAblb/Listeners', 02:14:12 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 02:14:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:12 INFO - 'USER': 'cltbld', 02:14:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:12 INFO - 'XPC_FLAGS': '0x0', 02:14:12 INFO - 'XPC_SERVICE_NAME': '0', 02:14:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:12 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 02:14:12 INFO - Cleaning up... 02:14:12 INFO - Return code: 0 02:14:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:14:12 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')]} 02:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:12 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')]} 02:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:12 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 0x102035b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102038768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b134d9d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e13d30>, '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 0x101d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e08be8>, '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.Z4ZpnJChsa/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.yuvMTuAblb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 02:14:12 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 02:14:12 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 02:14:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4ZpnJChsa/Render', 02:14:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:12 INFO - 'HOME': '/Users/cltbld', 02:14:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:12 INFO - 'LOGNAME': 'cltbld', 02:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:12 INFO - 'MOZ_NO_REMOTE': '1', 02:14:12 INFO - 'NO_EM_RESTART': '1', 02:14:12 INFO - 'PAGER': '/bin/cat', 02:14:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:12 INFO - 'PWD': '/builds/slave/test', 02:14:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:12 INFO - 'SHELL': '/bin/bash', 02:14:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuvMTuAblb/Listeners', 02:14:12 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 02:14:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:12 INFO - 'USER': 'cltbld', 02:14:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:12 INFO - 'XPC_FLAGS': '0x0', 02:14:12 INFO - 'XPC_SERVICE_NAME': '0', 02:14:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:12 INFO - Downloading/unpacking psutil>=3.1.1 02:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:14:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:14 INFO - Installing collected packages: psutil 02:14:14 INFO - Running setup.py install for psutil 02:14:15 INFO - building 'psutil._psutil_osx' extension 02:14:15 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 02:14:15 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 02:14:15 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 02:14:15 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 02:14:15 INFO - building 'psutil._psutil_posix' extension 02:14:15 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 02:14:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:14:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:14:15 INFO - ^ 02:14:15 INFO - 1 warning generated. 02:14:15 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 02:14:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:14:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:14:16 INFO - Successfully installed psutil 02:14:16 INFO - Cleaning up... 02:14:16 INFO - Return code: 0 02:14:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102035b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102038768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b134d9d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e13d30>, '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 0x101d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e08be8>, '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.Z4ZpnJChsa/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.yuvMTuAblb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 02:14:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:14:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4ZpnJChsa/Render', 02:14:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:16 INFO - 'HOME': '/Users/cltbld', 02:14:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:16 INFO - 'LOGNAME': 'cltbld', 02:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:16 INFO - 'MOZ_NO_REMOTE': '1', 02:14:16 INFO - 'NO_EM_RESTART': '1', 02:14:16 INFO - 'PAGER': '/bin/cat', 02:14:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:16 INFO - 'PWD': '/builds/slave/test', 02:14:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:16 INFO - 'SHELL': '/bin/bash', 02:14:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuvMTuAblb/Listeners', 02:14:16 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 02:14:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:16 INFO - 'USER': 'cltbld', 02:14:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:16 INFO - 'XPC_FLAGS': '0x0', 02:14:16 INFO - 'XPC_SERVICE_NAME': '0', 02:14:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:14:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:14:18 INFO - Installing collected packages: mozsystemmonitor 02:14:18 INFO - Running setup.py install for mozsystemmonitor 02:14:18 INFO - Successfully installed mozsystemmonitor 02:14:18 INFO - Cleaning up... 02:14:18 INFO - Return code: 0 02:14:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:18 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 0x102035b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102038768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b134d9d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e13d30>, '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 0x101d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e08be8>, '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.Z4ZpnJChsa/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.yuvMTuAblb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 02:14:18 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 02:14:18 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 02:14:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4ZpnJChsa/Render', 02:14:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:18 INFO - 'HOME': '/Users/cltbld', 02:14:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:18 INFO - 'LOGNAME': 'cltbld', 02:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:18 INFO - 'MOZ_NO_REMOTE': '1', 02:14:18 INFO - 'NO_EM_RESTART': '1', 02:14:18 INFO - 'PAGER': '/bin/cat', 02:14:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:18 INFO - 'PWD': '/builds/slave/test', 02:14:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:18 INFO - 'SHELL': '/bin/bash', 02:14:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuvMTuAblb/Listeners', 02:14:18 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 02:14:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:18 INFO - 'USER': 'cltbld', 02:14:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:18 INFO - 'XPC_FLAGS': '0x0', 02:14:18 INFO - 'XPC_SERVICE_NAME': '0', 02:14:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:19 INFO - Downloading/unpacking jsonschema==2.5.1 02:14:19 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 02:14:19 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 02:14:19 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 02:14:19 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 02:14:19 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 02:14:19 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 02:14:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:14:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:14:20 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 02:14:20 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 02:14:20 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 02:14:20 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 02:14:20 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 02:14:20 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 02:14:20 INFO - Downloading functools32-3.2.3-2.tar.gz 02:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:14:20 INFO - warning: no files found matching '*.txt' 02:14:20 INFO - no previously-included directories found matching 'build' 02:14:20 INFO - no previously-included directories found matching 'dist' 02:14:20 INFO - no previously-included directories found matching '.git*' 02:14:20 INFO - Installing collected packages: jsonschema, functools32 02:14:20 INFO - Running setup.py install for functools32 02:14:20 INFO - warning: no files found matching '*.txt' 02:14:20 INFO - no previously-included directories found matching 'build' 02:14:20 INFO - no previously-included directories found matching 'dist' 02:14:20 INFO - no previously-included directories found matching '.git*' 02:14:20 INFO - Successfully installed jsonschema functools32 02:14:20 INFO - Cleaning up... 02:14:20 INFO - Return code: 0 02:14:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:14: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')]} 02:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14: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')]} 02:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14: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', '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 0x102035b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102038768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b134d9d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e13d30>, '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 0x101d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e08be8>, '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.Z4ZpnJChsa/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.yuvMTuAblb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 02:14: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:14: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 functools32==3.2.3-2 02:14:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4ZpnJChsa/Render', 02:14:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:20 INFO - 'HOME': '/Users/cltbld', 02:14:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:20 INFO - 'LOGNAME': 'cltbld', 02:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:20 INFO - 'MOZ_NO_REMOTE': '1', 02:14:20 INFO - 'NO_EM_RESTART': '1', 02:14:20 INFO - 'PAGER': '/bin/cat', 02:14:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:20 INFO - 'PWD': '/builds/slave/test', 02:14:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:20 INFO - 'SHELL': '/bin/bash', 02:14:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuvMTuAblb/Listeners', 02:14:20 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 02:14:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:20 INFO - 'USER': 'cltbld', 02:14:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:20 INFO - 'XPC_FLAGS': '0x0', 02:14:20 INFO - 'XPC_SERVICE_NAME': '0', 02:14:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:14:21 INFO - Cleaning up... 02:14:21 INFO - Return code: 0 02:14:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:21 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 0x102035b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102038768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b134d9d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e13d30>, '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 0x101d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e08be8>, '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.Z4ZpnJChsa/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.yuvMTuAblb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 02:14:21 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 02:14:21 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 02:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4ZpnJChsa/Render', 02:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:21 INFO - 'HOME': '/Users/cltbld', 02:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:21 INFO - 'LOGNAME': 'cltbld', 02:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:21 INFO - 'MOZ_NO_REMOTE': '1', 02:14:21 INFO - 'NO_EM_RESTART': '1', 02:14:21 INFO - 'PAGER': '/bin/cat', 02:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:21 INFO - 'PWD': '/builds/slave/test', 02:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:21 INFO - 'SHELL': '/bin/bash', 02:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuvMTuAblb/Listeners', 02:14:21 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 02:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:21 INFO - 'USER': 'cltbld', 02:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:21 INFO - 'XPC_FLAGS': '0x0', 02:14:21 INFO - 'XPC_SERVICE_NAME': '0', 02:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:21 INFO - Downloading/unpacking blobuploader==1.2.4 02:14:21 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 02:14:21 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 02:14:21 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 02:14:21 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 02:14:21 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 02:14:21 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 02:14:22 INFO - Downloading blobuploader-1.2.4.tar.gz 02:14:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:14:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:14:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:14:23 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 02:14:23 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 02:14:23 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 02:14:23 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 02:14:23 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 02:14:23 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 02:14:23 INFO - Downloading docopt-0.6.1.tar.gz 02:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:14:23 INFO - Installing collected packages: blobuploader, requests, docopt 02:14:23 INFO - Running setup.py install for blobuploader 02:14:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:14:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:14:23 INFO - Running setup.py install for requests 02:14:24 INFO - Running setup.py install for docopt 02:14:24 INFO - Successfully installed blobuploader requests docopt 02:14:24 INFO - Cleaning up... 02:14:24 INFO - Return code: 0 02:14:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:24 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')]} 02:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:24 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')]} 02:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:24 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 0x102035b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102038768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b134d9d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e13d30>, '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 0x101d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e08be8>, '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.Z4ZpnJChsa/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.yuvMTuAblb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 02:14:24 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 02:14:24 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 02:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4ZpnJChsa/Render', 02:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:24 INFO - 'HOME': '/Users/cltbld', 02:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:24 INFO - 'LOGNAME': 'cltbld', 02:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:24 INFO - 'MOZ_NO_REMOTE': '1', 02:14:24 INFO - 'NO_EM_RESTART': '1', 02:14:24 INFO - 'PAGER': '/bin/cat', 02:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:24 INFO - 'PWD': '/builds/slave/test', 02:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:24 INFO - 'SHELL': '/bin/bash', 02:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuvMTuAblb/Listeners', 02:14:24 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 02:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:24 INFO - 'USER': 'cltbld', 02:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:24 INFO - 'XPC_FLAGS': '0x0', 02:14:24 INFO - 'XPC_SERVICE_NAME': '0', 02:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:24 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-L8kAsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:24 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-gHQ_gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-_CVdyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-BGTQLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-KWEPI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-SGS4IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-ErGQ7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-a1ImgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-ldRIyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Rb3Mtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:25 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-TzFxY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:26 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-NEBhxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:26 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-5UYCnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:26 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-Hs0Mp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:26 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-HW2BdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:26 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-S_QcY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:26 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-tW9P5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:14:26 INFO - Running setup.py install for manifestparser 02:14:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:14:26 INFO - Running setup.py install for mozcrash 02:14:26 INFO - Running setup.py install for mozdebug 02:14:27 INFO - Running setup.py install for mozdevice 02:14:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:14:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:14:27 INFO - Running setup.py install for mozfile 02:14:27 INFO - Running setup.py install for mozhttpd 02:14:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:14:27 INFO - Running setup.py install for mozinfo 02:14:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:14:27 INFO - Running setup.py install for mozInstall 02:14:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:14:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:14:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:14:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:14:27 INFO - Running setup.py install for mozleak 02:14:27 INFO - Running setup.py install for mozlog 02:14:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:14:28 INFO - Running setup.py install for moznetwork 02:14:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:14:28 INFO - Running setup.py install for mozprocess 02:14:28 INFO - Running setup.py install for mozprofile 02:14:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:14:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:14:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:14:28 INFO - Running setup.py install for mozrunner 02:14:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:14:28 INFO - Running setup.py install for mozscreenshot 02:14:28 INFO - Running setup.py install for moztest 02:14:29 INFO - Running setup.py install for mozversion 02:14:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:14:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:14:29 INFO - Cleaning up... 02:14:29 INFO - Return code: 0 02:14:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:29 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 0x102035b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102038768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b134d9d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e13d30>, '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 0x101d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e08be8>, '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.Z4ZpnJChsa/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.yuvMTuAblb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 02:14:29 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 02:14:29 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 02:14:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4ZpnJChsa/Render', 02:14:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:29 INFO - 'HOME': '/Users/cltbld', 02:14:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:29 INFO - 'LOGNAME': 'cltbld', 02:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:29 INFO - 'MOZ_NO_REMOTE': '1', 02:14:29 INFO - 'NO_EM_RESTART': '1', 02:14:29 INFO - 'PAGER': '/bin/cat', 02:14:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:29 INFO - 'PWD': '/builds/slave/test', 02:14:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:29 INFO - 'SHELL': '/bin/bash', 02:14:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuvMTuAblb/Listeners', 02:14:29 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 02:14:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:29 INFO - 'USER': 'cltbld', 02:14:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:29 INFO - 'XPC_FLAGS': '0x0', 02:14:29 INFO - 'XPC_SERVICE_NAME': '0', 02:14:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:14:29 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-_LP_2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:14:29 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)) 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:14:29 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-1vt6p1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:14:29 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)) 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:14:29 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-hJtm_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:14:29 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)) 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:14:29 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-TQ5GrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:14:29 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)) 02:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:14:29 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-dO7Fp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:14:30 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)) 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:14:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-C26_vZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:14:30 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)) 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:14:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-SeGXFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:14:30 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)) 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:14:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-k7nIl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:14:30 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)) 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:14:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-dlVwr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:14:30 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)) 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:14:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-8XJ3qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:14:30 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)) 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:14:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-wsKINK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:14:30 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)) 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:14:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-h2f7Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:14:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-JTbmcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:14:30 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)) 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:14:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-_MJ0gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:14:30 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)) 02:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:30 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-o5aglT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:14:31 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)) 02:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:14:31 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-ROg2BP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:14:31 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)) 02:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:14:31 INFO - Running setup.py (path:/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/pip-khVvET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:14:31 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)) 02:14:31 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)) 02:14:31 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)) 02:14:31 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)) 02:14:31 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)) 02:14:31 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)) 02:14:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:14:31 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 02:14:31 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 02:14:31 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 02:14:31 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 02:14:31 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 02:14:31 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 02:14:33 INFO - Downloading blessings-1.6.tar.gz 02:14:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:14:33 INFO - Installing collected packages: blessings 02:14:33 INFO - Running setup.py install for blessings 02:14:33 INFO - Successfully installed blessings 02:14:33 INFO - Cleaning up... 02:14:33 INFO - Return code: 0 02:14:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:14:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:34 INFO - Reading from file tmpfile_stdout 02:14:34 INFO - Current package versions: 02:14:34 INFO - blessings == 1.6 02:14:34 INFO - blobuploader == 1.2.4 02:14:34 INFO - docopt == 0.6.1 02:14:34 INFO - functools32 == 3.2.3-2 02:14:34 INFO - jsonschema == 2.5.1 02:14:34 INFO - manifestparser == 1.1 02:14:34 INFO - mozInstall == 1.12 02:14:34 INFO - mozcrash == 1.0 02:14:34 INFO - mozdebug == 0.1 02:14:34 INFO - mozdevice == 0.49 02:14:34 INFO - mozfile == 1.2 02:14:34 INFO - mozhttpd == 0.7 02:14:34 INFO - mozinfo == 0.9 02:14:34 INFO - mozleak == 0.1 02:14:34 INFO - mozlog == 3.4 02:14:34 INFO - moznetwork == 0.27 02:14:34 INFO - mozprocess == 0.25 02:14:34 INFO - mozprofile == 0.28 02:14:34 INFO - mozrunner == 6.13 02:14:34 INFO - mozscreenshot == 0.1 02:14:34 INFO - mozsystemmonitor == 0.3 02:14:34 INFO - moztest == 0.8 02:14:34 INFO - mozversion == 1.4 02:14:34 INFO - psutil == 3.1.1 02:14:34 INFO - requests == 1.2.3 02:14:34 INFO - wsgiref == 0.1.2 02:14:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:34 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 0x102035b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102038768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b134d9d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e13d30>, '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 0x101d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e08be8>, '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.Z4ZpnJChsa/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.yuvMTuAblb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 02:14:34 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 02:14:34 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 02:14:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4ZpnJChsa/Render', 02:14:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:34 INFO - 'HOME': '/Users/cltbld', 02:14:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:34 INFO - 'LOGNAME': 'cltbld', 02:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:34 INFO - 'MOZ_NO_REMOTE': '1', 02:14:34 INFO - 'NO_EM_RESTART': '1', 02:14:34 INFO - 'PAGER': '/bin/cat', 02:14:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:34 INFO - 'PWD': '/builds/slave/test', 02:14:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:34 INFO - 'SHELL': '/bin/bash', 02:14:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuvMTuAblb/Listeners', 02:14:34 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 02:14:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:34 INFO - 'USER': 'cltbld', 02:14:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:34 INFO - 'XPC_FLAGS': '0x0', 02:14:34 INFO - 'XPC_SERVICE_NAME': '0', 02:14:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:34 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)) 02:14:34 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)) 02:14:34 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)) 02:14:34 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)) 02:14:34 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)) 02:14:34 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)) 02:14:34 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)) 02:14:34 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)) 02:14:34 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)) 02:14:34 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)) 02:14:34 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)) 02:14:34 INFO - Cleaning up... 02:14:34 INFO - Return code: 0 02:14:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:14:34 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 0x102035b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102038768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b134d9d30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e13d30>, '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 0x101d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e08be8>, '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.Z4ZpnJChsa/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.yuvMTuAblb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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 02:14:34 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 02:14:34 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 02:14:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4ZpnJChsa/Render', 02:14:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:34 INFO - 'HOME': '/Users/cltbld', 02:14:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:34 INFO - 'LOGNAME': 'cltbld', 02:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:34 INFO - 'MOZ_NO_REMOTE': '1', 02:14:34 INFO - 'NO_EM_RESTART': '1', 02:14:34 INFO - 'PAGER': '/bin/cat', 02:14:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:34 INFO - 'PWD': '/builds/slave/test', 02:14:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:34 INFO - 'SHELL': '/bin/bash', 02:14:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuvMTuAblb/Listeners', 02:14:34 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 02:14:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:34 INFO - 'USER': 'cltbld', 02:14:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:34 INFO - 'XPC_FLAGS': '0x0', 02:14:34 INFO - 'XPC_SERVICE_NAME': '0', 02:14:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:14:34 INFO - Cleaning up... 02:14:34 INFO - Return code: 0 02:14:34 INFO - Running post-action listener: _resource_record_post_action 02:14:34 INFO - Running post-action listener: _start_resource_monitoring 02:14:34 INFO - Starting resource monitoring. 02:14:34 INFO - [mozharness: 2017-05-05 09:14:34.770496Z] Finished create-virtualenv step (success) 02:14:34 INFO - [mozharness: 2017-05-05 09:14:34.771450Z] Running install step. 02:14:34 INFO - Running pre-action listener: _resource_record_pre_action 02:14:34 INFO - Running main action method: install 02:14:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:14:35 INFO - Reading from file tmpfile_stdout 02:14:35 INFO - Detecting whether we're running mozinstall >=1.0... 02:14:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:14:35 INFO - Reading from file tmpfile_stdout 02:14:35 INFO - Output received: 02:14:35 INFO - Usage: mozinstall [options] installer 02:14:35 INFO - Options: 02:14:35 INFO - -h, --help show this help message and exit 02:14:35 INFO - -d DEST, --destination=DEST 02:14:35 INFO - Directory to install application into. [default: 02:14:35 INFO - "/builds/slave/test"] 02:14:35 INFO - --app=APP Application being installed. [default: firefox] 02:14:35 INFO - mkdir: /builds/slave/test/build/application 02:14:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:14:55 INFO - Reading from file tmpfile_stdout 02:14:55 INFO - Output received: 02:14:55 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:14:55 INFO - Running post-action listener: _resource_record_post_action 02:14:55 INFO - [mozharness: 2017-05-05 09:14:55.286400Z] Finished install step (success) 02:14:55 INFO - [mozharness: 2017-05-05 09:14:55.286569Z] Running run-tests step. 02:14:55 INFO - Running pre-action listener: _resource_record_pre_action 02:14:55 INFO - Running main action method: run_tests 02:14:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:14:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:14:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:14:55 INFO - 2017-05-05 02:14:55.301 screenresolution[1626:7489] starting screenresolution argv=screenresolution get 02:14:55 INFO - 2017-05-05 02:14:55.303 screenresolution[1626:7489] Display 0: 1600x1200x32@60 02:14:55 INFO - 2017-05-05 02:14:55.309 screenresolution[1627:7491] starting screenresolution argv=screenresolution list 02:14:55 INFO - Available Modes on Display 0 02:14:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:14:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:14:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:14:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:14:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:14:55 INFO - Intel Iris: 02:14:55 INFO - Chipset Model: Intel Iris 02:14:55 INFO - Type: GPU 02:14:55 INFO - Bus: Built-In 02:14:55 INFO - VRAM (Dynamic, Max): 1536 MB 02:14:55 INFO - Vendor: Intel (0x8086) 02:14:55 INFO - Device ID: 0x0a2e 02:14:55 INFO - Revision ID: 0x0009 02:14:55 INFO - Displays: 02:14:55 INFO - Display: 02:14:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:14:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:14:55 INFO - Display Serial Number: 1600x1200 60 02:14:55 INFO - Main Display: Yes 02:14:55 INFO - Mirror: Off 02:14:55 INFO - Online: Yes 02:14:55 INFO - Rotation: Supported 02:14:55 INFO - Return code: 0 02:14:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:14:55 INFO - Python 2.7.3 02:14:55 INFO - Return code: 0 02:14:55 INFO - grabbing minidump binary from tooltool 02:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:14:55 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 0x101e13d30>, '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 0x101d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e08be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:14:55 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 02:14:55 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 02:14:55 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 02:14:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:14:55 INFO - Return code: 0 02:14:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:14:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:14:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:14:55 INFO - ENV: RUST_BACKTRACE is now 1 02:14:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:14:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:14:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--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 02:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0264 --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 02:14:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4ZpnJChsa/Render', 02:14:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:14:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:14:55 INFO - 'HOME': '/Users/cltbld', 02:14:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:14:55 INFO - 'LOGNAME': 'cltbld', 02:14:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:14:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:14:55 INFO - 'MOZ_NO_REMOTE': '1', 02:14:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:14:55 INFO - 'NO_EM_RESTART': '1', 02:14:55 INFO - 'PAGER': '/bin/cat', 02:14:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:14:55 INFO - 'PWD': '/builds/slave/test', 02:14:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:14:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:14:55 INFO - 'RUST_BACKTRACE': '1', 02:14:55 INFO - 'SHELL': '/bin/bash', 02:14:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yuvMTuAblb/Listeners', 02:14:55 INFO - 'TMPDIR': '/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/', 02:14:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:14:55 INFO - 'USER': 'cltbld', 02:14:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:14:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:14:55 INFO - 'XPC_FLAGS': '0x0', 02:14:55 INFO - 'XPC_SERVICE_NAME': '0', 02:14:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:14:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0264', '--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 02:14:55 INFO - mozversion application_buildid: 20170505004016 02:14:55 INFO - mozversion application_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 02:14:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:14:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:14:55 INFO - mozversion application_name: Firefox 02:14:55 INFO - mozversion application_remotingname: firefox-dev 02:14:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:14:55 INFO - mozversion application_vendor: Mozilla 02:14:55 INFO - mozversion application_version: 54.0a2 02:14:55 INFO - mozversion platform_buildid: 20170505004016 02:14:55 INFO - mozversion platform_changeset: 94b7e538af7dbb9a6567cad9125c2f5411e7fb80 02:14:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:14:55 INFO - mozversion platform_version: 54.0a2 02:14:55 INFO - using testdate: 1493975695 02:14:55 INFO - actual date: 1493975695 02:14:55 INFO - starting webserver on 'localhost:49242' 02:14:55 INFO - SUITE-START | Running 2 tests 02:14:55 INFO - TEST-START | dromaeo_css 02:14:55 INFO - operating with platform_type : mac_ 02:14:55 INFO - Initialising browser for dromaeo_css test... 02:14:55 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpmMEhrr/profile http://localhost:49242/getInfo.html) 02:14:58 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 02:14:58 INFO - PROCESS | 1637 | colorDepth:24 02:14:58 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 02:14:58 INFO - PROCESS | 1637 | __metrics 02:14:58 INFO - PROCESS | 1637 | 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" 02:14:58 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:14:59 INFO - TEST-INFO | 1637: exit 0 02:14:59 INFO - Browser initialized. 02:14:59 INFO - Running cycle 1/1 for dromaeo_css test... 02:14:59 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpmMEhrr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:15:11 INFO - PROCESS | 1643 | RSS: Main: 215035904 02:15:11 INFO - PROCESS | 1643 | 02:18:15 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 02:18:17 INFO - PROCESS | 1643 | RSS: Main: 339738624 02:18:17 INFO - PROCESS | 1643 | 02:20:01 INFO - PROCESS | 1643 | ************************* 02:20:01 INFO - PROCESS | 1643 | A coding exception was thrown and uncaught in a Task. 02:20:01 INFO - PROCESS | 1643 | 02:20:01 ERROR - PROCESS | 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:20:01 INFO - PROCESS | 1643 | Full stack: 02:20:01 INFO - PROCESS | 1643 | ************************* 02:20:01 INFO - PROCESS | 1643 | ************************* 02:20:01 INFO - PROCESS | 1643 | A coding exception was thrown and uncaught in a Task. 02:20:01 INFO - PROCESS | 1643 | 02:20:01 ERROR - PROCESS | 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:20:01 INFO - PROCESS | 1643 | Full stack: 02:20:01 INFO - PROCESS | 1643 | ************************* 02:20:01 INFO - PROCESS | 1643 | ************************* 02:20:01 INFO - PROCESS | 1643 | A coding exception was thrown and uncaught in a Task. 02:20:01 INFO - PROCESS | 1643 | 02:20:01 ERROR - PROCESS | 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:20:01 INFO - PROCESS | 1643 | Full stack: 02:20:01 INFO - PROCESS | 1643 | ************************* 02:20:01 INFO - PROCESS | 1643 | ************************* 02:20:01 INFO - PROCESS | 1643 | A coding exception was thrown and uncaught in a Task. 02:20:01 INFO - PROCESS | 1643 | 02:20:01 ERROR - PROCESS | 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:20:01 INFO - PROCESS | 1643 | Full stack: 02:20:01 INFO - PROCESS | 1643 | ************************* 02:21:20 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 02:21:20 INFO - PROCESS | 1643 | RSS: Main: 351256576 02:21:20 INFO - PROCESS | 1643 | 02:24:23 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 02:24:24 INFO - PROCESS | 1643 | RSS: Main: 337715200 02:24:24 INFO - PROCESS | 1643 | 02:27:26 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 02:27:27 INFO - PROCESS | 1643 | RSS: Main: 316702720 02:27:27 INFO - PROCESS | 1643 | 02:30:30 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 02:30:31 INFO - PROCESS | 1643 | RSS: Main: 317960192 02:30:31 INFO - PROCESS | 1643 | 02:33:34 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 02:33:35 INFO - PROCESS | 1643 | RSS: Main: 379219968 02:33:35 INFO - PROCESS | 1643 | 02:33:35 INFO - PROCESS | 1643 | __start_tp_report 02:33:35 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 02:33:35 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 02:33:35 INFO - PROCESS | 1643 | |i|pagename|runs| 02:33:35 INFO - PROCESS | 1643 | |0;dojo.html;3381.6787405196505;3387.407203739345;3395.5925288965327;3399.082247793094;3435.9484607730874;5845.766169353232;5865.237519122519;5868.911966320503;5873.706314684259;5920.9407905920925;5862.032764593848;5910.34986151524;5918.171455996164;5938.52491800656;5946.464818166364;5252.212168174766;5277.683338999673;5293.602979776513;5337.866553336159;5381.81163659272;5230.006298803215;5235.2670626112185;5289.20661900716;5397.163439666858;5420.945790542103;5308.814191503298;5340.54605358545;5343.759530821122;5384.91922621161;5431.266778984846;5356.812511562096;5375.784968601251;5379.81170659027;5401;5402.8109016184635;5140.254663073833;5235.005348983681;5275.736213189325;5296.663867091428;5362.812301569426;5717.342505611825;5719.370869204384;5733.684647344395;5757.251557297566;5768.7980920668;5129.307543481619;6211.47202487789;6245.718942647592;6258.812235632939;6259.655718935457;6270.749170033193;6324.430801227912;6327.778527751507;6330.556861019731;6342.587731797418;5991.3109992351;6044.697765111727;6058.454739073504;6066.636001839904;6081.452669259744;6206.751729930752;6287.9056814147825;6296.874062518816;6325.65208913505;6347.587406818542;6317.905231421532;6324.3991820776955;6329.746810127635;6339.714712837934;6340.207474065742;6262.467690246289;6273.749129613033;6312.779052733133;6317.810465686037;6346.365363463709;6122.215193971364;6188.1027251048345;6219.315875253718;6242.032484964838;6291.748330066837;6221.96889015552;6244.1570387997945;6257.2804127525005;6279.843003924939;6295.276043254993;5091.9236211456855;5093.18509038552;5094.2358646203365;5102.209157580581;5103.668261562986;4508.143452744033;4541.091781643684;4546.568076032771;4550.385697930737;4592.517785632461;5016.322796422509;5215.973920130451;5763.135529670583;5778.797742079007;5782.45066718661;6311.873762524816;6312.873742525124;6321.683915804283;6340.4293613575;6343.5876668016435;5898.439648233411;5922.763089476372;5943.494802941798;5975.581709280395;5976.491998180203;5580.693061881636;5588.30146231721;5590.24531688225;5592.161175823578;5594.496495315359;6468.094466774655;6478.449331806849;6481.5138864584405;6486.481081513468;6493.870122597522;6204.162438070984;6235.657038862906;6238.625682459067;6249.312575616587;6284.780032698834;6432.549721519449;6436.066770318372;6445.2587952386075;6452.903206451813;6456.999165129412;6295.307516173126;6308.621482711052;6308.653024083719;6330.620162790247;6344.175257216532;5166.3025491558155;6206.782762603287;6216.813495594958;6237.376262373908;6291.370862913672;5494.2582751328055;6154.5384096192065;6250.249970003629;6291.905621415774;6303.527235457267;6250.06249062626;6269.435750782452;6278.937210627835;6283.59156654816;6302.117703521419;5921.644701317935;5934.2878854536;6082.148499210026;6141.170941922784;6174.351693072343;6209.410106039919;6220.253569571681;6273.404026617464;6280.497560195265;6284.371562843679;5158.638895277445;6095.908561371494;6099;6108.72510737009;6109.327973922776 02:33:35 INFO - PROCESS | 1643 | |1;ext.html;796.2674339607561;874.5102742464219;894.5437826708377;898.9955050224744;969.7527130581701;38317.04207394816;38718.806405968004;40574.1598088134;40616.59383406161;40711.77864664065;38882.416763748566;38989.61010389895;39037.21925561487;39076.21847563047;39237.41143882844;6501.187351581052;7808.1801410851895;7962.1639727828615;7974.1627129151475;7994.160613135624;7390.593517356543;7463.141738700037;7463.701451941915;7469.514481558708;11067.391293478855;11273.4363281836;11302.434878256096;11302.773944521105;11313;11377.544898204103;11191.776164476705;11235;11248.38133902635;11250.662480125568;11261.268017578832;7292.16140143885;7499;11023.61417350389;11085.667429977113;11098.611548595842;28405.147845564665;28578.285542861595;28606.713932860614;39312.803435982634;39947;3745.8501659933568;3830.3296923038633;3852.711046671483;3878.6703130233964;3926.430667553189;24850.37874053145;24865.5026899461;24900.750992490026;25220.747792522023;25883.482330353476;2876.755475784561;3161.4941609342395;3164.161497203243;3166.2401023754364;3167.4298626247264;365051;368323;368478;368669;368680;37143.25713485715;37850.43224351637;44549.109017819464;44644.330335045;44776.65670029904;39358.803205983786;39369.80315098406;39528;39598;39610;11557.24877882935;13526.93236533811;14031.859681403259;14061.367238474293;14085.436582536584;10142.847857282146;12000.519979200733;12061.396930153458;12065.698357541132;12076.275423474619;9653.565589548487;11890.405479726152;11982.58060967862;11988.880111198776;12013.219140755822;5430.701311427831;5596.776128954796;5614.214010038598;5621.128725047624;5625;1008.9495525223709;1107.9308467328906;1123.6347837377461;1140.3898914080926;1141.9371934543515;25262;26309.34226644349;27072.350504440023;27358;27455.901763929218;1240.3364200152876;1252.4113666576695;1281.3401098434315;1284.743051389726;1295.8315418995471;13965.65085872841;14115.218951902483;14130.434782608787;14177.503787367392;14256;195860;196993.0150349239;196999;197161;197332;58389;58900.70549647224;59027;59066;59123;1427.4512154312688;1439.1796675894639;1468.1778204205466;1468.4566710317251;1472.6980968901564;20208;25533.87233063897;26406.207813765617;26491.867540662173;26513.60229596596;43479.782601086794;43507.56492435035;43586.47447339455;43617;43652.908677283325;447929;449399;450023;450052;450755.7462212668;30210.395792084473;33122.17194570155;33150;33242.501362479095;33256;45255.868603285184;45397.773011134734;45513.63459096233;45891.311630324904;46176.07647846957;30258.697413026468;30458;30528.542071869382;30531.389372211986;31584.052478425685;23271.76728232696;29926.70073299239;31099.756009759356;31152.688473115886;31210.687893121685;36467.81766091259;36957.63042369649;37547.249055019296;37970.81014594909;38075.61924380721;30777.538336925412;31032.53451198189;31280.90516831991;31753.523697145025;32077.839610801795;19172.712409313594;23613;24263.75736242615;24275.878620606785;24830.87584562138 02:33:35 INFO - PROCESS | 1643 | |2;jquery.html;389.0080295247119;389.838217139887;409.9938500922487;426.075416346528;432.87663016040426;12807.48770049198;14479.420823167075;20382.898085509587;20776.8961155194;20846.270380536684;21584.676229856566;21876.124955001782;22145.44636384091;22375.993080311386;22481.988310526023;6719.395254427101;6738.393544580987;6813.352731490525;6907.827304317407;6923.446124310043;4159.376093585956;4466.687331886769;6853.9314606853795;6899.827504312382;6924.965375173142;4469.664775141861;7922.445428819985;7940.2456766607365;7943.364530837519;7949.284564389204;7631.465797394185;7874.330681892046;7961.36309095271;7961.96019019907;7969.362451003905;6915.170179578433;7214.206437291894;7708.113566939817;7716.7684969451;7724.884126738103;24518;25511.23466296014;25871.482570348675;25906.481870362488;26206.344841378927;2800.423794151457;2844.160972513093;2856.3430411005584;2883.740463358308;2931.0913616778867;15352.616184595363;15975.121368324737;16160.27278772458;16334.673306533803;16694.332226710918;2044.356027851222;2054.1783286685295;2085.2493102483095;2097.9370618881458;2197.5824593327216;104535.95464045338;107757;128751;154861.99999999886;155305.44694553135;19674.213031478866;20097;20270.391888243375;20294.28969986073;20391.490212744502;25669.871650641628;30759.384812304077;31353.216169595486;31365;31444.685553144176;9948.651797187209;10127.7468063299;10254.58981640726;10291.433971131659;10463.848976612566;8483.363747718946;8501.06488286288;8529.104444033412;8672;8690.78273043179;7604.581748003802;9173;9248.953755231181;9346.0653934606;9353.719388418358;3962.900927476836;4021.678265738734;4043.3126368517424;4045.5752146024242;4048.6153815387493;832.9296853543168;835.9122292159358;852.6972924611797;899.869518919766;903.742433406476;20293.594128117355;20986.3307424284;21809.781902180774;21885.890570547046;21892.343229703136;928.5867788833904;966.1353088985319;966.7051549277538;984.5077461269366;995.2933417273816;10340.638077667245;10399.272050956512;10965.61620343284;11050.834237486444;11072.612458564072;444683;477467;622993;784238;818333;134491.32754336167;146947;156151;167099;175408;1216.385725208764;1239.2130996816907;1257.6607510031151;1258.7671280813079;1266.3098611256887;17739.556511087325;18520.907395462935;18654.880707157616;18658;18714.812851871306;56140.71929640326;59216.70391648014;63682.68158659177;64630;65516.724163792576;90824.0917590842;91192;91288.54355728444;93177;93446;10703.732406689584;10904.291221070605;11122.888771112186;11313.71715707114;11481.253718508271;11863.288202707865;12408.503659853866;12575;12675.556355527513;12960.287184204959;10090.293679442368;10965.61620343284;11117.999380055833;11146.770645870696;11247.437628118725;9732.805343893224;9878.654247101316;9916.900830991886;10079.445630490394;10119.848202276824;11149.888501114885;11154.498047587716;11192.944035279772;11236.438178090899;11397.031252343644;10923;10993.395363254778;11137.498812553293;11204.83192752093;11207.495662695035;9068.727938161866;10153.64462243818;10796.082333001783;11084.667459976214;11237.269577477438 02:33:35 INFO - PROCESS | 1643 | |3;mootools.html;1530.296063810647;1548.2258870564717;1576.5428025872504;1586.4843925724135;1602.1348471825215;10658.307210031353;11147.665570032892;11155.498002589893;11175.329480231181;11187.32876027439;10595.735106622338;10927;10951.945240273788;11025.503852326645;11068.3912384819;2351.6825228594134;2388.5581167483983;2389.51015041916;2391.5695174868515;2392.162743039931;2284.0749496453964;2370.4473569811803;2388.9999999999914;2394.030417680842;2394.4732158925094;2240.7423146338137;2244.898979545916;2253.763354847734;2347.8121750260025;2353.8234632402555;2252.718410198725;2274.1585613323095;2276.4422716434415;2278.737945136306;2318.8724620145886;2308.0536979838353;2315.5021670340957;2321.245595181556;2321.5356928614347;2327.569399661051;10967.451627418597;11029.724256893562;11057.170712196617;11090.500927458284;11103.72240693981;5510.669359838423;5678;5678.9432105678825;5687.203791469197;5693.402192769741;2958.00906696257;3009.593704849839;3092.721655051034;3246.788958717676;3255.658155893621;1113.5323164271026;1129.8305254211853;1164.885732395699;1172.255617682769;1189.6906804230875;13739.24434156121;14077.507287245;14321.283935803272;15157.469488567847;15202.239888005555;4068.572799856032;4298.118885628439;4449.7330160190495;4614.930776038362;4618.122556714214;11660.30038197711;11664.708382290512;11678.474468648761;11689.415529223676;11704.765904681859;4842.685225460334;5631.436856314336;5646.717664116778;5654.5193658538665;5665.858353541112;4407.42703448556;5072.771725272371;5218.034663587248;5285.418603953562;5296.549793267615;3661.853525858936;3758.248350329945;3829.6744776694295;3854.903627409281;3864.903377415531;984.1192133040888;988.3575675810637;994.7612572982576;1000.5047501486811;1004.4224570871631;800.87986801979;882.4705176893813;890.1365675295083;928.2481190235931;951.2580187453659;6671.799846004627;6719.832004199934;6750.054992301082;6811.727530898807;6845.313627429066;991.1228562722043;993.4734590666958;997.5012493753123;1011.7116621762763;1016.6899095775711;4107.938380924288;4260.672816330565;4315.654747620183;4386.4736231652405;4478.328250762412;13077.01922355827;13688.52090176859;13712.588622341345;13732.86267137316;13796.655083622789;13204.471821127046;13477.999999999804;13605.115667481581;13648.65878353049;13653.863461365458;10011.949940250252;10107.494625268855;10149.086582207638;10155.796884062425;10169.389836609827;4688.578027977498;6467.514936379885;6555.115059466911;6582.308857569887;6649.501287403367;11768.235064720766;12144.96767774749;12152.149349545447;12153.392330383269;12163.939180304396;11934.343611101473;12138.878611213775;12363.258204507758;12371.072169587496;12510.562130325396;9264.351495395527;9287.164155226063;9321.487318197564;9378.624855005995;9426.245900328095;10195.7451063724;10295.485225738832;10369.481525923824;10390.792184156426;10394.48027598602;8835.69075082369;8906.376553641441;8917.331200159884;8997.505137217517;9096.363254572381;8689.000764911863;8724;8736.956315218384;8777.517236551796;8801.691940782042;7795.298423141718;7834.020747406575;7919.326857217201;7921.722739704082;7934.484258523177;5538.224648549287;5846.824595262149;5859.589828711949;5927.525797936241;5999.70001499932;5703.116017017369;5826.533877289891;5916.645001299936;6082.60463069899;6180.134781130555 02:33:35 INFO - PROCESS | 1643 | |4;prototype.html;358.51958375776456;366.6736604422065;374.62350337910397;378.18689816893675;386.82979489024825;4326.351047342896;4676.381226513155;5090.643654944155;5120.539151476366;5158.587313014959;4849.490803465629;4858.392700912386;4998.57512111471;5003;5052.873678158048;3599.3341231872123;3936.7757217172207;4302.354646802974;4311.636923199909;4366.607005369516;3583.5341405617364;3702.740808143431;4316.56834316569;4321.438213032301;4362.16459301455;3445.8284183377646;4068.4507591475067;4148.561039687535;4409.889752756175;4437.2472873215065;4289.970407102304;4293.742375457483;4345.97827010863;4357.320248047428;4365.847195348163;3647.94528082079;3919.274934137165;3929.9367831888203;4131.5455299916985;4137.765606572447;4179.477565304337;4399.0204408016525;4408.470983482002;4604.631629469634;5035.924461133086;4028.798560071985;4298.527162012176;4337.267521461491;4536.841210557648;4734.100520901018;4419.911601767979;5237.454950789526;5305.965336759334;5356.8306584146485;5506.91739623906;4105.91788164235;4300.6344460720875;4382.400423845305;4400.669949753749;4456.9331460028125;4720.905581888377;4769.761511924425;5158.587313014949;5537.280153580009;5667.433256674382;3867.8452861885207;4376.737395756265;4428.889277768018;4479.70881892676;4479.820807167742;3932.4691166692132;4284.3145096784365;4489.7979590918485;4510.985028368591;4577.885552861205;3986.700997425147;4266.06146647737;4671.991043851177;4701.613024157813;4841.588464980446;4485.529019452975;5032.314174751426;5466.234727138204;5466.781328746885;5467.480589344006;1312.8030795380769;1362.4686372314804;1406.3405181885269;1479.9260036998107;1567.4905655661955;1072.6835583502886;1077.6820837852852;1083.4636854756789;1160.3791971295316;1175.8882906124077;4396.86751925316;4447.777611119431;4844.8304309349005;4977.276132447641;5036.597072234213;4876.4879687633;5100.846974590768;5616.466435688603;5694.4590263924865;5701.800436984769;4860.896059137891;5010.997800439854;5055.949440505621;5092.108880945893;5104.259882317043;2549.961750573743;2654.8407095574325;2659.654244948183;2948.6019387382858;2969;4881.707097574157;5365.056683337743;5628.943710562842;5777;5899.675517846474;4770.013632890769;5043.773030213649;5271.339528048652;5513.58648101386;5708.743106560215;4695.882602934954;5599.7480113394995;5725.456081672234;5737.512311453574;5781.624194427349;4780.944193996615;5104.668196567211;5247.790088396574;5320.654157479751;5675.091985282335;4992.775325110306;5351.411344751997;5355.062863998863;5499;5597.944020559905;5147.845564633067;5557.972210138923;5592.664440133605;5833.649981001154;5904.955105752573;3779.3952967525065;3928.8035598220545;3943.023017621792;3951.3677811550015;4454.732716037048;5070.721110338966;5175.37895452533;5330.773921998039;5425.233131103087;5630.3109067280475;4714.7406892619865;5111.747621832675;5225.817096401608;5355.732213389237;5429.918551221814;4459.777011149495;4816.8554943351755;5014.297998280171;5118.564921981673;5447.3735520414075;4913.484084171254;4974.228994505857;5138.049460849755;5366.302380690485;5384.6769193848495;4946.985867897144;5092.363454568179;5282.445343239058;5535.972320138373;5576.721163941867;4566.589006989387;5141.331626888481;5205.349331333583;5403.351597808288;5420.53925416344 02:33:35 INFO - PROCESS | 1643 | |5;yui.html;632.6235889645659;751.4326683354067;765.743475935562;820.552798724695;822.1080128061055;14978.775318370233;15159.014664046828;15801.920990395047;15805.604859878495;15935;11613.941930290357;12056.57801976931;14333;14560.417583296656;14577.708445831076;913.9314551408638;921.806420651664;938.2681508423441;940.7695114696909;953.9856902146473;926.754410081329;933.2207606648457;934.4066517761237;934.5420743835506;956.4404823178448;989.9257555683353;989.9554520046579;990.10395591989;991.5934466868586;991.7966816802574;981.79873126009;985.4481490365418;985.4579981010415;985.5762022330395;986.753311672082;731.1226528166169;731.5464412064554;731.5647189921988;732.0556482138036;732.798480417884;15414.306356213998;15912.840871591368;15928.362865485367;16298;16748.99506029642;12815;13634;14126.646833829134;14213.78679319811;14248.21634810085;11435;11663.24188927717;11757.118216133824;11861.881381186251;11938.164328497009;3654.524911761481;3677.4530012168934;3683.3922402803505;3735.62643735627;3862.092408284051;79934.60032699858;106755;106928.46535767349;106938.3959240612;107885.46057269743;10279.845802312972;10484.73788155287;10606.310589811792;10961.725956851142;11182.552697891993;22469.325920222418;22727.545449090925;22740.43148921257;22744.772552274597;22758;7700.933837466644;7767.02912135983;7822.647980840876;7911.723089691834;7919.920800792033;4239.957600424018;4251.022264879033;4347.673924455678;4364.454443194601;4411.889702757392;3430.468277417004;3527.5943266524678;3531.5585551806025;3535.398982173037;3543.291341731664;515.8692711773783;624.7376102037156;626.8652239768471;627.6046090962665;629.6096420219493;688.2326206279962;697.1842943755818;711.9501634885509;713.9071920650387;719.6617589732817;9632.373895696757;10097.646582369582;10355.01627345401;10520.316179448311;10541.84187237192;666.3270097201861;666.3403230801472;687.3504538211442;712.3482013957171;712.4193782067598;4111.938320925188;4738.715677059387;4944.134776414113;4953.50464953509;4976.8755781105765;98743.50628246812;106846.3973040405;107037;110040.4497977505;111316;48103.5189648106;75882.9999999989;80254.19745802584;84715.57642211749;93340;76558.23441765511;80222;80396;81873.18126818656;81923;9066.320025997944;10368.326058806153;10542.262041657317;11260.549578016788;11281.661550153509;46113;47217.527824721314;47640;49761;51760.48239517557;65403.67298163479;67063.66468167628;68404;69867.65066174636;71254.64372678104;12551.121421500407;12657.11400201977;12859.614211573293;13200.867991319963;13668.384922678702;14540.345684444437;14598.562043138723;14700;15187.772183417479;15530.1458419788;11732.237404568676;12096.637100886988;12372.319522426353;12438.378081095729;12526.812097818722;13305.866941330463;13855.96080294002;13865.514706985206;13870.375833087333;13970.930145349615;13081.62298311671;13332.404985229381;13552.390142443812;13662.11196272239;14079.225642589756;8382.874256886029;8455.11221321777;9015.594298256463;9206.539673016456;9505;9878.811786265416;9972.122023601563;9992.197478344067;10085.142762864945;10141.036601522843 02:33:35 INFO - PROCESS | 1643 | __end_tp_report 02:33:35 INFO - PROCESS | 1643 | __start_cc_report 02:33:35 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1618 02:33:35 INFO - PROCESS | 1643 | __end_cc_report 02:33:35 INFO - PROCESS | 1643 | __startTimestamp1493976815097__endTimestamp 02:33:35 INFO - PROCESS | 1643 | 02:33:35 INFO - PROCESS | 1643 | ------- Summary: start ------- 02:33:35 INFO - PROCESS | 1643 | Number of tests: 6 02:33:35 INFO - PROCESS | 1643 | 02:33:35 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5832.30 Median:6095.91 stddev:645.58 (10.6%) stddev-sans-first:618.28 02:33:35 INFO - PROCESS | 1643 | Values: 3381.7 3387.4 3395.6 3399.1 3435.9 5845.8 5865.2 5868.9 5873.7 5920.9 5862.0 5910.3 5918.2 5938.5 5946.5 5252.2 5277.7 5293.6 5337.9 5381.8 5230.0 5235.3 5289.2 5397.2 5420.9 5308.8 5340.5 5343.8 5384.9 5431.3 5356.8 5375.8 5379.8 5401.0 5402.8 5140.3 5235.0 5275.7 5296.7 5362.8 5717.3 5719.4 5733.7 5757.3 5768.8 5129.3 6211.5 6245.7 6258.8 6259.7 6270.7 6324.4 6327.8 6330.6 6342.6 5991.3 6044.7 6058.5 6066.6 6081.5 6206.8 6287.9 6296.9 6325.7 6347.6 6317.9 6324.4 6329.7 6339.7 6340.2 6262.5 6273.7 6312.8 6317.8 6346.4 6122.2 6188.1 6219.3 6242.0 6291.7 6222.0 6244.2 6257.3 6279.8 6295.3 5091.9 5093.2 5094.2 5102.2 5103.7 4508.1 4541.1 4546.6 4550.4 4592.5 5016.3 5216.0 5763.1 5778.8 5782.5 6311.9 6312.9 6321.7 6340.4 6343.6 5898.4 5922.8 5943.5 5975.6 5976.5 5580.7 5588.3 5590.2 5592.2 5594.5 6468.1 6478.4 6481.5 6486.5 6493.9 6204.2 6235.7 6238.6 6249.3 6284.8 6432.5 6436.1 6445.3 6452.9 6457.0 6295.3 6308.6 6308.7 6330.6 6344.2 5166.3 6206.8 6216.8 6237.4 6291.4 5494.3 6154.5 6250.2 6291.9 6303.5 6250.1 6269.4 6278.9 6283.6 6302.1 5921.6 5934.3 6082.1 6141.2 6174.4 6209.4 6220.3 6273.4 6280.5 6284.4 5158.6 6095.9 6099.0 6108.7 6109.3 02:33:35 INFO - PROCESS | 1643 | 02:33:35 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:48139.11 Median:17372.77 stddev:94066.59 (541.5%) stddev-sans-first:94263.31 02:33:35 INFO - PROCESS | 1643 | Values: 796.3 874.5 894.5 899.0 969.8 38317.0 38718.8 40574.2 40616.6 40711.8 38882.4 38989.6 39037.2 39076.2 39237.4 6501.2 7808.2 7962.2 7974.2 7994.2 7390.6 7463.1 7463.7 7469.5 11067.4 11273.4 11302.4 11302.8 11313.0 11377.5 11191.8 11235.0 11248.4 11250.7 11261.3 7292.2 7499.0 11023.6 11085.7 11098.6 28405.1 28578.3 28606.7 39312.8 39947.0 3745.9 3830.3 3852.7 3878.7 3926.4 24850.4 24865.5 24900.8 25220.7 25883.5 2876.8 3161.5 3164.2 3166.2 3167.4 365051.0 368323.0 368478.0 368669.0 368680.0 37143.3 37850.4 44549.1 44644.3 44776.7 39358.8 39369.8 39528.0 39598.0 39610.0 11557.2 13526.9 14031.9 14061.4 14085.4 10142.8 12000.5 12061.4 12065.7 12076.3 9653.6 11890.4 11982.6 11988.9 12013.2 5430.7 5596.8 5614.2 5621.1 5625.0 1008.9 1107.9 1123.6 1140.4 1141.9 25262.0 26309.3 27072.4 27358.0 27455.9 1240.3 1252.4 1281.3 1284.7 1295.8 13965.7 14115.2 14130.4 14177.5 14256.0 195860.0 196993.0 196999.0 197161.0 197332.0 58389.0 58900.7 59027.0 59066.0 59123.0 1427.5 1439.2 1468.2 1468.5 1472.7 20208.0 25533.9 26406.2 26491.9 26513.6 43479.8 43507.6 43586.5 43617.0 43652.9 447929.0 449399.0 450023.0 450052.0 450755.7 30210.4 33122.2 33150.0 33242.5 33256.0 45255.9 45397.8 45513.6 45891.3 46176.1 30258.7 30458.0 30528.5 30531.4 31584.1 23271.8 29926.7 31099.8 31152.7 31210.7 36467.8 36957.6 37547.2 37970.8 38075.6 30777.5 31032.5 31280.9 31753.5 32077.8 19172.7 23613.0 24263.8 24275.9 24830.9 02:33:35 INFO - PROCESS | 1643 | 02:33:35 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:39024.10 Median:25014.62 stddev:108898.32 (435.3%) stddev-sans-first:109165.17 02:33:35 INFO - PROCESS | 1643 | Values: 389.0 389.8 410.0 426.1 432.9 12807.5 14479.4 20382.9 20776.9 20846.3 21584.7 21876.1 22145.4 22376.0 22482.0 6719.4 6738.4 6813.4 6907.8 6923.4 4159.4 4466.7 6853.9 6899.8 6925.0 4469.7 7922.4 7940.2 7943.4 7949.3 7631.5 7874.3 7961.4 7962.0 7969.4 6915.2 7214.2 7708.1 7716.8 7724.9 24518.0 25511.2 25871.5 25906.5 26206.3 2800.4 2844.2 2856.3 2883.7 2931.1 15352.6 15975.1 16160.3 16334.7 16694.3 2044.4 2054.2 2085.2 2097.9 2197.6 104536.0 107757.0 128751.0 154862.0 155305.4 19674.2 20097.0 20270.4 20294.3 20391.5 25669.9 30759.4 31353.2 31365.0 31444.7 9948.7 10127.7 10254.6 10291.4 10463.8 8483.4 8501.1 8529.1 8672.0 8690.8 7604.6 9173.0 9249.0 9346.1 9353.7 3962.9 4021.7 4043.3 4045.6 4048.6 832.9 835.9 852.7 899.9 903.7 20293.6 20986.3 21809.8 21885.9 21892.3 928.6 966.1 966.7 984.5 995.3 10340.6 10399.3 10965.6 11050.8 11072.6 444683.0 477467.0 622993.0 784238.0 818333.0 134491.3 146947.0 156151.0 167099.0 175408.0 1216.4 1239.2 1257.7 1258.8 1266.3 17739.6 18520.9 18654.9 18658.0 18714.8 56140.7 59216.7 63682.7 64630.0 65516.7 90824.1 91192.0 91288.5 93177.0 93446.0 10703.7 10904.3 11122.9 11313.7 11481.3 11863.3 12408.5 12575.0 12675.6 12960.3 10090.3 10965.6 11118.0 11146.8 11247.4 9732.8 9878.7 9916.9 10079.4 10119.8 11149.9 11154.5 11192.9 11236.4 11397.0 10923.0 10993.4 11137.5 11204.8 11207.5 9068.7 10153.6 10796.1 11084.7 11237.3 02:33:35 INFO - PROCESS | 1643 | 02:33:35 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:6661.63 Median:2391.87 stddev:4194.55 (175.4%) stddev-sans-first:4188.60 02:33:35 INFO - PROCESS | 1643 | Values: 1530.3 1548.2 1576.5 1586.5 1602.1 10658.3 11147.7 11155.5 11175.3 11187.3 10595.7 10927.0 10951.9 11025.5 11068.4 2351.7 2388.6 2389.5 2391.6 2392.2 2284.1 2370.4 2389.0 2394.0 2394.5 2240.7 2244.9 2253.8 2347.8 2353.8 2252.7 2274.2 2276.4 2278.7 2318.9 2308.1 2315.5 2321.2 2321.5 2327.6 10967.5 11029.7 11057.2 11090.5 11103.7 5510.7 5678.0 5678.9 5687.2 5693.4 2958.0 3009.6 3092.7 3246.8 3255.7 1113.5 1129.8 1164.9 1172.3 1189.7 13739.2 14077.5 14321.3 15157.5 15202.2 4068.6 4298.1 4449.7 4614.9 4618.1 11660.3 11664.7 11678.5 11689.4 11704.8 4842.7 5631.4 5646.7 5654.5 5665.9 4407.4 5072.8 5218.0 5285.4 5296.5 3661.9 3758.2 3829.7 3854.9 3864.9 984.1 988.4 994.8 1000.5 1004.4 800.9 882.5 890.1 928.2 951.3 6671.8 6719.8 6750.1 6811.7 6845.3 991.1 993.5 997.5 1011.7 1016.7 4107.9 4260.7 4315.7 4386.5 4478.3 13077.0 13688.5 13712.6 13732.9 13796.7 13204.5 13478.0 13605.1 13648.7 13653.9 10011.9 10107.5 10149.1 10155.8 10169.4 4688.6 6467.5 6555.1 6582.3 6649.5 11768.2 12145.0 12152.1 12153.4 12163.9 11934.3 12138.9 12363.3 12371.1 12510.6 9264.4 9287.2 9321.5 9378.6 9426.2 10195.7 10295.5 10369.5 10390.8 10394.5 8835.7 8906.4 8917.3 8997.5 9096.4 8689.0 8724.0 8737.0 8777.5 8801.7 7795.3 7834.0 7919.3 7921.7 7934.5 5538.2 5846.8 5859.6 5927.5 5999.7 5703.1 5826.5 5916.6 6082.6 6180.1 02:33:35 INFO - PROCESS | 1643 | 02:33:35 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4463.51 Median:4775.48 stddev:1244.75 (26.1%) stddev-sans-first:1209.51 02:33:35 INFO - PROCESS | 1643 | Values: 358.5 366.7 374.6 378.2 386.8 4326.4 4676.4 5090.6 5120.5 5158.6 4849.5 4858.4 4998.6 5003.0 5052.9 3599.3 3936.8 4302.4 4311.6 4366.6 3583.5 3702.7 4316.6 4321.4 4362.2 3445.8 4068.5 4148.6 4409.9 4437.2 4290.0 4293.7 4346.0 4357.3 4365.8 3647.9 3919.3 3929.9 4131.5 4137.8 4179.5 4399.0 4408.5 4604.6 5035.9 4028.8 4298.5 4337.3 4536.8 4734.1 4419.9 5237.5 5306.0 5356.8 5506.9 4105.9 4300.6 4382.4 4400.7 4456.9 4720.9 4769.8 5158.6 5537.3 5667.4 3867.8 4376.7 4428.9 4479.7 4479.8 3932.5 4284.3 4489.8 4511.0 4577.9 3986.7 4266.1 4672.0 4701.6 4841.6 4485.5 5032.3 5466.2 5466.8 5467.5 1312.8 1362.5 1406.3 1479.9 1567.5 1072.7 1077.7 1083.5 1160.4 1175.9 4396.9 4447.8 4844.8 4977.3 5036.6 4876.5 5100.8 5616.5 5694.5 5701.8 4860.9 5011.0 5055.9 5092.1 5104.3 2550.0 2654.8 2659.7 2948.6 2969.0 4881.7 5365.1 5628.9 5777.0 5899.7 4770.0 5043.8 5271.3 5513.6 5708.7 4695.9 5599.7 5725.5 5737.5 5781.6 4780.9 5104.7 5247.8 5320.7 5675.1 4992.8 5351.4 5355.1 5499.0 5597.9 5147.8 5558.0 5592.7 5833.6 5905.0 3779.4 3928.8 3943.0 3951.4 4454.7 5070.7 5175.4 5330.8 5425.2 5630.3 4714.7 5111.7 5225.8 5355.7 5429.9 4459.8 4816.9 5014.3 5118.6 5447.4 4913.5 4974.2 5138.0 5366.3 5384.7 4947.0 5092.4 5282.4 5536.0 5576.7 4566.6 5141.3 5205.3 5403.4 5420.5 02:33:35 INFO - PROCESS | 1643 | 02:33:35 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20126.77 Median:4299.35 stddev:28918.74 (672.6%) stddev-sans-first:28962.82 02:33:35 INFO - PROCESS | 1643 | Values: 632.6 751.4 765.7 820.6 822.1 14978.8 15159.0 15801.9 15805.6 15935.0 11613.9 12056.6 14333.0 14560.4 14577.7 913.9 921.8 938.3 940.8 954.0 926.8 933.2 934.4 934.5 956.4 989.9 990.0 990.1 991.6 991.8 981.8 985.4 985.5 985.6 986.8 731.1 731.5 731.6 732.1 732.8 15414.3 15912.8 15928.4 16298.0 16749.0 12815.0 13634.0 14126.6 14213.8 14248.2 11435.0 11663.2 11757.1 11861.9 11938.2 3654.5 3677.5 3683.4 3735.6 3862.1 79934.6 106755.0 106928.5 106938.4 107885.5 10279.8 10484.7 10606.3 10961.7 11182.6 22469.3 22727.5 22740.4 22744.8 22758.0 7700.9 7767.0 7822.6 7911.7 7919.9 4240.0 4251.0 4347.7 4364.5 4411.9 3430.5 3527.6 3531.6 3535.4 3543.3 515.9 624.7 626.9 627.6 629.6 688.2 697.2 712.0 713.9 719.7 9632.4 10097.6 10355.0 10520.3 10541.8 666.3 666.3 687.4 712.3 712.4 4111.9 4738.7 4944.1 4953.5 4976.9 98743.5 106846.4 107037.0 110040.4 111316.0 48103.5 75883.0 80254.2 84715.6 93340.0 76558.2 80222.0 80396.0 81873.2 81923.0 9066.3 10368.3 10542.3 11260.5 11281.7 46113.0 47217.5 47640.0 49761.0 51760.5 65403.7 67063.7 68404.0 69867.7 71254.6 12551.1 12657.1 12859.6 13200.9 13668.4 14540.3 14598.6 14700.0 15187.8 15530.1 11732.2 12096.6 12372.3 12438.4 12526.8 13305.9 13856.0 13865.5 13870.4 13970.9 13081.6 13332.4 13552.4 13662.1 14079.2 8382.9 8455.1 9015.6 9206.5 9505.0 9878.8 9972.1 9992.2 10085.1 10141.0 02:33:35 INFO - PROCESS | 1643 | -------- Summary: end -------- 02:33:35 INFO - PROCESS | 1643 | 02:33:35 INFO - TEST-INFO | 1643: exit 0 02:33:35 INFO - TEST-OK | dromaeo_css | took 1119883ms 02:33:35 INFO - TEST-START | kraken 02:33:35 INFO - operating with platform_type : mac_ 02:33:35 INFO - Initialising browser for kraken test... 02:33:35 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpM5zmax/profile http://localhost:49242/getInfo.html) 02:33:38 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 02:33:38 INFO - PROCESS | 1650 | colorDepth:24 02:33:38 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 02:33:38 INFO - PROCESS | 1650 | __metrics 02:33:38 INFO - PROCESS | 1650 | 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" 02:33:38 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:33:39 INFO - TEST-INFO | 1650: exit 0 02:33:39 INFO - Browser initialized. 02:33:39 INFO - Running cycle 1/1 for kraken test... 02:33:39 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/tmpM5zmax/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:51 INFO - PROCESS | 1652 | RSS: Main: 214622208 02:33:51 INFO - PROCESS | 1652 | 02:33:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 02:33:54 INFO - PROCESS | 1652 | RSS: Main: 267489280 02:33:54 INFO - PROCESS | 1652 | 02:33:57 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 02:33:58 INFO - PROCESS | 1652 | RSS: Main: 278851584 02:33:58 INFO - PROCESS | 1652 | 02:34:01 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 02:34:01 INFO - PROCESS | 1652 | RSS: Main: 376020992 02:34:01 INFO - PROCESS | 1652 | 02:34:04 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 02:34:04 INFO - PROCESS | 1652 | RSS: Main: 277852160 02:34:04 INFO - PROCESS | 1652 | 02:34:06 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:34:07 INFO - PROCESS | 1652 | RSS: Main: 279003136 02:34:07 INFO - PROCESS | 1652 | 02:34:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 02:34:10 INFO - PROCESS | 1652 | RSS: Main: 320196608 02:34:10 INFO - PROCESS | 1652 | 02:34:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 02:34:14 INFO - PROCESS | 1652 | RSS: Main: 321409024 02:34:14 INFO - PROCESS | 1652 | 02:34:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 02:34:18 INFO - PROCESS | 1652 | RSS: Main: 317313024 02:34:18 INFO - PROCESS | 1652 | 02:34:19 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:34:20 INFO - PROCESS | 1652 | RSS: Main: 293711872 02:34:20 INFO - PROCESS | 1652 | 02:34:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:34:22 INFO - PROCESS | 1652 | RSS: Main: 298819584 02:34:22 INFO - PROCESS | 1652 | 02:34:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:34:25 INFO - PROCESS | 1652 | RSS: Main: 307089408 02:34:25 INFO - PROCESS | 1652 | 02:34:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:34:29 INFO - PROCESS | 1652 | RSS: Main: 318382080 02:34:29 INFO - PROCESS | 1652 | 02:34:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:34:32 INFO - PROCESS | 1652 | RSS: Main: 312569856 02:34:32 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 02:34:34 INFO - PROCESS | 1652 | RSS: Main: 357040128 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | __start_tp_report 02:34:34 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 02:34:34 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 02:34:34 INFO - PROCESS | 1652 | |i|pagename|runs| 02:34:34 INFO - PROCESS | 1652 | |0;ai-astar;117;116;116;140;172;143;115;116;117;115 02:34:34 INFO - PROCESS | 1652 | |1;audio-beat-detection;144;110;108;145;110;111;109;107;130;120 02:34:34 INFO - PROCESS | 1652 | |2;audio-dft;183;187;184;187;184;185;182;184;185;184 02:34:34 INFO - PROCESS | 1652 | |3;audio-fft;84;79;83;91;64;61;60;60;74;60 02:34:34 INFO - PROCESS | 1652 | |4;audio-oscillator;89;69;87;70;70;68;82;71;69;84 02:34:34 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;88;86;90;87;86;90;90;88;86;86 02:34:34 INFO - PROCESS | 1652 | |6;imaging-darkroom;93;94;95;94;95;94;95;94;94;94 02:34:34 INFO - PROCESS | 1652 | |7;imaging-desaturate;84;93;137;98;83;85;86;87;84;84 02:34:34 INFO - PROCESS | 1652 | |8;json-parse-financial;62;64;60;60;66;65;63;63;64;63 02:34:34 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;55;57;67;61;63;57;57;58;58;57 02:34:34 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;79;76;83;81;86;81;84;86;84;84 02:34:34 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;139;138;137;135;135;136;136;142;188;136 02:34:34 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;165;164;163;163;162;218;177;165;165;165 02:34:34 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;65;66;64;64;77;81;79;78;72;63 02:34:34 INFO - PROCESS | 1652 | __end_tp_report 02:34:34 INFO - PROCESS | 1652 | __start_cc_report 02:34:34 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2188 02:34:34 INFO - PROCESS | 1652 | __end_cc_report 02:34:34 INFO - PROCESS | 1652 | __startTimestamp1493976874735__endTimestamp 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | ------- Summary: start ------- 02:34:34 INFO - PROCESS | 1652 | Number of tests: 14 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:126.70 Median:117.00 stddev:19.15 (16.4%) stddev-sans-first:19.99 02:34:34 INFO - PROCESS | 1652 | Values: 117.0 116.0 116.0 140.0 172.0 143.0 115.0 116.0 117.0 115.0 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:119.40 Median:115.50 stddev:14.95 (12.9%) stddev-sans-first:12.94 02:34:34 INFO - PROCESS | 1652 | Values: 144.0 110.0 108.0 145.0 110.0 111.0 109.0 107.0 130.0 120.0 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:184.50 Median:184.50 stddev:1.58 (0.9%) stddev-sans-first:1.58 02:34:34 INFO - PROCESS | 1652 | Values: 183.0 187.0 184.0 187.0 184.0 185.0 182.0 184.0 185.0 184.0 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:71.60 Median:76.50 stddev:11.99 (15.7%) stddev-sans-first:11.85 02:34:34 INFO - PROCESS | 1652 | Values: 84.0 79.0 83.0 91.0 64.0 61.0 60.0 60.0 74.0 60.0 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:75.90 Median:76.50 stddev:8.49 (11.1%) stddev-sans-first:7.57 02:34:34 INFO - PROCESS | 1652 | Values: 89.0 69.0 87.0 70.0 70.0 68.0 82.0 71.0 69.0 84.0 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:88.00 stddev:1.77 (2.0%) stddev-sans-first:1.87 02:34:34 INFO - PROCESS | 1652 | Values: 88.0 86.0 90.0 87.0 86.0 90.0 90.0 88.0 86.0 86.0 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 02:34:34 INFO - PROCESS | 1652 | Values: 93.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 94.0 94.0 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:92.10 Median:85.50 stddev:16.48 (19.3%) stddev-sans-first:17.22 02:34:34 INFO - PROCESS | 1652 | Values: 84.0 93.0 137.0 98.0 83.0 85.0 86.0 87.0 84.0 84.0 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.50 stddev:1.94 (3.1%) stddev-sans-first:2.03 02:34:34 INFO - PROCESS | 1652 | Values: 62.0 64.0 60.0 60.0 66.0 65.0 63.0 63.0 64.0 63.0 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:58.00 stddev:3.62 (6.2%) stddev-sans-first:3.54 02:34:34 INFO - PROCESS | 1652 | Values: 55.0 57.0 67.0 61.0 63.0 57.0 57.0 58.0 58.0 57.0 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:84.00 stddev:3.17 (3.8%) stddev-sans-first:3.11 02:34:34 INFO - PROCESS | 1652 | Values: 79.0 76.0 83.0 81.0 86.0 81.0 84.0 86.0 84.0 84.0 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:137.50 stddev:16.23 (11.8%) stddev-sans-first:17.18 02:34:34 INFO - PROCESS | 1652 | Values: 139.0 138.0 137.0 135.0 135.0 136.0 136.0 142.0 188.0 136.0 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:165.00 stddev:17.15 (10.4%) stddev-sans-first:18.06 02:34:34 INFO - PROCESS | 1652 | Values: 165.0 164.0 163.0 163.0 162.0 218.0 177.0 165.0 165.0 165.0 02:34:34 INFO - PROCESS | 1652 | 02:34:34 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:74.50 stddev:7.25 (9.7%) stddev-sans-first:7.37 02:34:34 INFO - PROCESS | 1652 | Values: 65.0 66.0 64.0 64.0 77.0 81.0 79.0 78.0 72.0 63.0 02:34:34 INFO - PROCESS | 1652 | -------- Summary: end -------- 02:34:34 INFO - PROCESS | 1652 | 02:34:35 INFO - TEST-INFO | 1652: exit 0 02:34:35 INFO - TEST-OK | kraken | took 59909ms 02:34:35 INFO - SUITE-END | took 1179s 02:34:35 INFO - Completed test suite (00:19:40) 02:34:35 INFO - javascript benchmark 02:34:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7525.755293587068, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3381.6787405196505, 3387.407203739345, 3395.5925288965327, 3399.082247793094, 3435.9484607730874, 5845.766169353232, 5865.237519122519, 5868.911966320503, 5873.706314684259, 5920.9407905920925, 5862.032764593848, 5910.34986151524, 5918.171455996164, 5938.52491800656, 5946.464818166364, 5252.212168174766, 5277.683338999673, 5293.602979776513, 5337.866553336159, 5381.81163659272, 5230.006298803215, 5235.2670626112185, 5289.20661900716, 5397.163439666858, 5420.945790542103, 5308.814191503298, 5340.54605358545, 5343.759530821122, 5384.91922621161, 5431.266778984846, 5356.812511562096, 5375.784968601251, 5379.81170659027, 5401.0, 5402.8109016184635, 5140.254663073833, 5235.005348983681, 5275.736213189325, 5296.663867091428, 5362.812301569426, 5717.342505611825, 5719.370869204384, 5733.684647344395, 5757.251557297566, 5768.7980920668, 5129.307543481619, 6211.47202487789, 6245.718942647592, 6258.812235632939, 6259.655718935457, 6270.749170033193, 6324.430801227912, 6327.778527751507, 6330.556861019731, 6342.587731797418, 5991.3109992351, 6044.697765111727, 6058.454739073504, 6066.636001839904, 6081.452669259744, 6206.751729930752, 6287.9056814147825, 6296.874062518816, 6325.65208913505, 6347.587406818542, 6317.905231421532, 6324.3991820776955, 6329.746810127635, 6339.714712837934, 6340.207474065742, 6262.467690246289, 6273.749129613033, 6312.779052733133, 6317.810465686037, 6346.365363463709, 6122.215193971364, 6188.1027251048345, 6219.315875253718, 6242.032484964838, 6291.748330066837, 6221.96889015552, 6244.1570387997945, 6257.2804127525005, 6279.843003924939, 6295.276043254993, 5091.9236211456855, 5093.18509038552, 5094.2358646203365, 5102.209157580581, 5103.668261562986, 4508.143452744033, 4541.091781643684, 4546.568076032771, 4550.385697930737, 4592.517785632461, 5016.322796422509, 5215.973920130451, 5763.135529670583, 5778.797742079007, 5782.45066718661, 6311.873762524816, 6312.873742525124, 6321.683915804283, 6340.4293613575, 6343.5876668016435, 5898.439648233411, 5922.763089476372, 5943.494802941798, 5975.581709280395, 5976.491998180203, 5580.693061881636, 5588.30146231721, 5590.24531688225, 5592.161175823578, 5594.496495315359, 6468.094466774655, 6478.449331806849, 6481.5138864584405, 6486.481081513468, 6493.870122597522, 6204.162438070984, 6235.657038862906, 6238.625682459067, 6249.312575616587, 6284.780032698834, 6432.549721519449, 6436.066770318372, 6445.2587952386075, 6452.903206451813, 6456.999165129412, 6295.307516173126, 6308.621482711052, 6308.653024083719, 6330.620162790247, 6344.175257216532, 5166.3025491558155, 6206.782762603287, 6216.813495594958, 6237.376262373908, 6291.370862913672, 5494.2582751328055, 6154.5384096192065, 6250.249970003629, 6291.905621415774, 6303.527235457267, 6250.06249062626, 6269.435750782452, 6278.937210627835, 6283.59156654816, 6302.117703521419, 5921.644701317935, 5934.2878854536, 6082.148499210026, 6141.170941922784, 6174.351693072343, 6209.410106039919, 6220.253569571681, 6273.404026617464, 6280.497560195265, 6284.371562843679, 5158.638895277445, 6095.908561371494, 6099.0, 6108.72510737009, 6109.327973922776], "value": 5791.97554317441, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.2674339607561, 874.5102742464219, 894.5437826708377, 898.9955050224744, 969.7527130581701, 38317.04207394816, 38718.806405968004, 40574.1598088134, 40616.59383406161, 40711.77864664065, 38882.416763748566, 38989.61010389895, 39037.21925561487, 39076.21847563047, 39237.41143882844, 6501.187351581052, 7808.1801410851895, 7962.1639727828615, 7974.1627129151475, 7994.160613135624, 7390.593517356543, 7463.141738700037, 7463.701451941915, 7469.514481558708, 11067.391293478855, 11273.4363281836, 11302.434878256096, 11302.773944521105, 11313.0, 11377.544898204103, 11191.776164476705, 11235.0, 11248.38133902635, 11250.662480125568, 11261.268017578832, 7292.16140143885, 7499.0, 11023.61417350389, 11085.667429977113, 11098.611548595842, 28405.147845564665, 28578.285542861595, 28606.713932860614, 39312.803435982634, 39947.0, 3745.8501659933568, 3830.3296923038633, 3852.711046671483, 3878.6703130233964, 3926.430667553189, 24850.37874053145, 24865.5026899461, 24900.750992490026, 25220.747792522023, 25883.482330353476, 2876.755475784561, 3161.4941609342395, 3164.161497203243, 3166.2401023754364, 3167.4298626247264, 365051.0, 368323.0, 368478.0, 368669.0, 368680.0, 37143.25713485715, 37850.43224351637, 44549.109017819464, 44644.330335045, 44776.65670029904, 39358.803205983786, 39369.80315098406, 39528.0, 39598.0, 39610.0, 11557.24877882935, 13526.93236533811, 14031.859681403259, 14061.367238474293, 14085.436582536584, 10142.847857282146, 12000.519979200733, 12061.396930153458, 12065.698357541132, 12076.275423474619, 9653.565589548487, 11890.405479726152, 11982.58060967862, 11988.880111198776, 12013.219140755822, 5430.701311427831, 5596.776128954796, 5614.214010038598, 5621.128725047624, 5625.0, 1008.9495525223709, 1107.9308467328906, 1123.6347837377461, 1140.3898914080926, 1141.9371934543515, 25262.0, 26309.34226644349, 27072.350504440023, 27358.0, 27455.901763929218, 1240.3364200152876, 1252.4113666576695, 1281.3401098434315, 1284.743051389726, 1295.8315418995471, 13965.65085872841, 14115.218951902483, 14130.434782608787, 14177.503787367392, 14256.0, 195860.0, 196993.0150349239, 196999.0, 197161.0, 197332.0, 58389.0, 58900.70549647224, 59027.0, 59066.0, 59123.0, 1427.4512154312688, 1439.1796675894639, 1468.1778204205466, 1468.4566710317251, 1472.6980968901564, 20208.0, 25533.87233063897, 26406.207813765617, 26491.867540662173, 26513.60229596596, 43479.782601086794, 43507.56492435035, 43586.47447339455, 43617.0, 43652.908677283325, 447929.0, 449399.0, 450023.0, 450052.0, 450755.7462212668, 30210.395792084473, 33122.17194570155, 33150.0, 33242.501362479095, 33256.0, 45255.868603285184, 45397.773011134734, 45513.63459096233, 45891.311630324904, 46176.07647846957, 30258.697413026468, 30458.0, 30528.542071869382, 30531.389372211986, 31584.052478425685, 23271.76728232696, 29926.70073299239, 31099.756009759356, 31152.688473115886, 31210.687893121685, 36467.81766091259, 36957.63042369649, 37547.249055019296, 37970.81014594909, 38075.61924380721, 30777.538336925412, 31032.53451198189, 31280.90516831991, 31753.523697145025, 32077.839610801795, 19172.712409313594, 23613.0, 24263.75736242615, 24275.878620606785, 24830.87584562138], "value": 17793.579809796705, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.0080295247119, 389.838217139887, 409.9938500922487, 426.075416346528, 432.87663016040426, 12807.48770049198, 14479.420823167075, 20382.898085509587, 20776.8961155194, 20846.270380536684, 21584.676229856566, 21876.124955001782, 22145.44636384091, 22375.993080311386, 22481.988310526023, 6719.395254427101, 6738.393544580987, 6813.352731490525, 6907.827304317407, 6923.446124310043, 4159.376093585956, 4466.687331886769, 6853.9314606853795, 6899.827504312382, 6924.965375173142, 4469.664775141861, 7922.445428819985, 7940.2456766607365, 7943.364530837519, 7949.284564389204, 7631.465797394185, 7874.330681892046, 7961.36309095271, 7961.96019019907, 7969.362451003905, 6915.170179578433, 7214.206437291894, 7708.113566939817, 7716.7684969451, 7724.884126738103, 24518.0, 25511.23466296014, 25871.482570348675, 25906.481870362488, 26206.344841378927, 2800.423794151457, 2844.160972513093, 2856.3430411005584, 2883.740463358308, 2931.0913616778867, 15352.616184595363, 15975.121368324737, 16160.27278772458, 16334.673306533803, 16694.332226710918, 2044.356027851222, 2054.1783286685295, 2085.2493102483095, 2097.9370618881458, 2197.5824593327216, 104535.95464045338, 107757.0, 128751.0, 154861.99999999886, 155305.44694553135, 19674.213031478866, 20097.0, 20270.391888243375, 20294.28969986073, 20391.490212744502, 25669.871650641628, 30759.384812304077, 31353.216169595486, 31365.0, 31444.685553144176, 9948.651797187209, 10127.7468063299, 10254.58981640726, 10291.433971131659, 10463.848976612566, 8483.363747718946, 8501.06488286288, 8529.104444033412, 8672.0, 8690.78273043179, 7604.581748003802, 9173.0, 9248.953755231181, 9346.0653934606, 9353.719388418358, 3962.900927476836, 4021.678265738734, 4043.3126368517424, 4045.5752146024242, 4048.6153815387493, 832.9296853543168, 835.9122292159358, 852.6972924611797, 899.869518919766, 903.742433406476, 20293.594128117355, 20986.3307424284, 21809.781902180774, 21885.890570547046, 21892.343229703136, 928.5867788833904, 966.1353088985319, 966.7051549277538, 984.5077461269366, 995.2933417273816, 10340.638077667245, 10399.272050956512, 10965.61620343284, 11050.834237486444, 11072.612458564072, 444683.0, 477467.0, 622993.0, 784238.0, 818333.0, 134491.32754336167, 146947.0, 156151.0, 167099.0, 175408.0, 1216.385725208764, 1239.2130996816907, 1257.6607510031151, 1258.7671280813079, 1266.3098611256887, 17739.556511087325, 18520.907395462935, 18654.880707157616, 18658.0, 18714.812851871306, 56140.71929640326, 59216.70391648014, 63682.68158659177, 64630.0, 65516.724163792576, 90824.0917590842, 91192.0, 91288.54355728444, 93177.0, 93446.0, 10703.732406689584, 10904.291221070605, 11122.888771112186, 11313.71715707114, 11481.253718508271, 11863.288202707865, 12408.503659853866, 12575.0, 12675.556355527513, 12960.287184204959, 10090.293679442368, 10965.61620343284, 11117.999380055833, 11146.770645870696, 11247.437628118725, 9732.805343893224, 9878.654247101316, 9916.900830991886, 10079.445630490394, 10119.848202276824, 11149.888501114885, 11154.498047587716, 11192.944035279772, 11236.438178090899, 11397.031252343644, 10923.0, 10993.395363254778, 11137.498812553293, 11204.83192752093, 11207.495662695035, 9068.727938161866, 10153.64462243818, 10796.082333001783, 11084.667459976214, 11237.269577477438], "value": 11306.017176479221, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.296063810647, 1548.2258870564717, 1576.5428025872504, 1586.4843925724135, 1602.1348471825215, 10658.307210031353, 11147.665570032892, 11155.498002589893, 11175.329480231181, 11187.32876027439, 10595.735106622338, 10927.0, 10951.945240273788, 11025.503852326645, 11068.3912384819, 2351.6825228594134, 2388.5581167483983, 2389.51015041916, 2391.5695174868515, 2392.162743039931, 2284.0749496453964, 2370.4473569811803, 2388.9999999999914, 2394.030417680842, 2394.4732158925094, 2240.7423146338137, 2244.898979545916, 2253.763354847734, 2347.8121750260025, 2353.8234632402555, 2252.718410198725, 2274.1585613323095, 2276.4422716434415, 2278.737945136306, 2318.8724620145886, 2308.0536979838353, 2315.5021670340957, 2321.245595181556, 2321.5356928614347, 2327.569399661051, 10967.451627418597, 11029.724256893562, 11057.170712196617, 11090.500927458284, 11103.72240693981, 5510.669359838423, 5678.0, 5678.9432105678825, 5687.203791469197, 5693.402192769741, 2958.00906696257, 3009.593704849839, 3092.721655051034, 3246.788958717676, 3255.658155893621, 1113.5323164271026, 1129.8305254211853, 1164.885732395699, 1172.255617682769, 1189.6906804230875, 13739.24434156121, 14077.507287245, 14321.283935803272, 15157.469488567847, 15202.239888005555, 4068.572799856032, 4298.118885628439, 4449.7330160190495, 4614.930776038362, 4618.122556714214, 11660.30038197711, 11664.708382290512, 11678.474468648761, 11689.415529223676, 11704.765904681859, 4842.685225460334, 5631.436856314336, 5646.717664116778, 5654.5193658538665, 5665.858353541112, 4407.42703448556, 5072.771725272371, 5218.034663587248, 5285.418603953562, 5296.549793267615, 3661.853525858936, 3758.248350329945, 3829.6744776694295, 3854.903627409281, 3864.903377415531, 984.1192133040888, 988.3575675810637, 994.7612572982576, 1000.5047501486811, 1004.4224570871631, 800.87986801979, 882.4705176893813, 890.1365675295083, 928.2481190235931, 951.2580187453659, 6671.799846004627, 6719.832004199934, 6750.054992301082, 6811.727530898807, 6845.313627429066, 991.1228562722043, 993.4734590666958, 997.5012493753123, 1011.7116621762763, 1016.6899095775711, 4107.938380924288, 4260.672816330565, 4315.654747620183, 4386.4736231652405, 4478.328250762412, 13077.01922355827, 13688.52090176859, 13712.588622341345, 13732.86267137316, 13796.655083622789, 13204.471821127046, 13477.999999999804, 13605.115667481581, 13648.65878353049, 13653.863461365458, 10011.949940250252, 10107.494625268855, 10149.086582207638, 10155.796884062425, 10169.389836609827, 4688.578027977498, 6467.514936379885, 6555.115059466911, 6582.308857569887, 6649.501287403367, 11768.235064720766, 12144.96767774749, 12152.149349545447, 12153.392330383269, 12163.939180304396, 11934.343611101473, 12138.878611213775, 12363.258204507758, 12371.072169587496, 12510.562130325396, 9264.351495395527, 9287.164155226063, 9321.487318197564, 9378.624855005995, 9426.245900328095, 10195.7451063724, 10295.485225738832, 10369.481525923824, 10390.792184156426, 10394.48027598602, 8835.69075082369, 8906.376553641441, 8917.331200159884, 8997.505137217517, 9096.363254572381, 8689.000764911863, 8724.0, 8736.956315218384, 8777.517236551796, 8801.691940782042, 7795.298423141718, 7834.020747406575, 7919.326857217201, 7921.722739704082, 7934.484258523177, 5538.224648549287, 5846.824595262149, 5859.589828711949, 5927.525797936241, 5999.70001499932, 5703.116017017369, 5826.533877289891, 5916.645001299936, 6082.60463069899, 6180.134781130555], "value": 5049.752984792613, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.51958375776456, 366.6736604422065, 374.62350337910397, 378.18689816893675, 386.82979489024825, 4326.351047342896, 4676.381226513155, 5090.643654944155, 5120.539151476366, 5158.587313014959, 4849.490803465629, 4858.392700912386, 4998.57512111471, 5003.0, 5052.873678158048, 3599.3341231872123, 3936.7757217172207, 4302.354646802974, 4311.636923199909, 4366.607005369516, 3583.5341405617364, 3702.740808143431, 4316.56834316569, 4321.438213032301, 4362.16459301455, 3445.8284183377646, 4068.4507591475067, 4148.561039687535, 4409.889752756175, 4437.2472873215065, 4289.970407102304, 4293.742375457483, 4345.97827010863, 4357.320248047428, 4365.847195348163, 3647.94528082079, 3919.274934137165, 3929.9367831888203, 4131.5455299916985, 4137.765606572447, 4179.477565304337, 4399.0204408016525, 4408.470983482002, 4604.631629469634, 5035.924461133086, 4028.798560071985, 4298.527162012176, 4337.267521461491, 4536.841210557648, 4734.100520901018, 4419.911601767979, 5237.454950789526, 5305.965336759334, 5356.8306584146485, 5506.91739623906, 4105.91788164235, 4300.6344460720875, 4382.400423845305, 4400.669949753749, 4456.9331460028125, 4720.905581888377, 4769.761511924425, 5158.587313014949, 5537.280153580009, 5667.433256674382, 3867.8452861885207, 4376.737395756265, 4428.889277768018, 4479.70881892676, 4479.820807167742, 3932.4691166692132, 4284.3145096784365, 4489.7979590918485, 4510.985028368591, 4577.885552861205, 3986.700997425147, 4266.06146647737, 4671.991043851177, 4701.613024157813, 4841.588464980446, 4485.529019452975, 5032.314174751426, 5466.234727138204, 5466.781328746885, 5467.480589344006, 1312.8030795380769, 1362.4686372314804, 1406.3405181885269, 1479.9260036998107, 1567.4905655661955, 1072.6835583502886, 1077.6820837852852, 1083.4636854756789, 1160.3791971295316, 1175.8882906124077, 4396.86751925316, 4447.777611119431, 4844.8304309349005, 4977.276132447641, 5036.597072234213, 4876.4879687633, 5100.846974590768, 5616.466435688603, 5694.4590263924865, 5701.800436984769, 4860.896059137891, 5010.997800439854, 5055.949440505621, 5092.108880945893, 5104.259882317043, 2549.961750573743, 2654.8407095574325, 2659.654244948183, 2948.6019387382858, 2969.0, 4881.707097574157, 5365.056683337743, 5628.943710562842, 5777.0, 5899.675517846474, 4770.013632890769, 5043.773030213649, 5271.339528048652, 5513.58648101386, 5708.743106560215, 4695.882602934954, 5599.7480113394995, 5725.456081672234, 5737.512311453574, 5781.624194427349, 4780.944193996615, 5104.668196567211, 5247.790088396574, 5320.654157479751, 5675.091985282335, 4992.775325110306, 5351.411344751997, 5355.062863998863, 5499.0, 5597.944020559905, 5147.845564633067, 5557.972210138923, 5592.664440133605, 5833.649981001154, 5904.955105752573, 3779.3952967525065, 3928.8035598220545, 3943.023017621792, 3951.3677811550015, 4454.732716037048, 5070.721110338966, 5175.37895452533, 5330.773921998039, 5425.233131103087, 5630.3109067280475, 4714.7406892619865, 5111.747621832675, 5225.817096401608, 5355.732213389237, 5429.918551221814, 4459.777011149495, 4816.8554943351755, 5014.297998280171, 5118.564921981673, 5447.3735520414075, 4913.484084171254, 4974.228994505857, 5138.049460849755, 5366.302380690485, 5384.6769193848495, 4946.985867897144, 5092.363454568179, 5282.445343239058, 5535.972320138373, 5576.721163941867, 4566.589006989387, 5141.331626888481, 5205.349331333583, 5403.351597808288, 5420.53925416344], "value": 4100.85168869264, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.6235889645659, 751.4326683354067, 765.743475935562, 820.552798724695, 822.1080128061055, 14978.775318370233, 15159.014664046828, 15801.920990395047, 15805.604859878495, 15935.0, 11613.941930290357, 12056.57801976931, 14333.0, 14560.417583296656, 14577.708445831076, 913.9314551408638, 921.806420651664, 938.2681508423441, 940.7695114696909, 953.9856902146473, 926.754410081329, 933.2207606648457, 934.4066517761237, 934.5420743835506, 956.4404823178448, 989.9257555683353, 989.9554520046579, 990.10395591989, 991.5934466868586, 991.7966816802574, 981.79873126009, 985.4481490365418, 985.4579981010415, 985.5762022330395, 986.753311672082, 731.1226528166169, 731.5464412064554, 731.5647189921988, 732.0556482138036, 732.798480417884, 15414.306356213998, 15912.840871591368, 15928.362865485367, 16298.0, 16748.99506029642, 12815.0, 13634.0, 14126.646833829134, 14213.78679319811, 14248.21634810085, 11435.0, 11663.24188927717, 11757.118216133824, 11861.881381186251, 11938.164328497009, 3654.524911761481, 3677.4530012168934, 3683.3922402803505, 3735.62643735627, 3862.092408284051, 79934.60032699858, 106755.0, 106928.46535767349, 106938.3959240612, 107885.46057269743, 10279.845802312972, 10484.73788155287, 10606.310589811792, 10961.725956851142, 11182.552697891993, 22469.325920222418, 22727.545449090925, 22740.43148921257, 22744.772552274597, 22758.0, 7700.933837466644, 7767.02912135983, 7822.647980840876, 7911.723089691834, 7919.920800792033, 4239.957600424018, 4251.022264879033, 4347.673924455678, 4364.454443194601, 4411.889702757392, 3430.468277417004, 3527.5943266524678, 3531.5585551806025, 3535.398982173037, 3543.291341731664, 515.8692711773783, 624.7376102037156, 626.8652239768471, 627.6046090962665, 629.6096420219493, 688.2326206279962, 697.1842943755818, 711.9501634885509, 713.9071920650387, 719.6617589732817, 9632.373895696757, 10097.646582369582, 10355.01627345401, 10520.316179448311, 10541.84187237192, 666.3270097201861, 666.3403230801472, 687.3504538211442, 712.3482013957171, 712.4193782067598, 4111.938320925188, 4738.715677059387, 4944.134776414113, 4953.50464953509, 4976.8755781105765, 98743.50628246812, 106846.3973040405, 107037.0, 110040.4497977505, 111316.0, 48103.5189648106, 75882.9999999989, 80254.19745802584, 84715.57642211749, 93340.0, 76558.23441765511, 80222.0, 80396.0, 81873.18126818656, 81923.0, 9066.320025997944, 10368.326058806153, 10542.262041657317, 11260.549578016788, 11281.661550153509, 46113.0, 47217.527824721314, 47640.0, 49761.0, 51760.48239517557, 65403.67298163479, 67063.66468167628, 68404.0, 69867.65066174636, 71254.64372678104, 12551.121421500407, 12657.11400201977, 12859.614211573293, 13200.867991319963, 13668.384922678702, 14540.345684444437, 14598.562043138723, 14700.0, 15187.772183417479, 15530.1458419788, 11732.237404568676, 12096.637100886988, 12372.319522426353, 12438.378081095729, 12526.812097818722, 13305.866941330463, 13855.96080294002, 13865.514706985206, 13870.375833087333, 13970.930145349615, 13081.62298311671, 13332.404985229381, 13552.390142443812, 13662.11196272239, 14079.225642589756, 8382.874256886029, 8455.11221321777, 9015.594298256463, 9206.539673016456, 9505.0, 9878.811786265416, 9972.122023601563, 9992.197478344067, 10085.142762864945, 10141.036601522843], "value": 7528.622673498546, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1440.3000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 140.0, 172.0, 143.0, 115.0, 116.0, 117.0, 115.0], "value": 126.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 110.0, 108.0, 145.0, 110.0, 111.0, 109.0, 107.0, 130.0, 120.0], "value": 119.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 187.0, 184.0, 187.0, 184.0, 185.0, 182.0, 184.0, 185.0, 184.0], "value": 184.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 83.0, 91.0, 64.0, 61.0, 60.0, 60.0, 74.0, 60.0], "value": 71.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 87.0, 70.0, 70.0, 68.0, 82.0, 71.0, 69.0, 84.0], "value": 75.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 90.0, 87.0, 86.0, 90.0, 90.0, 88.0, 86.0, 86.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 93.0, 137.0, 98.0, 83.0, 85.0, 86.0, 87.0, 84.0, 84.0], "value": 92.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 60.0, 60.0, 66.0, 65.0, 63.0, 63.0, 64.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 67.0, 61.0, 63.0, 57.0, 57.0, 58.0, 58.0, 57.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 83.0, 81.0, 86.0, 81.0, 84.0, 86.0, 84.0, 84.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 137.0, 135.0, 135.0, 136.0, 136.0, 142.0, 188.0, 136.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 163.0, 162.0, 218.0, 177.0, 165.0, 165.0, 165.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 64.0, 77.0, 81.0, 79.0, 78.0, 72.0, 63.0], "value": 70.9, "unit": "score"}]}]} 02:34:35 INFO - Return code: 0 02:34:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:34:36 ERROR - # TBPL SUCCESS # 02:34:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:34:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:34:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:34:36 INFO - 2017-05-05 02:34:36.055 screenresolution[1656:9849] starting screenresolution argv=screenresolution get 02:34:36 INFO - 2017-05-05 02:34:36.057 screenresolution[1656:9849] Display 0: 1600x1200x32@60 02:34:36 INFO - 2017-05-05 02:34:36.063 screenresolution[1657:9852] starting screenresolution argv=screenresolution list 02:34:36 INFO - Available Modes on Display 0 02:34:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:34:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:34:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:34:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:34:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:34:36 INFO - Intel Iris: 02:34:36 INFO - Chipset Model: Intel Iris 02:34:36 INFO - Type: GPU 02:34:36 INFO - Bus: Built-In 02:34:36 INFO - VRAM (Dynamic, Max): 1536 MB 02:34:36 INFO - Vendor: Intel (0x8086) 02:34:36 INFO - Device ID: 0x0a2e 02:34:36 INFO - Revision ID: 0x0009 02:34:36 INFO - Displays: 02:34:36 INFO - Display: 02:34:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:34:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:34:36 INFO - Display Serial Number: 1600x1200 60 02:34:36 INFO - Main Display: Yes 02:34:36 INFO - Mirror: Off 02:34:36 INFO - Online: Yes 02:34:36 INFO - Rotation: Supported 02:34:36 INFO - Return code: 0 02:34:36 INFO - Running post-action listener: _resource_record_post_action 02:34:36 INFO - [mozharness: 2017-05-05 09:34:36.299371Z] Finished run-tests step (success) 02:34:36 INFO - Running post-run listener: _resource_record_post_run 02:34:36 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 38241280; Write bytes: 508489216; Read time: 246; Write time: 1519 02:34:36 INFO - TinderboxPrint: CPU usage
53.9% 02:34:36 INFO - TinderboxPrint: I/O read bytes / time
38,241,280 / 246 02:34:36 INFO - TinderboxPrint: I/O write bytes / time
508,489,216 / 1,519 02:34:36 INFO - TinderboxPrint: CPU idle
2,216.6 (46.1%) 02:34:36 INFO - TinderboxPrint: CPU system
956.8 (19.9%) 02:34:36 INFO - TinderboxPrint: CPU user
1,632.3 (34.0%) 02:34:36 INFO - TinderboxPrint: Swap in / out
245,981,184 / 0 02:34:36 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203907584; Write bytes: 199294976; Read time: 15618; Write time: 411 02:34:36 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 36221952; Write bytes: 298352128; Read time: 226; Write time: 1070 02:34:36 INFO - Running post-run listener: _upload_blobber_files 02:34:36 INFO - Blob upload gear active. 02:34:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:34:36 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 02:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:34:37 INFO - (blobuploader) - INFO - Open directory for files ... 02:34:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:34:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:34:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:38 INFO - (blobuploader) - INFO - Done attempting. 02:34:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:34:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:34:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:39 INFO - (blobuploader) - INFO - Done attempting. 02:34:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:34:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:34:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:40 INFO - (blobuploader) - INFO - Done attempting. 02:34:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:34:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:34:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:34:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:42 INFO - (blobuploader) - INFO - Done attempting. 02:34:42 INFO - (blobuploader) - INFO - Iteration through files over. 02:34:42 INFO - Return code: 0 02:34:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:34:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:34:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5f839f01c9a428bdac3e02cad883979914975d32f3318e41248aa958241fa7e501efce18e49a67b0a8a9b24cf3f8a2ad31e04528b1b934987d3293370e11192", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9fb4796f140e5466eddf513399bbd2d5bf0499cfcfde150310879040e02c5aeb95ca5b024e6e672734dca0778c50773a8b45cc1b5b90a292e9acedbeb33d589d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b7f2ffd3b2833513c314e4d79f931f8f9b06b2b954de4d19164c88a68610f02a4fb56ccf25b29225a84beff872d7361323e581af2dfd095ca868d996c198d83", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a7cf4350eca3ad87dead632634432e6f7da5689d880ce82b2d80ebf9370009b870238fb1ab4391328d260e9b3bd479efefc899369eb179044d222078863187d"} 02:34:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:34:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:34:42 INFO - Contents: 02:34:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5f839f01c9a428bdac3e02cad883979914975d32f3318e41248aa958241fa7e501efce18e49a67b0a8a9b24cf3f8a2ad31e04528b1b934987d3293370e11192", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9fb4796f140e5466eddf513399bbd2d5bf0499cfcfde150310879040e02c5aeb95ca5b024e6e672734dca0778c50773a8b45cc1b5b90a292e9acedbeb33d589d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b7f2ffd3b2833513c314e4d79f931f8f9b06b2b954de4d19164c88a68610f02a4fb56ccf25b29225a84beff872d7361323e581af2dfd095ca868d996c198d83", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a7cf4350eca3ad87dead632634432e6f7da5689d880ce82b2d80ebf9370009b870238fb1ab4391328d260e9b3bd479efefc899369eb179044d222078863187d"} 02:34:42 INFO - Running post-run listener: copy_logs_to_upload_dir 02:34:42 INFO - Copying logs to upload dir... 02:34:42 INFO - mkdir: /builds/slave/test/build/upload/logs 02:34:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.058122 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2017-05-05 02:34:42.862018) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 02:34:42.865865) ========= 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.Z4ZpnJChsa/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.yuvMTuAblb/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5f839f01c9a428bdac3e02cad883979914975d32f3318e41248aa958241fa7e501efce18e49a67b0a8a9b24cf3f8a2ad31e04528b1b934987d3293370e11192", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9fb4796f140e5466eddf513399bbd2d5bf0499cfcfde150310879040e02c5aeb95ca5b024e6e672734dca0778c50773a8b45cc1b5b90a292e9acedbeb33d589d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b7f2ffd3b2833513c314e4d79f931f8f9b06b2b954de4d19164c88a68610f02a4fb56ccf25b29225a84beff872d7361323e581af2dfd095ca868d996c198d83", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a7cf4350eca3ad87dead632634432e6f7da5689d880ce82b2d80ebf9370009b870238fb1ab4391328d260e9b3bd479efefc899369eb179044d222078863187d"} build_url:https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/QXVdDuBFSTWAVGmHf-GiYw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5f839f01c9a428bdac3e02cad883979914975d32f3318e41248aa958241fa7e501efce18e49a67b0a8a9b24cf3f8a2ad31e04528b1b934987d3293370e11192", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9fb4796f140e5466eddf513399bbd2d5bf0499cfcfde150310879040e02c5aeb95ca5b024e6e672734dca0778c50773a8b45cc1b5b90a292e9acedbeb33d589d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b7f2ffd3b2833513c314e4d79f931f8f9b06b2b954de4d19164c88a68610f02a4fb56ccf25b29225a84beff872d7361323e581af2dfd095ca868d996c198d83", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4a7cf4350eca3ad87dead632634432e6f7da5689d880ce82b2d80ebf9370009b870238fb1ab4391328d260e9b3bd479efefc899369eb179044d222078863187d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 02:34:42.904371) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 02:34:42.904951) ========= 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.Z4ZpnJChsa/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.yuvMTuAblb/Listeners TMPDIR=/var/folders/zr/ytw5mt592jdfk1rbvw03yt0h00000w/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.005172 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 02:34:42.954244) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 02:34:42.954572) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 02:34:42.954905) ========= ========= Total master_lag: 0.23 =========