builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0016 starttime: 1490970244.23 results: success (0) buildid: 20170331063801 builduid: 2f7668d0933e474785785f7a1bf7d7c8 revision: 1105ff76f42a96c1af3a54c043aa2a338ca45081 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:04.229041) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:04.229614) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:04.229911) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:04.256397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:04.256691) ========= 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.hXlGKU86rw/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.GaZQVLvKVJ/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-31 07:24:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.2M=0s 2017-03-31 07:24:04 (28.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137630 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:04.419380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:04.419701) ========= 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.hXlGKU86rw/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.GaZQVLvKVJ/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.036494 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:04.478002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 07:24:04.478350) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1105ff76f42a96c1af3a54c043aa2a338ca45081 --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 1105ff76f42a96c1af3a54c043aa2a338ca45081 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hXlGKU86rw/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.GaZQVLvKVJ/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-31 07:24:04,578 truncating revision to first 12 chars 2017-03-31 07:24:04,579 Setting DEBUG logging. 2017-03-31 07:24:04,579 attempt 1/10 2017-03-31 07:24:04,579 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1105ff76f42a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 07:24:05,589 unpacking tar archive at: mozilla-aurora-1105ff76f42a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.308305 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 07:24:05.809886) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:05.810203) ========= script_repo_revision: 1105ff76f42a96c1af3a54c043aa2a338ca45081 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:05.810635) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:05.810896) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 07:24:05.830784) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-31 07:24:05.831084) ========= /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.hXlGKU86rw/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.GaZQVLvKVJ/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 07:24:06 INFO - MultiFileLogger online at 20170331 07:24:06 in /builds/slave/test 07:24:06 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 07:24:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:24:06 INFO - {'append_to_log': False, 07:24:06 INFO - 'base_work_dir': '/builds/slave/test', 07:24:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:24:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:24:06 INFO - 'branch': 'Mozilla-Aurora', 07:24:06 INFO - 'buildbot_json_path': 'buildprops.json', 07:24:06 INFO - 'config_files': ('talos/mac_config.py',), 07:24:06 INFO - 'default_actions': ('clobber', 07:24:06 INFO - 'read-buildbot-config', 07:24:06 INFO - 'download-and-extract', 07:24:06 INFO - 'populate-webroot', 07:24:06 INFO - 'create-virtualenv', 07:24:06 INFO - 'install', 07:24:06 INFO - 'run-tests'), 07:24:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:24:06 INFO - 'download_minidump_stackwalk': True, 07:24:06 INFO - 'download_symbols': 'ondemand', 07:24:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:24:06 INFO - 'tooltool.py': '/tools/tooltool.py', 07:24:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:24:06 INFO - '/tools/misc-python/virtualenv.py')}, 07:24:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:24:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:24:06 INFO - 'gecko_profile': False, 07:24:06 INFO - 'gecko_profile_interval': 0, 07:24:06 INFO - 'installer_path': 'installer.exe', 07:24:06 INFO - 'log_level': 'info', 07:24:06 INFO - 'log_name': 'talos', 07:24:06 INFO - 'log_to_console': True, 07:24:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:24:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:24:06 INFO - 'opt_config_files': (), 07:24:06 INFO - 'pip_index': False, 07:24:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:24:06 INFO - 'cmd': ('bash', 07:24:06 INFO - '-c', 07:24:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:24:06 INFO - 'enabled': True, 07:24:06 INFO - 'halt_on_failure': False, 07:24:06 INFO - 'name': 'check_screen_resolution'},), 07:24:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:24:06 INFO - 'cmd': ('bash', 07:24:06 INFO - '-c', 07:24:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:24:06 INFO - 'enabled': True, 07:24:06 INFO - 'halt_on_failure': False, 07:24:06 INFO - 'name': 'check_screen_resolution'},), 07:24:06 INFO - 'run_cmd_checks_enabled': True, 07:24:06 INFO - 'suite': 'dromaeojs', 07:24:06 INFO - 'system_bits': '32', 07:24:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:24:06 INFO - 'title': 't-yosemite-r7-0016', 07:24:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:24:06 INFO - 'use_talos_json': True, 07:24:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:24:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:24:06 INFO - 'work_dir': 'build'} 07:24:06 INFO - [mozharness: 2017-03-31 14:24:06.044685Z] Running clobber step. 07:24:06 INFO - Running pre-action listener: _resource_record_pre_action 07:24:06 INFO - Running main action method: clobber 07:24:06 INFO - rmtree: /builds/slave/test/build 07:24:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:24:08 INFO - Running post-action listener: _resource_record_post_action 07:24:08 INFO - [mozharness: 2017-03-31 14:24:08.578140Z] Finished clobber step (success) 07:24:08 INFO - [mozharness: 2017-03-31 14:24:08.578275Z] Running read-buildbot-config step. 07:24:08 INFO - Running pre-action listener: _resource_record_pre_action 07:24:08 INFO - Running main action method: read_buildbot_config 07:24:08 INFO - Using buildbot properties: 07:24:08 INFO - { 07:24:08 INFO - "project": "", 07:24:08 INFO - "product": "firefox", 07:24:08 INFO - "script_repo_revision": "production", 07:24:08 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:24:08 INFO - "repository": "", 07:24:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:24:08 INFO - "buildid": "20170331063801", 07:24:08 INFO - "pgo_build": "False", 07:24:08 INFO - "basedir": "/builds/slave/test", 07:24:08 INFO - "buildnumber": 73, 07:24:08 INFO - "slavename": "t-yosemite-r7-0016", 07:24:08 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:24:08 INFO - "platform": "yosemite_r7", 07:24:08 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:24:08 INFO - "branch": "mozilla-aurora", 07:24:08 INFO - "repo_path": "releases/mozilla-aurora", 07:24:08 INFO - "revision": "1105ff76f42a96c1af3a54c043aa2a338ca45081", 07:24:08 INFO - "stage_platform": "macosx64", 07:24:08 INFO - "builduid": "2f7668d0933e474785785f7a1bf7d7c8", 07:24:08 INFO - "slavebuilddir": "test" 07:24:08 INFO - } 07:24:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 07:24:08 INFO - Running post-action listener: _resource_record_post_action 07:24:08 INFO - [mozharness: 2017-03-31 14:24:08.581702Z] Finished read-buildbot-config step (success) 07:24:08 INFO - [mozharness: 2017-03-31 14:24:08.581838Z] Running download-and-extract step. 07:24:08 INFO - Running pre-action listener: _resource_record_pre_action 07:24:08 INFO - Running main action method: download_and_extract 07:24:08 INFO - mkdir: /builds/slave/test/build/tests 07:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:08 INFO - trying https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 07:24:08 INFO - Downloading https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/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 07:24:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/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 07:24:09 INFO - Downloaded 1199 bytes. 07:24:09 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 07:24:09 INFO - Using the following test package requirements: 07:24:09 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 07:24:09 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:09 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 07:24:09 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:09 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 07:24:09 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:09 INFO - u'jsshell-mac.zip'], 07:24:09 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:09 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 07:24:09 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 07:24:09 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:09 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 07:24:09 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:09 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 07:24:09 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:09 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 07:24:09 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:24:09 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 07:24:09 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:24:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 07:24:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:24:09 INFO - Fetch https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 07:24:11 INFO - Expected file size: 51791407 07:24:11 INFO - Obtained file size: 51791407 07:24:27 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 07:24:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 07:24:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:24:27 INFO - Fetch https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 07:24:29 INFO - Expected file size: 51791407 07:24:29 INFO - Obtained file size: 51791407 07:24:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 07:24:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:24:44 INFO - Fetch https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 07:24:45 INFO - Expected file size: 14404438 07:24:45 INFO - Obtained file size: 14404438 07:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:45 INFO - trying https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:24:45 INFO - Downloading https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 07:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/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 07:24:47 INFO - Downloaded 74696202 bytes. 07:24:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:24:47 INFO - mkdir: /builds/slave/test/properties 07:24:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:24:47 INFO - Writing to file /builds/slave/test/properties/build_url 07:24:47 INFO - Contents: 07:24:47 INFO - build_url:https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:24:48 INFO - Running post-action listener: _resource_record_post_action 07:24:48 INFO - Running post-action listener: set_extra_try_arguments 07:24:48 INFO - [mozharness: 2017-03-31 14:24:48.598225Z] Finished download-and-extract step (success) 07:24:48 INFO - [mozharness: 2017-03-31 14:24:48.598346Z] Running populate-webroot step. 07:24:48 INFO - Running pre-action listener: _resource_record_pre_action 07:24:48 INFO - Running main action method: populate_webroot 07:24:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:24:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:24:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:24:48 INFO - '--tppagecycles', 07:24:48 INFO - '7'], 07:24:48 INFO - 'tests': ['tsvgm']}}, 07:24:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:24:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:24:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:24:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:24:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:24:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:24:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:24:48 INFO - 'talos_options': ['--disable-e10s'], 07:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:24:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:24:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:24:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:24:48 INFO - 'talos_options': ['--disable-e10s'], 07:24:48 INFO - 'tests': ['damp', 'tps']}, 07:24:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:24:48 INFO - 'tests': ['damp', 'tps']}, 07:24:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:24:48 INFO - 'tests': ['dromaeo_dom']}, 07:24:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:24:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:24:48 INFO - 'tests': ['basic_compositor_video']}, 07:24:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:24:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:24:48 INFO - 'tests': ['a11yr', 07:24:48 INFO - 'ts_paint', 07:24:48 INFO - 'tpaint', 07:24:48 INFO - 'sessionrestore', 07:24:48 INFO - 'sessionrestore_no_auto_restore', 07:24:48 INFO - 'tabpaint']}, 07:24:48 INFO - 'other-e10s': {'tests': ['a11yr', 07:24:48 INFO - 'ts_paint', 07:24:48 INFO - 'tpaint', 07:24:48 INFO - 'sessionrestore', 07:24:48 INFO - 'sessionrestore_no_auto_restore', 07:24:48 INFO - 'tabpaint']}, 07:24:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:24:48 INFO - 'ts_paint', 07:24:48 INFO - 'tpaint', 07:24:48 INFO - 'sessionrestore', 07:24:48 INFO - 'sessionrestore_no_auto_restore', 07:24:48 INFO - 'tabpaint']}, 07:24:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:24:48 INFO - 'ts_paint', 07:24:48 INFO - 'tpaint', 07:24:48 INFO - 'sessionrestore', 07:24:48 INFO - 'sessionrestore_no_auto_restore', 07:24:48 INFO - 'tabpaint']}, 07:24:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:24:48 INFO - 'tests': ['a11yr', 07:24:48 INFO - 'ts_paint', 07:24:48 INFO - 'tpaint', 07:24:48 INFO - 'sessionrestore', 07:24:48 INFO - 'sessionrestore_no_auto_restore', 07:24:48 INFO - 'tabpaint']}, 07:24:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:24:48 INFO - 'tests': ['a11yr', 07:24:48 INFO - 'ts_paint', 07:24:48 INFO - 'tpaint', 07:24:48 INFO - 'sessionrestore', 07:24:48 INFO - 'sessionrestore_no_auto_restore', 07:24:48 INFO - 'tabpaint']}, 07:24:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:24:48 INFO - 'tests': ['tsvgx', 07:24:48 INFO - 'tsvgr_opacity', 07:24:48 INFO - 'tart', 07:24:48 INFO - 'tscrollx', 07:24:48 INFO - 'cart', 07:24:48 INFO - 'tsvg_static']}, 07:24:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:24:48 INFO - 'tsvgr_opacity', 07:24:48 INFO - 'tart', 07:24:48 INFO - 'tscrollx', 07:24:48 INFO - 'cart', 07:24:48 INFO - 'tsvg_static']}, 07:24:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:24:48 INFO - 'talos_options': ['--disable-e10s'], 07:24:48 INFO - 'tests': ['tp5o']}, 07:24:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:24:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:24:48 INFO - 'talos_options': ['--disable-e10s', 07:24:48 INFO - '--xperf_path', 07:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:24:48 INFO - 'tests': ['tp5n']}, 07:24:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:24:48 INFO - 'talos_options': ['--xperf_path', 07:24:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:24:48 INFO - 'tests': ['tp5n']}}, 07:24:48 INFO - 'talos.zip': {'path': '', 07:24:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:24:48 INFO - Running post-action listener: _resource_record_post_action 07:24:48 INFO - [mozharness: 2017-03-31 14:24:48.616850Z] Finished populate-webroot step (success) 07:24:48 INFO - [mozharness: 2017-03-31 14:24:48.616992Z] Running create-virtualenv step. 07:24:48 INFO - Running pre-action listener: _resource_record_pre_action 07:24:48 INFO - Running main action method: create_virtualenv 07:24:48 INFO - Creating virtualenv /builds/slave/test/build/venv 07:24:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:24:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:24:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:24:48 INFO - Using real prefix '/tools/python27' 07:24:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:24:49 INFO - Installing distribute.............................................................................................................................................................................................done. 07:24:52 INFO - Installing pip.................done. 07:24:52 INFO - Return code: 0 07:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:24:52 INFO - Reading from file tmpfile_stdout 07:24:52 INFO - Output received: 07:24:52 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:24:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074deb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074e1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc3ac6eec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072bcd30>, '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 0x1071e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072b1be8>, '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.hXlGKU86rw/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.GaZQVLvKVJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 07:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXlGKU86rw/Render', 07:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:24:52 INFO - 'HOME': '/Users/cltbld', 07:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:24:52 INFO - 'LOGNAME': 'cltbld', 07:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:52 INFO - 'MOZ_NO_REMOTE': '1', 07:24:52 INFO - 'NO_EM_RESTART': '1', 07:24:52 INFO - 'PAGER': '/bin/cat', 07:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:52 INFO - 'PWD': '/builds/slave/test', 07:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:24:52 INFO - 'SHELL': '/bin/bash', 07:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GaZQVLvKVJ/Listeners', 07:24:52 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 07:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:24:52 INFO - 'USER': 'cltbld', 07:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:52 INFO - 'XPC_FLAGS': '0x0', 07:24:52 INFO - 'XPC_SERVICE_NAME': '0', 07:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:24:52 INFO - Cleaning up... 07:24:52 INFO - Return code: 0 07:24:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074deb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074e1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc3ac6eec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072bcd30>, '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 0x1071e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072b1be8>, '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.hXlGKU86rw/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.GaZQVLvKVJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 07:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXlGKU86rw/Render', 07:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:24:52 INFO - 'HOME': '/Users/cltbld', 07:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:24:52 INFO - 'LOGNAME': 'cltbld', 07:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:52 INFO - 'MOZ_NO_REMOTE': '1', 07:24:52 INFO - 'NO_EM_RESTART': '1', 07:24:52 INFO - 'PAGER': '/bin/cat', 07:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:52 INFO - 'PWD': '/builds/slave/test', 07:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:24:52 INFO - 'SHELL': '/bin/bash', 07:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GaZQVLvKVJ/Listeners', 07:24:52 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 07:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:24:52 INFO - 'USER': 'cltbld', 07:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:52 INFO - 'XPC_FLAGS': '0x0', 07:24:52 INFO - 'XPC_SERVICE_NAME': '0', 07:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:53 INFO - Downloading/unpacking psutil>=3.1.1 07:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:24:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:24:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:24:56 INFO - Installing collected packages: psutil 07:24:56 INFO - Running setup.py install for psutil 07:24:56 INFO - building 'psutil._psutil_osx' extension 07:24:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:24:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:24:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:24:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:24:57 INFO - building 'psutil._psutil_posix' extension 07:24:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:24:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:24:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:24:57 INFO - ^ 07:24:57 INFO - 1 warning generated. 07:24:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:24:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:24:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:24:57 INFO - Successfully installed psutil 07:24:57 INFO - Cleaning up... 07:24:57 INFO - Return code: 0 07:24:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:24:57 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')]} 07:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:57 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')]} 07:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:57 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 0x1074deb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074e1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc3ac6eec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072bcd30>, '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 0x1071e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072b1be8>, '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.hXlGKU86rw/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.GaZQVLvKVJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 07:24:57 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 07:24:57 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 07:24:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXlGKU86rw/Render', 07:24:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:24:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:24:57 INFO - 'HOME': '/Users/cltbld', 07:24:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:24:57 INFO - 'LOGNAME': 'cltbld', 07:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:57 INFO - 'MOZ_NO_REMOTE': '1', 07:24:57 INFO - 'NO_EM_RESTART': '1', 07:24:57 INFO - 'PAGER': '/bin/cat', 07:24:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:57 INFO - 'PWD': '/builds/slave/test', 07:24:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:24:57 INFO - 'SHELL': '/bin/bash', 07:24:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GaZQVLvKVJ/Listeners', 07:24:57 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 07:24:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:24:57 INFO - 'USER': 'cltbld', 07:24:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:24:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:57 INFO - 'XPC_FLAGS': '0x0', 07:24:57 INFO - 'XPC_SERVICE_NAME': '0', 07:24:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:25:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:25:00 INFO - Installing collected packages: mozsystemmonitor 07:25:00 INFO - Running setup.py install for mozsystemmonitor 07:25:01 INFO - Successfully installed mozsystemmonitor 07:25:01 INFO - Cleaning up... 07:25:01 INFO - Return code: 0 07:25:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074deb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074e1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc3ac6eec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072bcd30>, '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 0x1071e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072b1be8>, '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.hXlGKU86rw/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.GaZQVLvKVJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 07:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:25:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXlGKU86rw/Render', 07:25:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:01 INFO - 'HOME': '/Users/cltbld', 07:25:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:01 INFO - 'LOGNAME': 'cltbld', 07:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:01 INFO - 'MOZ_NO_REMOTE': '1', 07:25:01 INFO - 'NO_EM_RESTART': '1', 07:25:01 INFO - 'PAGER': '/bin/cat', 07:25:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:01 INFO - 'PWD': '/builds/slave/test', 07:25:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:01 INFO - 'SHELL': '/bin/bash', 07:25:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GaZQVLvKVJ/Listeners', 07:25:01 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 07:25:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:01 INFO - 'USER': 'cltbld', 07:25:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:01 INFO - 'XPC_FLAGS': '0x0', 07:25:01 INFO - 'XPC_SERVICE_NAME': '0', 07:25:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:02 INFO - Downloading/unpacking jsonschema==2.5.1 07:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:25:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:05 INFO - Downloading functools32-3.2.3-2.tar.gz 07:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:25:05 INFO - warning: no files found matching '*.txt' 07:25:05 INFO - no previously-included directories found matching 'build' 07:25:05 INFO - no previously-included directories found matching 'dist' 07:25:05 INFO - no previously-included directories found matching '.git*' 07:25:05 INFO - Installing collected packages: jsonschema, functools32 07:25:05 INFO - Running setup.py install for functools32 07:25:05 INFO - warning: no files found matching '*.txt' 07:25:05 INFO - no previously-included directories found matching 'build' 07:25:05 INFO - no previously-included directories found matching 'dist' 07:25:05 INFO - no previously-included directories found matching '.git*' 07:25:05 INFO - Successfully installed jsonschema functools32 07:25:05 INFO - Cleaning up... 07:25:05 INFO - Return code: 0 07:25:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1074deb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074e1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc3ac6eec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072bcd30>, '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 0x1071e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072b1be8>, '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.hXlGKU86rw/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.GaZQVLvKVJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 07:25:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:25:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXlGKU86rw/Render', 07:25:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:05 INFO - 'HOME': '/Users/cltbld', 07:25:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:05 INFO - 'LOGNAME': 'cltbld', 07:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:05 INFO - 'MOZ_NO_REMOTE': '1', 07:25:05 INFO - 'NO_EM_RESTART': '1', 07:25:05 INFO - 'PAGER': '/bin/cat', 07:25:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:05 INFO - 'PWD': '/builds/slave/test', 07:25:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:05 INFO - 'SHELL': '/bin/bash', 07:25:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GaZQVLvKVJ/Listeners', 07:25:05 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 07:25:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:05 INFO - 'USER': 'cltbld', 07:25:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:05 INFO - 'XPC_FLAGS': '0x0', 07:25:05 INFO - 'XPC_SERVICE_NAME': '0', 07:25:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:25:06 INFO - Cleaning up... 07:25:06 INFO - Return code: 0 07:25:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:06 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 0x1074deb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074e1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc3ac6eec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072bcd30>, '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 0x1071e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072b1be8>, '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.hXlGKU86rw/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.GaZQVLvKVJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 07:25:06 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 07:25:06 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 07:25:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXlGKU86rw/Render', 07:25:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:06 INFO - 'HOME': '/Users/cltbld', 07:25:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:06 INFO - 'LOGNAME': 'cltbld', 07:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:06 INFO - 'MOZ_NO_REMOTE': '1', 07:25:06 INFO - 'NO_EM_RESTART': '1', 07:25:06 INFO - 'PAGER': '/bin/cat', 07:25:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:06 INFO - 'PWD': '/builds/slave/test', 07:25:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:06 INFO - 'SHELL': '/bin/bash', 07:25:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GaZQVLvKVJ/Listeners', 07:25:06 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 07:25:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:06 INFO - 'USER': 'cltbld', 07:25:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:06 INFO - 'XPC_FLAGS': '0x0', 07:25:06 INFO - 'XPC_SERVICE_NAME': '0', 07:25:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:06 INFO - Downloading/unpacking blobuploader==1.2.4 07:25:06 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 07:25:06 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 07:25:06 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 07:25:06 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 07:25:06 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 07:25:06 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 07:25:09 INFO - Downloading blobuploader-1.2.4.tar.gz 07:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:25:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:25:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:10 INFO - Downloading docopt-0.6.1.tar.gz 07:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:25:10 INFO - Installing collected packages: blobuploader, requests, docopt 07:25:10 INFO - Running setup.py install for blobuploader 07:25:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:25:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:25:10 INFO - Running setup.py install for requests 07:25:11 INFO - Running setup.py install for docopt 07:25:11 INFO - Successfully installed blobuploader requests docopt 07:25:11 INFO - Cleaning up... 07:25:11 INFO - Return code: 0 07:25:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:11 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')]} 07:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:11 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')]} 07:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:11 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 0x1074deb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074e1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc3ac6eec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072bcd30>, '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 0x1071e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072b1be8>, '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.hXlGKU86rw/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.GaZQVLvKVJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 07:25:11 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 07:25:11 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 07:25:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXlGKU86rw/Render', 07:25:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:11 INFO - 'HOME': '/Users/cltbld', 07:25:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:11 INFO - 'LOGNAME': 'cltbld', 07:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:11 INFO - 'MOZ_NO_REMOTE': '1', 07:25:11 INFO - 'NO_EM_RESTART': '1', 07:25:11 INFO - 'PAGER': '/bin/cat', 07:25:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:11 INFO - 'PWD': '/builds/slave/test', 07:25:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:11 INFO - 'SHELL': '/bin/bash', 07:25:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GaZQVLvKVJ/Listeners', 07:25:11 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 07:25:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:11 INFO - 'USER': 'cltbld', 07:25:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:11 INFO - 'XPC_FLAGS': '0x0', 07:25:11 INFO - 'XPC_SERVICE_NAME': '0', 07:25:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:11 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-QyIvfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:11 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-teGWr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:11 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-7L56IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:11 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-oWuAeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:11 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-wsZ2t8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-51gsk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-nZ9ZwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-6KoMVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-jeY7pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-sTmoQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-7Fdg14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-OgQvOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-NMSIUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:12 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-luQt1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:13 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-ywFZhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:13 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-UdDBLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:13 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-lDkJEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:25:13 INFO - Running setup.py install for manifestparser 07:25:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:25:13 INFO - Running setup.py install for mozcrash 07:25:13 INFO - Running setup.py install for mozdebug 07:25:13 INFO - Running setup.py install for mozdevice 07:25:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:25:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:25:13 INFO - Running setup.py install for mozfile 07:25:14 INFO - Running setup.py install for mozhttpd 07:25:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:25:14 INFO - Running setup.py install for mozinfo 07:25:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:25:14 INFO - Running setup.py install for mozInstall 07:25:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:25:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:25:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:25:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:25:14 INFO - Running setup.py install for mozleak 07:25:14 INFO - Running setup.py install for mozlog 07:25:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:25:14 INFO - Running setup.py install for moznetwork 07:25:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:25:14 INFO - Running setup.py install for mozprocess 07:25:15 INFO - Running setup.py install for mozprofile 07:25:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:25:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:25:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:25:15 INFO - Running setup.py install for mozrunner 07:25:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:25:15 INFO - Running setup.py install for mozscreenshot 07:25:15 INFO - Running setup.py install for moztest 07:25:15 INFO - Running setup.py install for mozversion 07:25:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:25:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:25:15 INFO - Cleaning up... 07:25:15 INFO - Return code: 0 07:25:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:15 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 0x1074deb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074e1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc3ac6eec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072bcd30>, '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 0x1071e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072b1be8>, '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.hXlGKU86rw/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.GaZQVLvKVJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 07:25:15 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 07:25:15 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 07:25:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXlGKU86rw/Render', 07:25:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:15 INFO - 'HOME': '/Users/cltbld', 07:25:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:15 INFO - 'LOGNAME': 'cltbld', 07:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:15 INFO - 'MOZ_NO_REMOTE': '1', 07:25:15 INFO - 'NO_EM_RESTART': '1', 07:25:15 INFO - 'PAGER': '/bin/cat', 07:25:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:15 INFO - 'PWD': '/builds/slave/test', 07:25:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:15 INFO - 'SHELL': '/bin/bash', 07:25:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GaZQVLvKVJ/Listeners', 07:25:15 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 07:25:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:15 INFO - 'USER': 'cltbld', 07:25:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:15 INFO - 'XPC_FLAGS': '0x0', 07:25:15 INFO - 'XPC_SERVICE_NAME': '0', 07:25:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:16 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-EIxm1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:16 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)) 07:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:16 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-kvLRM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:16 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)) 07:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:16 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-ms7DMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:16 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)) 07:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:16 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-VZieMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:16 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)) 07:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:16 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-NCeWsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:16 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)) 07:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:16 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-2IrhNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:16 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)) 07:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:16 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-9mIQLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:16 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)) 07:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:16 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-bO2OYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:17 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)) 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-p1gd47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:17 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)) 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-efP11h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:17 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)) 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-v5OChg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:17 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)) 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-i_bRJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:17 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)) 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-wFjfKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:17 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)) 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-cTuYfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:17 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)) 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-9WrW20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:17 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)) 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-2qfpts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:17 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)) 07:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:17 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-K0JFla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:18 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)) 07:25:18 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)) 07:25:18 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)) 07:25:18 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)) 07:25:18 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)) 07:25:18 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)) 07:25:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:25:18 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 07:25:18 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 07:25:18 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 07:25:18 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 07:25:18 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 07:25:18 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 07:25:20 INFO - Downloading blessings-1.6.tar.gz 07:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:25:20 INFO - Installing collected packages: blessings 07:25:20 INFO - Running setup.py install for blessings 07:25:20 INFO - Successfully installed blessings 07:25:20 INFO - Cleaning up... 07:25:21 INFO - Return code: 0 07:25:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:25:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:21 INFO - Reading from file tmpfile_stdout 07:25:21 INFO - Current package versions: 07:25:21 INFO - blessings == 1.6 07:25:21 INFO - blobuploader == 1.2.4 07:25:21 INFO - docopt == 0.6.1 07:25:21 INFO - functools32 == 3.2.3-2 07:25:21 INFO - jsonschema == 2.5.1 07:25:21 INFO - manifestparser == 1.1 07:25:21 INFO - mozInstall == 1.12 07:25:21 INFO - mozcrash == 1.0 07:25:21 INFO - mozdebug == 0.1 07:25:21 INFO - mozdevice == 0.49 07:25:21 INFO - mozfile == 1.2 07:25:21 INFO - mozhttpd == 0.7 07:25:21 INFO - mozinfo == 0.9 07:25:21 INFO - mozleak == 0.1 07:25:21 INFO - mozlog == 3.4 07:25:21 INFO - moznetwork == 0.27 07:25:21 INFO - mozprocess == 0.25 07:25:21 INFO - mozprofile == 0.28 07:25:21 INFO - mozrunner == 6.13 07:25:21 INFO - mozscreenshot == 0.1 07:25:21 INFO - mozsystemmonitor == 0.3 07:25:21 INFO - moztest == 0.8 07:25:21 INFO - mozversion == 1.4 07:25:21 INFO - psutil == 3.1.1 07:25:21 INFO - requests == 1.2.3 07:25:21 INFO - wsgiref == 0.1.2 07:25:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:21 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 0x1074deb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074e1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc3ac6eec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072bcd30>, '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 0x1071e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072b1be8>, '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.hXlGKU86rw/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.GaZQVLvKVJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 07:25:21 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 07:25:21 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 07:25:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXlGKU86rw/Render', 07:25:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:21 INFO - 'HOME': '/Users/cltbld', 07:25:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:21 INFO - 'LOGNAME': 'cltbld', 07:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:21 INFO - 'MOZ_NO_REMOTE': '1', 07:25:21 INFO - 'NO_EM_RESTART': '1', 07:25:21 INFO - 'PAGER': '/bin/cat', 07:25:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:21 INFO - 'PWD': '/builds/slave/test', 07:25:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:21 INFO - 'SHELL': '/bin/bash', 07:25:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GaZQVLvKVJ/Listeners', 07:25:21 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 07:25:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:21 INFO - 'USER': 'cltbld', 07:25:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:21 INFO - 'XPC_FLAGS': '0x0', 07:25:21 INFO - 'XPC_SERVICE_NAME': '0', 07:25:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:21 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)) 07:25:21 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)) 07:25:21 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)) 07:25:21 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)) 07:25:21 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)) 07:25:21 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)) 07:25:21 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)) 07:25:21 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)) 07:25:21 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)) 07:25:21 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)) 07:25:21 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)) 07:25:21 INFO - Cleaning up... 07:25:21 INFO - Return code: 0 07:25:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1074deb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074e1768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc3ac6eec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072bcd30>, '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 0x1071e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072b1be8>, '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.hXlGKU86rw/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.GaZQVLvKVJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 07:25: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', 'jsonschema'] in /builds/slave/test/build 07:25: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 jsonschema 07:25:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXlGKU86rw/Render', 07:25:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:21 INFO - 'HOME': '/Users/cltbld', 07:25:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:21 INFO - 'LOGNAME': 'cltbld', 07:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:21 INFO - 'MOZ_NO_REMOTE': '1', 07:25:21 INFO - 'NO_EM_RESTART': '1', 07:25:21 INFO - 'PAGER': '/bin/cat', 07:25:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:21 INFO - 'PWD': '/builds/slave/test', 07:25:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:21 INFO - 'SHELL': '/bin/bash', 07:25:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GaZQVLvKVJ/Listeners', 07:25:21 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 07:25:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:21 INFO - 'USER': 'cltbld', 07:25:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:21 INFO - 'XPC_FLAGS': '0x0', 07:25:21 INFO - 'XPC_SERVICE_NAME': '0', 07:25:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:25:21 INFO - Cleaning up... 07:25:21 INFO - Return code: 0 07:25:21 INFO - Running post-action listener: _resource_record_post_action 07:25:21 INFO - Running post-action listener: _start_resource_monitoring 07:25:21 INFO - Starting resource monitoring. 07:25:21 INFO - [mozharness: 2017-03-31 14:25:21.868754Z] Finished create-virtualenv step (success) 07:25:21 INFO - [mozharness: 2017-03-31 14:25:21.869764Z] Running install step. 07:25:21 INFO - Running pre-action listener: _resource_record_pre_action 07:25:21 INFO - Running main action method: install 07:25:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:25:22 INFO - Reading from file tmpfile_stdout 07:25:22 INFO - Detecting whether we're running mozinstall >=1.0... 07:25:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:25:22 INFO - Reading from file tmpfile_stdout 07:25:22 INFO - Output received: 07:25:22 INFO - Usage: mozinstall [options] installer 07:25:22 INFO - Options: 07:25:22 INFO - -h, --help show this help message and exit 07:25:22 INFO - -d DEST, --destination=DEST 07:25:22 INFO - Directory to install application into. [default: 07:25:22 INFO - "/builds/slave/test"] 07:25:22 INFO - --app=APP Application being installed. [default: firefox] 07:25:22 INFO - mkdir: /builds/slave/test/build/application 07:25:22 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'] 07:25:22 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 07:25:42 INFO - Reading from file tmpfile_stdout 07:25:42 INFO - Output received: 07:25:42 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:25:42 INFO - Running post-action listener: _resource_record_post_action 07:25:42 INFO - [mozharness: 2017-03-31 14:25:42.801894Z] Finished install step (success) 07:25:42 INFO - [mozharness: 2017-03-31 14:25:42.802071Z] Running run-tests step. 07:25:42 INFO - Running pre-action listener: _resource_record_pre_action 07:25:42 INFO - Running main action method: run_tests 07:25:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:25:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:25:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:25:42 INFO - 2017-03-31 07:25:42.817 screenresolution[1618:7443] starting screenresolution argv=screenresolution get 07:25:42 INFO - 2017-03-31 07:25:42.819 screenresolution[1618:7443] Display 0: 1600x1200x32@60 07:25:42 INFO - 2017-03-31 07:25:42.825 screenresolution[1619:7446] starting screenresolution argv=screenresolution list 07:25:42 INFO - Available Modes on Display 0 07:25:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:25:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:25:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:25:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:25:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:25:43 INFO - Intel Iris: 07:25:43 INFO - Chipset Model: Intel Iris 07:25:43 INFO - Type: GPU 07:25:43 INFO - Bus: Built-In 07:25:43 INFO - VRAM (Dynamic, Max): 1536 MB 07:25:43 INFO - Vendor: Intel (0x8086) 07:25:43 INFO - Device ID: 0x0a2e 07:25:43 INFO - Revision ID: 0x0009 07:25:43 INFO - Displays: 07:25:43 INFO - Display: 07:25:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:25:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:25:43 INFO - Display Serial Number: 1600x1200 60 07:25:43 INFO - Main Display: Yes 07:25:43 INFO - Mirror: Off 07:25:43 INFO - Online: Yes 07:25:43 INFO - Rotation: Supported 07:25:43 INFO - Return code: 0 07:25:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:25:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:25:43 INFO - Python 2.7.3 07:25:43 INFO - Return code: 0 07:25:43 INFO - grabbing minidump binary from tooltool 07:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:25:43 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072bcd30>, '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 0x1071e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1072b1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:25:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:25:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:25:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:25:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:25:43 INFO - Return code: 0 07:25:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:25:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:25:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:25:43 INFO - ENV: RUST_BACKTRACE is now 1 07:25:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:25:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:25:43 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/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--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 07:25:43 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/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0016 --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 07:25:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXlGKU86rw/Render', 07:25:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:25:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:25:43 INFO - 'HOME': '/Users/cltbld', 07:25:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:25:43 INFO - 'LOGNAME': 'cltbld', 07:25:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:25:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:43 INFO - 'MOZ_NO_REMOTE': '1', 07:25:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:25:43 INFO - 'NO_EM_RESTART': '1', 07:25:43 INFO - 'PAGER': '/bin/cat', 07:25:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:43 INFO - 'PWD': '/builds/slave/test', 07:25:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:25:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:25:43 INFO - 'RUST_BACKTRACE': '1', 07:25:43 INFO - 'SHELL': '/bin/bash', 07:25:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GaZQVLvKVJ/Listeners', 07:25:43 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 07:25:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:25:43 INFO - 'USER': 'cltbld', 07:25:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:25:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:43 INFO - 'XPC_FLAGS': '0x0', 07:25:43 INFO - 'XPC_SERVICE_NAME': '0', 07:25:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:25:43 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/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--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 07:25:43 INFO - mozversion application_buildid: 20170331063801 07:25:43 INFO - mozversion application_changeset: 1105ff76f42a96c1af3a54c043aa2a338ca45081 07:25:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:25:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:25:43 INFO - mozversion application_name: Firefox 07:25:43 INFO - mozversion application_remotingname: firefox-dev 07:25:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:25:43 INFO - mozversion application_vendor: Mozilla 07:25:43 INFO - mozversion application_version: 54.0a2 07:25:43 INFO - mozversion platform_buildid: 20170331063801 07:25:43 INFO - mozversion platform_changeset: 1105ff76f42a96c1af3a54c043aa2a338ca45081 07:25:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:25:43 INFO - mozversion platform_version: 54.0a2 07:25:43 INFO - using testdate: 1490970343 07:25:43 INFO - actual date: 1490970343 07:25:43 INFO - starting webserver on 'localhost:49249' 07:25:43 INFO - SUITE-START | Running 2 tests 07:25:43 INFO - TEST-START | dromaeo_css 07:25:43 INFO - operating with platform_type : mac_ 07:25:43 INFO - Initialising browser for dromaeo_css test... 07:25:43 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpEH_wsu/profile http://localhost:49249/getInfo.html) 07:25:46 INFO - PROCESS | 1629 | __metrics Screen width/height:1600/1200 07:25:46 INFO - PROCESS | 1629 | colorDepth:24 07:25:46 INFO - PROCESS | 1629 | Browser inner width/height: 1024/689 07:25:46 INFO - PROCESS | 1629 | __metrics 07:25:46 INFO - PROCESS | 1629 | 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" 07:25:46 INFO - PROCESS | 1629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:25:47 INFO - TEST-INFO | 1629: exit 0 07:25:47 INFO - Browser initialized. 07:25:47 INFO - Running cycle 1/1 for dromaeo_css test... 07:25:47 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpEH_wsu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:59 INFO - PROCESS | 1631 | RSS: Main: 214679552 07:25:59 INFO - PROCESS | 1631 | 07:29:03 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 07:29:05 INFO - PROCESS | 1631 | RSS: Main: 375582720 07:29:05 INFO - PROCESS | 1631 | 07:30:49 INFO - PROCESS | 1631 | ************************* 07:30:49 INFO - PROCESS | 1631 | A coding exception was thrown and uncaught in a Task. 07:30:49 INFO - PROCESS | 1631 | 07:30:49 ERROR - PROCESS | 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:30:49 INFO - PROCESS | 1631 | Full stack: 07:30:49 INFO - PROCESS | 1631 | ************************* 07:32:08 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 07:32:08 INFO - PROCESS | 1631 | RSS: Main: 351199232 07:32:08 INFO - PROCESS | 1631 | 07:35:11 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 07:35:12 INFO - PROCESS | 1631 | RSS: Main: 334860288 07:35:12 INFO - PROCESS | 1631 | 07:38:14 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 07:38:15 INFO - PROCESS | 1631 | RSS: Main: 326688768 07:38:15 INFO - PROCESS | 1631 | 07:41:18 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 07:41:19 INFO - PROCESS | 1631 | RSS: Main: 323903488 07:41:19 INFO - PROCESS | 1631 | 07:44:22 INFO - PROCESS | 1631 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 07:44:23 INFO - PROCESS | 1631 | RSS: Main: 414814208 07:44:23 INFO - PROCESS | 1631 | 07:44:23 INFO - PROCESS | 1631 | __start_tp_report 07:44:23 INFO - PROCESS | 1631 | _x_x_mozilla_page_load 07:44:23 INFO - PROCESS | 1631 | _x_x_mozilla_page_load_details 07:44:23 INFO - PROCESS | 1631 | |i|pagename|runs| 07:44:23 INFO - PROCESS | 1631 | |0;dojo.html;2918.2850201700585;3213.8108899707113;3399.881004164853;3430.2624935638864;3457.464093065574;5998.850028749283;5999.6700181490005;6025.035994240922;6070.5143588512865;6093.360197179293;5991;6061.515078793697;6069.332373438918;6080.483158931496;6089.939100608993;5413.593980451472;5436.483534064278;5456.563474921997;5468.507834294933;5553.194786755918;5345.866353341159;5353.973230133844;5531.170324451345;5553.527950124224;5600.859978500529;5395.946040539603;5430.56555475561;5458.727063646822;5460.672359658433;5465.890682186354;5429.375621803503;5437.755301011464;5438.564914806806;5448.182772584085;5460.781568737246;5278.551323137538;5386.865328366822;5392.137258038695;5397.136458166714;5437.939601777655;5980.312264089642;5981.8803623927715;5982.8504287392725;5986.880262394771;5994.670293133876;6305.527085468562;6307.96846015767;6308.589941653824;6309.747610095591;6319.3680631936895;6515.283318834924;6530.183727034121;6530.771423000172;6532;6534.575252608565;6105.32841387447;6180.196574445338;6180.690965451754;6180.938190618126;6195.783147589813;6286.15136956505;6328.6835658216905;6629.834254143637;6634.601923884582;6637.535372523877;6117.897713130785;6255.874882502416;6260.342664020303;6267.749290028348;6276.309605943343;6224.719887604978;6439.034144878212;6507.34926507355;6516.152900122954;6518.511111666644;6401.295857455676;6402.167718196604;6402.711877965503;6414.743410263537;6418.19772528434;6255.843603909939;6402.967985160044;6405.19935008124;6425.036244563353;6443.613383196929;4905.018996200774;5157.994191132768;5188.351456067991;5233.476652334813;5245.580353571705;4623.583877450978;4633.675642705046;4650.023495066074;4651.4418269807165;4667.789949452283;6041.758329666764;6060.393960603904;6084.5436592255755;6100;6111;6249.812505624838;6417.294097649255;6420.165378500765;6522.804315870531;6536.346365363425;6052.818415447544;6069.089636554552;6070.908936365958;6075.817725468243;6078.878422431615;4936.308916751657;5690.317161940594;5701.971490142523;5717.199592057115;5725.484706376363;5748.223989761329;6299.055141728777;6334.683265836782;6569.967150164219;6651.268360480247;6418.293987661447;6445.226572811105;6458.7093580789915;6466.805995820133;6483.124778154889;6610.10763546915;6663.100481434944;6673.366030227121;6684.498662600422;6692.665366731741;6293;6296.905546416716;6312.2740884796995;6332.240131184103;6410.134631824644;6491.383318584727;6507.869842603216;6525.119108920425;6529.183852018497;6535.2811190768025;6070.453659170696;6250.531210159347;6299.275583307978;6306.495480361652;6316.242050953731;6171.876562468636;6229;6231.875362492634;6277.497800176066;6343.3022367538615;6086.6348019119;6279.183706118175;6280.214973128359;6282.905756413749;6287.654179020198;6313.210848643919;6330.113784070326;6331.2085989251345;6339.049142628643;6340.1123842661145;6021.939780602138;6075.817725468066;6107.114468402146;6168.568200225941;6217.285012223471 07:44:23 INFO - PROCESS | 1631 | |1;ext.html;743.9070116235471;777.3936329662863;799.6481548118829;870.886784717987;880.3837313880285;22894.88552557239;28092.71907280929;28486.866444691066;38938.415923761095;39364.606353936455;40375.79812100943;40614.39078413826;40619.187616247655;40634.79682601583;40689.982750431256;9047.683331083397;9209.907900920973;9220.077992200793;9220.815583688322;9228.031056739046;7309.780706578811;7474.887876681854;7524.172341042508;7527.021487206655;9037.819243615124;7443.553386796782;7468;10872.347659140476;11124.221304508688;11153.163512736537;10706.357618542912;10966.122710183206;11033.117350612012;11048.723781905437;11053.17101217412;9587.42475451468;10826.971437713404;10835.783284334348;10838;10850.29473084247;27720.722792772016;28133.015344462845;38014.80992595047;38668.226635467414;38817.22365552673;3858.7005317185726;3866.4393662919;3887.708421868343;3920.6079392060565;4052.797360132011;26653.200403987717;27077.323066923287;27807;28110.43779124406;28303.716962830313;2674.438367942734;2696.865156742175;2703.972960270392;2706.431649353638;2708.5801700736415;368452;372632;373419;375396;383086.3382732358;51092.489075109515;51154.74422627863;51320.48679513232;51331.7433412838;51478.74260628748;54251;54300;54326.18510722342;54370.45629543733;54434.45565544294;14077.859221407654;14475.348609312607;14482.782758258634;14483.348249328596;14510.709785804225;12624.81062784059;12636.989040876708;12641.925436338015;12653.74692506163;12658.556950506872;10046.397216167054;11504.884951150549;11660.591879284353;11761.411929403495;11809.645710628694;4745.525447455296;4765.046990601824;4786.904261914742;4788.664793464493;4793.209120495149;1087.3041253597703;1111.394290111891;1112.0047557436048;1183.680406290314;1195.2649120790652;26080;26521.46957060848;26653.86673066661;26714.5992810108;26714.732852671612;1237.6348977051791;1246.8815462531045;1250.6810763255494;1295.1710905020793;1295.4429595273934;13207.273599951903;13714.725705485835;13799.379027943565;13845.376958036912;13882.652933676738;476631;477593;477823;478723;479115;55672.72163639156;55712.885742284925;55796;55888.6027849307;55898.72050639721;1411.9929400353137;1455.294182321573;1459.8613131752466;1460.3428457194304;1464.1361596658023;24273.757262427855;24984.62523062119;25751.356216094;25823.612645810703;25846.22461326163;41469;41472.54846080373;41479;41479.7926010368;41540.58459415367;424860;425105;425499;425847;425900;28273;28983.85508072446;30195.849020754755;30261.394772103995;33112.1721956953;35370.64629353674;36065;36492.898103660424;36664.26671466503;36839.44740828836;20773.169073236902;27179.456410871277;27911.023114190906;28171.43657126887;28602.856985714938;27204.727952721012;27622.447551049267;27835.58246626262;28079;28237.858810705817;25807.870960645076;31889.202769930936;31998.52002220015;32515;32620.673793262715;23784.881075595204;27817.72182278232;28015.71984280131;28174.71825281721;29048.273793154494;21501;22389.776102238768;22833.31500055001;22850.542989140456;22894 07:44:23 INFO - PROCESS | 1631 | |2;jquery.html;383.034752423892;407.2791159647424;413.65666496807654;423.50661479376527;441.2190422951374;12752.426140823662;14475.276236188189;20375.08312125954;21096.0506777195;21125.57748845022;22007.22974695886;22084.11663533461;22655.660165097535;22668.319950401514;23013.84930753464;6513.67431628419;6585.934140658604;6736.730530778763;6803.795886123399;6809.5233333666665;4075.510938687347;4207.768572728499;6636.634985075843;6784.7286108555845;6786.864262714743;6801.21785994612;7637.961810190941;7719.228077192264;7725.111612164589;7756.534607923514;7457.925420745777;7568;7711.537307761552;7724.6523906424345;7739.883901741478;7214.96392518034;7347.118345798485;7497.025386699749;7552.509086909334;7564.4704870658525;26918.327041823915;26954.595681064602;27057.729422705914;27070;27105.864470677716;2945.631796025497;2969.9257518561994;3054.22117360074;3120.953185702216;3167.081546351555;15449;16060.437884674096;16092.275847586887;16101.872868899181;16752.916235418747;2035.7862424445516;2050.241410678044;2186.35502526755;2190.4742861713235;2191.7260342457193;124087;127888;129454.70545294615;132580;133324.33337833345;21537.67693484599;21767;21842.672359914613;21968.560628787334;22077.558448830932;34386.140346491535;34985.65014349875;35081.298374032376;35095;35208;10527.105196058268;10799.622013229498;10973.725656858642;10982.615608453825;11168.274062186094;8926.776865232046;8940;8963.910360896438;9092.499912504876;9126.49804260772;8660.834791302175;8701.738947831574;10126.696199114038;10185.796284074426;10446.738831529272;3380.6646374682355;3676.889693309205;4040.3535434330365;4097.385392191195;4171.186618609403;790;879.9120087991278;917.554985831871;933.7478880702308;939.7791518993031;22415.439614009454;22914.198003070145;23293.301200963997;23343.533129337316;23417;829.7178959153916;954.627695198873;960.5869476125333;972.1590823937385;992.1764935103846;11645.767084658259;11998.580049698394;12029.354500524152;12197.207181533173;12219.633410997685;759147;761331;777991;791455;826468;129157;147921;157548.21225894027;159543;166755.11656966942;1221.7434338788953;1248.8251644769557;1280.654223359669;1288.8711128887037;1290.9677258068623;18046.2781488739;18523.90738046301;19303.51741206481;19608;19670.606587867875;48997.75501122472;55759.884802304536;59521.702391487765;60178;60462.69768651129;86059.56970215109;86266;87325;88595.11404885868;88608.55695721738;11059.336439813636;11295;11369.090472761995;11562.30626162433;11625;12517.311547864954;12752.325215279112;13003.869961300266;13038.869611303766;13163.341832908507;10278.229132815219;10770.676879693621;11042.889571104186;11219.158563107636;11387.430628468377;9873.358231714916;9992.350497217658;10011.349262297927;10121.190304775453;10382.740431489274;10890.945545272223;10971.50628221716;11052.557897684002;11173.944130279297;11280.09759219244;9023.81952360936;11201.487799147011;11231.943840280746;11449.14131440162;11548;10755;10794.352338859379;11018;11040.447977600927;11138.777224455303 07:44:23 INFO - PROCESS | 1631 | |3;mootools.html;1323.404467989405;1545.1192820092551;1572.8584427401524;1592.1243316176103;1607.2124658917128;10491.318064325813;11152.219344645879;11152.553897844076;11167.609133680313;11171;10521.52653130609;10851.457427128651;10927.398993055378;11038.668839934795;11042.944785276062;2342.5666251743396;2380.940476488084;2381.130887226159;2385.666006759055;2387.3434805428474;2296.8851557422145;2347.4835536182013;2378.3459548624096;2380.0241900820665;2381.1665916929023;2281.190177486993;2347.2606129069372;2353.376355265856;2360.3745007573007;2361.598528250193;2296.276672848064;2299.977000229993;2329.755375685554;2336.544373847092;2339.4619237575284;2337.2520793346134;2337.9532409351887;2342.9297121086393;2346.9647955280684;2348.1194552042984;10994.010539051524;11011.889881101166;11016.228863979524;11024.283421577651;11029.117670586334;5460.945390546083;5494.478024587658;5666.065099258617;5683;5702.3157221133315;3339.215284408162;3506;3568.3398571264397;3601.7478776485655;3602.1174812170925;1102.311055590256;1128.7065363005677;1164.9767004659943;1182.4442512019336;1188.8097904335266;11870.406479675896;13452.260125693083;13845.100068495616;15636.921815390964;15675.294611742498;4062.431259623655;4172.603602657743;4175.665946724315;4176.352665336878;4177.958220417757;11196.552137914392;11559.075273978062;11604.245724027911;11671.533138674527;11679.240849344766;5431.619786614899;5494.5054945054335;5497.505224529811;5499.477549632778;5507.752151153208;4901.534354236342;5075.467075957045;5134.922976155361;5137.12668846297;5165.48345165488;3725.6088110747983;3834.827432765532;3869.729118961702;3901.122247494291;3914.336407027002;1010.4392062405288;1013.4831236069657;1015.1827778638267;1028.4035259549594;1031.742064483879;898.820235952812;931.3201363005044;932.8880534335788;933.4166146158651;980.0836218136066;6604.933950660528;6618.735250590019;6765.458763298924;6854.725810967605;6870.965645171742;953.1612181280428;977.4672803322206;994.5077186792439;1040.6149724601794;1040.6305761454576;4149.647279981235;4223.450951376363;4223.640990515841;4235.131797981407;4317.438732964757;13236.602901912765;13933.303334833217;13938;13948.302584870717;13973.86026139746;13514.864851351558;13686.589402317946;13761;13819.861801381858;13972.650683732785;10169.23730720199;10287.845682314772;10306.227032972558;10310;10310.742231444125;6374.58565193261;6463.676816159267;6609.074729537772;6664.500162487736;6684.966575167093;11902.761944761229;12295.139340246455;12327.445264962918;12369.93815030919;12469.625911222314;9783.85324220123;10989.494307334275;11129.777404452028;12726.87273127257;12744.553940612033;8967.50678712651;9100.726978190665;9312.44125352481;9360.344775865624;9362.297827662816;8771.780705482159;10186.694399168036;10251.974802519688;10383.792324153626;10432.530536126045;8503.1921967413;8556.144385561394;8592.484450932963;8622.310215182644;8663.6101375437;7293.416526677959;8571.871421928552;8651.91348086511;8684;8853.380263381501;7799.18108598589;7916.525008499509;8037.7588672339925;8045.07481639619;8052.919470805217;5954.940450595439;6030.276366836008;6031.366706495754;6032.656487329116;6084.90872636902;5075.365579302587;5669.858253543694;5894.6757928314355;5981;6122.448979591858 07:44:23 INFO - PROCESS | 1631 | |4;prototype.html;356.42793316726653;373.7757345592645;376.80029584320283;382.6078269773483;384.12994567305043;4275.007494753677;4510.774461276936;4810.278458231267;5116.565091967178;5177.870553236166;3977.6420122188997;4989.326440930473;5021.623378246628;5028.874278143048;5079.619028572863;3295.9452975047993;3449.999500144955;3587.587427445851;4174.937375939363;4200.453940987667;3709.517762690846;4150.398192262135;4175.64291605228;4177.101923086536;4224.471941007374;3344.715699165574;3684.889453316405;3997.5627053970215;4212.440487787814;4243.660507159435;3780.5615378080984;3806.7906265155407;4168.812403441852;4181.184668989548;4204.3903633972905;3808.428735689641;3814.256220037094;3815.351390263662;3837.808109594509;3849.9230015399817;4148.522919864224;4230.682698797572;4822.71063736177;4877.414710234759;4936.777844996984;4616.607588354994;4801.791176058982;4805.3753012108555;4814.06125805468;4838.6371022173125;5160.329157209539;5330.626856120073;5345.839624811262;5362.329708786402;5379.1662292344745;3617.8914632561064;4297.699161058727;4309.375140604595;4311.61195492404;4351.891202719926;4618.376519169903;5039.672421292605;5461.292948868402;5679.091345384719;5725.799597014126;4071.877843664695;4175.1629283115335;4298.505671847777;4346.087321662423;4353.651707863363;4054.553999060101;4278.101598664253;4445.755483448376;4455.75493347869;4471.485779135376;3849.9230015400094;4395.7142785718825;4507.31239510905;4651.720896746206;4856.805727770849;4725.456572494207;5187.625279300988;5315.468453154654;5376.46235376467;5401.8109366172785;1431.8496557861274;1440.337444775394;1503.88720845937;1508.351408894186;1508.547435769265;943.9197668198143;990.7424069741919;1070.688406701784;1142.651491295163;1143.9542418303174;4781.760911954389;4958;4960.280759289955;4985.675931064469;5028.974855125774;4833.347498087784;4912.901741965141;5537.280153580009;5552.833414997556;5562.721863906789;4330.39374487572;4567.4062371892105;4570.88572785683;4760.619150467955;4795.017021510582;2345.835791494613;2750.868077240155;2779.4996900558094;2835.149455163443;2910.2869796899895;5456.454354564591;5461.317335333083;5732.815045017161;5755.482006619341;5760.724513817019;4844.75776211188;5251.606129540223;5347.839564813062;5505.03661859173;5536.640118392372;4484.775761211927;5027.497250274943;5545.473180047889;5551.8056868010235;5737.741801618854;4805.9038819224115;4813.232391374903;5539.612227144061;5563.972180139073;5573.136163894603;4577.924187815927;4940.975295123501;4948.703077815343;5525.392206857323;5534.889302213853;5167.560757335668;5661.631993920382;5689.6586204827845;5727;5798.275215598051;4329.350597410414;4361.168309310034;4399.758013309171;4463.750149958017;4481.887952801076;5081.39935920184;5391.353037635509;5398.13629819227;5398.892022159614;5603.80386686464;4892.143874821963;4910.386201724785;4913.43495498008;5332.733363331896;5359.624826262124;4404.405405270376;4992.2761199626575;5004;5137.998090372491;5228.241904923689;4159.937600935928;4792.873674686376;4839.177339852304;4918.761963306615;5234.685918844882;4796.784144713426;4808.581468466741;4908.484609115992;5263.473652634859;5389.59578031657;5313.601479888946;5342.839714808562;5349.358077030781;5357.116075847442;5358.651687640447 07:44:23 INFO - PROCESS | 1631 | |5;yui.html;730.9122905251371;746.1792028768352;749.8725216713158;821.9876701849472;846.2468403121221;15225.543233702992;17752.911235443822;18657.533561660966;18727.25090996362;18736.1568729407;16333.033662970756;17040.659186816287;17346;17393.39123130691;17394.739078913826;941.7598512379351;968.0464742228899;968.2060710217625;970.3110791338158;970.3983530211243;931.3247895275938;947.052947052947;959.8080383923208;969.4377261188494;973.0221127766584;1011.8633984412121;1015.035716069733;1015.6851376073441;1017.20657886848;1019.5157300282381;1007.9869730920451;1010.1060561403137;1010.3230835340339;1010.691739019595;1011.6762635956497;749.0449676662299;749.1160430691782;750.3284560318484;750.4596690382915;750.6209364271008;14873.256337183098;15583.610409739735;15669;15969.201539923073;16006.679866402606;13916.165030098227;14122.71754564903;14161.78757318641;14199.36102875373;14327.856721432861;11609.535618575246;11657.76684466306;11861.940690296493;11909.821352679717;12064.336461494615;3644.526211592476;3663.3952477815246;3752.3808571585655;3761.9059523511855;3871.9225615487812;100768.99231007743;115174.42412787882;118713;120094.79905200923;120166.39916800447;10501.264911456125;10511.52698128586;10854.023137917626;11013.174011949135;11015.944920275348;22755;22934.42663933415;22983.195588154333;22998.540029199656;23018.079276829074;7597.430192735567;7653.57905315213;7732;7771.844563108706;8001.4398992071165;3624.655657712513;4229.429027081366;4303;4319.632831209319;4413.227685155085;3461.6019157797177;3561.216532362876;3635.836387362575;3830.387138057953;3854.6145385461227;683.5693513086823;692.6571347183076;704.2851505721696;706.2231545300232;707.2079271216168;661.9569727967666;685.3797313431353;697.6546609428366;709.5104377979178;730.6456368661195;9686.176674982706;9849.655262065793;10091.444970526545;10352.430616316024;10453.9477302613;533.2294833964961;536.3965538768884;573.2604939627834;581.2792137749245;638.2054342343812;4207.84284321814;4856.8300109495995;4989.926858072953;5026.874328141753;5044.545990860766;105146.422803658;106980;109140;109187.45406273077;110684;75330.24669753232;75807;83222;85579;86050;67630.30924226933;67910.98133528001;71144.64427678035;73786;75435;8887.600057997535;9504.572294246636;9597;10779.67660970172;11285.830712539482;46879.29681054855;47327.52672473231;48718.5128148714;50693.746531267105;50844;68628.6568567154;68810.3118968824;69454.65272673604;70647.64676176586;70672.29327706656;12397.28262481807;12477.625671229878;12483.251004939733;12617.242965422103;13376;13035.47858085666;14349.713005740035;14560.49038283655;14678.559643210294;14874.925625371803;12628.684282893002;12798.552050678181;13298;13325;13431;11898.821517677416;12674.746505070032;13897.37461814241;13952.16287022782;14189.929050354682;12549.811752823533;12646.002806450033;13511.256880871646;13532.93233533826;13615.455381785014;9361.485118318558;9618.467777783317;9912.15746661513;9926.652567160403;9943.850842237516;10180.745481363025;11206.383648899062;11413.372264525198;11415.486303116546;11468.31190128595 07:44:23 INFO - PROCESS | 1631 | __end_tp_report 07:44:23 INFO - PROCESS | 1631 | __start_cc_report 07:44:23 INFO - PROCESS | 1631 | _x_x_mozilla_cycle_collect,1496 07:44:23 INFO - PROCESS | 1631 | __end_cc_report 07:44:23 INFO - PROCESS | 1631 | __startTimestamp1490971463104__endTimestamp 07:44:23 INFO - PROCESS | 1631 | 07:44:23 INFO - PROCESS | 1631 | ------- Summary: start ------- 07:44:23 INFO - PROCESS | 1631 | Number of tests: 6 07:44:23 INFO - PROCESS | 1631 | 07:44:23 INFO - PROCESS | 1631 | [#0] dojo.html Cycles:165 Average:5968.35 Median:6180.94 stddev:673.74 (10.9%) stddev-sans-first:631.89 07:44:23 INFO - PROCESS | 1631 | Values: 2918.3 3213.8 3399.9 3430.3 3457.5 5998.9 5999.7 6025.0 6070.5 6093.4 5991.0 6061.5 6069.3 6080.5 6089.9 5413.6 5436.5 5456.6 5468.5 5553.2 5345.9 5354.0 5531.2 5553.5 5600.9 5395.9 5430.6 5458.7 5460.7 5465.9 5429.4 5437.8 5438.6 5448.2 5460.8 5278.6 5386.9 5392.1 5397.1 5437.9 5980.3 5981.9 5982.9 5986.9 5994.7 6305.5 6308.0 6308.6 6309.7 6319.4 6515.3 6530.2 6530.8 6532.0 6534.6 6105.3 6180.2 6180.7 6180.9 6195.8 6286.2 6328.7 6629.8 6634.6 6637.5 6117.9 6255.9 6260.3 6267.7 6276.3 6224.7 6439.0 6507.3 6516.2 6518.5 6401.3 6402.2 6402.7 6414.7 6418.2 6255.8 6403.0 6405.2 6425.0 6443.6 4905.0 5158.0 5188.4 5233.5 5245.6 4623.6 4633.7 4650.0 4651.4 4667.8 6041.8 6060.4 6084.5 6100.0 6111.0 6249.8 6417.3 6420.2 6522.8 6536.3 6052.8 6069.1 6070.9 6075.8 6078.9 4936.3 5690.3 5702.0 5717.2 5725.5 5748.2 6299.1 6334.7 6570.0 6651.3 6418.3 6445.2 6458.7 6466.8 6483.1 6610.1 6663.1 6673.4 6684.5 6692.7 6293.0 6296.9 6312.3 6332.2 6410.1 6491.4 6507.9 6525.1 6529.2 6535.3 6070.5 6250.5 6299.3 6306.5 6316.2 6171.9 6229.0 6231.9 6277.5 6343.3 6086.6 6279.2 6280.2 6282.9 6287.7 6313.2 6330.1 6331.2 6339.0 6340.1 6021.9 6075.8 6107.1 6168.6 6217.3 07:44:23 INFO - PROCESS | 1631 | 07:44:23 INFO - PROCESS | 1631 | [#1] ext.html Cycles:180 Average:55129.62 Median:28395.29 stddev:113840.36 (400.9%) stddev-sans-first:114086.48 07:44:23 INFO - PROCESS | 1631 | Values: 743.9 777.4 799.6 870.9 880.4 22894.9 28092.7 28486.9 38938.4 39364.6 40375.8 40614.4 40619.2 40634.8 40690.0 9047.7 9209.9 9220.1 9220.8 9228.0 7309.8 7474.9 7524.2 7527.0 9037.8 7443.6 7468.0 10872.3 11124.2 11153.2 10706.4 10966.1 11033.1 11048.7 11053.2 9587.4 10827.0 10835.8 10838.0 10850.3 27720.7 28133.0 38014.8 38668.2 38817.2 3858.7 3866.4 3887.7 3920.6 4052.8 26653.2 27077.3 27807.0 28110.4 28303.7 2674.4 2696.9 2704.0 2706.4 2708.6 368452.0 372632.0 373419.0 375396.0 383086.3 51092.5 51154.7 51320.5 51331.7 51478.7 54251.0 54300.0 54326.2 54370.5 54434.5 14077.9 14475.3 14482.8 14483.3 14510.7 12624.8 12637.0 12641.9 12653.7 12658.6 10046.4 11504.9 11660.6 11761.4 11809.6 4745.5 4765.0 4786.9 4788.7 4793.2 1087.3 1111.4 1112.0 1183.7 1195.3 26080.0 26521.5 26653.9 26714.6 26714.7 1237.6 1246.9 1250.7 1295.2 1295.4 13207.3 13714.7 13799.4 13845.4 13882.7 476631.0 477593.0 477823.0 478723.0 479115.0 55672.7 55712.9 55796.0 55888.6 55898.7 1412.0 1455.3 1459.9 1460.3 1464.1 24273.8 24984.6 25751.4 25823.6 25846.2 41469.0 41472.5 41479.0 41479.8 41540.6 424860.0 425105.0 425499.0 425847.0 425900.0 28273.0 28983.9 30195.8 30261.4 33112.2 35370.6 36065.0 36492.9 36664.3 36839.4 20773.2 27179.5 27911.0 28171.4 28602.9 27204.7 27622.4 27835.6 28079.0 28237.9 25807.9 31889.2 31998.5 32515.0 32620.7 23784.9 27817.7 28015.7 28174.7 29048.3 21501.0 22389.8 22833.3 22850.5 22894.0 07:44:23 INFO - PROCESS | 1631 | 07:44:23 INFO - PROCESS | 1631 | [#2] jquery.html Cycles:180 Average:43307.13 Median:22964.02 stddev:129851.40 (565.5%) stddev-sans-first:130175.66 07:44:23 INFO - PROCESS | 1631 | Values: 383.0 407.3 413.7 423.5 441.2 12752.4 14475.3 20375.1 21096.1 21125.6 22007.2 22084.1 22655.7 22668.3 23013.8 6513.7 6585.9 6736.7 6803.8 6809.5 4075.5 4207.8 6636.6 6784.7 6786.9 6801.2 7638.0 7719.2 7725.1 7756.5 7457.9 7568.0 7711.5 7724.7 7739.9 7215.0 7347.1 7497.0 7552.5 7564.5 26918.3 26954.6 27057.7 27070.0 27105.9 2945.6 2969.9 3054.2 3121.0 3167.1 15449.0 16060.4 16092.3 16101.9 16752.9 2035.8 2050.2 2186.4 2190.5 2191.7 124087.0 127888.0 129454.7 132580.0 133324.3 21537.7 21767.0 21842.7 21968.6 22077.6 34386.1 34985.7 35081.3 35095.0 35208.0 10527.1 10799.6 10973.7 10982.6 11168.3 8926.8 8940.0 8963.9 9092.5 9126.5 8660.8 8701.7 10126.7 10185.8 10446.7 3380.7 3676.9 4040.4 4097.4 4171.2 790.0 879.9 917.6 933.7 939.8 22415.4 22914.2 23293.3 23343.5 23417.0 829.7 954.6 960.6 972.2 992.2 11645.8 11998.6 12029.4 12197.2 12219.6 759147.0 761331.0 777991.0 791455.0 826468.0 129157.0 147921.0 157548.2 159543.0 166755.1 1221.7 1248.8 1280.7 1288.9 1291.0 18046.3 18523.9 19303.5 19608.0 19670.6 48997.8 55759.9 59521.7 60178.0 60462.7 86059.6 86266.0 87325.0 88595.1 88608.6 11059.3 11295.0 11369.1 11562.3 11625.0 12517.3 12752.3 13003.9 13038.9 13163.3 10278.2 10770.7 11042.9 11219.2 11387.4 9873.4 9992.4 10011.3 10121.2 10382.7 10890.9 10971.5 11052.6 11173.9 11280.1 9023.8 11201.5 11231.9 11449.1 11548.0 10755.0 10794.4 11018.0 11040.4 11138.8 07:44:23 INFO - PROCESS | 1631 | 07:44:23 INFO - PROCESS | 1631 | [#3] mootools.html Cycles:180 Average:6630.86 Median:2381.04 stddev:4152.46 (174.4%) stddev-sans-first:4144.96 07:44:23 INFO - PROCESS | 1631 | Values: 1323.4 1545.1 1572.9 1592.1 1607.2 10491.3 11152.2 11152.6 11167.6 11171.0 10521.5 10851.5 10927.4 11038.7 11042.9 2342.6 2380.9 2381.1 2385.7 2387.3 2296.9 2347.5 2378.3 2380.0 2381.2 2281.2 2347.3 2353.4 2360.4 2361.6 2296.3 2300.0 2329.8 2336.5 2339.5 2337.3 2338.0 2342.9 2347.0 2348.1 10994.0 11011.9 11016.2 11024.3 11029.1 5460.9 5494.5 5666.1 5683.0 5702.3 3339.2 3506.0 3568.3 3601.7 3602.1 1102.3 1128.7 1165.0 1182.4 1188.8 11870.4 13452.3 13845.1 15636.9 15675.3 4062.4 4172.6 4175.7 4176.4 4178.0 11196.6 11559.1 11604.2 11671.5 11679.2 5431.6 5494.5 5497.5 5499.5 5507.8 4901.5 5075.5 5134.9 5137.1 5165.5 3725.6 3834.8 3869.7 3901.1 3914.3 1010.4 1013.5 1015.2 1028.4 1031.7 898.8 931.3 932.9 933.4 980.1 6604.9 6618.7 6765.5 6854.7 6871.0 953.2 977.5 994.5 1040.6 1040.6 4149.6 4223.5 4223.6 4235.1 4317.4 13236.6 13933.3 13938.0 13948.3 13973.9 13514.9 13686.6 13761.0 13819.9 13972.7 10169.2 10287.8 10306.2 10310.0 10310.7 6374.6 6463.7 6609.1 6664.5 6685.0 11902.8 12295.1 12327.4 12369.9 12469.6 9783.9 10989.5 11129.8 12726.9 12744.6 8967.5 9100.7 9312.4 9360.3 9362.3 8771.8 10186.7 10252.0 10383.8 10432.5 8503.2 8556.1 8592.5 8622.3 8663.6 7293.4 8571.9 8651.9 8684.0 8853.4 7799.2 7916.5 8037.8 8045.1 8052.9 5954.9 6030.3 6031.4 6032.7 6084.9 5075.4 5669.9 5894.7 5981.0 6122.4 07:44:23 INFO - PROCESS | 1631 | 07:44:23 INFO - PROCESS | 1631 | [#4] prototype.html Cycles:180 Average:4422.73 Median:4809.43 stddev:1242.40 (25.8%) stddev-sans-first:1207.82 07:44:23 INFO - PROCESS | 1631 | Values: 356.4 373.8 376.8 382.6 384.1 4275.0 4510.8 4810.3 5116.6 5177.9 3977.6 4989.3 5021.6 5028.9 5079.6 3295.9 3450.0 3587.6 4174.9 4200.5 3709.5 4150.4 4175.6 4177.1 4224.5 3344.7 3684.9 3997.6 4212.4 4243.7 3780.6 3806.8 4168.8 4181.2 4204.4 3808.4 3814.3 3815.4 3837.8 3849.9 4148.5 4230.7 4822.7 4877.4 4936.8 4616.6 4801.8 4805.4 4814.1 4838.6 5160.3 5330.6 5345.8 5362.3 5379.2 3617.9 4297.7 4309.4 4311.6 4351.9 4618.4 5039.7 5461.3 5679.1 5725.8 4071.9 4175.2 4298.5 4346.1 4353.7 4054.6 4278.1 4445.8 4455.8 4471.5 3849.9 4395.7 4507.3 4651.7 4856.8 4725.5 5187.6 5315.5 5376.5 5401.8 1431.8 1440.3 1503.9 1508.4 1508.5 943.9 990.7 1070.7 1142.7 1144.0 4781.8 4958.0 4960.3 4985.7 5029.0 4833.3 4912.9 5537.3 5552.8 5562.7 4330.4 4567.4 4570.9 4760.6 4795.0 2345.8 2750.9 2779.5 2835.1 2910.3 5456.5 5461.3 5732.8 5755.5 5760.7 4844.8 5251.6 5347.8 5505.0 5536.6 4484.8 5027.5 5545.5 5551.8 5737.7 4805.9 4813.2 5539.6 5564.0 5573.1 4577.9 4941.0 4948.7 5525.4 5534.9 5167.6 5661.6 5689.7 5727.0 5798.3 4329.4 4361.2 4399.8 4463.8 4481.9 5081.4 5391.4 5398.1 5398.9 5603.8 4892.1 4910.4 4913.4 5332.7 5359.6 4404.4 4992.3 5004.0 5138.0 5228.2 4159.9 4792.9 4839.2 4918.8 5234.7 4796.8 4808.6 4908.5 5263.5 5389.6 5313.6 5342.8 5349.4 5357.1 5358.7 07:44:23 INFO - PROCESS | 1631 | 07:44:23 INFO - PROCESS | 1631 | [#5] yui.html Cycles:180 Average:20652.86 Median:3511.41 stddev:29830.47 (849.5%) stddev-sans-first:29876.64 07:44:23 INFO - PROCESS | 1631 | Values: 730.9 746.2 749.9 822.0 846.2 15225.5 17752.9 18657.5 18727.3 18736.2 16333.0 17040.7 17346.0 17393.4 17394.7 941.8 968.0 968.2 970.3 970.4 931.3 947.1 959.8 969.4 973.0 1011.9 1015.0 1015.7 1017.2 1019.5 1008.0 1010.1 1010.3 1010.7 1011.7 749.0 749.1 750.3 750.5 750.6 14873.3 15583.6 15669.0 15969.2 16006.7 13916.2 14122.7 14161.8 14199.4 14327.9 11609.5 11657.8 11861.9 11909.8 12064.3 3644.5 3663.4 3752.4 3761.9 3871.9 100769.0 115174.4 118713.0 120094.8 120166.4 10501.3 10511.5 10854.0 11013.2 11015.9 22755.0 22934.4 22983.2 22998.5 23018.1 7597.4 7653.6 7732.0 7771.8 8001.4 3624.7 4229.4 4303.0 4319.6 4413.2 3461.6 3561.2 3635.8 3830.4 3854.6 683.6 692.7 704.3 706.2 707.2 662.0 685.4 697.7 709.5 730.6 9686.2 9849.7 10091.4 10352.4 10453.9 533.2 536.4 573.3 581.3 638.2 4207.8 4856.8 4989.9 5026.9 5044.5 105146.4 106980.0 109140.0 109187.5 110684.0 75330.2 75807.0 83222.0 85579.0 86050.0 67630.3 67911.0 71144.6 73786.0 75435.0 8887.6 9504.6 9597.0 10779.7 11285.8 46879.3 47327.5 48718.5 50693.7 50844.0 68628.7 68810.3 69454.7 70647.6 70672.3 12397.3 12477.6 12483.3 12617.2 13376.0 13035.5 14349.7 14560.5 14678.6 14874.9 12628.7 12798.6 13298.0 13325.0 13431.0 11898.8 12674.7 13897.4 13952.2 14189.9 12549.8 12646.0 13511.3 13532.9 13615.5 9361.5 9618.5 9912.2 9926.7 9943.9 10180.7 11206.4 11413.4 11415.5 11468.3 07:44:23 INFO - PROCESS | 1631 | -------- Summary: end -------- 07:44:23 INFO - PROCESS | 1631 | 07:44:23 INFO - TEST-INFO | 1631: exit 0 07:44:23 INFO - TEST-OK | dromaeo_css | took 1120430ms 07:44:23 INFO - TEST-START | kraken 07:44:23 INFO - operating with platform_type : mac_ 07:44:23 INFO - Initialising browser for kraken test... 07:44:23 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpqGX1DR/profile http://localhost:49249/getInfo.html) 07:44:26 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 07:44:26 INFO - PROCESS | 1642 | colorDepth:24 07:44:26 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 07:44:26 INFO - PROCESS | 1642 | __metrics 07:44:26 INFO - PROCESS | 1642 | 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" 07:44:26 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:44:27 INFO - TEST-INFO | 1642: exit 0 07:44:27 INFO - Browser initialized. 07:44:27 INFO - Running cycle 1/1 for kraken test... 07:44:27 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpqGX1DR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:39 INFO - PROCESS | 1643 | RSS: Main: 215105536 07:44:39 INFO - PROCESS | 1643 | 07:44:42 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 07:44:43 INFO - PROCESS | 1643 | RSS: Main: 268509184 07:44:43 INFO - PROCESS | 1643 | 07:44:45 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 07:44:46 INFO - PROCESS | 1643 | RSS: Main: 280473600 07:44:46 INFO - PROCESS | 1643 | 07:44:49 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 07:44:49 INFO - PROCESS | 1643 | RSS: Main: 375209984 07:44:49 INFO - PROCESS | 1643 | 07:44:51 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 07:44:52 INFO - PROCESS | 1643 | RSS: Main: 278933504 07:44:52 INFO - PROCESS | 1643 | 07:44:54 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:44:55 INFO - PROCESS | 1643 | RSS: Main: 280600576 07:44:55 INFO - PROCESS | 1643 | 07:44:58 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 07:44:58 INFO - PROCESS | 1643 | RSS: Main: 319430656 07:44:58 INFO - PROCESS | 1643 | 07:45:01 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 07:45:02 INFO - PROCESS | 1643 | RSS: Main: 320741376 07:45:02 INFO - PROCESS | 1643 | 07:45:05 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 07:45:05 INFO - PROCESS | 1643 | RSS: Main: 320233472 07:45:05 INFO - PROCESS | 1643 | 07:45:07 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:45:08 INFO - PROCESS | 1643 | RSS: Main: 294846464 07:45:08 INFO - PROCESS | 1643 | 07:45:09 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:45:10 INFO - PROCESS | 1643 | RSS: Main: 298418176 07:45:10 INFO - PROCESS | 1643 | 07:45:12 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:45:13 INFO - PROCESS | 1643 | RSS: Main: 304496640 07:45:13 INFO - PROCESS | 1643 | 07:45:16 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:45:17 INFO - PROCESS | 1643 | RSS: Main: 319840256 07:45:17 INFO - PROCESS | 1643 | 07:45:19 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:45:20 INFO - PROCESS | 1643 | RSS: Main: 313278464 07:45:20 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 07:45:22 INFO - PROCESS | 1643 | RSS: Main: 357752832 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | __start_tp_report 07:45:22 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 07:45:22 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 07:45:22 INFO - PROCESS | 1643 | |i|pagename|runs| 07:45:22 INFO - PROCESS | 1643 | |0;ai-astar;117;116;115;112;116;114;114;116;115;115 07:45:22 INFO - PROCESS | 1643 | |1;audio-beat-detection;146;108;112;144;111;110;110;110;130;108 07:45:22 INFO - PROCESS | 1643 | |2;audio-dft;186;183;184;184;185;184;185;185;187;185 07:45:22 INFO - PROCESS | 1643 | |3;audio-fft;83;58;59;91;63;61;60;62;78;61 07:45:22 INFO - PROCESS | 1643 | |4;audio-oscillator;85;70;87;69;67;67;81;66;68;79 07:45:22 INFO - PROCESS | 1643 | |5;imaging-gaussian-blur;89;90;88;88;88;88;88;88;88;88 07:45:22 INFO - PROCESS | 1643 | |6;imaging-darkroom;96;95;95;93;96;96;95;97;96;95 07:45:22 INFO - PROCESS | 1643 | |7;imaging-desaturate;83;96;83;85;86;84;87;83;83;82 07:45:22 INFO - PROCESS | 1643 | |8;json-parse-financial;62;61;61;60;63;63;64;63;63;62 07:45:22 INFO - PROCESS | 1643 | |9;json-stringify-tinderbox;54;59;57;64;59;56;58;57;57;58 07:45:22 INFO - PROCESS | 1643 | |10;stanford-crypto-aes;86;86;82;76;81;98;97;100;87;85 07:45:22 INFO - PROCESS | 1643 | |11;stanford-crypto-ccm;141;149;146;135;137;138;138;138;177;137 07:45:22 INFO - PROCESS | 1643 | |12;stanford-crypto-pbkdf2;162;167;163;181;167;166;166;162;165;163 07:45:22 INFO - PROCESS | 1643 | |13;stanford-crypto-sha256-iterative;66;65;67;69;81;83;80;79;63;62 07:45:22 INFO - PROCESS | 1643 | __end_tp_report 07:45:22 INFO - PROCESS | 1643 | __start_cc_report 07:45:22 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,2122 07:45:22 INFO - PROCESS | 1643 | __end_cc_report 07:45:22 INFO - PROCESS | 1643 | __startTimestamp1490971522526__endTimestamp 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | ------- Summary: start ------- 07:45:22 INFO - PROCESS | 1643 | Number of tests: 14 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.50 stddev:1.41 (1.2%) stddev-sans-first:1.30 07:45:22 INFO - PROCESS | 1643 | Values: 117.0 116.0 115.0 112.0 116.0 114.0 114.0 116.0 115.0 115.0 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | [#1] audio-beat-detection Cycles:10 Average:118.90 Median:111.50 stddev:15.18 (13.6%) stddev-sans-first:12.53 07:45:22 INFO - PROCESS | 1643 | Values: 146.0 108.0 112.0 144.0 111.0 110.0 110.0 110.0 130.0 108.0 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.00 stddev:1.14 (0.6%) stddev-sans-first:1.12 07:45:22 INFO - PROCESS | 1643 | Values: 186.0 183.0 184.0 184.0 185.0 184.0 185.0 185.0 187.0 185.0 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | [#3] audio-fft Cycles:10 Average:67.60 Median:62.50 stddev:11.82 (18.9%) stddev-sans-first:11.14 07:45:22 INFO - PROCESS | 1643 | Values: 83.0 58.0 59.0 91.0 63.0 61.0 60.0 62.0 78.0 61.0 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | [#4] audio-oscillator Cycles:10 Average:73.90 Median:74.50 stddev:8.18 (11.0%) stddev-sans-first:7.63 07:45:22 INFO - PROCESS | 1643 | Values: 85.0 70.0 87.0 69.0 67.0 67.0 81.0 66.0 68.0 79.0 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:88.00 stddev:0.67 (0.8%) stddev-sans-first:0.67 07:45:22 INFO - PROCESS | 1643 | Values: 89.0 90.0 88.0 88.0 88.0 88.0 88.0 88.0 88.0 88.0 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | [#6] imaging-darkroom Cycles:10 Average:95.40 Median:96.00 stddev:1.07 (1.1%) stddev-sans-first:1.12 07:45:22 INFO - PROCESS | 1643 | Values: 96.0 95.0 95.0 93.0 96.0 96.0 95.0 97.0 96.0 95.0 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:84.50 stddev:4.10 (4.9%) stddev-sans-first:4.28 07:45:22 INFO - PROCESS | 1643 | Values: 83.0 96.0 83.0 85.0 86.0 84.0 87.0 83.0 83.0 82.0 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:63.00 stddev:1.23 (2.0%) stddev-sans-first:1.30 07:45:22 INFO - PROCESS | 1643 | Values: 62.0 61.0 61.0 60.0 63.0 63.0 64.0 63.0 63.0 62.0 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:2.60 (4.5%) stddev-sans-first:2.35 07:45:22 INFO - PROCESS | 1643 | Values: 54.0 59.0 57.0 64.0 59.0 56.0 58.0 57.0 57.0 58.0 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:86.00 stddev:7.97 (9.3%) stddev-sans-first:8.43 07:45:22 INFO - PROCESS | 1643 | Values: 86.0 86.0 82.0 76.0 81.0 98.0 97.0 100.0 87.0 85.0 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:139.50 stddev:12.53 (9.0%) stddev-sans-first:13.25 07:45:22 INFO - PROCESS | 1643 | Values: 141.0 149.0 146.0 135.0 137.0 138.0 138.0 138.0 177.0 137.0 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.00 stddev:5.55 (3.3%) stddev-sans-first:5.68 07:45:22 INFO - PROCESS | 1643 | Values: 162.0 167.0 163.0 181.0 167.0 166.0 166.0 162.0 165.0 163.0 07:45:22 INFO - PROCESS | 1643 | 07:45:22 INFO - PROCESS | 1643 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:74.00 stddev:8.25 (11.1%) stddev-sans-first:8.51 07:45:22 INFO - PROCESS | 1643 | Values: 66.0 65.0 67.0 69.0 81.0 83.0 80.0 79.0 63.0 62.0 07:45:22 INFO - PROCESS | 1643 | -------- Summary: end -------- 07:45:22 INFO - PROCESS | 1643 | 07:45:23 INFO - TEST-INFO | 1643: exit 0 07:45:23 INFO - TEST-OK | kraken | took 59595ms 07:45:23 INFO - SUITE-END | took 1180s 07:45:23 INFO - Completed test suite (00:19:40) 07:45:23 INFO - javascript benchmark 07:45:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7603.624157400518, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2918.2850201700585, 3213.8108899707113, 3399.881004164853, 3430.2624935638864, 3457.464093065574, 5998.850028749283, 5999.6700181490005, 6025.035994240922, 6070.5143588512865, 6093.360197179293, 5991.0, 6061.515078793697, 6069.332373438918, 6080.483158931496, 6089.939100608993, 5413.593980451472, 5436.483534064278, 5456.563474921997, 5468.507834294933, 5553.194786755918, 5345.866353341159, 5353.973230133844, 5531.170324451345, 5553.527950124224, 5600.859978500529, 5395.946040539603, 5430.56555475561, 5458.727063646822, 5460.672359658433, 5465.890682186354, 5429.375621803503, 5437.755301011464, 5438.564914806806, 5448.182772584085, 5460.781568737246, 5278.551323137538, 5386.865328366822, 5392.137258038695, 5397.136458166714, 5437.939601777655, 5980.312264089642, 5981.8803623927715, 5982.8504287392725, 5986.880262394771, 5994.670293133876, 6305.527085468562, 6307.96846015767, 6308.589941653824, 6309.747610095591, 6319.3680631936895, 6515.283318834924, 6530.183727034121, 6530.771423000172, 6532.0, 6534.575252608565, 6105.32841387447, 6180.196574445338, 6180.690965451754, 6180.938190618126, 6195.783147589813, 6286.15136956505, 6328.6835658216905, 6629.834254143637, 6634.601923884582, 6637.535372523877, 6117.897713130785, 6255.874882502416, 6260.342664020303, 6267.749290028348, 6276.309605943343, 6224.719887604978, 6439.034144878212, 6507.34926507355, 6516.152900122954, 6518.511111666644, 6401.295857455676, 6402.167718196604, 6402.711877965503, 6414.743410263537, 6418.19772528434, 6255.843603909939, 6402.967985160044, 6405.19935008124, 6425.036244563353, 6443.613383196929, 4905.018996200774, 5157.994191132768, 5188.351456067991, 5233.476652334813, 5245.580353571705, 4623.583877450978, 4633.675642705046, 4650.023495066074, 4651.4418269807165, 4667.789949452283, 6041.758329666764, 6060.393960603904, 6084.5436592255755, 6100.0, 6111.0, 6249.812505624838, 6417.294097649255, 6420.165378500765, 6522.804315870531, 6536.346365363425, 6052.818415447544, 6069.089636554552, 6070.908936365958, 6075.817725468243, 6078.878422431615, 4936.308916751657, 5690.317161940594, 5701.971490142523, 5717.199592057115, 5725.484706376363, 5748.223989761329, 6299.055141728777, 6334.683265836782, 6569.967150164219, 6651.268360480247, 6418.293987661447, 6445.226572811105, 6458.7093580789915, 6466.805995820133, 6483.124778154889, 6610.10763546915, 6663.100481434944, 6673.366030227121, 6684.498662600422, 6692.665366731741, 6293.0, 6296.905546416716, 6312.2740884796995, 6332.240131184103, 6410.134631824644, 6491.383318584727, 6507.869842603216, 6525.119108920425, 6529.183852018497, 6535.2811190768025, 6070.453659170696, 6250.531210159347, 6299.275583307978, 6306.495480361652, 6316.242050953731, 6171.876562468636, 6229.0, 6231.875362492634, 6277.497800176066, 6343.3022367538615, 6086.6348019119, 6279.183706118175, 6280.214973128359, 6282.905756413749, 6287.654179020198, 6313.210848643919, 6330.113784070326, 6331.2085989251345, 6339.049142628643, 6340.1123842661145, 6021.939780602138, 6075.817725468066, 6107.114468402146, 6168.568200225941, 6217.285012223471], "value": 5922.448718264843, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.9070116235471, 777.3936329662863, 799.6481548118829, 870.886784717987, 880.3837313880285, 22894.88552557239, 28092.71907280929, 28486.866444691066, 38938.415923761095, 39364.606353936455, 40375.79812100943, 40614.39078413826, 40619.187616247655, 40634.79682601583, 40689.982750431256, 9047.683331083397, 9209.907900920973, 9220.077992200793, 9220.815583688322, 9228.031056739046, 7309.780706578811, 7474.887876681854, 7524.172341042508, 7527.021487206655, 9037.819243615124, 7443.553386796782, 7468.0, 10872.347659140476, 11124.221304508688, 11153.163512736537, 10706.357618542912, 10966.122710183206, 11033.117350612012, 11048.723781905437, 11053.17101217412, 9587.42475451468, 10826.971437713404, 10835.783284334348, 10838.0, 10850.29473084247, 27720.722792772016, 28133.015344462845, 38014.80992595047, 38668.226635467414, 38817.22365552673, 3858.7005317185726, 3866.4393662919, 3887.708421868343, 3920.6079392060565, 4052.797360132011, 26653.200403987717, 27077.323066923287, 27807.0, 28110.43779124406, 28303.716962830313, 2674.438367942734, 2696.865156742175, 2703.972960270392, 2706.431649353638, 2708.5801700736415, 368452.0, 372632.0, 373419.0, 375396.0, 383086.3382732358, 51092.489075109515, 51154.74422627863, 51320.48679513232, 51331.7433412838, 51478.74260628748, 54251.0, 54300.0, 54326.18510722342, 54370.45629543733, 54434.45565544294, 14077.859221407654, 14475.348609312607, 14482.782758258634, 14483.348249328596, 14510.709785804225, 12624.81062784059, 12636.989040876708, 12641.925436338015, 12653.74692506163, 12658.556950506872, 10046.397216167054, 11504.884951150549, 11660.591879284353, 11761.411929403495, 11809.645710628694, 4745.525447455296, 4765.046990601824, 4786.904261914742, 4788.664793464493, 4793.209120495149, 1087.3041253597703, 1111.394290111891, 1112.0047557436048, 1183.680406290314, 1195.2649120790652, 26080.0, 26521.46957060848, 26653.86673066661, 26714.5992810108, 26714.732852671612, 1237.6348977051791, 1246.8815462531045, 1250.6810763255494, 1295.1710905020793, 1295.4429595273934, 13207.273599951903, 13714.725705485835, 13799.379027943565, 13845.376958036912, 13882.652933676738, 476631.0, 477593.0, 477823.0, 478723.0, 479115.0, 55672.72163639156, 55712.885742284925, 55796.0, 55888.6027849307, 55898.72050639721, 1411.9929400353137, 1455.294182321573, 1459.8613131752466, 1460.3428457194304, 1464.1361596658023, 24273.757262427855, 24984.62523062119, 25751.356216094, 25823.612645810703, 25846.22461326163, 41469.0, 41472.54846080373, 41479.0, 41479.7926010368, 41540.58459415367, 424860.0, 425105.0, 425499.0, 425847.0, 425900.0, 28273.0, 28983.85508072446, 30195.849020754755, 30261.394772103995, 33112.1721956953, 35370.64629353674, 36065.0, 36492.898103660424, 36664.26671466503, 36839.44740828836, 20773.169073236902, 27179.456410871277, 27911.023114190906, 28171.43657126887, 28602.856985714938, 27204.727952721012, 27622.447551049267, 27835.58246626262, 28079.0, 28237.858810705817, 25807.870960645076, 31889.202769930936, 31998.52002220015, 32515.0, 32620.673793262715, 23784.881075595204, 27817.72182278232, 28015.71984280131, 28174.71825281721, 29048.273793154494, 21501.0, 22389.776102238768, 22833.31500055001, 22850.542989140456, 22894.0], "value": 17871.52539698329, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.034752423892, 407.2791159647424, 413.65666496807654, 423.50661479376527, 441.2190422951374, 12752.426140823662, 14475.276236188189, 20375.08312125954, 21096.0506777195, 21125.57748845022, 22007.22974695886, 22084.11663533461, 22655.660165097535, 22668.319950401514, 23013.84930753464, 6513.67431628419, 6585.934140658604, 6736.730530778763, 6803.795886123399, 6809.5233333666665, 4075.510938687347, 4207.768572728499, 6636.634985075843, 6784.7286108555845, 6786.864262714743, 6801.21785994612, 7637.961810190941, 7719.228077192264, 7725.111612164589, 7756.534607923514, 7457.925420745777, 7568.0, 7711.537307761552, 7724.6523906424345, 7739.883901741478, 7214.96392518034, 7347.118345798485, 7497.025386699749, 7552.509086909334, 7564.4704870658525, 26918.327041823915, 26954.595681064602, 27057.729422705914, 27070.0, 27105.864470677716, 2945.631796025497, 2969.9257518561994, 3054.22117360074, 3120.953185702216, 3167.081546351555, 15449.0, 16060.437884674096, 16092.275847586887, 16101.872868899181, 16752.916235418747, 2035.7862424445516, 2050.241410678044, 2186.35502526755, 2190.4742861713235, 2191.7260342457193, 124087.0, 127888.0, 129454.70545294615, 132580.0, 133324.33337833345, 21537.67693484599, 21767.0, 21842.672359914613, 21968.560628787334, 22077.558448830932, 34386.140346491535, 34985.65014349875, 35081.298374032376, 35095.0, 35208.0, 10527.105196058268, 10799.622013229498, 10973.725656858642, 10982.615608453825, 11168.274062186094, 8926.776865232046, 8940.0, 8963.910360896438, 9092.499912504876, 9126.49804260772, 8660.834791302175, 8701.738947831574, 10126.696199114038, 10185.796284074426, 10446.738831529272, 3380.6646374682355, 3676.889693309205, 4040.3535434330365, 4097.385392191195, 4171.186618609403, 790.0, 879.9120087991278, 917.554985831871, 933.7478880702308, 939.7791518993031, 22415.439614009454, 22914.198003070145, 23293.301200963997, 23343.533129337316, 23417.0, 829.7178959153916, 954.627695198873, 960.5869476125333, 972.1590823937385, 992.1764935103846, 11645.767084658259, 11998.580049698394, 12029.354500524152, 12197.207181533173, 12219.633410997685, 759147.0, 761331.0, 777991.0, 791455.0, 826468.0, 129157.0, 147921.0, 157548.21225894027, 159543.0, 166755.11656966942, 1221.7434338788953, 1248.8251644769557, 1280.654223359669, 1288.8711128887037, 1290.9677258068623, 18046.2781488739, 18523.90738046301, 19303.51741206481, 19608.0, 19670.606587867875, 48997.75501122472, 55759.884802304536, 59521.702391487765, 60178.0, 60462.69768651129, 86059.56970215109, 86266.0, 87325.0, 88595.11404885868, 88608.55695721738, 11059.336439813636, 11295.0, 11369.090472761995, 11562.30626162433, 11625.0, 12517.311547864954, 12752.325215279112, 13003.869961300266, 13038.869611303766, 13163.341832908507, 10278.229132815219, 10770.676879693621, 11042.889571104186, 11219.158563107636, 11387.430628468377, 9873.358231714916, 9992.350497217658, 10011.349262297927, 10121.190304775453, 10382.740431489274, 10890.945545272223, 10971.50628221716, 11052.557897684002, 11173.944130279297, 11280.09759219244, 9023.81952360936, 11201.487799147011, 11231.943840280746, 11449.14131440162, 11548.0, 10755.0, 10794.352338859379, 11018.0, 11040.447977600927, 11138.777224455303], "value": 11584.560258189887, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.404467989405, 1545.1192820092551, 1572.8584427401524, 1592.1243316176103, 1607.2124658917128, 10491.318064325813, 11152.219344645879, 11152.553897844076, 11167.609133680313, 11171.0, 10521.52653130609, 10851.457427128651, 10927.398993055378, 11038.668839934795, 11042.944785276062, 2342.5666251743396, 2380.940476488084, 2381.130887226159, 2385.666006759055, 2387.3434805428474, 2296.8851557422145, 2347.4835536182013, 2378.3459548624096, 2380.0241900820665, 2381.1665916929023, 2281.190177486993, 2347.2606129069372, 2353.376355265856, 2360.3745007573007, 2361.598528250193, 2296.276672848064, 2299.977000229993, 2329.755375685554, 2336.544373847092, 2339.4619237575284, 2337.2520793346134, 2337.9532409351887, 2342.9297121086393, 2346.9647955280684, 2348.1194552042984, 10994.010539051524, 11011.889881101166, 11016.228863979524, 11024.283421577651, 11029.117670586334, 5460.945390546083, 5494.478024587658, 5666.065099258617, 5683.0, 5702.3157221133315, 3339.215284408162, 3506.0, 3568.3398571264397, 3601.7478776485655, 3602.1174812170925, 1102.311055590256, 1128.7065363005677, 1164.9767004659943, 1182.4442512019336, 1188.8097904335266, 11870.406479675896, 13452.260125693083, 13845.100068495616, 15636.921815390964, 15675.294611742498, 4062.431259623655, 4172.603602657743, 4175.665946724315, 4176.352665336878, 4177.958220417757, 11196.552137914392, 11559.075273978062, 11604.245724027911, 11671.533138674527, 11679.240849344766, 5431.619786614899, 5494.5054945054335, 5497.505224529811, 5499.477549632778, 5507.752151153208, 4901.534354236342, 5075.467075957045, 5134.922976155361, 5137.12668846297, 5165.48345165488, 3725.6088110747983, 3834.827432765532, 3869.729118961702, 3901.122247494291, 3914.336407027002, 1010.4392062405288, 1013.4831236069657, 1015.1827778638267, 1028.4035259549594, 1031.742064483879, 898.820235952812, 931.3201363005044, 932.8880534335788, 933.4166146158651, 980.0836218136066, 6604.933950660528, 6618.735250590019, 6765.458763298924, 6854.725810967605, 6870.965645171742, 953.1612181280428, 977.4672803322206, 994.5077186792439, 1040.6149724601794, 1040.6305761454576, 4149.647279981235, 4223.450951376363, 4223.640990515841, 4235.131797981407, 4317.438732964757, 13236.602901912765, 13933.303334833217, 13938.0, 13948.302584870717, 13973.86026139746, 13514.864851351558, 13686.589402317946, 13761.0, 13819.861801381858, 13972.650683732785, 10169.23730720199, 10287.845682314772, 10306.227032972558, 10310.0, 10310.742231444125, 6374.58565193261, 6463.676816159267, 6609.074729537772, 6664.500162487736, 6684.966575167093, 11902.761944761229, 12295.139340246455, 12327.445264962918, 12369.93815030919, 12469.625911222314, 9783.85324220123, 10989.494307334275, 11129.777404452028, 12726.87273127257, 12744.553940612033, 8967.50678712651, 9100.726978190665, 9312.44125352481, 9360.344775865624, 9362.297827662816, 8771.780705482159, 10186.694399168036, 10251.974802519688, 10383.792324153626, 10432.530536126045, 8503.1921967413, 8556.144385561394, 8592.484450932963, 8622.310215182644, 8663.6101375437, 7293.416526677959, 8571.871421928552, 8651.91348086511, 8684.0, 8853.380263381501, 7799.18108598589, 7916.525008499509, 8037.7588672339925, 8045.07481639619, 8052.919470805217, 5954.940450595439, 6030.276366836008, 6031.366706495754, 6032.656487329116, 6084.90872636902, 5075.365579302587, 5669.858253543694, 5894.6757928314355, 5981.0, 6122.448979591858], "value": 5054.632126504189, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.42793316726653, 373.7757345592645, 376.80029584320283, 382.6078269773483, 384.12994567305043, 4275.007494753677, 4510.774461276936, 4810.278458231267, 5116.565091967178, 5177.870553236166, 3977.6420122188997, 4989.326440930473, 5021.623378246628, 5028.874278143048, 5079.619028572863, 3295.9452975047993, 3449.999500144955, 3587.587427445851, 4174.937375939363, 4200.453940987667, 3709.517762690846, 4150.398192262135, 4175.64291605228, 4177.101923086536, 4224.471941007374, 3344.715699165574, 3684.889453316405, 3997.5627053970215, 4212.440487787814, 4243.660507159435, 3780.5615378080984, 3806.7906265155407, 4168.812403441852, 4181.184668989548, 4204.3903633972905, 3808.428735689641, 3814.256220037094, 3815.351390263662, 3837.808109594509, 3849.9230015399817, 4148.522919864224, 4230.682698797572, 4822.71063736177, 4877.414710234759, 4936.777844996984, 4616.607588354994, 4801.791176058982, 4805.3753012108555, 4814.06125805468, 4838.6371022173125, 5160.329157209539, 5330.626856120073, 5345.839624811262, 5362.329708786402, 5379.1662292344745, 3617.8914632561064, 4297.699161058727, 4309.375140604595, 4311.61195492404, 4351.891202719926, 4618.376519169903, 5039.672421292605, 5461.292948868402, 5679.091345384719, 5725.799597014126, 4071.877843664695, 4175.1629283115335, 4298.505671847777, 4346.087321662423, 4353.651707863363, 4054.553999060101, 4278.101598664253, 4445.755483448376, 4455.75493347869, 4471.485779135376, 3849.9230015400094, 4395.7142785718825, 4507.31239510905, 4651.720896746206, 4856.805727770849, 4725.456572494207, 5187.625279300988, 5315.468453154654, 5376.46235376467, 5401.8109366172785, 1431.8496557861274, 1440.337444775394, 1503.88720845937, 1508.351408894186, 1508.547435769265, 943.9197668198143, 990.7424069741919, 1070.688406701784, 1142.651491295163, 1143.9542418303174, 4781.760911954389, 4958.0, 4960.280759289955, 4985.675931064469, 5028.974855125774, 4833.347498087784, 4912.901741965141, 5537.280153580009, 5552.833414997556, 5562.721863906789, 4330.39374487572, 4567.4062371892105, 4570.88572785683, 4760.619150467955, 4795.017021510582, 2345.835791494613, 2750.868077240155, 2779.4996900558094, 2835.149455163443, 2910.2869796899895, 5456.454354564591, 5461.317335333083, 5732.815045017161, 5755.482006619341, 5760.724513817019, 4844.75776211188, 5251.606129540223, 5347.839564813062, 5505.03661859173, 5536.640118392372, 4484.775761211927, 5027.497250274943, 5545.473180047889, 5551.8056868010235, 5737.741801618854, 4805.9038819224115, 4813.232391374903, 5539.612227144061, 5563.972180139073, 5573.136163894603, 4577.924187815927, 4940.975295123501, 4948.703077815343, 5525.392206857323, 5534.889302213853, 5167.560757335668, 5661.631993920382, 5689.6586204827845, 5727.0, 5798.275215598051, 4329.350597410414, 4361.168309310034, 4399.758013309171, 4463.750149958017, 4481.887952801076, 5081.39935920184, 5391.353037635509, 5398.13629819227, 5398.892022159614, 5603.80386686464, 4892.143874821963, 4910.386201724785, 4913.43495498008, 5332.733363331896, 5359.624826262124, 4404.405405270376, 4992.2761199626575, 5004.0, 5137.998090372491, 5228.241904923689, 4159.937600935928, 4792.873674686376, 4839.177339852304, 4918.761963306615, 5234.685918844882, 4796.784144713426, 4808.581468466741, 4908.484609115992, 5263.473652634859, 5389.59578031657, 5313.601479888946, 5342.839714808562, 5349.358077030781, 5357.116075847442, 5358.651687640447], "value": 4061.6612766555104, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.9122905251371, 746.1792028768352, 749.8725216713158, 821.9876701849472, 846.2468403121221, 15225.543233702992, 17752.911235443822, 18657.533561660966, 18727.25090996362, 18736.1568729407, 16333.033662970756, 17040.659186816287, 17346.0, 17393.39123130691, 17394.739078913826, 941.7598512379351, 968.0464742228899, 968.2060710217625, 970.3110791338158, 970.3983530211243, 931.3247895275938, 947.052947052947, 959.8080383923208, 969.4377261188494, 973.0221127766584, 1011.8633984412121, 1015.035716069733, 1015.6851376073441, 1017.20657886848, 1019.5157300282381, 1007.9869730920451, 1010.1060561403137, 1010.3230835340339, 1010.691739019595, 1011.6762635956497, 749.0449676662299, 749.1160430691782, 750.3284560318484, 750.4596690382915, 750.6209364271008, 14873.256337183098, 15583.610409739735, 15669.0, 15969.201539923073, 16006.679866402606, 13916.165030098227, 14122.71754564903, 14161.78757318641, 14199.36102875373, 14327.856721432861, 11609.535618575246, 11657.76684466306, 11861.940690296493, 11909.821352679717, 12064.336461494615, 3644.526211592476, 3663.3952477815246, 3752.3808571585655, 3761.9059523511855, 3871.9225615487812, 100768.99231007743, 115174.42412787882, 118713.0, 120094.79905200923, 120166.39916800447, 10501.264911456125, 10511.52698128586, 10854.023137917626, 11013.174011949135, 11015.944920275348, 22755.0, 22934.42663933415, 22983.195588154333, 22998.540029199656, 23018.079276829074, 7597.430192735567, 7653.57905315213, 7732.0, 7771.844563108706, 8001.4398992071165, 3624.655657712513, 4229.429027081366, 4303.0, 4319.632831209319, 4413.227685155085, 3461.6019157797177, 3561.216532362876, 3635.836387362575, 3830.387138057953, 3854.6145385461227, 683.5693513086823, 692.6571347183076, 704.2851505721696, 706.2231545300232, 707.2079271216168, 661.9569727967666, 685.3797313431353, 697.6546609428366, 709.5104377979178, 730.6456368661195, 9686.176674982706, 9849.655262065793, 10091.444970526545, 10352.430616316024, 10453.9477302613, 533.2294833964961, 536.3965538768884, 573.2604939627834, 581.2792137749245, 638.2054342343812, 4207.84284321814, 4856.8300109495995, 4989.926858072953, 5026.874328141753, 5044.545990860766, 105146.422803658, 106980.0, 109140.0, 109187.45406273077, 110684.0, 75330.24669753232, 75807.0, 83222.0, 85579.0, 86050.0, 67630.30924226933, 67910.98133528001, 71144.64427678035, 73786.0, 75435.0, 8887.600057997535, 9504.572294246636, 9597.0, 10779.67660970172, 11285.830712539482, 46879.29681054855, 47327.52672473231, 48718.5128148714, 50693.746531267105, 50844.0, 68628.6568567154, 68810.3118968824, 69454.65272673604, 70647.64676176586, 70672.29327706656, 12397.28262481807, 12477.625671229878, 12483.251004939733, 12617.242965422103, 13376.0, 13035.47858085666, 14349.713005740035, 14560.49038283655, 14678.559643210294, 14874.925625371803, 12628.684282893002, 12798.552050678181, 13298.0, 13325.0, 13431.0, 11898.821517677416, 12674.746505070032, 13897.37461814241, 13952.16287022782, 14189.929050354682, 12549.811752823533, 12646.002806450033, 13511.256880871646, 13532.93233533826, 13615.455381785014, 9361.485118318558, 9618.467777783317, 9912.15746661513, 9926.652567160403, 9943.850842237516, 10180.745481363025, 11206.383648899062, 11413.372264525198, 11415.486303116546, 11468.31190128595], "value": 7676.199973970429, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1418.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 115.0, 112.0, 116.0, 114.0, 114.0, 116.0, 115.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 108.0, 112.0, 144.0, 111.0, 110.0, 110.0, 110.0, 130.0, 108.0], "value": 118.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 184.0, 184.0, 185.0, 184.0, 185.0, 185.0, 187.0, 185.0], "value": 184.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 59.0, 91.0, 63.0, 61.0, 60.0, 62.0, 78.0, 61.0], "value": 67.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 87.0, 69.0, 67.0, 67.0, 81.0, 66.0, 68.0, 79.0], "value": 73.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 88.0, 88.0, 88.0, 88.0, 88.0, 88.0, 88.0, 88.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 93.0, 96.0, 96.0, 95.0, 97.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 96.0, 83.0, 85.0, 86.0, 84.0, 87.0, 83.0, 83.0, 82.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 60.0, 63.0, 63.0, 64.0, 63.0, 63.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 57.0, 64.0, 59.0, 56.0, 58.0, 57.0, 57.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 82.0, 76.0, 81.0, 98.0, 97.0, 100.0, 87.0, 85.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 149.0, 146.0, 135.0, 137.0, 138.0, 138.0, 138.0, 177.0, 137.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 167.0, 163.0, 181.0, 167.0, 166.0, 166.0, 162.0, 165.0, 163.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 69.0, 81.0, 83.0, 80.0, 79.0, 63.0, 62.0], "value": 71.5, "unit": "score"}]}]} 07:45:23 INFO - Return code: 0 07:45:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:45:23 ERROR - # TBPL SUCCESS # 07:45:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:45:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:45:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:45:23 INFO - 2017-03-31 07:45:23.875 screenresolution[1647:9913] starting screenresolution argv=screenresolution get 07:45:23 INFO - 2017-03-31 07:45:23.878 screenresolution[1647:9913] Display 0: 1600x1200x32@60 07:45:23 INFO - 2017-03-31 07:45:23.884 screenresolution[1648:9916] starting screenresolution argv=screenresolution list 07:45:23 INFO - Available Modes on Display 0 07:45:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:45:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:45:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:45:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:45:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:45:24 INFO - Intel Iris: 07:45:24 INFO - Chipset Model: Intel Iris 07:45:24 INFO - Type: GPU 07:45:24 INFO - Bus: Built-In 07:45:24 INFO - VRAM (Dynamic, Max): 1536 MB 07:45:24 INFO - Vendor: Intel (0x8086) 07:45:24 INFO - Device ID: 0x0a2e 07:45:24 INFO - Revision ID: 0x0009 07:45:24 INFO - Displays: 07:45:24 INFO - Display: 07:45:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:45:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:45:24 INFO - Display Serial Number: 1600x1200 60 07:45:24 INFO - Main Display: Yes 07:45:24 INFO - Mirror: Off 07:45:24 INFO - Online: Yes 07:45:24 INFO - Rotation: Supported 07:45:24 INFO - Return code: 0 07:45:24 INFO - Running post-action listener: _resource_record_post_action 07:45:24 INFO - [mozharness: 2017-03-31 14:45:24.123440Z] Finished run-tests step (success) 07:45:24 INFO - Running post-run listener: _resource_record_post_run 07:45:24 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 42267648; Write bytes: 510844928; Read time: 422; Write time: 1851 07:45:24 INFO - TinderboxPrint: CPU usage
53.7% 07:45:24 INFO - TinderboxPrint: I/O read bytes / time
42,267,648 / 422 07:45:24 INFO - TinderboxPrint: I/O write bytes / time
510,844,928 / 1,851 07:45:24 INFO - TinderboxPrint: CPU idle
2,224.2 (46.3%) 07:45:24 INFO - TinderboxPrint: CPU system
955.1 (19.9%) 07:45:24 INFO - TinderboxPrint: CPU user
1,626.4 (33.8%) 07:45:24 INFO - TinderboxPrint: Swap in / out
247,463,936 / 0 07:45:24 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 197100032; Write bytes: 192174080; Read time: 15449; Write time: 460 07:45:24 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 41243648; Write bytes: 298895360; Read time: 406; Write time: 1340 07:45:24 INFO - Running post-run listener: _upload_blobber_files 07:45:24 INFO - Blob upload gear active. 07:45:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:45:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:45:24 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'] 07:45:24 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 07:45:24 INFO - (blobuploader) - INFO - Open directory for files ... 07:45:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:45:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:45:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:25 INFO - (blobuploader) - INFO - Done attempting. 07:45:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:45:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:45:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:26 INFO - (blobuploader) - INFO - Done attempting. 07:45:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:45:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:45:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:27 INFO - (blobuploader) - INFO - Done attempting. 07:45:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:45:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:45:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:45:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:45:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:45:30 INFO - (blobuploader) - INFO - Done attempting. 07:45:30 INFO - (blobuploader) - INFO - Iteration through files over. 07:45:30 INFO - Return code: 0 07:45:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:45:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:45:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74786e558c7a8dc50023cfeb28b78348c0c2c0554a3699e7cfa9dac9c26cfaced6c5ac7cf5093b9048727aceca22e100a59f7b1edb50040ca5a6b2c41593f81b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ddd9f8a77db8aaeadac1ffcc5e313a360111401d8088e0e4f1427edc76f2d988d05f07459dbe305018b873ba935dca823bcff907bbac74b43e1ccb4fab0cd2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ab98752b7809a1930c257acda436e713e57c315b3c50d54a07e6c3a0852dba5343bc812e81b93957f4a7e68c2137cf8d6678f5ddfd4e41204e7eee56a7f8e88", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfac67d50be635445dac2769498a76c0b3aab3d96c413fd23d8d05e608090d83b45b855a271f5e2bd6e57fb70182f850a7282c8ab322774c3b279e7917879a80"} 07:45:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:45:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:45:30 INFO - Contents: 07:45:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/74786e558c7a8dc50023cfeb28b78348c0c2c0554a3699e7cfa9dac9c26cfaced6c5ac7cf5093b9048727aceca22e100a59f7b1edb50040ca5a6b2c41593f81b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ddd9f8a77db8aaeadac1ffcc5e313a360111401d8088e0e4f1427edc76f2d988d05f07459dbe305018b873ba935dca823bcff907bbac74b43e1ccb4fab0cd2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ab98752b7809a1930c257acda436e713e57c315b3c50d54a07e6c3a0852dba5343bc812e81b93957f4a7e68c2137cf8d6678f5ddfd4e41204e7eee56a7f8e88", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfac67d50be635445dac2769498a76c0b3aab3d96c413fd23d8d05e608090d83b45b855a271f5e2bd6e57fb70182f850a7282c8ab322774c3b279e7917879a80"} 07:45:30 INFO - Running post-run listener: copy_logs_to_upload_dir 07:45:30 INFO - Copying logs to upload dir... 07:45:30 INFO - mkdir: /builds/slave/test/build/upload/logs 07:45:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.296441 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-31 07:45:30.188943) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 07:45:30.193937) ========= 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.hXlGKU86rw/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.GaZQVLvKVJ/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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/74786e558c7a8dc50023cfeb28b78348c0c2c0554a3699e7cfa9dac9c26cfaced6c5ac7cf5093b9048727aceca22e100a59f7b1edb50040ca5a6b2c41593f81b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ddd9f8a77db8aaeadac1ffcc5e313a360111401d8088e0e4f1427edc76f2d988d05f07459dbe305018b873ba935dca823bcff907bbac74b43e1ccb4fab0cd2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ab98752b7809a1930c257acda436e713e57c315b3c50d54a07e6c3a0852dba5343bc812e81b93957f4a7e68c2137cf8d6678f5ddfd4e41204e7eee56a7f8e88", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfac67d50be635445dac2769498a76c0b3aab3d96c413fd23d8d05e608090d83b45b855a271f5e2bd6e57fb70182f850a7282c8ab322774c3b279e7917879a80"} build_url:https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010942 build_url: 'https://queue.taskcluster.net/v1/task/c2Nx2sB7TAqKeuwRcVZQiw/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/74786e558c7a8dc50023cfeb28b78348c0c2c0554a3699e7cfa9dac9c26cfaced6c5ac7cf5093b9048727aceca22e100a59f7b1edb50040ca5a6b2c41593f81b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ddd9f8a77db8aaeadac1ffcc5e313a360111401d8088e0e4f1427edc76f2d988d05f07459dbe305018b873ba935dca823bcff907bbac74b43e1ccb4fab0cd2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2ab98752b7809a1930c257acda436e713e57c315b3c50d54a07e6c3a0852dba5343bc812e81b93957f4a7e68c2137cf8d6678f5ddfd4e41204e7eee56a7f8e88", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dfac67d50be635445dac2769498a76c0b3aab3d96c413fd23d8d05e608090d83b45b855a271f5e2bd6e57fb70182f850a7282c8ab322774c3b279e7917879a80"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 07:45:30.227442) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 07:45:30.227775) ========= 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.hXlGKU86rw/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.GaZQVLvKVJ/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.005177 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 07:45:30.279282) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 07:45:30.283620) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 07:45:30.283945) ========= ========= Total master_lag: 0.20 =========