builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0375 starttime: 1488593618.65 results: success (0) buildid: 20170303171724 builduid: cf8dfb25e677428fb73ba5e0c353b4d3 revision: 9a117f52a1371a223ff79a1f67a4b8cf08f9b69b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 18:13:38.648533) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 18:13:38.649008) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 18:13:38.649279) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 18:13:38.712244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:13:38.712609) ========= 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.hKNnASELPO/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.jWEwVuAHSA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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-03 18:13:38-- 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% 13.7M=0.001s 2017-03-03 18:13:39 (13.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.495551 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:13:39.234853) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:13:39.235194) ========= 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.hKNnASELPO/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.jWEwVuAHSA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.020950 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:13:39.283830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:13:39.284204) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9a117f52a1371a223ff79a1f67a4b8cf08f9b69b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9a117f52a1371a223ff79a1f67a4b8cf08f9b69b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hKNnASELPO/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.jWEwVuAHSA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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-03 18:13:39,373 truncating revision to first 12 chars 2017-03-03 18:13:39,373 Setting DEBUG logging. 2017-03-03 18:13:39,373 attempt 1/10 2017-03-03 18:13:39,373 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9a117f52a137?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-03 18:13:40,004 unpacking tar archive at: mozilla-central-9a117f52a137/testing/mozharness/ program finished with exit code 0 elapsedTime=0.893709 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:13:40.201943) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 18:13:40.202257) ========= script_repo_revision: 9a117f52a1371a223ff79a1f67a4b8cf08f9b69b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 18:13:40.202653) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 18:13:40.202917) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 18:13:40.227820) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-03 18:13:40.228169) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hKNnASELPO/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.jWEwVuAHSA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 18:13:40 INFO - MultiFileLogger online at 20170303 18:13:40 in /builds/slave/test 18:13:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:13:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:13:40 INFO - {'append_to_log': False, 18:13:40 INFO - 'base_work_dir': '/builds/slave/test', 18:13:40 INFO - 'blob_upload_branch': 'Firefox', 18:13:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:13:40 INFO - 'branch': 'Firefox', 18:13:40 INFO - 'buildbot_json_path': 'buildprops.json', 18:13:40 INFO - 'config_files': ('talos/mac_config.py',), 18:13:40 INFO - 'default_actions': ('clobber', 18:13:40 INFO - 'read-buildbot-config', 18:13:40 INFO - 'download-and-extract', 18:13:40 INFO - 'populate-webroot', 18:13:40 INFO - 'create-virtualenv', 18:13:40 INFO - 'install', 18:13:40 INFO - 'run-tests'), 18:13:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:13:40 INFO - 'download_minidump_stackwalk': True, 18:13:40 INFO - 'download_symbols': 'ondemand', 18:13:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:13:40 INFO - 'tooltool.py': '/tools/tooltool.py', 18:13:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:13:40 INFO - '/tools/misc-python/virtualenv.py')}, 18:13:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:13:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:13:40 INFO - 'gecko_profile': False, 18:13:40 INFO - 'gecko_profile_interval': 0, 18:13:40 INFO - 'installer_path': 'installer.exe', 18:13:40 INFO - 'log_level': 'info', 18:13:40 INFO - 'log_name': 'talos', 18:13:40 INFO - 'log_to_console': True, 18:13:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:13:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:13:40 INFO - 'opt_config_files': (), 18:13:40 INFO - 'pip_index': False, 18:13:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:13:40 INFO - 'cmd': ('bash', 18:13:40 INFO - '-c', 18:13:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:13:40 INFO - 'enabled': True, 18:13:40 INFO - 'halt_on_failure': False, 18:13:40 INFO - 'name': 'check_screen_resolution'},), 18:13:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:13:40 INFO - 'cmd': ('bash', 18:13:40 INFO - '-c', 18:13:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:13:40 INFO - 'enabled': True, 18:13:40 INFO - 'halt_on_failure': False, 18:13:40 INFO - 'name': 'check_screen_resolution'},), 18:13:40 INFO - 'run_cmd_checks_enabled': True, 18:13:40 INFO - 'suite': 'dromaeojs', 18:13:40 INFO - 'system_bits': '32', 18:13:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:13:40 INFO - 'title': 't-yosemite-r7-0375', 18:13:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:13:40 INFO - 'use_talos_json': True, 18:13:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:13:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:13:40 INFO - 'work_dir': 'build'} 18:13:40 INFO - [mozharness: 2017-03-04 02:13:40.436983Z] Running clobber step. 18:13:40 INFO - Running pre-action listener: _resource_record_pre_action 18:13:40 INFO - Running main action method: clobber 18:13:40 INFO - rmtree: /builds/slave/test/build 18:13:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:13:41 INFO - Running post-action listener: _resource_record_post_action 18:13:41 INFO - [mozharness: 2017-03-04 02:13:41.349180Z] Finished clobber step (success) 18:13:41 INFO - [mozharness: 2017-03-04 02:13:41.349345Z] Running read-buildbot-config step. 18:13:41 INFO - Running pre-action listener: _resource_record_pre_action 18:13:41 INFO - Running main action method: read_buildbot_config 18:13:41 INFO - Using buildbot properties: 18:13:41 INFO - { 18:13:41 INFO - "project": "", 18:13:41 INFO - "product": "firefox", 18:13:41 INFO - "script_repo_revision": "production", 18:13:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:13:41 INFO - "repository": "", 18:13:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:13:41 INFO - "buildid": "20170303171724", 18:13:41 INFO - "pgo_build": "False", 18:13:41 INFO - "basedir": "/builds/slave/test", 18:13:41 INFO - "buildnumber": 9, 18:13:41 INFO - "slavename": "t-yosemite-r7-0375", 18:13:41 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 18:13:41 INFO - "platform": "yosemite_r7", 18:13:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:13:41 INFO - "branch": "mozilla-central", 18:13:41 INFO - "repo_path": "mozilla-central", 18:13:41 INFO - "revision": "9a117f52a1371a223ff79a1f67a4b8cf08f9b69b", 18:13:41 INFO - "stage_platform": "macosx64", 18:13:41 INFO - "builduid": "cf8dfb25e677428fb73ba5e0c353b4d3", 18:13:41 INFO - "slavebuilddir": "test" 18:13:41 INFO - } 18:13:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 18:13:41 INFO - Running post-action listener: _resource_record_post_action 18:13:41 INFO - [mozharness: 2017-03-04 02:13:41.352745Z] Finished read-buildbot-config step (success) 18:13:41 INFO - [mozharness: 2017-03-04 02:13:41.352843Z] Running download-and-extract step. 18:13:41 INFO - Running pre-action listener: _resource_record_pre_action 18:13:41 INFO - Running main action method: download_and_extract 18:13:41 INFO - mkdir: /builds/slave/test/build/tests 18:13:41 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')]} 18:13:41 INFO - trying https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 18:13:41 INFO - Downloading https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 18:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 18:13:42 INFO - Downloaded 1199 bytes. 18:13:42 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 18:13:42 INFO - Using the following test package requirements: 18:13:42 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 18:13:42 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:13:42 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 18:13:42 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:13:42 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 18:13:42 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:13:42 INFO - u'jsshell-mac.zip'], 18:13:42 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:13:42 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 18:13:42 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 18:13:42 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:13:42 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 18:13:42 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:13:42 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 18:13:42 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:13:42 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 18:13:42 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:13:42 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 18:13:42 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:13:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 18:13:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:13:42 INFO - Fetch https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 18:13:44 INFO - Expected file size: 51775328 18:13:44 INFO - Obtained file size: 51775328 18:14:00 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:14:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 18:14:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:14:00 INFO - Fetch https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 18:14:02 INFO - Expected file size: 51775328 18:14:02 INFO - Obtained file size: 51775328 18:14:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 18:14:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:14:17 INFO - Fetch https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 18:14:18 INFO - Expected file size: 14404424 18:14:18 INFO - Obtained file size: 14404424 18:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:18 INFO - trying https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:14:18 INFO - Downloading https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 18:14:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 18:14:21 INFO - Downloaded 75187322 bytes. 18:14:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:14:21 INFO - mkdir: /builds/slave/test/properties 18:14:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:14:21 INFO - Writing to file /builds/slave/test/properties/build_url 18:14:21 INFO - Contents: 18:14:21 INFO - build_url:https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:14:22 INFO - Running post-action listener: _resource_record_post_action 18:14:22 INFO - Running post-action listener: set_extra_try_arguments 18:14:22 INFO - [mozharness: 2017-03-04 02:14:22.100415Z] Finished download-and-extract step (success) 18:14:22 INFO - [mozharness: 2017-03-04 02:14:22.100569Z] Running populate-webroot step. 18:14:22 INFO - Running pre-action listener: _resource_record_pre_action 18:14:22 INFO - Running main action method: populate_webroot 18:14:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:14:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:14:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:14:22 INFO - '--tppagecycles', 18:14:22 INFO - '7'], 18:14:22 INFO - 'tests': ['tsvgm']}}, 18:14:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:14:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:14:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:14:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:14:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:14:22 INFO - 'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:14:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:14:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:14:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:14:22 INFO - 'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['damp', 'tps']}, 18:14:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:14:22 INFO - 'tests': ['damp', 'tps']}, 18:14:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['dromaeo_dom']}, 18:14:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:14:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['basic_compositor_video']}, 18:14:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:14:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['a11yr', 18:14:22 INFO - 'ts_paint', 18:14:22 INFO - 'tpaint', 18:14:22 INFO - 'sessionrestore', 18:14:22 INFO - 'sessionrestore_no_auto_restore', 18:14:22 INFO - 'tabpaint']}, 18:14:22 INFO - 'other-e10s': {'tests': ['a11yr', 18:14:22 INFO - 'ts_paint', 18:14:22 INFO - 'tpaint', 18:14:22 INFO - 'sessionrestore', 18:14:22 INFO - 'sessionrestore_no_auto_restore', 18:14:22 INFO - 'tabpaint']}, 18:14:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:14:22 INFO - 'ts_paint', 18:14:22 INFO - 'tpaint', 18:14:22 INFO - 'sessionrestore', 18:14:22 INFO - 'sessionrestore_no_auto_restore', 18:14:22 INFO - 'tabpaint']}, 18:14:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:14:22 INFO - 'ts_paint', 18:14:22 INFO - 'tpaint', 18:14:22 INFO - 'sessionrestore', 18:14:22 INFO - 'sessionrestore_no_auto_restore', 18:14:22 INFO - 'tabpaint']}, 18:14:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['a11yr', 18:14:22 INFO - 'ts_paint', 18:14:22 INFO - 'tpaint', 18:14:22 INFO - 'sessionrestore', 18:14:22 INFO - 'sessionrestore_no_auto_restore', 18:14:22 INFO - 'tabpaint']}, 18:14:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['a11yr', 18:14:22 INFO - 'ts_paint', 18:14:22 INFO - 'tpaint', 18:14:22 INFO - 'sessionrestore', 18:14:22 INFO - 'sessionrestore_no_auto_restore', 18:14:22 INFO - 'tabpaint']}, 18:14:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['tsvgx', 18:14:22 INFO - 'tsvgr_opacity', 18:14:22 INFO - 'tart', 18:14:22 INFO - 'tscrollx', 18:14:22 INFO - 'cart', 18:14:22 INFO - 'tsvg_static']}, 18:14:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:14:22 INFO - 'tsvgr_opacity', 18:14:22 INFO - 'tart', 18:14:22 INFO - 'tscrollx', 18:14:22 INFO - 'cart', 18:14:22 INFO - 'tsvg_static']}, 18:14:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:14:22 INFO - 'talos_options': ['--disable-e10s'], 18:14:22 INFO - 'tests': ['tp5o']}, 18:14:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:14:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:14:22 INFO - 'talos_options': ['--disable-e10s', 18:14:22 INFO - '--xperf_path', 18:14:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:14:22 INFO - 'tests': ['tp5n']}, 18:14:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:14:22 INFO - 'talos_options': ['--xperf_path', 18:14:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:14:22 INFO - 'tests': ['tp5n']}}, 18:14:22 INFO - 'talos.zip': {'path': '', 18:14:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:14:22 INFO - Running post-action listener: _resource_record_post_action 18:14:22 INFO - [mozharness: 2017-03-04 02:14:22.118924Z] Finished populate-webroot step (success) 18:14:22 INFO - [mozharness: 2017-03-04 02:14:22.119056Z] Running create-virtualenv step. 18:14:22 INFO - Running pre-action listener: _resource_record_pre_action 18:14:22 INFO - Running main action method: create_virtualenv 18:14:22 INFO - Creating virtualenv /builds/slave/test/build/venv 18:14:22 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 18:14:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:14:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:14:22 INFO - Using real prefix '/tools/python27' 18:14:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:14:22 INFO - Installing distribute.............................................................................................................................................................................................done. 18:14:25 INFO - Installing pip.................done. 18:14:25 INFO - Return code: 0 18:14:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:14:26 INFO - Reading from file tmpfile_stdout 18:14:26 INFO - Output received: 18:14:26 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) 18:14:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:14:26 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')]} 18:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:26 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')]} 18:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:26 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 0x105e01b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f224a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bdfd30>, '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 0x105b06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bd4be8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 18:14:26 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 18:14:26 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 18:14:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 18:14:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:26 INFO - 'HOME': '/Users/cltbld', 18:14:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:26 INFO - 'LOGNAME': 'cltbld', 18:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:26 INFO - 'MOZ_NO_REMOTE': '1', 18:14:26 INFO - 'NO_EM_RESTART': '1', 18:14:26 INFO - 'PAGER': '/bin/cat', 18:14:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:26 INFO - 'PWD': '/builds/slave/test', 18:14:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:26 INFO - 'SHELL': '/bin/bash', 18:14:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 18:14:26 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 18:14:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:26 INFO - 'USER': 'cltbld', 18:14:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:26 INFO - 'XPC_FLAGS': '0x0', 18:14:26 INFO - 'XPC_SERVICE_NAME': '0', 18:14:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:26 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 18:14:26 INFO - Cleaning up... 18:14:26 INFO - Return code: 0 18:14:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:14:26 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')]} 18:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:26 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')]} 18:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:26 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 0x105e01b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f224a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bdfd30>, '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 0x105b06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bd4be8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 18:14:26 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 18:14:26 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 18:14:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 18:14:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:26 INFO - 'HOME': '/Users/cltbld', 18:14:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:26 INFO - 'LOGNAME': 'cltbld', 18:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:26 INFO - 'MOZ_NO_REMOTE': '1', 18:14:26 INFO - 'NO_EM_RESTART': '1', 18:14:26 INFO - 'PAGER': '/bin/cat', 18:14:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:26 INFO - 'PWD': '/builds/slave/test', 18:14:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:26 INFO - 'SHELL': '/bin/bash', 18:14:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 18:14:26 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 18:14:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:26 INFO - 'USER': 'cltbld', 18:14:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:26 INFO - 'XPC_FLAGS': '0x0', 18:14:26 INFO - 'XPC_SERVICE_NAME': '0', 18:14:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:26 INFO - Downloading/unpacking psutil>=3.1.1 18:14:26 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 18:14:26 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 18:14:26 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 18:14:26 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 18:14:26 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 18:14:26 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 18:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:14:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:14:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:14:30 INFO - Installing collected packages: psutil 18:14:30 INFO - Running setup.py install for psutil 18:14:30 INFO - building 'psutil._psutil_osx' extension 18:14:30 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 18:14:31 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 18:14:31 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 18:14:31 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 18:14:31 INFO - building 'psutil._psutil_posix' extension 18:14:31 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 18:14:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:14:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:14:31 INFO - ^ 18:14:31 INFO - 1 warning generated. 18:14:31 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 18:14:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:14:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:14:31 INFO - Successfully installed psutil 18:14:31 INFO - Cleaning up... 18:14:31 INFO - Return code: 0 18:14:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:31 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 0x105e01b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f224a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bdfd30>, '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 0x105b06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bd4be8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 18:14:31 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 18:14:31 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 18:14:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 18:14:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:31 INFO - 'HOME': '/Users/cltbld', 18:14:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:31 INFO - 'LOGNAME': 'cltbld', 18:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:31 INFO - 'MOZ_NO_REMOTE': '1', 18:14:31 INFO - 'NO_EM_RESTART': '1', 18:14:31 INFO - 'PAGER': '/bin/cat', 18:14:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:31 INFO - 'PWD': '/builds/slave/test', 18:14:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:31 INFO - 'SHELL': '/bin/bash', 18:14:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 18:14:31 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 18:14:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:31 INFO - 'USER': 'cltbld', 18:14:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:31 INFO - 'XPC_FLAGS': '0x0', 18:14:31 INFO - 'XPC_SERVICE_NAME': '0', 18:14:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:14:34 INFO - Installing collected packages: mozsystemmonitor 18:14:34 INFO - Running setup.py install for mozsystemmonitor 18:14:34 INFO - Successfully installed mozsystemmonitor 18:14:34 INFO - Cleaning up... 18:14:34 INFO - Return code: 0 18:14:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e01b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f224a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bdfd30>, '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 0x105b06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bd4be8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 18:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:14:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 18:14:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:34 INFO - 'HOME': '/Users/cltbld', 18:14:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:34 INFO - 'LOGNAME': 'cltbld', 18:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:34 INFO - 'MOZ_NO_REMOTE': '1', 18:14:34 INFO - 'NO_EM_RESTART': '1', 18:14:34 INFO - 'PAGER': '/bin/cat', 18:14:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:34 INFO - 'PWD': '/builds/slave/test', 18:14:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:34 INFO - 'SHELL': '/bin/bash', 18:14:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 18:14:34 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 18:14:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:34 INFO - 'USER': 'cltbld', 18:14:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:34 INFO - 'XPC_FLAGS': '0x0', 18:14:34 INFO - 'XPC_SERVICE_NAME': '0', 18:14:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:35 INFO - Downloading/unpacking jsonschema==2.5.1 18:14:35 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 18:14:35 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 18:14:35 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 18:14:35 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 18:14:35 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 18:14:35 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 18:14:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:14:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:14:37 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 18:14:37 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 18:14:37 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 18:14:37 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 18:14:37 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 18:14:37 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 18:14:38 INFO - Downloading functools32-3.2.3-2.tar.gz 18:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:14:38 INFO - warning: no files found matching '*.txt' 18:14:38 INFO - no previously-included directories found matching 'build' 18:14:38 INFO - no previously-included directories found matching 'dist' 18:14:38 INFO - no previously-included directories found matching '.git*' 18:14:38 INFO - Installing collected packages: jsonschema, functools32 18:14:38 INFO - Running setup.py install for functools32 18:14:38 INFO - warning: no files found matching '*.txt' 18:14:38 INFO - no previously-included directories found matching 'build' 18:14:38 INFO - no previously-included directories found matching 'dist' 18:14:38 INFO - no previously-included directories found matching '.git*' 18:14:38 INFO - Successfully installed jsonschema functools32 18:14:38 INFO - Cleaning up... 18:14:38 INFO - Return code: 0 18:14:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105e01b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f224a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bdfd30>, '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 0x105b06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bd4be8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 18:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:14:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 18:14:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:38 INFO - 'HOME': '/Users/cltbld', 18:14:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:38 INFO - 'LOGNAME': 'cltbld', 18:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:38 INFO - 'MOZ_NO_REMOTE': '1', 18:14:38 INFO - 'NO_EM_RESTART': '1', 18:14:38 INFO - 'PAGER': '/bin/cat', 18:14:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:38 INFO - 'PWD': '/builds/slave/test', 18:14:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:38 INFO - 'SHELL': '/bin/bash', 18:14:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 18:14:38 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 18:14:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:38 INFO - 'USER': 'cltbld', 18:14:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:38 INFO - 'XPC_FLAGS': '0x0', 18:14:38 INFO - 'XPC_SERVICE_NAME': '0', 18:14:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:14:38 INFO - Cleaning up... 18:14:38 INFO - Return code: 0 18:14:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105e01b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f224a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bdfd30>, '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 0x105b06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bd4be8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 18:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:14:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 18:14:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:38 INFO - 'HOME': '/Users/cltbld', 18:14:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:38 INFO - 'LOGNAME': 'cltbld', 18:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:38 INFO - 'MOZ_NO_REMOTE': '1', 18:14:38 INFO - 'NO_EM_RESTART': '1', 18:14:38 INFO - 'PAGER': '/bin/cat', 18:14:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:38 INFO - 'PWD': '/builds/slave/test', 18:14:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:38 INFO - 'SHELL': '/bin/bash', 18:14:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 18:14:38 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 18:14:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:38 INFO - 'USER': 'cltbld', 18:14:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:38 INFO - 'XPC_FLAGS': '0x0', 18:14:38 INFO - 'XPC_SERVICE_NAME': '0', 18:14:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:39 INFO - Downloading/unpacking blobuploader==1.2.4 18:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:14:41 INFO - Downloading blobuploader-1.2.4.tar.gz 18:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:14:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:14:41 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 18:14:41 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 18:14:41 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 18:14:41 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 18:14:41 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 18:14:41 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 18:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:14:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:14:42 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 18:14:42 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 18:14:42 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 18:14:42 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 18:14:42 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 18:14:42 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 18:14:42 INFO - Downloading docopt-0.6.1.tar.gz 18:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:14:43 INFO - Installing collected packages: blobuploader, requests, docopt 18:14:43 INFO - Running setup.py install for blobuploader 18:14:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:14:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:14:43 INFO - Running setup.py install for requests 18:14:43 INFO - Running setup.py install for docopt 18:14:43 INFO - Successfully installed blobuploader requests docopt 18:14:43 INFO - Cleaning up... 18:14:43 INFO - Return code: 0 18:14:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:14: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')]} 18:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14: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')]} 18:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:43 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 0x105e01b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f224a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bdfd30>, '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 0x105b06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bd4be8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 18:14:43 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 18:14:43 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 18:14:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 18:14:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:43 INFO - 'HOME': '/Users/cltbld', 18:14:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:43 INFO - 'LOGNAME': 'cltbld', 18:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:43 INFO - 'MOZ_NO_REMOTE': '1', 18:14:43 INFO - 'NO_EM_RESTART': '1', 18:14:43 INFO - 'PAGER': '/bin/cat', 18:14:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:43 INFO - 'PWD': '/builds/slave/test', 18:14:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:43 INFO - 'SHELL': '/bin/bash', 18:14:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 18:14:43 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 18:14:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:43 INFO - 'USER': 'cltbld', 18:14:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:43 INFO - 'XPC_FLAGS': '0x0', 18:14:43 INFO - 'XPC_SERVICE_NAME': '0', 18:14:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:14:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-2DzKKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:14:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-cYxRpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:14:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-QD0nlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:14:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-J7Ux6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:14:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-dBzaEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:14:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-r7IZTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:14:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-CQxLoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:14:44 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-r1acIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:14:45 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-7oLfy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:14:45 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-SvlA97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:14:45 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-SnuACy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:14:45 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-TjuviI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:14:45 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-D6Ug0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:14:45 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-l0r54g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:45 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-9J7lzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:14:45 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-vBh5TN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:14:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:14:45 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-E64NlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:14:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:14:45 INFO - Running setup.py install for manifestparser 18:14:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:14:46 INFO - Running setup.py install for mozcrash 18:14:46 INFO - Running setup.py install for mozdebug 18:14:46 INFO - Running setup.py install for mozdevice 18:14:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:14:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:14:46 INFO - Running setup.py install for mozfile 18:14:46 INFO - Running setup.py install for mozhttpd 18:14:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:14:46 INFO - Running setup.py install for mozinfo 18:14:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:14:47 INFO - Running setup.py install for mozInstall 18:14:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:14:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:14:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:14:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:14:47 INFO - Running setup.py install for mozleak 18:14:47 INFO - Running setup.py install for mozlog 18:14:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:14:47 INFO - Running setup.py install for moznetwork 18:14:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:14:47 INFO - Running setup.py install for mozprocess 18:14:47 INFO - Running setup.py install for mozprofile 18:14:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:14:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:14:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:14:47 INFO - Running setup.py install for mozrunner 18:14:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:14:48 INFO - Running setup.py install for mozscreenshot 18:14:48 INFO - Running setup.py install for moztest 18:14:48 INFO - Running setup.py install for mozversion 18:14:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:14:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:14:48 INFO - Cleaning up... 18:14:48 INFO - Return code: 0 18:14:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:14:48 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')]} 18:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:48 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')]} 18:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:48 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 0x105e01b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f224a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bdfd30>, '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 0x105b06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bd4be8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 18:14:48 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 18:14:48 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 18:14:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 18:14:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:48 INFO - 'HOME': '/Users/cltbld', 18:14:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:48 INFO - 'LOGNAME': 'cltbld', 18:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:48 INFO - 'MOZ_NO_REMOTE': '1', 18:14:48 INFO - 'NO_EM_RESTART': '1', 18:14:48 INFO - 'PAGER': '/bin/cat', 18:14:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:48 INFO - 'PWD': '/builds/slave/test', 18:14:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:48 INFO - 'SHELL': '/bin/bash', 18:14:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 18:14:48 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 18:14:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:48 INFO - 'USER': 'cltbld', 18:14:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:48 INFO - 'XPC_FLAGS': '0x0', 18:14:48 INFO - 'XPC_SERVICE_NAME': '0', 18:14:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:14:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Lf3JvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:14:48 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)) 18:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:14:48 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-OFwo0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:14:49 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)) 18:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:14:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-EiiOK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:14:49 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)) 18:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:14:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-k___5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:14:49 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)) 18:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:14:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-qJSSHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:14:49 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)) 18:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:14:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-8Wl2oZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:14:49 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)) 18:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:14:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-wHcUe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:14:49 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)) 18:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:14:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-pOy15V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:14:49 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)) 18:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:14:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-TXU_74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:14:49 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)) 18:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:14:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-4mfwMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:14:49 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)) 18:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:14:49 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-Fq5SIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:14:50 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)) 18:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:14:50 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-cPDg8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:14:50 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)) 18:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:14:50 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-0qCw01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:14:50 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)) 18:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:14:50 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-ChubF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:14:50 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)) 18:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:50 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-LtvSof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:14:50 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)) 18:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:14:50 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-FKjguo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:14:50 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)) 18:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:14:50 INFO - Running setup.py (path:/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/pip-BfcLMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:14:50 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)) 18:14:50 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)) 18:14:50 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)) 18:14:50 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)) 18:14:50 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)) 18:14:50 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)) 18:14:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:14:50 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 18:14:50 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 18:14:50 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 18:14:50 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 18:14:50 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 18:14:50 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 18:14:53 INFO - Downloading blessings-1.6.tar.gz 18:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:14:53 INFO - Installing collected packages: blessings 18:14:53 INFO - Running setup.py install for blessings 18:14:53 INFO - Successfully installed blessings 18:14:53 INFO - Cleaning up... 18:14:53 INFO - Return code: 0 18:14:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:14:54 INFO - Reading from file tmpfile_stdout 18:14:54 INFO - Current package versions: 18:14:54 INFO - blessings == 1.6 18:14:54 INFO - blobuploader == 1.2.4 18:14:54 INFO - docopt == 0.6.1 18:14:54 INFO - functools32 == 3.2.3-2 18:14:54 INFO - jsonschema == 2.5.1 18:14:54 INFO - manifestparser == 1.1 18:14:54 INFO - mozInstall == 1.12 18:14:54 INFO - mozcrash == 1.0 18:14:54 INFO - mozdebug == 0.1 18:14:54 INFO - mozdevice == 0.49 18:14:54 INFO - mozfile == 1.2 18:14:54 INFO - mozhttpd == 0.7 18:14:54 INFO - mozinfo == 0.9 18:14:54 INFO - mozleak == 0.1 18:14:54 INFO - mozlog == 3.4 18:14:54 INFO - moznetwork == 0.27 18:14:54 INFO - mozprocess == 0.25 18:14:54 INFO - mozprofile == 0.28 18:14:54 INFO - mozrunner == 6.13 18:14:54 INFO - mozscreenshot == 0.1 18:14:54 INFO - mozsystemmonitor == 0.3 18:14:54 INFO - moztest == 0.8 18:14:54 INFO - mozversion == 1.4 18:14:54 INFO - psutil == 3.1.1 18:14:54 INFO - requests == 1.2.3 18:14:54 INFO - wsgiref == 0.1.2 18:14:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:14:54 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')]} 18:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:54 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')]} 18:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:54 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 0x105e01b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f224a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bdfd30>, '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 0x105b06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bd4be8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 18:14:54 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 18:14:54 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 18:14:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 18:14:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:54 INFO - 'HOME': '/Users/cltbld', 18:14:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:54 INFO - 'LOGNAME': 'cltbld', 18:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:54 INFO - 'MOZ_NO_REMOTE': '1', 18:14:54 INFO - 'NO_EM_RESTART': '1', 18:14:54 INFO - 'PAGER': '/bin/cat', 18:14:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:54 INFO - 'PWD': '/builds/slave/test', 18:14:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:54 INFO - 'SHELL': '/bin/bash', 18:14:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 18:14:54 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 18:14:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:54 INFO - 'USER': 'cltbld', 18:14:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:54 INFO - 'XPC_FLAGS': '0x0', 18:14:54 INFO - 'XPC_SERVICE_NAME': '0', 18:14:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:54 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)) 18:14:54 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)) 18:14:54 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)) 18:14:54 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)) 18:14:54 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)) 18:14:54 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)) 18:14:54 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)) 18:14:54 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)) 18:14:54 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)) 18:14:54 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)) 18:14:54 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)) 18:14:54 INFO - Cleaning up... 18:14:54 INFO - Return code: 0 18:14:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:14:54 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')]} 18:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:54 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')]} 18:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:14:54 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 0x105e01b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e04768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f224a8c50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105bdfd30>, '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 0x105b06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bd4be8>, '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.hKNnASELPO/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.jWEwVuAHSA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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 18:14:54 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 18:14:54 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 18:14:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 18:14:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:14:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:14:54 INFO - 'HOME': '/Users/cltbld', 18:14:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:14:54 INFO - 'LOGNAME': 'cltbld', 18:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:14:54 INFO - 'MOZ_NO_REMOTE': '1', 18:14:54 INFO - 'NO_EM_RESTART': '1', 18:14:54 INFO - 'PAGER': '/bin/cat', 18:14:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:14:54 INFO - 'PWD': '/builds/slave/test', 18:14:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:14:54 INFO - 'SHELL': '/bin/bash', 18:14:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 18:14:54 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 18:14:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:14:54 INFO - 'USER': 'cltbld', 18:14:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:14:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:14:54 INFO - 'XPC_FLAGS': '0x0', 18:14:54 INFO - 'XPC_SERVICE_NAME': '0', 18:14:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:14:54 INFO - Cleaning up... 18:14:54 INFO - Return code: 0 18:14:54 INFO - Running post-action listener: _resource_record_post_action 18:14:54 INFO - Running post-action listener: _start_resource_monitoring 18:14:54 INFO - Starting resource monitoring. 18:14:54 INFO - [mozharness: 2017-03-04 02:14:54.604660Z] Finished create-virtualenv step (success) 18:14:54 INFO - [mozharness: 2017-03-04 02:14:54.605646Z] Running install step. 18:14:54 INFO - Running pre-action listener: _resource_record_pre_action 18:14:54 INFO - Running main action method: install 18:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:14:54 INFO - Reading from file tmpfile_stdout 18:14:54 INFO - Detecting whether we're running mozinstall >=1.0... 18:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:14:54 INFO - Reading from file tmpfile_stdout 18:14:54 INFO - Output received: 18:14:54 INFO - Usage: mozinstall [options] installer 18:14:54 INFO - Options: 18:14:54 INFO - -h, --help show this help message and exit 18:14:54 INFO - -d DEST, --destination=DEST 18:14:54 INFO - Directory to install application into. [default: 18:14:54 INFO - "/builds/slave/test"] 18:14:54 INFO - --app=APP Application being installed. [default: firefox] 18:14:54 INFO - mkdir: /builds/slave/test/build/application 18:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:15:14 INFO - Reading from file tmpfile_stdout 18:15:14 INFO - Output received: 18:15:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:15:14 INFO - Running post-action listener: _resource_record_post_action 18:15:14 INFO - [mozharness: 2017-03-04 02:15:14.992372Z] Finished install step (success) 18:15:14 INFO - [mozharness: 2017-03-04 02:15:14.992522Z] Running run-tests step. 18:15:14 INFO - Running pre-action listener: _resource_record_pre_action 18:15:14 INFO - Running main action method: run_tests 18:15:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:15:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:15:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:15:15 INFO - 2017-03-03 18:15:15.007 screenresolution[2169:16208] starting screenresolution argv=screenresolution get 18:15:15 INFO - 2017-03-03 18:15:15.009 screenresolution[2169:16208] Display 0: 1600x1200x32@60 18:15:15 INFO - 2017-03-03 18:15:15.015 screenresolution[2170:16211] starting screenresolution argv=screenresolution list 18:15:15 INFO - Available Modes on Display 0 18:15:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:15:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:15:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:15:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:15:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:15:15 INFO - Intel Iris: 18:15:15 INFO - Chipset Model: Intel Iris 18:15:15 INFO - Type: GPU 18:15:15 INFO - Bus: Built-In 18:15:15 INFO - VRAM (Dynamic, Max): 1536 MB 18:15:15 INFO - Vendor: Intel (0x8086) 18:15:15 INFO - Device ID: 0x0a2e 18:15:15 INFO - Revision ID: 0x0009 18:15:15 INFO - Displays: 18:15:15 INFO - Display: 18:15:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:15:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:15:15 INFO - Display Serial Number: 1600x1200 60 18:15:15 INFO - Main Display: Yes 18:15:15 INFO - Mirror: Off 18:15:15 INFO - Online: Yes 18:15:15 INFO - Rotation: Supported 18:15:15 INFO - Return code: 0 18:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:15:15 INFO - Python 2.7.3 18:15:15 INFO - Return code: 0 18:15:15 INFO - grabbing minidump binary from tooltool 18:15: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')]} 18:15:15 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 0x105bdfd30>, '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 0x105b06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105bd4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:15:15 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 18:15:15 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 18:15:15 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 18:15:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:15:15 INFO - Return code: 0 18:15:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:15:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:15:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:15:15 INFO - ENV: RUST_BACKTRACE is now 1 18:15:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:15:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 18:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0375 --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 18:15:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKNnASELPO/Render', 18:15:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:15:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:15:15 INFO - 'HOME': '/Users/cltbld', 18:15:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:15:15 INFO - 'LOGNAME': 'cltbld', 18:15:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:15:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:15 INFO - 'MOZ_NO_REMOTE': '1', 18:15:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:15:15 INFO - 'NO_EM_RESTART': '1', 18:15:15 INFO - 'PAGER': '/bin/cat', 18:15:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:15 INFO - 'PWD': '/builds/slave/test', 18:15:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:15:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:15:15 INFO - 'RUST_BACKTRACE': '1', 18:15:15 INFO - 'SHELL': '/bin/bash', 18:15:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWEwVuAHSA/Listeners', 18:15:15 INFO - 'TMPDIR': '/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/', 18:15:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:15:15 INFO - 'USER': 'cltbld', 18:15:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:15:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:15 INFO - 'XPC_FLAGS': '0x0', 18:15:15 INFO - 'XPC_SERVICE_NAME': '0', 18:15:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:15:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0375', '--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 18:15:15 INFO - mozversion application_buildid: 20170303171724 18:15:15 INFO - mozversion application_changeset: 9a117f52a1371a223ff79a1f67a4b8cf08f9b69b 18:15:15 INFO - mozversion application_display_name: Nightly 18:15:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:15:15 INFO - mozversion application_name: Firefox 18:15:15 INFO - mozversion application_remotingname: firefox 18:15:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:15:15 INFO - mozversion application_vendor: Mozilla 18:15:15 INFO - mozversion application_version: 54.0a1 18:15:15 INFO - mozversion platform_buildid: 20170303171724 18:15:15 INFO - mozversion platform_changeset: 9a117f52a1371a223ff79a1f67a4b8cf08f9b69b 18:15:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:15:15 INFO - mozversion platform_version: 54.0a1 18:15:15 INFO - using testdate: 1488593715 18:15:15 INFO - actual date: 1488593715 18:15:15 INFO - starting webserver on 'localhost:49777' 18:15:15 INFO - SUITE-START | Running 2 tests 18:15:15 INFO - TEST-START | dromaeo_css 18:15:15 INFO - operating with platform_type : mac_ 18:15:15 INFO - Initialising browser for dromaeo_css test... 18:15:15 INFO - TEST-INFO | started process 2180 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpm6HDIL/profile http://localhost:49777/getInfo.html) 18:15:18 INFO - PROCESS | 2180 | __metrics Screen width/height:1600/1200 18:15:18 INFO - PROCESS | 2180 | colorDepth:24 18:15:18 INFO - PROCESS | 2180 | Browser inner width/height: 1024/689 18:15:18 INFO - PROCESS | 2180 | __metrics 18:15:18 INFO - PROCESS | 2180 | 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" 18:15:18 INFO - PROCESS | 2180 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:15:18 INFO - TEST-INFO | 2180: exit 0 18:15:18 INFO - Browser initialized. 18:15:18 INFO - Running cycle 1/1 for dromaeo_css test... 18:15:18 INFO - TEST-INFO | started process 2182 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpm6HDIL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:15:31 INFO - PROCESS | 2182 | RSS: Main: 232042496 18:15:31 INFO - PROCESS | 2182 | 18:18:36 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49777/tests/dromaeo/cssquery-ext.html) 18:18:37 INFO - PROCESS | 2182 | RSS: Main: 371998720 18:18:37 INFO - PROCESS | 2182 | 18:20:20 INFO - PROCESS | 2182 | ************************* 18:20:20 INFO - PROCESS | 2182 | A coding exception was thrown and uncaught in a Task. 18:20:20 INFO - PROCESS | 2182 | 18:20:20 ERROR - PROCESS | 2182 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:20:20 INFO - PROCESS | 2182 | Full stack: 18:20:20 INFO - PROCESS | 2182 | ************************* 18:21:40 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-ext.html (next: http://localhost:49777/tests/dromaeo/cssquery-jquery.html) 18:21:41 INFO - PROCESS | 2182 | RSS: Main: 367886336 18:21:41 INFO - PROCESS | 2182 | 18:24:43 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49777/tests/dromaeo/cssquery-mootools.html) 18:24:44 INFO - PROCESS | 2182 | RSS: Main: 353660928 18:24:44 INFO - PROCESS | 2182 | 18:27:46 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49777/tests/dromaeo/cssquery-prototype.html) 18:27:47 INFO - PROCESS | 2182 | RSS: Main: 329973760 18:27:47 INFO - PROCESS | 2182 | 18:30:51 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49777/tests/dromaeo/cssquery-yui.html) 18:30:52 INFO - PROCESS | 2182 | RSS: Main: 334356480 18:30:52 INFO - PROCESS | 2182 | 18:33:55 INFO - PROCESS | 2182 | Cycle 1(1): loaded http://localhost:49777/tests/dromaeo/cssquery-yui.html (next: http://localhost:49777/tests/dromaeo/cssquery-dojo.html) 18:33:55 INFO - PROCESS | 2182 | RSS: Main: 420802560 18:33:55 INFO - PROCESS | 2182 | 18:33:55 INFO - PROCESS | 2182 | __start_tp_report 18:33:55 INFO - PROCESS | 2182 | _x_x_mozilla_page_load 18:33:55 INFO - PROCESS | 2182 | _x_x_mozilla_page_load_details 18:33:55 INFO - PROCESS | 2182 | |i|pagename|runs| 18:33:55 INFO - PROCESS | 2182 | |0;dojo.html;3308.057203696947;3309.983450082749;3323.7174840138587;3325.517799919013;3360.781549199302;5497.670139791615;5613.186088017235;5672.092465205568;5745.138229265613;5789.59472836901;5565.026120428929;5600.691961942091;5602.551795856332;5606.243157173781;5625.987322281988;5075.593952483792;5104.821331253407;5115.10485665009;5131.255967884655;5172.120739474299;5198.870028249286;5202;5207.791688332462;5216.947830521684;5217.921731174036;5192.61055420845;5202.583793296546;5206.635535512516;5207.270982062514;5216.035033518792;5207.453217412193;5208.010478009185;5219.504147106057;5220.425753167148;5220.634555581111;5039;5161.948380516222;5165.690058596496;5172.327597412313;5180.844574662766;5741.971290143564;5773.191753154561;5779.219805326311;5782.9421705782825;5786.247787787561;6048.939510604881;6229.626222426624;6239.719212635442;6250.968745156245;6265.310815810257;6144.863200307957;6160.229971253593;6177.81466556004;6185.350538193515;6189.783357582463;5196.45437229093;5698.34469036062;5841.824745257649;5891.764329426775;5894.823155305347;5613.933352662981;6021.849453763691;6232.127502149703;6246.781362652286;6262.874742505124;6138.907916381258;6164.260288765287;6186.876262474725;6187.938120618736;6190.597611155261;5258.6581872178185;6089.634621922699;6129.478994285447;6134.447899689049;6179.196704428396;6217.533684973555;6230.532710046674;6233.875322493524;6240.157578726905;6244;6248.250209974832;6268.279147897959;6268.937310626927;6274.843128921722;6285.779997700059;4846.927296090562;4860.0765854488245;4929.852104436873;4987.501249874984;5031.899362012739;4403.559644035635;4446.221911165533;4469.128519938646;4512.187806194851;4517;5888;5902.144189092557;5906.970465147647;5910.231669882888;5951.077582974646;6038.033914573647;6109.351931479865;6109.480694141048;6294.087357333253;6304.05439184126;5628.943710562924;5700.657960522382;5703.914441283384;5707.800226992118;5713.4000929902595;5334.466553344712;5339.786408543692;5339.919901201485;5341.145416733381;5353.38436079848;6330.240371155307;6330.303666596578;6331.461825744863;6345.079963405373;6347.238331400262;6252.374762523711;6297.685115744286;6308.08532762756;6313.463355614824;6319.873602528016;5304.602154838325;5837.29952405714;6198.442140207403;6339.397757213057;6354.7140378684;6107.037103281039;6131.816045518642;6133.202683651275;6141.170941922784;6144.508439324933;5695.202671626059;5873;6138.572327483795;6144.2488890665945;6165.907511387243;6069.453749162597;6074.149619053424;6114.419025732222;6115.270764408881;6148.139260503623;5844;5920.082387229986;6086.6652334122045;6107.84730381744;6135.202423684892;5642.548596112383;5813.157092221689;5822.854428639318;5833.766649333979;5841.036229022164;5327;5986.910196346971;5988.281406231106;6075.2405949256345;6085;5600.35595906476;5791.247137872049;5962.821115366546;5969.283685957539;5977.462028417463 18:33:55 INFO - PROCESS | 2182 | |1;ext.html;740.7999840043188;766.1534004924558;788.8540619985305;852.7825404521842;868.8218915122401;28158.29604259892;40131.799341003294;40740.59259407405;40794.18411631766;40884.99999999993;41738.58261417385;41981.79009104958;42119.578804211946;42139.57860421395;42144.36783448243;7213.170485394195;8998.280137588994;9128.954355228214;9162;9206.355555111146;7285.817854553652;7332.230115837813;7335.926640733578;7351.154617219008;10776.40729759863;11000.064994475479;11016.17378696601;11016.449177541092;11019.228653994223;11040.227184097117;10942.56229750809;10954.561817527288;10955.945220273848;10962.123030157569;10985.890141098647;7160.606166660831;7331.3401793838275;10717.517711702993;10784.622538211124;10796.028357447867;27990.300242493897;28241.85879070612;28254.717452825415;38649.61350386516;39276;3716.201016781405;3757.1170774867883;3776.7545109568064;3804.8668296609762;3821.102041020358;28186;28327.71672283292;28371.72327245279;28504;28681.426371472662;3026.0921723482866;3048.131282584453;3054.5461746388473;3055.724984751361;3066.723994840475;330450;336588;338334;338417;339401;52568.737156313975;52607.947841042966;52670.73664631729;52675.209871851956;52860.47139528555;54618.45381546134;54645;54761.60718303058;54765.452345476835;54807.725961369935;13730.65673358154;14114.85885141156;14115.505957291445;14118.50585229512;14168.149911005372;11982.221155624857;11989.760204795855;12000.75998480043;12017.158798883995;12023.27860328383;10804.567817287378;11020.283681560673;11243;12337.444814983168;12595.93702031484;5503.532199762985;5611.887762244733;5648.068068768689;5649.943500564942;5845.795397161164;1089.493385575711;1092.6995076354067;1105.2815669814686;1114.5374669512062;1130.5308297056629;21865.12539498434;22557.43606409853;23286.65070023951;25016.124435644666;25714.742852571235;1103.8289065194908;1198.3049831097942;1205.758069188737;1215.1190386969554;1261.438659796382;12576;13074.411651475706;13407.329633518286;13421.530246441327;13447.193168409927;417661;420237;420759;421958;422646;54872;55197.72401137969;55409.72295138498;55436.445635543125;55453.445465545636;1361.768499355112;1435.5549779568366;1440.625437386287;1440.6614445605485;1441.1209162410921;24115.246815286904;25027.998880044594;25066.498670026864;25137.74862251427;25717.871410642827;38694.419583705705;47254.29118563293;47259.76370118128;47371.52628473671;47536.286955696385;385278;387900.0604996957;393699;395905;398570.0071499624;33565.371218973705;33900.83049584835;34048;34160;34351.82824085864;35835.28329433344;35863;39359;43364.78317608392;43827.78086109549;33536.49695254524;34196.14509637279;34220.973370798914;35408.82295588506;36767.44848827216;30544.694553055073;35091.64908350884;35380.292394152486;36745.44881826828;36946.630533695396;30344.696553034188;35371.46942795809;35794.92615221548;36427.45358819673;36561.45157822582;30639.846800765852;31922.840385798852;32024;32087.037388878372;32145;19103.522411939255;23307.883460582587;23761.287161385186;23782.054486378405;23824.642630360213 18:33:55 INFO - PROCESS | 2182 | |2;jquery.html;372.96829769469593;396.1008510680753;402.74828232354776;407.85317285777114;435.04507605805253;13147.6713082173;17839.910800445996;20319.492012699673;21347.359579212647;21581.67627485589;21518;21944.780552194472;22319.776802231972;22650.320490385275;22748.886255568697;5985.970070149643;6269.749210031593;6409.327020662833;6573;6619.635920024397;6458.870822583545;6466.708998095097;6518.6740662966895;6536.150300460958;6537;6027.276726792791;6536.281009088996;6554.311797261291;7180.56916585004;7332.41340692746;6566.967165164144;6823.38589526945;7274.381677557388;7301.342879140902;7307.451941104438;7078.221395646475;7098;7102.396296314768;7111.64441777909;7116.466265030143;25044.123455679146;25975.610365844528;26183.214503564923;26398.472030559282;26757;2784.8468334241606;2828.7454129128273;2934.7358737713494;2949.6460424749166;2958.9704102959126;11399;14283.571492855232;14987.550373488813;15758.76361854573;16035;1524.9008814427027;1880.6802843516498;1883.256113835041;1914.2247389807012;1920.7599050118736;147361;150414;150615;152375;164088;14672.555406782727;17103.14484275781;17768.55578610545;19149.329773457863;19402.70895936562;24823.875880620843;28940.27649308784;30080.081581236;30353.69646303553;30381.69618303833;8679.045305016443;8770.736877893672;8838.425502342327;8865.734027979172;10848.728781780519;8576.871346929802;8653.134686531297;8902.620093885458;8944.552772361356;8944.597493112826;9285.25717942563;9770.853437198448;10623.981443525705;10733.570657173626;10755.181910421845;3989.8628890765995;4048.817803198863;4064.1871625674985;4074.796260186979;4077.347624380144;800.207794283655;809.8461292354434;810.6352141536332;817.3869597801648;845.5053793530853;21521.309836270466;22199.778002220093;22314.88842555777;22366.32901012972;22499.55000899973;815.0993152566447;842.1704620948361;846.3144852669358;850.5194565070715;853.7566793463833;11346;11449.828252576219;11504.482298296596;11507.769844603228;11591.362475063952;684125;693643;706239;723434;729244;137944.17195398113;138274;138624.30687846697;138635;149714;1153.6712037069562;1162.4245998230929;1188.0317541204065;1189.0368801270997;1199.412287978884;17476.650466990843;18460;19128.80018797856;19130.808691912902;19144.61710765749;56409.28865139871;56504.717476412356;56856.71571642115;57287.71356143193;57562.7121864388;76661.61669191618;78316.21683783089;82747.3450530974;83522;88037;11033.61382351646;11048.502817373077;11303.943480282545;11389.715257118307;11403.486843091914;12015.639530814089;12020.459079341626;12043.458044388199;12395.442205100611;12422.440990155645;10649.680509584725;10676.145908327471;10816.783664326827;10937;11000.944995274973;9912.513123031604;10166.796664066826;10759.3544387337;10871.239013268996;11108;9957.253206009724;11074.723131921766;11379.089672825989;11381.244189417306;11518.481668324777;9743.9025609743;10869.402182880018;10965.324273008766;10971.561137554409;11260.493277802683;10835.241533092609;10951.513591636894;11065.280756750786;11185;11237.3257604544 18:33:55 INFO - PROCESS | 2182 | |3;mootools.html;1343.6439343573954;1520.5742392130207;1559.812822461305;1567.1459054815127;1585.5798213473429;9130.589123489442;10118.443485608288;10641.042306192441;10645.627403040895;10653.520591573379;9236.8614470783;10162.441065741381;10247;10838.837417438745;10854.565817367316;1991.7211590377358;2317.7334606520253;2356.6936298281285;2357.634566642173;2359.917402890899;2300.1949317738827;2320.153144102407;2333.4749681321737;2337.3805941425535;2338.5089131282366;2292.839501234914;2318.2929206591984;2318.988405057972;2321.2688003279;2324.4769926766426;2283.120998415622;2292.610256256432;2297.574948634508;2299.6895419118455;2302.9654555181687;2256;2318.7449380568123;2321.6401457773904;2327.44141406063;2331.184085570054;10731.624393146203;10812.621558245424;10832.837507437394;10838.403887786248;10852.503924097502;4635.675502714811;5593.776248950037;5597.132444471114;5602.291301153146;5792.507636850873;3061.158181500083;3272.460044092722;3357.194273374397;3589.6410358964154;3598.6221446747977;1161;1176.247201790846;1199.8440202773584;1207.746373261616;1220.2190598017276;13295.069345145843;13659.609568325503;13938.95457840656;14986.325615347336;15036.774448383283;4188.308929026737;4302.935455968163;4305.225059489259;4313.288307429302;4319.157764236007;11039.558417663204;11366.715832104264;11417.657470275904;11471.770564588662;11475.368854712904;5450.809221677222;5538.861528461821;5565.610407271533;5566.832995010075;5571.860703482445;4187.832486700559;5129.8717532062;5214.165733482625;5220.034293655686;5221.425643179247;3214.2767877227902;3573.9642603574152;3660.7071434285726;3715.721320900889;3789.2989796887664;953.0707560128819;981.6711401680374;1025.8615086963164;1030.4538594544904;1039.599754094679;835.5947365527715;873.908239634842;873.9425295392646;918.4168053286211;925.5048549026238;6395.20059992501;6496.6426846522945;6653.334666533405;6720.193576770819;6746.628935408501;979.5511221945137;990.4503000834462;1000.7698229407132;1015.6140666546665;1057.5293994172519;4084.081081756581;4091.754494730326;4240.321548552217;4254.29804082323;4263.445752052276;12712.491500340067;13167.934160329138;13195.60413187606;13203.075784695171;13203.933980330037;12691.555795547112;12754.107212495037;12827.615171544869;13092.541761038317;13116.01629877763;9715.319927605142;9727.708168754949;9883.802323953481;9985.700428987142;10053.748656283506;6205.751769929152;6262.812115636538;6336.746530138743;6436.388543088399;6474.805755827333;11538.88461115378;11883.405829708307;11957.581484647995;11983.161178717406;12059.397030148282;10329;10851.67444976652;11231.876812318702;12157;12335.629931102081;7127.75052873147;8891.822163556822;8925.419847709878;8989.325800565115;9000.324975626723;9662.855057174289;9760.755981100529;10018.749531261485;10043.196544276587;10044.748881278027;8617.224449799549;8703.693521217008;8776.254018408506;8836.028036916063;8977.326700497359;8570.828583428172;8603.05366409707;8632;8632.309415246891;8712.91287087121;7366.152892417226;7496.400287977058;7504.174540800398;7512.21121782205;7518.135414427411;5146.8934179150165;5471.8084867029465;5612.943870561242;5696.031674615242;5705.144228365778;5424.83725488236;5650.689212093374;5754.395788442321;5786.958347497491;5825.70871456417 18:33:55 INFO - PROCESS | 2182 | |4;prototype.html;365.636191988971;368.39215294763636;368.9852405903764;377.7620099337415;379.9487069245652;3976.8011599420056;4703.460131528979;4740.620750339973;4751.786169622366;4824.563595384335;4197.874063778091;4257.914841703172;4439.800208990595;4628.861134165972;4743.7153770773775;3731.291054699605;3868.535775706919;3990.7605543667473;4010.4786377770847;4024.9597504024878;3690.852365905374;3860.82626281818;3992.441058251847;4038.4749982502235;4045.59544045596;4014.3777714454304;4016;4041.575634558373;4048.898777530556;4105.220008198447;3406.386850366933;3952.2490726761825;4024.2353952748886;4030.45588845505;4062.4718786557705;3335.666433356669;3436.4501679731125;3539.8584056637706;3653.4337177737493;3693.0582701410967;4128.422020917044;4163.812628431698;4175.536433504217;4665.836695715634;4714.222153344694;4645.442546894361;4655.906881862377;4664.440267167927;4698.436187657503;4733.786979585927;4133.875983720493;4739.762562368567;4942.443130413944;5067.4797560732;5108.565771909392;3664.6518580734787;3793.050069659094;4044.919101617951;4052.7365721228025;4112.362583799516;4672.883177920511;4780.976095119537;5096.712620359885;5211.062008838408;5347.197920311945;3754.4180651998986;3907.1087395327822;4027.3153563894207;4039.6162364575316;4054.9797251013556;4130.483689538808;4198.732684350478;4222.577742225752;4235.004773878198;4281.929517620595;3926.9607303926596;4573.428321459817;4584.312353146988;4608.470025946992;4613.907721845544;4723.551262630044;5020.1214787412055;5050.4949505049935;5053.722045287471;5101.20931255656;1253.9184952978028;1376.745302119111;1398.5384823008383;1409.901306908527;1454.2655958740768;1011.9291649584605;1087.8313861351503;1094.715374002765;1106.363840791548;1114.765899161169;3938.5864484229314;4407.096545208289;4453.198424283595;4715.81136754526;4723.607045447698;4264.893377665521;4646.7444290564345;5083.38999320084;5146.768395422215;5236.32437619958;4367.45406824147;4505.796581809518;4734.479207287196;4737.95262047382;4802.535226755803;2408.373822806048;2554.6295787110766;2666.7333016816856;2700.4734076854825;2701.5542435497923;4835.95164048362;5106.310648062538;5446.673199607957;5513.696746678971;5514.285286080424;4546.726916463395;4665.2302370108555;4877.951260470611;5329.307190065344;5339.839804805862;4583.74789386587;5429.484199001167;5439.564834813205;5477.972610136924;5479.904019196097;5231.686098834082;5236.14630026644;5254.842354729364;5259.4477579853565;5267.71027593486;4484.618807401407;4736.768440205503;5108.642395032461;5109.182530795055;5196.414474012919;4777.593904518016;5186.988537235203;5322.600804939568;5342.759575819176;5432.668996095982;4118.91762164761;4152.937705934353;4164.6668266538;4164.77093759834;4203.579642035895;4381;4715.453655026247;5223.686578805284;5282.286891269783;5326.8934621308135;4396.824127034883;4659.627229821538;4722.48052714208;4722.693024953367;5059.797608095782;4483.775811209492;4674.368960190331;4860.975695121501;5025.773840177274;5068.746562671926;4517.412736344254;4613.630909527163;4756.643251756202;4940.357753492023;4972.781668491243;4331.920678074604;4403.911921761611;4929.457759646508;5017.448080711192;5042.218456139304;4133.937990930199;4397.560243975577;4507.842225522091;4968.677035992793;4982.234859652927 18:33:55 INFO - PROCESS | 2182 | |5;yui.html;755.2938002967226;755.8337165823517;821.4578378270343;822.7531740477855;832.9541875196866;14752;15339.463118790858;15350.385984560604;15382;15388.846111538895;13945.511907083253;14082;14088.506902258423;14099.647508812284;14114.57656270311;938.127541386512;952.0431965874321;952.3190918493276;952.3761935931975;953.6328513522309;759.8670232709281;892.9642814287421;939.1172298039855;948.6679662118272;968.9951550242239;1019.1235537437798;1021.8160731068405;1023.0281232828805;1023.1405619279803;1023.9436830974294;1006.1749365520276;1014.5333146752503;1015.0610685116238;1015.1320620869161;1015.5785349080123;753.8002429356225;755.1994885421416;757.9355754760852;757.9886301705479;758.2190343945745;12271.631851044483;14629.195394253311;15205.935584509089;15239;15669;12450.276850500719;13082;13371.465141394332;13418.72522110398;13842.515511957134;11102.666919992413;11530.942345288304;11570.652880413518;11619.360935148563;12250.509979600805;3642.307961487309;3653.9269214615824;3654.086478380405;3677.4483827425834;3691.53855768029;105296;106397.46801266022;108101;108128.4593577035;108725;8547.487150770974;10541.420221887716;10712;10806.945965270123;11102.833457498144;22358.66462003071;22436;22436;22467;22515.43711407228;7235.167955685059;7427.034485516956;7504.287092726182;7531.623418829036;7764.029496312961;4003.8798836034384;4167;4273.850415235452;4412.646988240933;4423.424954755861;3366.596008478949;3410.4372778491766;3467.09855437588;3469.3061387722555;3488.720902327808;607.1287702147345;617.2038070888593;628.4846425930693;630.0549176235646;631.9462845658079;618.4866560754563;639.8035030727419;652.3932742549474;660.6028745152119;696.7282759723712;8839.312332306443;9569.090936361035;9610.375325603813;9862.512556786645;9912.822699818424;595.4194660206351;613.355976224971;665.9067730517731;701.2461603775961;701.7438634898225;4181.686373521998;4452.4211852458975;4685.4143232095985;4690.179218636725;4707.534345481391;98477;99370.50314748524;100655;102313.48843255737;102420;49555.75222123866;57295;67372.32627673759;73013;91065;60203;61062;62406.37593624006;71847;74031.88952165721;10279.691609251435;10368.614247506073;10477.895221047693;10648.307859989076;10688.41213733221;32829.67170328362;40151.59848401596;44789.77605111954;45601.07755085875;48424.515754842;49745.75127124341;64470.67764661147;67552.3244767546;68361;68811;11925;12204.938975305067;12437;12613.747725045265;12761.93619031899;10341.4312212829;13809.930950345586;13885.444582217002;14117.435302588192;14219.573412797632;12783.61649150527;12854.935725321313;12898.871011289766;13033.934830325788;13035.355912886278;12921.095523313277;13002.544910928073;13284.86779863574;13361.198328100345;13488.460461581819;12677.239365638092;12800.551980680631;12804.359782011048;12914.612561623166;13218;10579.94710026445;10646.307989980627;10714.839277410689;10793.244472887136;10868.565257389615;8401.178414316219;9509.857352139861;9845;10502.52738626779;10583.994520520539 18:33:55 INFO - PROCESS | 2182 | __end_tp_report 18:33:55 INFO - PROCESS | 2182 | __start_cc_report 18:33:55 INFO - PROCESS | 2182 | _x_x_mozilla_cycle_collect,1593 18:33:55 INFO - PROCESS | 2182 | __end_cc_report 18:33:55 INFO - PROCESS | 2182 | __startTimestamp1488594835944__endTimestamp 18:33:55 INFO - PROCESS | 2182 | 18:33:55 INFO - PROCESS | 2182 | ------- Summary: start ------- 18:33:55 INFO - PROCESS | 2182 | Number of tests: 6 18:33:55 INFO - PROCESS | 2182 | 18:33:55 INFO - PROCESS | 2182 | [#0] dojo.html Cycles:165 Average:5697.19 Median:5873.00 stddev:632.62 (10.8%) stddev-sans-first:606.16 18:33:55 INFO - PROCESS | 2182 | Values: 3308.1 3310.0 3323.7 3325.5 3360.8 5497.7 5613.2 5672.1 5745.1 5789.6 5565.0 5600.7 5602.6 5606.2 5626.0 5075.6 5104.8 5115.1 5131.3 5172.1 5198.9 5202.0 5207.8 5216.9 5217.9 5192.6 5202.6 5206.6 5207.3 5216.0 5207.5 5208.0 5219.5 5220.4 5220.6 5039.0 5161.9 5165.7 5172.3 5180.8 5742.0 5773.2 5779.2 5782.9 5786.2 6048.9 6229.6 6239.7 6251.0 6265.3 6144.9 6160.2 6177.8 6185.4 6189.8 5196.5 5698.3 5841.8 5891.8 5894.8 5613.9 6021.8 6232.1 6246.8 6262.9 6138.9 6164.3 6186.9 6187.9 6190.6 5258.7 6089.6 6129.5 6134.4 6179.2 6217.5 6230.5 6233.9 6240.2 6244.0 6248.3 6268.3 6268.9 6274.8 6285.8 4846.9 4860.1 4929.9 4987.5 5031.9 4403.6 4446.2 4469.1 4512.2 4517.0 5888.0 5902.1 5907.0 5910.2 5951.1 6038.0 6109.4 6109.5 6294.1 6304.1 5628.9 5700.7 5703.9 5707.8 5713.4 5334.5 5339.8 5339.9 5341.1 5353.4 6330.2 6330.3 6331.5 6345.1 6347.2 6252.4 6297.7 6308.1 6313.5 6319.9 5304.6 5837.3 6198.4 6339.4 6354.7 6107.0 6131.8 6133.2 6141.2 6144.5 5695.2 5873.0 6138.6 6144.2 6165.9 6069.5 6074.1 6114.4 6115.3 6148.1 5844.0 5920.1 6086.7 6107.8 6135.2 5642.5 5813.2 5822.9 5833.8 5841.0 5327.0 5986.9 5988.3 6075.2 6085.0 5600.4 5791.2 5962.8 5969.3 5977.5 18:33:55 INFO - PROCESS | 2182 | 18:33:55 INFO - PROCESS | 2182 | [#1] ext.html Cycles:180 Average:52677.82 Median:186158.92 stddev:101751.98 (54.7%) stddev-sans-first:101962.70 18:33:55 INFO - PROCESS | 2182 | Values: 740.8 766.2 788.9 852.8 868.8 28158.3 40131.8 40740.6 40794.2 40885.0 41738.6 41981.8 42119.6 42139.6 42144.4 7213.2 8998.3 9129.0 9162.0 9206.4 7285.8 7332.2 7335.9 7351.2 10776.4 11000.1 11016.2 11016.4 11019.2 11040.2 10942.6 10954.6 10955.9 10962.1 10985.9 7160.6 7331.3 10717.5 10784.6 10796.0 27990.3 28241.9 28254.7 38649.6 39276.0 3716.2 3757.1 3776.8 3804.9 3821.1 28186.0 28327.7 28371.7 28504.0 28681.4 3026.1 3048.1 3054.5 3055.7 3066.7 330450.0 336588.0 338334.0 338417.0 339401.0 52568.7 52607.9 52670.7 52675.2 52860.5 54618.5 54645.0 54761.6 54765.5 54807.7 13730.7 14114.9 14115.5 14118.5 14168.1 11982.2 11989.8 12000.8 12017.2 12023.3 10804.6 11020.3 11243.0 12337.4 12595.9 5503.5 5611.9 5648.1 5649.9 5845.8 1089.5 1092.7 1105.3 1114.5 1130.5 21865.1 22557.4 23286.7 25016.1 25714.7 1103.8 1198.3 1205.8 1215.1 1261.4 12576.0 13074.4 13407.3 13421.5 13447.2 417661.0 420237.0 420759.0 421958.0 422646.0 54872.0 55197.7 55409.7 55436.4 55453.4 1361.8 1435.6 1440.6 1440.7 1441.1 24115.2 25028.0 25066.5 25137.7 25717.9 38694.4 47254.3 47259.8 47371.5 47536.3 385278.0 387900.1 393699.0 395905.0 398570.0 33565.4 33900.8 34048.0 34160.0 34351.8 35835.3 35863.0 39359.0 43364.8 43827.8 33536.5 34196.1 34221.0 35408.8 36767.4 30544.7 35091.6 35380.3 36745.4 36946.6 30344.7 35371.5 35794.9 36427.5 36561.5 30639.8 31922.8 32024.0 32087.0 32145.0 19103.5 23307.9 23761.3 23782.1 23824.6 18:33:55 INFO - PROCESS | 2182 | 18:33:55 INFO - PROCESS | 2182 | [#2] jquery.html Cycles:180 Average:40886.54 Median:23786.38 stddev:118049.75 (496.3%) stddev-sans-first:118341.72 18:33:55 INFO - PROCESS | 2182 | Values: 373.0 396.1 402.7 407.9 435.0 13147.7 17839.9 20319.5 21347.4 21581.7 21518.0 21944.8 22319.8 22650.3 22748.9 5986.0 6269.7 6409.3 6573.0 6619.6 6458.9 6466.7 6518.7 6536.2 6537.0 6027.3 6536.3 6554.3 7180.6 7332.4 6567.0 6823.4 7274.4 7301.3 7307.5 7078.2 7098.0 7102.4 7111.6 7116.5 25044.1 25975.6 26183.2 26398.5 26757.0 2784.8 2828.7 2934.7 2949.6 2959.0 11399.0 14283.6 14987.6 15758.8 16035.0 1524.9 1880.7 1883.3 1914.2 1920.8 147361.0 150414.0 150615.0 152375.0 164088.0 14672.6 17103.1 17768.6 19149.3 19402.7 24823.9 28940.3 30080.1 30353.7 30381.7 8679.0 8770.7 8838.4 8865.7 10848.7 8576.9 8653.1 8902.6 8944.6 8944.6 9285.3 9770.9 10624.0 10733.6 10755.2 3989.9 4048.8 4064.2 4074.8 4077.3 800.2 809.8 810.6 817.4 845.5 21521.3 22199.8 22314.9 22366.3 22499.6 815.1 842.2 846.3 850.5 853.8 11346.0 11449.8 11504.5 11507.8 11591.4 684125.0 693643.0 706239.0 723434.0 729244.0 137944.2 138274.0 138624.3 138635.0 149714.0 1153.7 1162.4 1188.0 1189.0 1199.4 17476.7 18460.0 19128.8 19130.8 19144.6 56409.3 56504.7 56856.7 57287.7 57562.7 76661.6 78316.2 82747.3 83522.0 88037.0 11033.6 11048.5 11303.9 11389.7 11403.5 12015.6 12020.5 12043.5 12395.4 12422.4 10649.7 10676.1 10816.8 10937.0 11000.9 9912.5 10166.8 10759.4 10871.2 11108.0 9957.3 11074.7 11379.1 11381.2 11518.5 9743.9 10869.4 10965.3 10971.6 11260.5 10835.2 10951.5 11065.3 11185.0 11237.3 18:33:55 INFO - PROCESS | 2182 | 18:33:55 INFO - PROCESS | 2182 | [#3] mootools.html Cycles:180 Average:6446.78 Median:3314.83 stddev:4007.36 (120.9%) stddev-sans-first:4000.26 18:33:55 INFO - PROCESS | 2182 | Values: 1343.6 1520.6 1559.8 1567.1 1585.6 9130.6 10118.4 10641.0 10645.6 10653.5 9236.9 10162.4 10247.0 10838.8 10854.6 1991.7 2317.7 2356.7 2357.6 2359.9 2300.2 2320.2 2333.5 2337.4 2338.5 2292.8 2318.3 2319.0 2321.3 2324.5 2283.1 2292.6 2297.6 2299.7 2303.0 2256.0 2318.7 2321.6 2327.4 2331.2 10731.6 10812.6 10832.8 10838.4 10852.5 4635.7 5593.8 5597.1 5602.3 5792.5 3061.2 3272.5 3357.2 3589.6 3598.6 1161.0 1176.2 1199.8 1207.7 1220.2 13295.1 13659.6 13939.0 14986.3 15036.8 4188.3 4302.9 4305.2 4313.3 4319.2 11039.6 11366.7 11417.7 11471.8 11475.4 5450.8 5538.9 5565.6 5566.8 5571.9 4187.8 5129.9 5214.2 5220.0 5221.4 3214.3 3574.0 3660.7 3715.7 3789.3 953.1 981.7 1025.9 1030.5 1039.6 835.6 873.9 873.9 918.4 925.5 6395.2 6496.6 6653.3 6720.2 6746.6 979.6 990.5 1000.8 1015.6 1057.5 4084.1 4091.8 4240.3 4254.3 4263.4 12712.5 13167.9 13195.6 13203.1 13203.9 12691.6 12754.1 12827.6 13092.5 13116.0 9715.3 9727.7 9883.8 9985.7 10053.7 6205.8 6262.8 6336.7 6436.4 6474.8 11538.9 11883.4 11957.6 11983.2 12059.4 10329.0 10851.7 11231.9 12157.0 12335.6 7127.8 8891.8 8925.4 8989.3 9000.3 9662.9 9760.8 10018.7 10043.2 10044.7 8617.2 8703.7 8776.3 8836.0 8977.3 8570.8 8603.1 8632.0 8632.3 8712.9 7366.2 7496.4 7504.2 7512.2 7518.1 5146.9 5471.8 5612.9 5696.0 5705.1 5424.8 5650.7 5754.4 5787.0 5825.7 18:33:55 INFO - PROCESS | 2182 | 18:33:55 INFO - PROCESS | 2182 | [#4] prototype.html Cycles:180 Average:4219.05 Median:4560.08 stddev:1158.29 (25.4%) stddev-sans-first:1124.85 18:33:55 INFO - PROCESS | 2182 | Values: 365.6 368.4 369.0 377.8 379.9 3976.8 4703.5 4740.6 4751.8 4824.6 4197.9 4257.9 4439.8 4628.9 4743.7 3731.3 3868.5 3990.8 4010.5 4025.0 3690.9 3860.8 3992.4 4038.5 4045.6 4014.4 4016.0 4041.6 4048.9 4105.2 3406.4 3952.2 4024.2 4030.5 4062.5 3335.7 3436.5 3539.9 3653.4 3693.1 4128.4 4163.8 4175.5 4665.8 4714.2 4645.4 4655.9 4664.4 4698.4 4733.8 4133.9 4739.8 4942.4 5067.5 5108.6 3664.7 3793.1 4044.9 4052.7 4112.4 4672.9 4781.0 5096.7 5211.1 5347.2 3754.4 3907.1 4027.3 4039.6 4055.0 4130.5 4198.7 4222.6 4235.0 4281.9 3927.0 4573.4 4584.3 4608.5 4613.9 4723.6 5020.1 5050.5 5053.7 5101.2 1253.9 1376.7 1398.5 1409.9 1454.3 1011.9 1087.8 1094.7 1106.4 1114.8 3938.6 4407.1 4453.2 4715.8 4723.6 4264.9 4646.7 5083.4 5146.8 5236.3 4367.5 4505.8 4734.5 4738.0 4802.5 2408.4 2554.6 2666.7 2700.5 2701.6 4836.0 5106.3 5446.7 5513.7 5514.3 4546.7 4665.2 4878.0 5329.3 5339.8 4583.7 5429.5 5439.6 5478.0 5479.9 5231.7 5236.1 5254.8 5259.4 5267.7 4484.6 4736.8 5108.6 5109.2 5196.4 4777.6 5187.0 5322.6 5342.8 5432.7 4118.9 4152.9 4164.7 4164.8 4203.6 4381.0 4715.5 5223.7 5282.3 5326.9 4396.8 4659.6 4722.5 4722.7 5059.8 4483.8 4674.4 4861.0 5025.8 5068.7 4517.4 4613.6 4756.6 4940.4 4972.8 4331.9 4403.9 4929.5 5017.4 5042.2 4133.9 4397.6 4507.8 4968.7 4982.2 18:33:55 INFO - PROCESS | 2182 | 18:33:55 INFO - PROCESS | 2182 | [#5] yui.html Cycles:180 Average:19034.12 Median:3388.52 stddev:27288.67 (805.3%) stddev-sans-first:27330.71 18:33:55 INFO - PROCESS | 2182 | Values: 755.3 755.8 821.5 822.8 833.0 14752.0 15339.5 15350.4 15382.0 15388.8 13945.5 14082.0 14088.5 14099.6 14114.6 938.1 952.0 952.3 952.4 953.6 759.9 893.0 939.1 948.7 969.0 1019.1 1021.8 1023.0 1023.1 1023.9 1006.2 1014.5 1015.1 1015.1 1015.6 753.8 755.2 757.9 758.0 758.2 12271.6 14629.2 15205.9 15239.0 15669.0 12450.3 13082.0 13371.5 13418.7 13842.5 11102.7 11530.9 11570.7 11619.4 12250.5 3642.3 3653.9 3654.1 3677.4 3691.5 105296.0 106397.5 108101.0 108128.5 108725.0 8547.5 10541.4 10712.0 10806.9 11102.8 22358.7 22436.0 22436.0 22467.0 22515.4 7235.2 7427.0 7504.3 7531.6 7764.0 4003.9 4167.0 4273.9 4412.6 4423.4 3366.6 3410.4 3467.1 3469.3 3488.7 607.1 617.2 628.5 630.1 631.9 618.5 639.8 652.4 660.6 696.7 8839.3 9569.1 9610.4 9862.5 9912.8 595.4 613.4 665.9 701.2 701.7 4181.7 4452.4 4685.4 4690.2 4707.5 98477.0 99370.5 100655.0 102313.5 102420.0 49555.8 57295.0 67372.3 73013.0 91065.0 60203.0 61062.0 62406.4 71847.0 74031.9 10279.7 10368.6 10477.9 10648.3 10688.4 32829.7 40151.6 44789.8 45601.1 48424.5 49745.8 64470.7 67552.3 68361.0 68811.0 11925.0 12204.9 12437.0 12613.7 12761.9 10341.4 13809.9 13885.4 14117.4 14219.6 12783.6 12854.9 12898.9 13033.9 13035.4 12921.1 13002.5 13284.9 13361.2 13488.5 12677.2 12800.6 12804.4 12914.6 13218.0 10579.9 10646.3 10714.8 10793.2 10868.6 8401.2 9509.9 9845.0 10502.5 10584.0 18:33:55 INFO - PROCESS | 2182 | -------- Summary: end -------- 18:33:55 INFO - PROCESS | 2182 | 18:33:56 INFO - TEST-INFO | 2182: exit 0 18:33:56 INFO - TEST-OK | dromaeo_css | took 1121182ms 18:33:56 INFO - TEST-START | kraken 18:33:56 INFO - operating with platform_type : mac_ 18:33:56 INFO - Initialising browser for kraken test... 18:33:56 INFO - TEST-INFO | started process 2186 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpWCSzB9/profile http://localhost:49777/getInfo.html) 18:33:59 INFO - PROCESS | 2186 | __metrics Screen width/height:1600/1200 18:33:59 INFO - PROCESS | 2186 | colorDepth:24 18:33:59 INFO - PROCESS | 2186 | Browser inner width/height: 1024/689 18:33:59 INFO - PROCESS | 2186 | __metrics 18:33:59 INFO - PROCESS | 2186 | 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" 18:33:59 INFO - PROCESS | 2186 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:34:00 INFO - TEST-INFO | 2186: exit 0 18:34:00 INFO - Browser initialized. 18:34:00 INFO - Running cycle 1/1 for kraken test... 18:34:00 INFO - TEST-INFO | started process 2187 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/tmpWCSzB9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:34:12 INFO - PROCESS | 2187 | RSS: Main: 232501248 18:34:12 INFO - PROCESS | 2187 | 18:34:15 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49777/tests/kraken/driver.html?testName=audio-beat-detection) 18:34:16 INFO - PROCESS | 2187 | RSS: Main: 284237824 18:34:16 INFO - PROCESS | 2187 | 18:34:18 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49777/tests/kraken/driver.html?testName=audio-dft) 18:34:19 INFO - PROCESS | 2187 | RSS: Main: 287293440 18:34:19 INFO - PROCESS | 2187 | 18:34:22 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49777/tests/kraken/driver.html?testName=audio-fft) 18:34:23 INFO - PROCESS | 2187 | RSS: Main: 376164352 18:34:23 INFO - PROCESS | 2187 | 18:34:25 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49777/tests/kraken/driver.html?testName=audio-oscillator) 18:34:26 INFO - PROCESS | 2187 | RSS: Main: 281489408 18:34:26 INFO - PROCESS | 2187 | 18:34:28 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49777/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:34:28 INFO - PROCESS | 2187 | RSS: Main: 283254784 18:34:28 INFO - PROCESS | 2187 | 18:34:31 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49777/tests/kraken/driver.html?testName=imaging-darkroom) 18:34:32 INFO - PROCESS | 2187 | RSS: Main: 325148672 18:34:32 INFO - PROCESS | 2187 | 18:34:35 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49777/tests/kraken/driver.html?testName=imaging-desaturate) 18:34:36 INFO - PROCESS | 2187 | RSS: Main: 328413184 18:34:36 INFO - PROCESS | 2187 | 18:34:39 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49777/tests/kraken/driver.html?testName=json-parse-financial) 18:34:39 INFO - PROCESS | 2187 | RSS: Main: 323293184 18:34:39 INFO - PROCESS | 2187 | 18:34:41 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49777/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:34:42 INFO - PROCESS | 2187 | RSS: Main: 299945984 18:34:42 INFO - PROCESS | 2187 | 18:34:44 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:34:44 INFO - PROCESS | 2187 | RSS: Main: 306077696 18:34:44 INFO - PROCESS | 2187 | 18:34:46 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:34:47 INFO - PROCESS | 2187 | RSS: Main: 311312384 18:34:47 INFO - PROCESS | 2187 | 18:34:50 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:34:51 INFO - PROCESS | 2187 | RSS: Main: 323571712 18:34:51 INFO - PROCESS | 2187 | 18:34:54 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:34:55 INFO - PROCESS | 2187 | RSS: Main: 317808640 18:34:55 INFO - PROCESS | 2187 | 18:34:56 INFO - PROCESS | 2187 | Cycle 1(1): loaded http://localhost:49777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49777/tests/kraken/driver.html?testName=ai-astar) 18:34:57 INFO - PROCESS | 2187 | RSS: Main: 362401792 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | __start_tp_report 18:34:57 INFO - PROCESS | 2187 | _x_x_mozilla_page_load 18:34:57 INFO - PROCESS | 2187 | _x_x_mozilla_page_load_details 18:34:57 INFO - PROCESS | 2187 | |i|pagename|runs| 18:34:57 INFO - PROCESS | 2187 | |0;ai-astar;116;117;117;117;116;117;117;117;117;117 18:34:57 INFO - PROCESS | 2187 | |1;audio-beat-detection;133;111;108;149;111;113;109;109;133;109 18:34:57 INFO - PROCESS | 2187 | |2;audio-dft;186;187;185;186;182;183;183;187;183;187 18:34:57 INFO - PROCESS | 2187 | |3;audio-fft;80;63;61;92;60;59;62;61;78;59 18:34:57 INFO - PROCESS | 2187 | |4;audio-oscillator;95;70;90;69;70;69;85;70;68;85 18:34:57 INFO - PROCESS | 2187 | |5;imaging-gaussian-blur;88;89;87;87;88;88;87;88;88;87 18:34:57 INFO - PROCESS | 2187 | |6;imaging-darkroom;95;94;95;94;95;94;95;95;95;93 18:34:57 INFO - PROCESS | 2187 | |7;imaging-desaturate;86;86;85;85;84;84;85;83;85;83 18:34:57 INFO - PROCESS | 2187 | |8;json-parse-financial;64;60;61;60;60;63;62;60;61;61 18:34:57 INFO - PROCESS | 2187 | |9;json-stringify-tinderbox;55;59;67;67;61;59;59;58;59;59 18:34:57 INFO - PROCESS | 2187 | |10;stanford-crypto-aes;89;90;90;87;87;88;88;79;94;95 18:34:57 INFO - PROCESS | 2187 | |11;stanford-crypto-ccm;146;150;139;147;141;143;157;142;181;149 18:34:57 INFO - PROCESS | 2187 | |12;stanford-crypto-pbkdf2;175;174;172;175;173;179;180;232;200;176 18:34:57 INFO - PROCESS | 2187 | |13;stanford-crypto-sha256-iterative;66;84;90;73;67;68;72;69;66;68 18:34:57 INFO - PROCESS | 2187 | __end_tp_report 18:34:57 INFO - PROCESS | 2187 | __start_cc_report 18:34:57 INFO - PROCESS | 2187 | _x_x_mozilla_cycle_collect,2180 18:34:57 INFO - PROCESS | 2187 | __end_cc_report 18:34:57 INFO - PROCESS | 2187 | __startTimestamp1488594897182__endTimestamp 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | ------- Summary: start ------- 18:34:57 INFO - PROCESS | 2187 | Number of tests: 14 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | [#0] ai-astar Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 18:34:57 INFO - PROCESS | 2187 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | [#1] audio-beat-detection Cycles:10 Average:118.50 Median:112.00 stddev:14.43 (12.9%) stddev-sans-first:14.32 18:34:57 INFO - PROCESS | 2187 | Values: 133.0 111.0 108.0 149.0 111.0 113.0 109.0 109.0 133.0 109.0 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | [#2] audio-dft Cycles:10 Average:184.90 Median:186.00 stddev:1.97 (1.1%) stddev-sans-first:2.05 18:34:57 INFO - PROCESS | 2187 | Values: 186.0 187.0 185.0 186.0 182.0 183.0 183.0 187.0 183.0 187.0 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | [#3] audio-fft Cycles:10 Average:67.50 Median:62.50 stddev:11.56 (18.5%) stddev-sans-first:11.34 18:34:57 INFO - PROCESS | 2187 | Values: 80.0 63.0 61.0 92.0 60.0 59.0 62.0 61.0 78.0 59.0 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:77.50 stddev:10.42 (13.4%) stddev-sans-first:8.81 18:34:57 INFO - PROCESS | 2187 | Values: 95.0 70.0 90.0 69.0 70.0 69.0 85.0 70.0 68.0 85.0 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:88.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 18:34:57 INFO - PROCESS | 2187 | Values: 88.0 89.0 87.0 87.0 88.0 88.0 87.0 88.0 88.0 87.0 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:95.00 stddev:0.71 (0.7%) stddev-sans-first:0.73 18:34:57 INFO - PROCESS | 2187 | Values: 95.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 93.0 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:1.07 (1.3%) stddev-sans-first:1.01 18:34:57 INFO - PROCESS | 2187 | Values: 86.0 86.0 85.0 85.0 84.0 84.0 85.0 83.0 85.0 83.0 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:61.00 stddev:1.40 (2.3%) stddev-sans-first:1.05 18:34:57 INFO - PROCESS | 2187 | Values: 64.0 60.0 61.0 60.0 60.0 63.0 62.0 60.0 61.0 61.0 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:59.00 stddev:3.83 (6.5%) stddev-sans-first:3.55 18:34:57 INFO - PROCESS | 2187 | Values: 55.0 59.0 67.0 67.0 61.0 59.0 59.0 58.0 59.0 59.0 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:89.50 stddev:4.37 (4.9%) stddev-sans-first:4.64 18:34:57 INFO - PROCESS | 2187 | Values: 89.0 90.0 90.0 87.0 87.0 88.0 88.0 79.0 94.0 95.0 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:148.00 stddev:12.24 (8.3%) stddev-sans-first:12.92 18:34:57 INFO - PROCESS | 2187 | Values: 146.0 150.0 139.0 147.0 141.0 143.0 157.0 142.0 181.0 149.0 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.60 Median:177.50 stddev:18.83 (10.6%) stddev-sans-first:19.71 18:34:57 INFO - PROCESS | 2187 | Values: 175.0 174.0 172.0 175.0 173.0 179.0 180.0 232.0 200.0 176.0 18:34:57 INFO - PROCESS | 2187 | 18:34:57 INFO - PROCESS | 2187 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:70.50 stddev:8.21 (11.6%) stddev-sans-first:8.38 18:34:57 INFO - PROCESS | 2187 | Values: 66.0 84.0 90.0 73.0 67.0 68.0 72.0 69.0 66.0 68.0 18:34:57 INFO - PROCESS | 2187 | -------- Summary: end -------- 18:34:57 INFO - PROCESS | 2187 | 18:34:58 INFO - TEST-INFO | 2187: exit 0 18:34:58 INFO - TEST-OK | kraken | took 61325ms 18:34:58 INFO - SUITE-END | took 1182s 18:34:58 INFO - Completed test suite (00:19:42) 18:34:58 INFO - javascript benchmark 18:34:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7385.669217961569, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3308.057203696947, 3309.983450082749, 3323.7174840138587, 3325.517799919013, 3360.781549199302, 5497.670139791615, 5613.186088017235, 5672.092465205568, 5745.138229265613, 5789.59472836901, 5565.026120428929, 5600.691961942091, 5602.551795856332, 5606.243157173781, 5625.987322281988, 5075.593952483792, 5104.821331253407, 5115.10485665009, 5131.255967884655, 5172.120739474299, 5198.870028249286, 5202.0, 5207.791688332462, 5216.947830521684, 5217.921731174036, 5192.61055420845, 5202.583793296546, 5206.635535512516, 5207.270982062514, 5216.035033518792, 5207.453217412193, 5208.010478009185, 5219.504147106057, 5220.425753167148, 5220.634555581111, 5039.0, 5161.948380516222, 5165.690058596496, 5172.327597412313, 5180.844574662766, 5741.971290143564, 5773.191753154561, 5779.219805326311, 5782.9421705782825, 5786.247787787561, 6048.939510604881, 6229.626222426624, 6239.719212635442, 6250.968745156245, 6265.310815810257, 6144.863200307957, 6160.229971253593, 6177.81466556004, 6185.350538193515, 6189.783357582463, 5196.45437229093, 5698.34469036062, 5841.824745257649, 5891.764329426775, 5894.823155305347, 5613.933352662981, 6021.849453763691, 6232.127502149703, 6246.781362652286, 6262.874742505124, 6138.907916381258, 6164.260288765287, 6186.876262474725, 6187.938120618736, 6190.597611155261, 5258.6581872178185, 6089.634621922699, 6129.478994285447, 6134.447899689049, 6179.196704428396, 6217.533684973555, 6230.532710046674, 6233.875322493524, 6240.157578726905, 6244.0, 6248.250209974832, 6268.279147897959, 6268.937310626927, 6274.843128921722, 6285.779997700059, 4846.927296090562, 4860.0765854488245, 4929.852104436873, 4987.501249874984, 5031.899362012739, 4403.559644035635, 4446.221911165533, 4469.128519938646, 4512.187806194851, 4517.0, 5888.0, 5902.144189092557, 5906.970465147647, 5910.231669882888, 5951.077582974646, 6038.033914573647, 6109.351931479865, 6109.480694141048, 6294.087357333253, 6304.05439184126, 5628.943710562924, 5700.657960522382, 5703.914441283384, 5707.800226992118, 5713.4000929902595, 5334.466553344712, 5339.786408543692, 5339.919901201485, 5341.145416733381, 5353.38436079848, 6330.240371155307, 6330.303666596578, 6331.461825744863, 6345.079963405373, 6347.238331400262, 6252.374762523711, 6297.685115744286, 6308.08532762756, 6313.463355614824, 6319.873602528016, 5304.602154838325, 5837.29952405714, 6198.442140207403, 6339.397757213057, 6354.7140378684, 6107.037103281039, 6131.816045518642, 6133.202683651275, 6141.170941922784, 6144.508439324933, 5695.202671626059, 5873.0, 6138.572327483795, 6144.2488890665945, 6165.907511387243, 6069.453749162597, 6074.149619053424, 6114.419025732222, 6115.270764408881, 6148.139260503623, 5844.0, 5920.082387229986, 6086.6652334122045, 6107.84730381744, 6135.202423684892, 5642.548596112383, 5813.157092221689, 5822.854428639318, 5833.766649333979, 5841.036229022164, 5327.0, 5986.910196346971, 5988.281406231106, 6075.2405949256345, 6085.0, 5600.35595906476, 5791.247137872049, 5962.821115366546, 5969.283685957539, 5977.462028417463], "value": 5657.325760911024, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.7999840043188, 766.1534004924558, 788.8540619985305, 852.7825404521842, 868.8218915122401, 28158.29604259892, 40131.799341003294, 40740.59259407405, 40794.18411631766, 40884.99999999993, 41738.58261417385, 41981.79009104958, 42119.578804211946, 42139.57860421395, 42144.36783448243, 7213.170485394195, 8998.280137588994, 9128.954355228214, 9162.0, 9206.355555111146, 7285.817854553652, 7332.230115837813, 7335.926640733578, 7351.154617219008, 10776.40729759863, 11000.064994475479, 11016.17378696601, 11016.449177541092, 11019.228653994223, 11040.227184097117, 10942.56229750809, 10954.561817527288, 10955.945220273848, 10962.123030157569, 10985.890141098647, 7160.606166660831, 7331.3401793838275, 10717.517711702993, 10784.622538211124, 10796.028357447867, 27990.300242493897, 28241.85879070612, 28254.717452825415, 38649.61350386516, 39276.0, 3716.201016781405, 3757.1170774867883, 3776.7545109568064, 3804.8668296609762, 3821.102041020358, 28186.0, 28327.71672283292, 28371.72327245279, 28504.0, 28681.426371472662, 3026.0921723482866, 3048.131282584453, 3054.5461746388473, 3055.724984751361, 3066.723994840475, 330450.0, 336588.0, 338334.0, 338417.0, 339401.0, 52568.737156313975, 52607.947841042966, 52670.73664631729, 52675.209871851956, 52860.47139528555, 54618.45381546134, 54645.0, 54761.60718303058, 54765.452345476835, 54807.725961369935, 13730.65673358154, 14114.85885141156, 14115.505957291445, 14118.50585229512, 14168.149911005372, 11982.221155624857, 11989.760204795855, 12000.75998480043, 12017.158798883995, 12023.27860328383, 10804.567817287378, 11020.283681560673, 11243.0, 12337.444814983168, 12595.93702031484, 5503.532199762985, 5611.887762244733, 5648.068068768689, 5649.943500564942, 5845.795397161164, 1089.493385575711, 1092.6995076354067, 1105.2815669814686, 1114.5374669512062, 1130.5308297056629, 21865.12539498434, 22557.43606409853, 23286.65070023951, 25016.124435644666, 25714.742852571235, 1103.8289065194908, 1198.3049831097942, 1205.758069188737, 1215.1190386969554, 1261.438659796382, 12576.0, 13074.411651475706, 13407.329633518286, 13421.530246441327, 13447.193168409927, 417661.0, 420237.0, 420759.0, 421958.0, 422646.0, 54872.0, 55197.72401137969, 55409.72295138498, 55436.445635543125, 55453.445465545636, 1361.768499355112, 1435.5549779568366, 1440.625437386287, 1440.6614445605485, 1441.1209162410921, 24115.246815286904, 25027.998880044594, 25066.498670026864, 25137.74862251427, 25717.871410642827, 38694.419583705705, 47254.29118563293, 47259.76370118128, 47371.52628473671, 47536.286955696385, 385278.0, 387900.0604996957, 393699.0, 395905.0, 398570.0071499624, 33565.371218973705, 33900.83049584835, 34048.0, 34160.0, 34351.82824085864, 35835.28329433344, 35863.0, 39359.0, 43364.78317608392, 43827.78086109549, 33536.49695254524, 34196.14509637279, 34220.973370798914, 35408.82295588506, 36767.44848827216, 30544.694553055073, 35091.64908350884, 35380.292394152486, 36745.44881826828, 36946.630533695396, 30344.696553034188, 35371.46942795809, 35794.92615221548, 36427.45358819673, 36561.45157822582, 30639.846800765852, 31922.840385798852, 32024.0, 32087.037388878372, 32145.0, 19103.522411939255, 23307.883460582587, 23761.287161385186, 23782.054486378405, 23824.642630360213], "value": 18327.38225438358, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.96829769469593, 396.1008510680753, 402.74828232354776, 407.85317285777114, 435.04507605805253, 13147.6713082173, 17839.910800445996, 20319.492012699673, 21347.359579212647, 21581.67627485589, 21518.0, 21944.780552194472, 22319.776802231972, 22650.320490385275, 22748.886255568697, 5985.970070149643, 6269.749210031593, 6409.327020662833, 6573.0, 6619.635920024397, 6458.870822583545, 6466.708998095097, 6518.6740662966895, 6536.150300460958, 6537.0, 6027.276726792791, 6536.281009088996, 6554.311797261291, 7180.56916585004, 7332.41340692746, 6566.967165164144, 6823.38589526945, 7274.381677557388, 7301.342879140902, 7307.451941104438, 7078.221395646475, 7098.0, 7102.396296314768, 7111.64441777909, 7116.466265030143, 25044.123455679146, 25975.610365844528, 26183.214503564923, 26398.472030559282, 26757.0, 2784.8468334241606, 2828.7454129128273, 2934.7358737713494, 2949.6460424749166, 2958.9704102959126, 11399.0, 14283.571492855232, 14987.550373488813, 15758.76361854573, 16035.0, 1524.9008814427027, 1880.6802843516498, 1883.256113835041, 1914.2247389807012, 1920.7599050118736, 147361.0, 150414.0, 150615.0, 152375.0, 164088.0, 14672.555406782727, 17103.14484275781, 17768.55578610545, 19149.329773457863, 19402.70895936562, 24823.875880620843, 28940.27649308784, 30080.081581236, 30353.69646303553, 30381.69618303833, 8679.045305016443, 8770.736877893672, 8838.425502342327, 8865.734027979172, 10848.728781780519, 8576.871346929802, 8653.134686531297, 8902.620093885458, 8944.552772361356, 8944.597493112826, 9285.25717942563, 9770.853437198448, 10623.981443525705, 10733.570657173626, 10755.181910421845, 3989.8628890765995, 4048.817803198863, 4064.1871625674985, 4074.796260186979, 4077.347624380144, 800.207794283655, 809.8461292354434, 810.6352141536332, 817.3869597801648, 845.5053793530853, 21521.309836270466, 22199.778002220093, 22314.88842555777, 22366.32901012972, 22499.55000899973, 815.0993152566447, 842.1704620948361, 846.3144852669358, 850.5194565070715, 853.7566793463833, 11346.0, 11449.828252576219, 11504.482298296596, 11507.769844603228, 11591.362475063952, 684125.0, 693643.0, 706239.0, 723434.0, 729244.0, 137944.17195398113, 138274.0, 138624.30687846697, 138635.0, 149714.0, 1153.6712037069562, 1162.4245998230929, 1188.0317541204065, 1189.0368801270997, 1199.412287978884, 17476.650466990843, 18460.0, 19128.80018797856, 19130.808691912902, 19144.61710765749, 56409.28865139871, 56504.717476412356, 56856.71571642115, 57287.71356143193, 57562.7121864388, 76661.61669191618, 78316.21683783089, 82747.3450530974, 83522.0, 88037.0, 11033.61382351646, 11048.502817373077, 11303.943480282545, 11389.715257118307, 11403.486843091914, 12015.639530814089, 12020.459079341626, 12043.458044388199, 12395.442205100611, 12422.440990155645, 10649.680509584725, 10676.145908327471, 10816.783664326827, 10937.0, 11000.944995274973, 9912.513123031604, 10166.796664066826, 10759.3544387337, 10871.239013268996, 11108.0, 9957.253206009724, 11074.723131921766, 11379.089672825989, 11381.244189417306, 11518.481668324777, 9743.9025609743, 10869.402182880018, 10965.324273008766, 10971.561137554409, 11260.493277802683, 10835.241533092609, 10951.513591636894, 11065.280756750786, 11185.0, 11237.3257604544], "value": 11118.420218693114, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.6439343573954, 1520.5742392130207, 1559.812822461305, 1567.1459054815127, 1585.5798213473429, 9130.589123489442, 10118.443485608288, 10641.042306192441, 10645.627403040895, 10653.520591573379, 9236.8614470783, 10162.441065741381, 10247.0, 10838.837417438745, 10854.565817367316, 1991.7211590377358, 2317.7334606520253, 2356.6936298281285, 2357.634566642173, 2359.917402890899, 2300.1949317738827, 2320.153144102407, 2333.4749681321737, 2337.3805941425535, 2338.5089131282366, 2292.839501234914, 2318.2929206591984, 2318.988405057972, 2321.2688003279, 2324.4769926766426, 2283.120998415622, 2292.610256256432, 2297.574948634508, 2299.6895419118455, 2302.9654555181687, 2256.0, 2318.7449380568123, 2321.6401457773904, 2327.44141406063, 2331.184085570054, 10731.624393146203, 10812.621558245424, 10832.837507437394, 10838.403887786248, 10852.503924097502, 4635.675502714811, 5593.776248950037, 5597.132444471114, 5602.291301153146, 5792.507636850873, 3061.158181500083, 3272.460044092722, 3357.194273374397, 3589.6410358964154, 3598.6221446747977, 1161.0, 1176.247201790846, 1199.8440202773584, 1207.746373261616, 1220.2190598017276, 13295.069345145843, 13659.609568325503, 13938.95457840656, 14986.325615347336, 15036.774448383283, 4188.308929026737, 4302.935455968163, 4305.225059489259, 4313.288307429302, 4319.157764236007, 11039.558417663204, 11366.715832104264, 11417.657470275904, 11471.770564588662, 11475.368854712904, 5450.809221677222, 5538.861528461821, 5565.610407271533, 5566.832995010075, 5571.860703482445, 4187.832486700559, 5129.8717532062, 5214.165733482625, 5220.034293655686, 5221.425643179247, 3214.2767877227902, 3573.9642603574152, 3660.7071434285726, 3715.721320900889, 3789.2989796887664, 953.0707560128819, 981.6711401680374, 1025.8615086963164, 1030.4538594544904, 1039.599754094679, 835.5947365527715, 873.908239634842, 873.9425295392646, 918.4168053286211, 925.5048549026238, 6395.20059992501, 6496.6426846522945, 6653.334666533405, 6720.193576770819, 6746.628935408501, 979.5511221945137, 990.4503000834462, 1000.7698229407132, 1015.6140666546665, 1057.5293994172519, 4084.081081756581, 4091.754494730326, 4240.321548552217, 4254.29804082323, 4263.445752052276, 12712.491500340067, 13167.934160329138, 13195.60413187606, 13203.075784695171, 13203.933980330037, 12691.555795547112, 12754.107212495037, 12827.615171544869, 13092.541761038317, 13116.01629877763, 9715.319927605142, 9727.708168754949, 9883.802323953481, 9985.700428987142, 10053.748656283506, 6205.751769929152, 6262.812115636538, 6336.746530138743, 6436.388543088399, 6474.805755827333, 11538.88461115378, 11883.405829708307, 11957.581484647995, 11983.161178717406, 12059.397030148282, 10329.0, 10851.67444976652, 11231.876812318702, 12157.0, 12335.629931102081, 7127.75052873147, 8891.822163556822, 8925.419847709878, 8989.325800565115, 9000.324975626723, 9662.855057174289, 9760.755981100529, 10018.749531261485, 10043.196544276587, 10044.748881278027, 8617.224449799549, 8703.693521217008, 8776.254018408506, 8836.028036916063, 8977.326700497359, 8570.828583428172, 8603.05366409707, 8632.0, 8632.309415246891, 8712.91287087121, 7366.152892417226, 7496.400287977058, 7504.174540800398, 7512.21121782205, 7518.135414427411, 5146.8934179150165, 5471.8084867029465, 5612.943870561242, 5696.031674615242, 5705.144228365778, 5424.83725488236, 5650.689212093374, 5754.395788442321, 5786.958347497491, 5825.70871456417], "value": 4935.26745490121, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.636191988971, 368.39215294763636, 368.9852405903764, 377.7620099337415, 379.9487069245652, 3976.8011599420056, 4703.460131528979, 4740.620750339973, 4751.786169622366, 4824.563595384335, 4197.874063778091, 4257.914841703172, 4439.800208990595, 4628.861134165972, 4743.7153770773775, 3731.291054699605, 3868.535775706919, 3990.7605543667473, 4010.4786377770847, 4024.9597504024878, 3690.852365905374, 3860.82626281818, 3992.441058251847, 4038.4749982502235, 4045.59544045596, 4014.3777714454304, 4016.0, 4041.575634558373, 4048.898777530556, 4105.220008198447, 3406.386850366933, 3952.2490726761825, 4024.2353952748886, 4030.45588845505, 4062.4718786557705, 3335.666433356669, 3436.4501679731125, 3539.8584056637706, 3653.4337177737493, 3693.0582701410967, 4128.422020917044, 4163.812628431698, 4175.536433504217, 4665.836695715634, 4714.222153344694, 4645.442546894361, 4655.906881862377, 4664.440267167927, 4698.436187657503, 4733.786979585927, 4133.875983720493, 4739.762562368567, 4942.443130413944, 5067.4797560732, 5108.565771909392, 3664.6518580734787, 3793.050069659094, 4044.919101617951, 4052.7365721228025, 4112.362583799516, 4672.883177920511, 4780.976095119537, 5096.712620359885, 5211.062008838408, 5347.197920311945, 3754.4180651998986, 3907.1087395327822, 4027.3153563894207, 4039.6162364575316, 4054.9797251013556, 4130.483689538808, 4198.732684350478, 4222.577742225752, 4235.004773878198, 4281.929517620595, 3926.9607303926596, 4573.428321459817, 4584.312353146988, 4608.470025946992, 4613.907721845544, 4723.551262630044, 5020.1214787412055, 5050.4949505049935, 5053.722045287471, 5101.20931255656, 1253.9184952978028, 1376.745302119111, 1398.5384823008383, 1409.901306908527, 1454.2655958740768, 1011.9291649584605, 1087.8313861351503, 1094.715374002765, 1106.363840791548, 1114.765899161169, 3938.5864484229314, 4407.096545208289, 4453.198424283595, 4715.81136754526, 4723.607045447698, 4264.893377665521, 4646.7444290564345, 5083.38999320084, 5146.768395422215, 5236.32437619958, 4367.45406824147, 4505.796581809518, 4734.479207287196, 4737.95262047382, 4802.535226755803, 2408.373822806048, 2554.6295787110766, 2666.7333016816856, 2700.4734076854825, 2701.5542435497923, 4835.95164048362, 5106.310648062538, 5446.673199607957, 5513.696746678971, 5514.285286080424, 4546.726916463395, 4665.2302370108555, 4877.951260470611, 5329.307190065344, 5339.839804805862, 4583.74789386587, 5429.484199001167, 5439.564834813205, 5477.972610136924, 5479.904019196097, 5231.686098834082, 5236.14630026644, 5254.842354729364, 5259.4477579853565, 5267.71027593486, 4484.618807401407, 4736.768440205503, 5108.642395032461, 5109.182530795055, 5196.414474012919, 4777.593904518016, 5186.988537235203, 5322.600804939568, 5342.759575819176, 5432.668996095982, 4118.91762164761, 4152.937705934353, 4164.6668266538, 4164.77093759834, 4203.579642035895, 4381.0, 4715.453655026247, 5223.686578805284, 5282.286891269783, 5326.8934621308135, 4396.824127034883, 4659.627229821538, 4722.48052714208, 4722.693024953367, 5059.797608095782, 4483.775811209492, 4674.368960190331, 4860.975695121501, 5025.773840177274, 5068.746562671926, 4517.412736344254, 4613.630909527163, 4756.643251756202, 4940.357753492023, 4972.781668491243, 4331.920678074604, 4403.911921761611, 4929.457759646508, 5017.448080711192, 5042.218456139304, 4133.937990930199, 4397.560243975577, 4507.842225522091, 4968.677035992793, 4982.234859652927], "value": 3886.8324526665565, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.2938002967226, 755.8337165823517, 821.4578378270343, 822.7531740477855, 832.9541875196866, 14752.0, 15339.463118790858, 15350.385984560604, 15382.0, 15388.846111538895, 13945.511907083253, 14082.0, 14088.506902258423, 14099.647508812284, 14114.57656270311, 938.127541386512, 952.0431965874321, 952.3190918493276, 952.3761935931975, 953.6328513522309, 759.8670232709281, 892.9642814287421, 939.1172298039855, 948.6679662118272, 968.9951550242239, 1019.1235537437798, 1021.8160731068405, 1023.0281232828805, 1023.1405619279803, 1023.9436830974294, 1006.1749365520276, 1014.5333146752503, 1015.0610685116238, 1015.1320620869161, 1015.5785349080123, 753.8002429356225, 755.1994885421416, 757.9355754760852, 757.9886301705479, 758.2190343945745, 12271.631851044483, 14629.195394253311, 15205.935584509089, 15239.0, 15669.0, 12450.276850500719, 13082.0, 13371.465141394332, 13418.72522110398, 13842.515511957134, 11102.666919992413, 11530.942345288304, 11570.652880413518, 11619.360935148563, 12250.509979600805, 3642.307961487309, 3653.9269214615824, 3654.086478380405, 3677.4483827425834, 3691.53855768029, 105296.0, 106397.46801266022, 108101.0, 108128.4593577035, 108725.0, 8547.487150770974, 10541.420221887716, 10712.0, 10806.945965270123, 11102.833457498144, 22358.66462003071, 22436.0, 22436.0, 22467.0, 22515.43711407228, 7235.167955685059, 7427.034485516956, 7504.287092726182, 7531.623418829036, 7764.029496312961, 4003.8798836034384, 4167.0, 4273.850415235452, 4412.646988240933, 4423.424954755861, 3366.596008478949, 3410.4372778491766, 3467.09855437588, 3469.3061387722555, 3488.720902327808, 607.1287702147345, 617.2038070888593, 628.4846425930693, 630.0549176235646, 631.9462845658079, 618.4866560754563, 639.8035030727419, 652.3932742549474, 660.6028745152119, 696.7282759723712, 8839.312332306443, 9569.090936361035, 9610.375325603813, 9862.512556786645, 9912.822699818424, 595.4194660206351, 613.355976224971, 665.9067730517731, 701.2461603775961, 701.7438634898225, 4181.686373521998, 4452.4211852458975, 4685.4143232095985, 4690.179218636725, 4707.534345481391, 98477.0, 99370.50314748524, 100655.0, 102313.48843255737, 102420.0, 49555.75222123866, 57295.0, 67372.32627673759, 73013.0, 91065.0, 60203.0, 61062.0, 62406.37593624006, 71847.0, 74031.88952165721, 10279.691609251435, 10368.614247506073, 10477.895221047693, 10648.307859989076, 10688.41213733221, 32829.67170328362, 40151.59848401596, 44789.77605111954, 45601.07755085875, 48424.515754842, 49745.75127124341, 64470.67764661147, 67552.3244767546, 68361.0, 68811.0, 11925.0, 12204.938975305067, 12437.0, 12613.747725045265, 12761.93619031899, 10341.4312212829, 13809.930950345586, 13885.444582217002, 14117.435302588192, 14219.573412797632, 12783.61649150527, 12854.935725321313, 12898.871011289766, 13033.934830325788, 13035.355912886278, 12921.095523313277, 13002.544910928073, 13284.86779863574, 13361.198328100345, 13488.460461581819, 12677.239365638092, 12800.551980680631, 12804.359782011048, 12914.612561623166, 13218.0, 10579.94710026445, 10646.307989980627, 10714.839277410689, 10793.244472887136, 10868.565257389615, 8401.178414316219, 9509.857352139861, 9845.0, 10502.52738626779, 10583.994520520539], "value": 7338.922273473214, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1447.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 111.0, 108.0, 149.0, 111.0, 113.0, 109.0, 109.0, 133.0, 109.0], "value": 118.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 185.0, 186.0, 182.0, 183.0, 183.0, 187.0, 183.0, 187.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 63.0, 61.0, 92.0, 60.0, 59.0, 62.0, 61.0, 78.0, 59.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 70.0, 90.0, 69.0, 70.0, 69.0, 85.0, 70.0, 68.0, 85.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 87.0, 87.0, 88.0, 88.0, 87.0, 88.0, 88.0, 87.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 93.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 85.0, 84.0, 84.0, 85.0, 83.0, 85.0, 83.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 60.0, 61.0, 60.0, 60.0, 63.0, 62.0, 60.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 67.0, 67.0, 61.0, 59.0, 59.0, 58.0, 59.0, 59.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 90.0, 87.0, 87.0, 88.0, 88.0, 79.0, 94.0, 95.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 150.0, 139.0, 147.0, 141.0, 143.0, 157.0, 142.0, 181.0, 149.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 172.0, 175.0, 173.0, 179.0, 180.0, 232.0, 200.0, 176.0], "value": 183.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 84.0, 90.0, 73.0, 67.0, 68.0, 72.0, 69.0, 66.0, 68.0], "value": 72.3, "unit": "score"}]}]} 18:34:58 INFO - Return code: 0 18:34:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:34:58 ERROR - # TBPL SUCCESS # 18:34:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:34:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:34:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:34:58 INFO - 2017-03-03 18:34:58.521 screenresolution[2191:18587] starting screenresolution argv=screenresolution get 18:34:58 INFO - 2017-03-03 18:34:58.524 screenresolution[2191:18587] Display 0: 1600x1200x32@60 18:34:58 INFO - 2017-03-03 18:34:58.531 screenresolution[2192:18590] starting screenresolution argv=screenresolution list 18:34:58 INFO - Available Modes on Display 0 18:34:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:34:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:34:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:34:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:34:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:34:58 INFO - Intel Iris: 18:34:58 INFO - Chipset Model: Intel Iris 18:34:58 INFO - Type: GPU 18:34:58 INFO - Bus: Built-In 18:34:58 INFO - VRAM (Dynamic, Max): 1536 MB 18:34:58 INFO - Vendor: Intel (0x8086) 18:34:58 INFO - Device ID: 0x0a2e 18:34:58 INFO - Revision ID: 0x0009 18:34:58 INFO - Displays: 18:34:58 INFO - Display: 18:34:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:34:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:34:58 INFO - Display Serial Number: 1600x1200 60 18:34:58 INFO - Main Display: Yes 18:34:58 INFO - Mirror: Off 18:34:58 INFO - Online: Yes 18:34:58 INFO - Rotation: Supported 18:34:58 INFO - Return code: 0 18:34:58 INFO - Running post-action listener: _resource_record_post_action 18:34:58 INFO - [mozharness: 2017-03-04 02:34:58.767618Z] Finished run-tests step (success) 18:34:58 INFO - Running post-run listener: _resource_record_post_run 18:34:58 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 0; Write bytes: 515545600; Read time: 0; Write time: 1599 18:34:58 INFO - TinderboxPrint: CPU usage
54.0% 18:34:58 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:34:58 INFO - TinderboxPrint: I/O write bytes / time
515,545,600 / 1,599 18:34:58 INFO - TinderboxPrint: CPU idle
2,213.8 (46.0%) 18:34:58 INFO - TinderboxPrint: CPU system
962.7 (20.0%) 18:34:58 INFO - TinderboxPrint: CPU user
1,637.2 (34.0%) 18:34:58 INFO - TinderboxPrint: Swap in / out
209,424,384 / 0 18:34:58 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207499776; Write bytes: 205117440; Read time: 15763; Write time: 444 18:34:58 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 0; Write bytes: 299459072; Read time: 0; Write time: 1115 18:34:59 INFO - Running post-run listener: _upload_blobber_files 18:34:59 INFO - Blob upload gear active. 18:34:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:34:59 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 18:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:34:59 INFO - (blobuploader) - INFO - Open directory for files ... 18:34:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:34:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:34:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:35:00 INFO - (blobuploader) - INFO - Done attempting. 18:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:35:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:35:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:35:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:35:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:35:01 INFO - (blobuploader) - INFO - Done attempting. 18:35:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:35:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:35:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:35:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:35:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:35:02 INFO - (blobuploader) - INFO - Done attempting. 18:35:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:35:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:35:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:35:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:35:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:35:04 INFO - (blobuploader) - INFO - Done attempting. 18:35:04 INFO - (blobuploader) - INFO - Iteration through files over. 18:35:04 INFO - Return code: 0 18:35:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:35:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:35:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/427f5bcd1a9d8c7dbf0a36f4cc53ecdbaef58bb9f242516082f24f8c73de4483223a5eb928dfd299c53b408b759859bc9362304f551f631dbf5e89e3bb6a9532", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e45b76bce36d312ddcd67304edf5012d3c85629e28fb7699860aaf47e6b342e4a65c1529b64110c29fbd2e6125e480db1970a08eb087b07d45dfeabb9830fa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d27f54a3d63141aa5587ea9593cb1ccd9494b0b515df3636b6a837910ff5fadc31bd477315affb772f0d4ed8bba631e9146a311b796076794c6856a0e8f32ede", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0fa272d49b5faf8439ee75047eefe90d4d49923abc14d360ae63a62456aa3b23e9425e5b2de0ac624fa4e5b9c0eb8c3e0e5927f35e01585b9ac22fe1202ccab"} 18:35:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:35:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:35:04 INFO - Contents: 18:35:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/427f5bcd1a9d8c7dbf0a36f4cc53ecdbaef58bb9f242516082f24f8c73de4483223a5eb928dfd299c53b408b759859bc9362304f551f631dbf5e89e3bb6a9532", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e45b76bce36d312ddcd67304edf5012d3c85629e28fb7699860aaf47e6b342e4a65c1529b64110c29fbd2e6125e480db1970a08eb087b07d45dfeabb9830fa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d27f54a3d63141aa5587ea9593cb1ccd9494b0b515df3636b6a837910ff5fadc31bd477315affb772f0d4ed8bba631e9146a311b796076794c6856a0e8f32ede", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0fa272d49b5faf8439ee75047eefe90d4d49923abc14d360ae63a62456aa3b23e9425e5b2de0ac624fa4e5b9c0eb8c3e0e5927f35e01585b9ac22fe1202ccab"} 18:35:04 INFO - Running post-run listener: copy_logs_to_upload_dir 18:35:04 INFO - Copying logs to upload dir... 18:35:04 INFO - mkdir: /builds/slave/test/build/upload/logs 18:35:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.497250 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-03 18:35:04.765266) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 18:35:04.768519) ========= 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.hKNnASELPO/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.jWEwVuAHSA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/427f5bcd1a9d8c7dbf0a36f4cc53ecdbaef58bb9f242516082f24f8c73de4483223a5eb928dfd299c53b408b759859bc9362304f551f631dbf5e89e3bb6a9532", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e45b76bce36d312ddcd67304edf5012d3c85629e28fb7699860aaf47e6b342e4a65c1529b64110c29fbd2e6125e480db1970a08eb087b07d45dfeabb9830fa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d27f54a3d63141aa5587ea9593cb1ccd9494b0b515df3636b6a837910ff5fadc31bd477315affb772f0d4ed8bba631e9146a311b796076794c6856a0e8f32ede", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0fa272d49b5faf8439ee75047eefe90d4d49923abc14d360ae63a62456aa3b23e9425e5b2de0ac624fa4e5b9c0eb8c3e0e5927f35e01585b9ac22fe1202ccab"} build_url:https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011576 build_url: 'https://queue.taskcluster.net/v1/task/bcj5-8QURkub6yqXD_-tiw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/427f5bcd1a9d8c7dbf0a36f4cc53ecdbaef58bb9f242516082f24f8c73de4483223a5eb928dfd299c53b408b759859bc9362304f551f631dbf5e89e3bb6a9532", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e45b76bce36d312ddcd67304edf5012d3c85629e28fb7699860aaf47e6b342e4a65c1529b64110c29fbd2e6125e480db1970a08eb087b07d45dfeabb9830fa9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d27f54a3d63141aa5587ea9593cb1ccd9494b0b515df3636b6a837910ff5fadc31bd477315affb772f0d4ed8bba631e9146a311b796076794c6856a0e8f32ede", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0fa272d49b5faf8439ee75047eefe90d4d49923abc14d360ae63a62456aa3b23e9425e5b2de0ac624fa4e5b9c0eb8c3e0e5927f35e01585b9ac22fe1202ccab"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 18:35:04.807082) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:35:04.807467) ========= 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.hKNnASELPO/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.jWEwVuAHSA/Listeners TMPDIR=/var/folders/kq/03dzpmjx5y95z5300b8pt38m00000w/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.005409 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 18:35:04.857058) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 18:35:04.857430) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 18:35:04.857768) ========= ========= Total master_lag: 0.19 =========