builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0163 starttime: 1490603621.2 results: success (0) buildid: 20170327004003 builduid: 6c9bc169310d4437942c97bdb5412eaa revision: 426f26d1a43efcbf9bed49a01a52afb4b8907c79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 01:33:41.197666) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 01:33:41.198184) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 01:33:41.198627) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 01:33:41.225668) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 01:33:41.226073) ========= 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.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-27 01:33:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 48.4M=0s 2017-03-27 01:33:41 (48.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.571254 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 01:33:41.821559) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 01:33:41.821891) ========= 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.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.027496 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 01:33:41.871880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 01:33:41.872240) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 426f26d1a43efcbf9bed49a01a52afb4b8907c79 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 426f26d1a43efcbf9bed49a01a52afb4b8907c79 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-27 01:33:41,974 truncating revision to first 12 chars 2017-03-27 01:33:41,974 Setting DEBUG logging. 2017-03-27 01:33:41,974 attempt 1/10 2017-03-27 01:33:41,974 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/426f26d1a43e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-27 01:33:43,220 unpacking tar archive at: mozilla-aurora-426f26d1a43e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.516651 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 01:33:43.412661) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 01:33:43.412975) ========= script_repo_revision: 426f26d1a43efcbf9bed49a01a52afb4b8907c79 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 01:33:43.413435) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 01:33:43.413750) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 01:33:43.433993) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-27 01:33:43.434389) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:33:43 INFO - MultiFileLogger online at 20170327 01:33:43 in /builds/slave/test 01:33:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:33:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:33:43 INFO - {'append_to_log': False, 01:33:43 INFO - 'base_work_dir': '/builds/slave/test', 01:33:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:33:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:33:43 INFO - 'branch': 'Mozilla-Aurora', 01:33:43 INFO - 'buildbot_json_path': 'buildprops.json', 01:33:43 INFO - 'config_files': ('talos/mac_config.py',), 01:33:43 INFO - 'default_actions': ('clobber', 01:33:43 INFO - 'read-buildbot-config', 01:33:43 INFO - 'download-and-extract', 01:33:43 INFO - 'populate-webroot', 01:33:43 INFO - 'create-virtualenv', 01:33:43 INFO - 'install', 01:33:43 INFO - 'run-tests'), 01:33:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:33:43 INFO - 'download_minidump_stackwalk': True, 01:33:43 INFO - 'download_symbols': 'ondemand', 01:33:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:33:43 INFO - 'tooltool.py': '/tools/tooltool.py', 01:33:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:33:43 INFO - '/tools/misc-python/virtualenv.py')}, 01:33:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:33:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:33:43 INFO - 'gecko_profile': False, 01:33:43 INFO - 'gecko_profile_interval': 0, 01:33:43 INFO - 'installer_path': 'installer.exe', 01:33:43 INFO - 'log_level': 'info', 01:33:43 INFO - 'log_name': 'talos', 01:33:43 INFO - 'log_to_console': True, 01:33:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:33:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:33:43 INFO - 'opt_config_files': (), 01:33:43 INFO - 'pip_index': False, 01:33:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:33:43 INFO - 'cmd': ('bash', 01:33:43 INFO - '-c', 01:33:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:33:43 INFO - 'enabled': True, 01:33:43 INFO - 'halt_on_failure': False, 01:33:43 INFO - 'name': 'check_screen_resolution'},), 01:33:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:33:43 INFO - 'cmd': ('bash', 01:33:43 INFO - '-c', 01:33:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:33:43 INFO - 'enabled': True, 01:33:43 INFO - 'halt_on_failure': False, 01:33:43 INFO - 'name': 'check_screen_resolution'},), 01:33:43 INFO - 'run_cmd_checks_enabled': True, 01:33:43 INFO - 'suite': 'dromaeojs', 01:33:43 INFO - 'system_bits': '32', 01:33:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:33:43 INFO - 'title': 't-yosemite-r7-0163', 01:33:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:33:43 INFO - 'use_talos_json': True, 01:33:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:33:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:33:43 INFO - 'work_dir': 'build'} 01:33:43 INFO - [mozharness: 2017-03-27 08:33:43.649067Z] Running clobber step. 01:33:43 INFO - Running pre-action listener: _resource_record_pre_action 01:33:43 INFO - Running main action method: clobber 01:33:43 INFO - rmtree: /builds/slave/test/build 01:33:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:33:46 INFO - Running post-action listener: _resource_record_post_action 01:33:46 INFO - [mozharness: 2017-03-27 08:33:46.289731Z] Finished clobber step (success) 01:33:46 INFO - [mozharness: 2017-03-27 08:33:46.289897Z] Running read-buildbot-config step. 01:33:46 INFO - Running pre-action listener: _resource_record_pre_action 01:33:46 INFO - Running main action method: read_buildbot_config 01:33:46 INFO - Using buildbot properties: 01:33:46 INFO - { 01:33:46 INFO - "project": "", 01:33:46 INFO - "product": "firefox", 01:33:46 INFO - "script_repo_revision": "production", 01:33:46 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 01:33:46 INFO - "repository": "", 01:33:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 01:33:46 INFO - "buildid": "20170327004003", 01:33:46 INFO - "stage_platform": "macosx64", 01:33:46 INFO - "basedir": "/builds/slave/test", 01:33:46 INFO - "nightly_build": "True", 01:33:46 INFO - "buildnumber": 32, 01:33:46 INFO - "slavename": "t-yosemite-r7-0163", 01:33:46 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 01:33:46 INFO - "platform": "yosemite_r7", 01:33:46 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:33:46 INFO - "branch": "mozilla-aurora", 01:33:46 INFO - "repo_path": "releases/mozilla-aurora", 01:33:46 INFO - "revision": "426f26d1a43efcbf9bed49a01a52afb4b8907c79", 01:33:46 INFO - "pgo_build": "False", 01:33:46 INFO - "builduid": "6c9bc169310d4437942c97bdb5412eaa", 01:33:46 INFO - "slavebuilddir": "test" 01:33:46 INFO - } 01:33:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 01:33:46 INFO - Running post-action listener: _resource_record_post_action 01:33:46 INFO - [mozharness: 2017-03-27 08:33:46.293470Z] Finished read-buildbot-config step (success) 01:33:46 INFO - [mozharness: 2017-03-27 08:33:46.293588Z] Running download-and-extract step. 01:33:46 INFO - Running pre-action listener: _resource_record_pre_action 01:33:46 INFO - Running main action method: download_and_extract 01:33:46 INFO - mkdir: /builds/slave/test/build/tests 01:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:33:46 INFO - trying https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 01:33:46 INFO - Downloading https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:33:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 01:33:47 INFO - Downloaded 1199 bytes. 01:33:47 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:33:47 INFO - Using the following test package requirements: 01:33:47 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:33:47 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 01:33:47 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 01:33:47 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'jsshell-mac.zip'], 01:33:47 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 01:33:47 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:33:47 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 01:33:47 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 01:33:47 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 01:33:47 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:33:47 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 01:33:47 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:33:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:33:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:33:47 INFO - Fetch https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:33:49 INFO - Expected file size: 51788657 01:33:49 INFO - Obtained file size: 51788657 01:34:05 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 01:34:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:34:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:34:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:34:06 INFO - Expected file size: 51788657 01:34:06 INFO - Obtained file size: 51788657 01:34:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 01:34:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:34:21 INFO - Fetch https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 01:34:22 INFO - Expected file size: 14404438 01:34:22 INFO - Obtained file size: 14404438 01:34:23 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')]} 01:34:23 INFO - trying https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:34:23 INFO - Downloading https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 01:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 01:34:25 INFO - Downloaded 74734986 bytes. 01:34:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:34:25 INFO - mkdir: /builds/slave/test/properties 01:34:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:34:25 INFO - Writing to file /builds/slave/test/properties/build_url 01:34:25 INFO - Contents: 01:34:25 INFO - build_url:https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:34:25 INFO - Running post-action listener: _resource_record_post_action 01:34:25 INFO - Running post-action listener: set_extra_try_arguments 01:34:25 INFO - [mozharness: 2017-03-27 08:34:25.876282Z] Finished download-and-extract step (success) 01:34:25 INFO - [mozharness: 2017-03-27 08:34:25.876454Z] Running populate-webroot step. 01:34:25 INFO - Running pre-action listener: _resource_record_pre_action 01:34:25 INFO - Running main action method: populate_webroot 01:34:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:34:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:34:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:34:25 INFO - '--tppagecycles', 01:34:25 INFO - '7'], 01:34:25 INFO - 'tests': ['tsvgm']}}, 01:34:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:34:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:34:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:34:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:34:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:34:25 INFO - 'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:34:25 INFO - 'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['damp', 'tps']}, 01:34:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:34:25 INFO - 'tests': ['damp', 'tps']}, 01:34:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['dromaeo_dom']}, 01:34:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:34:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['basic_compositor_video']}, 01:34:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:34:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['a11yr', 01:34:25 INFO - 'ts_paint', 01:34:25 INFO - 'tpaint', 01:34:25 INFO - 'sessionrestore', 01:34:25 INFO - 'sessionrestore_no_auto_restore', 01:34:25 INFO - 'tabpaint']}, 01:34:25 INFO - 'other-e10s': {'tests': ['a11yr', 01:34:25 INFO - 'ts_paint', 01:34:25 INFO - 'tpaint', 01:34:25 INFO - 'sessionrestore', 01:34:25 INFO - 'sessionrestore_no_auto_restore', 01:34:25 INFO - 'tabpaint']}, 01:34:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:34:25 INFO - 'ts_paint', 01:34:25 INFO - 'tpaint', 01:34:25 INFO - 'sessionrestore', 01:34:25 INFO - 'sessionrestore_no_auto_restore', 01:34:25 INFO - 'tabpaint']}, 01:34:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:34:25 INFO - 'ts_paint', 01:34:25 INFO - 'tpaint', 01:34:25 INFO - 'sessionrestore', 01:34:25 INFO - 'sessionrestore_no_auto_restore', 01:34:25 INFO - 'tabpaint']}, 01:34:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['a11yr', 01:34:25 INFO - 'ts_paint', 01:34:25 INFO - 'tpaint', 01:34:25 INFO - 'sessionrestore', 01:34:25 INFO - 'sessionrestore_no_auto_restore', 01:34:25 INFO - 'tabpaint']}, 01:34:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['a11yr', 01:34:25 INFO - 'ts_paint', 01:34:25 INFO - 'tpaint', 01:34:25 INFO - 'sessionrestore', 01:34:25 INFO - 'sessionrestore_no_auto_restore', 01:34:25 INFO - 'tabpaint']}, 01:34:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['tsvgx', 01:34:25 INFO - 'tsvgr_opacity', 01:34:25 INFO - 'tart', 01:34:25 INFO - 'tscrollx', 01:34:25 INFO - 'cart', 01:34:25 INFO - 'tsvg_static']}, 01:34:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:34:25 INFO - 'tsvgr_opacity', 01:34:25 INFO - 'tart', 01:34:25 INFO - 'tscrollx', 01:34:25 INFO - 'cart', 01:34:25 INFO - 'tsvg_static']}, 01:34:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:34:25 INFO - 'talos_options': ['--disable-e10s'], 01:34:25 INFO - 'tests': ['tp5o']}, 01:34:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:34:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:34:25 INFO - 'talos_options': ['--disable-e10s', 01:34:25 INFO - '--xperf_path', 01:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:25 INFO - 'tests': ['tp5n']}, 01:34:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:34:25 INFO - 'talos_options': ['--xperf_path', 01:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:25 INFO - 'tests': ['tp5n']}}, 01:34:25 INFO - 'talos.zip': {'path': '', 01:34:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:34:25 INFO - Running post-action listener: _resource_record_post_action 01:34:25 INFO - [mozharness: 2017-03-27 08:34:25.894902Z] Finished populate-webroot step (success) 01:34:25 INFO - [mozharness: 2017-03-27 08:34:25.895012Z] Running create-virtualenv step. 01:34:25 INFO - Running pre-action listener: _resource_record_pre_action 01:34:25 INFO - Running main action method: create_virtualenv 01:34:25 INFO - Creating virtualenv /builds/slave/test/build/venv 01:34:25 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 01:34:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:34:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:34:26 INFO - Using real prefix '/tools/python27' 01:34:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:34:26 INFO - Installing distribute.............................................................................................................................................................................................done. 01:34:29 INFO - Installing pip.................done. 01:34:29 INFO - Return code: 0 01:34:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:34:29 INFO - Reading from file tmpfile_stdout 01:34:29 INFO - Output received: 01:34:29 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) 01:34:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:29 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 0x10486ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10486d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63ada8860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104648d30>, '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 0x10456fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463dbe8>, '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.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:34:29 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 01:34:29 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 01:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jhMjL95CUQ/Render', 01:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:29 INFO - 'HOME': '/Users/cltbld', 01:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:29 INFO - 'LOGNAME': 'cltbld', 01:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:29 INFO - 'MOZ_NO_REMOTE': '1', 01:34:29 INFO - 'NO_EM_RESTART': '1', 01:34:29 INFO - 'PAGER': '/bin/cat', 01:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:29 INFO - 'PWD': '/builds/slave/test', 01:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:29 INFO - 'SHELL': '/bin/bash', 01:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VVhGCqf6SQ/Listeners', 01:34:29 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:29 INFO - 'USER': 'cltbld', 01:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:29 INFO - 'XPC_FLAGS': '0x0', 01:34:29 INFO - 'XPC_SERVICE_NAME': '0', 01:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:30 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 01:34:30 INFO - Cleaning up... 01:34:30 INFO - Return code: 0 01:34:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:34:30 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')]} 01:34:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:30 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')]} 01:34:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:30 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 0x10486ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10486d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63ada8860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104648d30>, '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 0x10456fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463dbe8>, '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.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:34:30 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 01:34:30 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 01:34:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jhMjL95CUQ/Render', 01:34:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:30 INFO - 'HOME': '/Users/cltbld', 01:34:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:30 INFO - 'LOGNAME': 'cltbld', 01:34:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:30 INFO - 'MOZ_NO_REMOTE': '1', 01:34:30 INFO - 'NO_EM_RESTART': '1', 01:34:30 INFO - 'PAGER': '/bin/cat', 01:34:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:30 INFO - 'PWD': '/builds/slave/test', 01:34:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:30 INFO - 'SHELL': '/bin/bash', 01:34:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VVhGCqf6SQ/Listeners', 01:34:30 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:34:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:30 INFO - 'USER': 'cltbld', 01:34:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:30 INFO - 'XPC_FLAGS': '0x0', 01:34:30 INFO - 'XPC_SERVICE_NAME': '0', 01:34:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:30 INFO - Downloading/unpacking psutil>=3.1.1 01:34:30 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 01:34:30 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 01:34:30 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 01:34:30 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 01:34:30 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 01:34:30 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 01:34:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:34:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:34:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:34:34 INFO - Installing collected packages: psutil 01:34:34 INFO - Running setup.py install for psutil 01:34:34 INFO - building 'psutil._psutil_osx' extension 01:34:34 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 01:34:35 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 01:34:35 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 01:34:35 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 01:34:35 INFO - building 'psutil._psutil_posix' extension 01:34:35 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 01:34:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:34:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:34:35 INFO - ^ 01:34:35 INFO - 1 warning generated. 01:34:35 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 01:34:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:34:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:34:35 INFO - Successfully installed psutil 01:34:35 INFO - Cleaning up... 01:34:35 INFO - Return code: 0 01:34:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:34:35 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')]} 01:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:35 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')]} 01:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:35 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 0x10486ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10486d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63ada8860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104648d30>, '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 0x10456fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463dbe8>, '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.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:34:35 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 01:34:35 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 01:34:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jhMjL95CUQ/Render', 01:34:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:35 INFO - 'HOME': '/Users/cltbld', 01:34:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:35 INFO - 'LOGNAME': 'cltbld', 01:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:35 INFO - 'MOZ_NO_REMOTE': '1', 01:34:35 INFO - 'NO_EM_RESTART': '1', 01:34:35 INFO - 'PAGER': '/bin/cat', 01:34:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:35 INFO - 'PWD': '/builds/slave/test', 01:34:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:35 INFO - 'SHELL': '/bin/bash', 01:34:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VVhGCqf6SQ/Listeners', 01:34:35 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:34:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:35 INFO - 'USER': 'cltbld', 01:34:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:35 INFO - 'XPC_FLAGS': '0x0', 01:34:35 INFO - 'XPC_SERVICE_NAME': '0', 01:34:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:34:36 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 01:34:36 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 01:34:36 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 01:34:36 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 01:34:36 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 01:34:36 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 01:34:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:34:38 INFO - Installing collected packages: mozsystemmonitor 01:34:38 INFO - Running setup.py install for mozsystemmonitor 01:34:39 INFO - Successfully installed mozsystemmonitor 01:34:39 INFO - Cleaning up... 01:34:39 INFO - Return code: 0 01:34:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:34:39 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')]} 01:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:39 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')]} 01:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:39 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 0x10486ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10486d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63ada8860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104648d30>, '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 0x10456fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463dbe8>, '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.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:34:39 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 01:34:39 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 01:34:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jhMjL95CUQ/Render', 01:34:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:39 INFO - 'HOME': '/Users/cltbld', 01:34:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:39 INFO - 'LOGNAME': 'cltbld', 01:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:39 INFO - 'MOZ_NO_REMOTE': '1', 01:34:39 INFO - 'NO_EM_RESTART': '1', 01:34:39 INFO - 'PAGER': '/bin/cat', 01:34:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:39 INFO - 'PWD': '/builds/slave/test', 01:34:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:39 INFO - 'SHELL': '/bin/bash', 01:34:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VVhGCqf6SQ/Listeners', 01:34:39 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:34:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:39 INFO - 'USER': 'cltbld', 01:34:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:39 INFO - 'XPC_FLAGS': '0x0', 01:34:39 INFO - 'XPC_SERVICE_NAME': '0', 01:34:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:39 INFO - Downloading/unpacking jsonschema==2.5.1 01:34: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 01:34: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 01:34: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 01:34: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 01:34: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 01:34: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 01:34:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:34:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:34: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 01:34: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 01:34: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 01:34: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 01:34: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 01:34: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 01:34:42 INFO - Downloading functools32-3.2.3-2.tar.gz 01:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:34:42 INFO - warning: no files found matching '*.txt' 01:34:42 INFO - no previously-included directories found matching 'build' 01:34:42 INFO - no previously-included directories found matching 'dist' 01:34:42 INFO - no previously-included directories found matching '.git*' 01:34:42 INFO - Installing collected packages: jsonschema, functools32 01:34:42 INFO - Running setup.py install for functools32 01:34:42 INFO - warning: no files found matching '*.txt' 01:34:42 INFO - no previously-included directories found matching 'build' 01:34:42 INFO - no previously-included directories found matching 'dist' 01:34:42 INFO - no previously-included directories found matching '.git*' 01:34:42 INFO - Successfully installed jsonschema functools32 01:34:42 INFO - Cleaning up... 01:34:42 INFO - Return code: 0 01:34:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:34:42 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')]} 01:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:42 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')]} 01:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:42 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 0x10486ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10486d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63ada8860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104648d30>, '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 0x10456fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463dbe8>, '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.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:34:42 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 01:34:42 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 01:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jhMjL95CUQ/Render', 01:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:42 INFO - 'HOME': '/Users/cltbld', 01:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:42 INFO - 'LOGNAME': 'cltbld', 01:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:42 INFO - 'MOZ_NO_REMOTE': '1', 01:34:42 INFO - 'NO_EM_RESTART': '1', 01:34:42 INFO - 'PAGER': '/bin/cat', 01:34:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:42 INFO - 'PWD': '/builds/slave/test', 01:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:42 INFO - 'SHELL': '/bin/bash', 01:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VVhGCqf6SQ/Listeners', 01:34:42 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:42 INFO - 'USER': 'cltbld', 01:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:42 INFO - 'XPC_FLAGS': '0x0', 01:34:42 INFO - 'XPC_SERVICE_NAME': '0', 01:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:34:43 INFO - Cleaning up... 01:34:43 INFO - Return code: 0 01:34:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:34: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')]} 01:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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')]} 01:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10486ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10486d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63ada8860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104648d30>, '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 0x10456fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463dbe8>, '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.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:34:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jhMjL95CUQ/Render', 01:34:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:43 INFO - 'HOME': '/Users/cltbld', 01:34:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:43 INFO - 'LOGNAME': 'cltbld', 01:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:43 INFO - 'MOZ_NO_REMOTE': '1', 01:34:43 INFO - 'NO_EM_RESTART': '1', 01:34:43 INFO - 'PAGER': '/bin/cat', 01:34:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:43 INFO - 'PWD': '/builds/slave/test', 01:34:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:43 INFO - 'SHELL': '/bin/bash', 01:34:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VVhGCqf6SQ/Listeners', 01:34:43 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:34:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:43 INFO - 'USER': 'cltbld', 01:34:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:43 INFO - 'XPC_FLAGS': '0x0', 01:34:43 INFO - 'XPC_SERVICE_NAME': '0', 01:34:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:43 INFO - Downloading/unpacking blobuploader==1.2.4 01:34:43 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 01:34:43 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 01:34:43 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 01:34:43 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 01:34:43 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 01:34:43 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 01:34:45 INFO - Downloading blobuploader-1.2.4.tar.gz 01:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:34:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:34:46 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 01:34:46 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 01:34:46 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 01:34:46 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 01:34:46 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 01:34:46 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 01:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:34:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:34:46 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 01:34:46 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 01:34:46 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 01:34:46 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 01:34:46 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 01:34:46 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 01:34:47 INFO - Downloading docopt-0.6.1.tar.gz 01:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:34:47 INFO - Installing collected packages: blobuploader, requests, docopt 01:34:47 INFO - Running setup.py install for blobuploader 01:34:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:34:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:34:47 INFO - Running setup.py install for requests 01:34:47 INFO - Running setup.py install for docopt 01:34:48 INFO - Successfully installed blobuploader requests docopt 01:34:48 INFO - Cleaning up... 01:34:48 INFO - Return code: 0 01:34:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:34: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')]} 01:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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')]} 01:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:48 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 0x10486ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10486d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63ada8860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104648d30>, '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 0x10456fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463dbe8>, '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.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:34:48 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 01:34:48 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 01:34:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jhMjL95CUQ/Render', 01:34:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:48 INFO - 'HOME': '/Users/cltbld', 01:34:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:48 INFO - 'LOGNAME': 'cltbld', 01:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:48 INFO - 'MOZ_NO_REMOTE': '1', 01:34:48 INFO - 'NO_EM_RESTART': '1', 01:34:48 INFO - 'PAGER': '/bin/cat', 01:34:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:48 INFO - 'PWD': '/builds/slave/test', 01:34:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:48 INFO - 'SHELL': '/bin/bash', 01:34:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VVhGCqf6SQ/Listeners', 01:34:48 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:34:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:48 INFO - 'USER': 'cltbld', 01:34:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:48 INFO - 'XPC_FLAGS': '0x0', 01:34:48 INFO - 'XPC_SERVICE_NAME': '0', 01:34:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:34:48 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-IhJaP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:34:48 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-w0iECQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:34:48 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-TJ2I7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:34:48 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Ph20wM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:34:48 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-KrqUxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:34:49 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ye4OYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:34:49 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-fUDX2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:34:49 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-kHZ7_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:34:49 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-r7JWhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:34:49 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-4t8iDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:34:49 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-GJ8PK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:34:49 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-JVDgjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:34:49 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ekBrhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:34:49 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-THOS6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:49 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-3Liwzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:34:50 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-MvEbtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:34:50 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ye1Gs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:34:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:34:50 INFO - Running setup.py install for manifestparser 01:34:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:34:50 INFO - Running setup.py install for mozcrash 01:34:50 INFO - Running setup.py install for mozdebug 01:34:50 INFO - Running setup.py install for mozdevice 01:34:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:34:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:34:50 INFO - Running setup.py install for mozfile 01:34:51 INFO - Running setup.py install for mozhttpd 01:34:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Running setup.py install for mozinfo 01:34:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Running setup.py install for mozInstall 01:34:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Running setup.py install for mozleak 01:34:51 INFO - Running setup.py install for mozlog 01:34:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Running setup.py install for moznetwork 01:34:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:34:51 INFO - Running setup.py install for mozprocess 01:34:52 INFO - Running setup.py install for mozprofile 01:34:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:34:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:34:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:34:52 INFO - Running setup.py install for mozrunner 01:34:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:34:52 INFO - Running setup.py install for mozscreenshot 01:34:52 INFO - Running setup.py install for moztest 01:34:52 INFO - Running setup.py install for mozversion 01:34:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:34:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:34:52 INFO - Cleaning up... 01:34:52 INFO - Return code: 0 01:34:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:52 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 0x10486ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10486d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63ada8860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104648d30>, '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 0x10456fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463dbe8>, '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.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:34:52 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 01:34:52 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 01:34:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jhMjL95CUQ/Render', 01:34:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:52 INFO - 'HOME': '/Users/cltbld', 01:34:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:52 INFO - 'LOGNAME': 'cltbld', 01:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:52 INFO - 'MOZ_NO_REMOTE': '1', 01:34:52 INFO - 'NO_EM_RESTART': '1', 01:34:52 INFO - 'PAGER': '/bin/cat', 01:34:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:52 INFO - 'PWD': '/builds/slave/test', 01:34:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:52 INFO - 'SHELL': '/bin/bash', 01:34:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VVhGCqf6SQ/Listeners', 01:34:52 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:34:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:52 INFO - 'USER': 'cltbld', 01:34:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:52 INFO - 'XPC_FLAGS': '0x0', 01:34:52 INFO - 'XPC_SERVICE_NAME': '0', 01:34:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:34:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-_lan9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:34:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-N_IpgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:34:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-nAmvhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:34:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-weRRI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:34:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-9T3HXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:34:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-wyQJ23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:34:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ek7CbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:34:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-kR9p_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:34:53 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)) 01:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:34:53 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-MUuFeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:34:54 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)) 01:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:34:54 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-mrfDn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:34:54 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)) 01:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:34:54 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-LM4Liu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:34:54 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)) 01:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:34:54 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-bZ1lhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:34:54 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)) 01:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:34:54 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-LTjJ02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:34:54 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)) 01:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:34:54 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-SxZdum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:34:54 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)) 01:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:54 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-2710Ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:54 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)) 01:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:34:54 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-wIqbHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:34:54 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)) 01:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:34:54 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-3sTGko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:34:54 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)) 01:34:54 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)) 01:34:54 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)) 01:34:54 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)) 01:34:54 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)) 01:34:54 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)) 01:34:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:34:57 INFO - Downloading blessings-1.6.tar.gz 01:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:34:57 INFO - Installing collected packages: blessings 01:34:57 INFO - Running setup.py install for blessings 01:34:57 INFO - Successfully installed blessings 01:34:57 INFO - Cleaning up... 01:34:57 INFO - Return code: 0 01:34:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:34:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:34:58 INFO - Reading from file tmpfile_stdout 01:34:58 INFO - Current package versions: 01:34:58 INFO - blessings == 1.6 01:34:58 INFO - blobuploader == 1.2.4 01:34:58 INFO - docopt == 0.6.1 01:34:58 INFO - functools32 == 3.2.3-2 01:34:58 INFO - jsonschema == 2.5.1 01:34:58 INFO - manifestparser == 1.1 01:34:58 INFO - mozInstall == 1.12 01:34:58 INFO - mozcrash == 1.0 01:34:58 INFO - mozdebug == 0.1 01:34:58 INFO - mozdevice == 0.49 01:34:58 INFO - mozfile == 1.2 01:34:58 INFO - mozhttpd == 0.7 01:34:58 INFO - mozinfo == 0.9 01:34:58 INFO - mozleak == 0.1 01:34:58 INFO - mozlog == 3.4 01:34:58 INFO - moznetwork == 0.27 01:34:58 INFO - mozprocess == 0.25 01:34:58 INFO - mozprofile == 0.28 01:34:58 INFO - mozrunner == 6.13 01:34:58 INFO - mozscreenshot == 0.1 01:34:58 INFO - mozsystemmonitor == 0.3 01:34:58 INFO - moztest == 0.8 01:34:58 INFO - mozversion == 1.4 01:34:58 INFO - psutil == 3.1.1 01:34:58 INFO - requests == 1.2.3 01:34:58 INFO - wsgiref == 0.1.2 01:34:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:58 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 0x10486ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10486d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63ada8860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104648d30>, '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 0x10456fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463dbe8>, '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.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:34:58 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 01:34:58 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 01:34:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jhMjL95CUQ/Render', 01:34:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:58 INFO - 'HOME': '/Users/cltbld', 01:34:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:58 INFO - 'LOGNAME': 'cltbld', 01:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:58 INFO - 'MOZ_NO_REMOTE': '1', 01:34:58 INFO - 'NO_EM_RESTART': '1', 01:34:58 INFO - 'PAGER': '/bin/cat', 01:34:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:58 INFO - 'PWD': '/builds/slave/test', 01:34:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:58 INFO - 'SHELL': '/bin/bash', 01:34:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VVhGCqf6SQ/Listeners', 01:34:58 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:34:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:58 INFO - 'USER': 'cltbld', 01:34:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:58 INFO - 'XPC_FLAGS': '0x0', 01:34:58 INFO - 'XPC_SERVICE_NAME': '0', 01:34:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 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)) 01:34:58 INFO - Cleaning up... 01:34:58 INFO - Return code: 0 01:34:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10486ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10486d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb63ada8860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104648d30>, '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 0x10456fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463dbe8>, '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.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 01:34:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:34:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jhMjL95CUQ/Render', 01:34:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:58 INFO - 'HOME': '/Users/cltbld', 01:34:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:58 INFO - 'LOGNAME': 'cltbld', 01:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:58 INFO - 'MOZ_NO_REMOTE': '1', 01:34:58 INFO - 'NO_EM_RESTART': '1', 01:34:58 INFO - 'PAGER': '/bin/cat', 01:34:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:58 INFO - 'PWD': '/builds/slave/test', 01:34:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:58 INFO - 'SHELL': '/bin/bash', 01:34:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VVhGCqf6SQ/Listeners', 01:34:58 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:34:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:58 INFO - 'USER': 'cltbld', 01:34:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:58 INFO - 'XPC_FLAGS': '0x0', 01:34:58 INFO - 'XPC_SERVICE_NAME': '0', 01:34:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:34:58 INFO - Cleaning up... 01:34:58 INFO - Return code: 0 01:34:58 INFO - Running post-action listener: _resource_record_post_action 01:34:58 INFO - Running post-action listener: _start_resource_monitoring 01:34:58 INFO - Starting resource monitoring. 01:34:58 INFO - [mozharness: 2017-03-27 08:34:58.798369Z] Finished create-virtualenv step (success) 01:34:58 INFO - [mozharness: 2017-03-27 08:34:58.799307Z] Running install step. 01:34:58 INFO - Running pre-action listener: _resource_record_pre_action 01:34:58 INFO - Running main action method: install 01:34:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:34:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:34:59 INFO - Reading from file tmpfile_stdout 01:34:59 INFO - Detecting whether we're running mozinstall >=1.0... 01:34:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:34:59 INFO - Reading from file tmpfile_stdout 01:34:59 INFO - Output received: 01:34:59 INFO - Usage: mozinstall [options] installer 01:34:59 INFO - Options: 01:34:59 INFO - -h, --help show this help message and exit 01:34:59 INFO - -d DEST, --destination=DEST 01:34:59 INFO - Directory to install application into. [default: 01:34:59 INFO - "/builds/slave/test"] 01:34:59 INFO - --app=APP Application being installed. [default: firefox] 01:34:59 INFO - mkdir: /builds/slave/test/build/application 01:34:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 01:35:18 INFO - Reading from file tmpfile_stdout 01:35:18 INFO - Output received: 01:35:18 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:35:18 INFO - Running post-action listener: _resource_record_post_action 01:35:18 INFO - [mozharness: 2017-03-27 08:35:18.959816Z] Finished install step (success) 01:35:18 INFO - [mozharness: 2017-03-27 08:35:18.959941Z] Running run-tests step. 01:35:18 INFO - Running pre-action listener: _resource_record_pre_action 01:35:18 INFO - Running main action method: run_tests 01:35:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:35:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:35:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:35:18 INFO - 2017-03-27 01:35:18.974 screenresolution[1638:9161] starting screenresolution argv=screenresolution get 01:35:18 INFO - 2017-03-27 01:35:18.977 screenresolution[1638:9161] Display 0: 1600x1200x32@60 01:35:18 INFO - 2017-03-27 01:35:18.982 screenresolution[1639:9164] starting screenresolution argv=screenresolution list 01:35:18 INFO - Available Modes on Display 0 01:35:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:35:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:35:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:35:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:35:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:35:19 INFO - Intel Iris: 01:35:19 INFO - Chipset Model: Intel Iris 01:35:19 INFO - Type: GPU 01:35:19 INFO - Bus: Built-In 01:35:19 INFO - VRAM (Dynamic, Max): 1536 MB 01:35:19 INFO - Vendor: Intel (0x8086) 01:35:19 INFO - Device ID: 0x0a2e 01:35:19 INFO - Revision ID: 0x0009 01:35:19 INFO - Displays: 01:35:19 INFO - Display: 01:35:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:35:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:35:19 INFO - Display Serial Number: 1600x1200 60 01:35:19 INFO - Main Display: Yes 01:35:19 INFO - Mirror: Off 01:35:19 INFO - Online: Yes 01:35:19 INFO - Rotation: Supported 01:35:19 INFO - Return code: 0 01:35:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:35:19 INFO - Python 2.7.3 01:35:19 INFO - Return code: 0 01:35:19 INFO - grabbing minidump binary from tooltool 01:35:19 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')]} 01:35:19 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 0x104648d30>, '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 0x10456fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10463dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:35:19 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 01:35:19 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 01:35:19 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 01:35:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:35:19 INFO - Return code: 0 01:35:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:35:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:35:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:35:19 INFO - ENV: RUST_BACKTRACE is now 1 01:35:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:35:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:35:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 01:35:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --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 01:35:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jhMjL95CUQ/Render', 01:35:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:35:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:35:19 INFO - 'HOME': '/Users/cltbld', 01:35:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:35:19 INFO - 'LOGNAME': 'cltbld', 01:35:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:35:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:19 INFO - 'MOZ_NO_REMOTE': '1', 01:35:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:35:19 INFO - 'NO_EM_RESTART': '1', 01:35:19 INFO - 'PAGER': '/bin/cat', 01:35:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:19 INFO - 'PWD': '/builds/slave/test', 01:35:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:35:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:35:19 INFO - 'RUST_BACKTRACE': '1', 01:35:19 INFO - 'SHELL': '/bin/bash', 01:35:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VVhGCqf6SQ/Listeners', 01:35:19 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 01:35:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:35:19 INFO - 'USER': 'cltbld', 01:35:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:35:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:19 INFO - 'XPC_FLAGS': '0x0', 01:35:19 INFO - 'XPC_SERVICE_NAME': '0', 01:35:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:35:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 01:35:19 INFO - mozversion application_buildid: 20170327004003 01:35:19 INFO - mozversion application_changeset: 426f26d1a43efcbf9bed49a01a52afb4b8907c79 01:35:19 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:35:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:35:19 INFO - mozversion application_name: Firefox 01:35:19 INFO - mozversion application_remotingname: firefox-dev 01:35:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:35:19 INFO - mozversion application_vendor: Mozilla 01:35:19 INFO - mozversion application_version: 54.0a2 01:35:19 INFO - mozversion platform_buildid: 20170327004003 01:35:19 INFO - mozversion platform_changeset: 426f26d1a43efcbf9bed49a01a52afb4b8907c79 01:35:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:35:19 INFO - mozversion platform_version: 54.0a2 01:35:19 INFO - using testdate: 1490603719 01:35:19 INFO - actual date: 1490603719 01:35:19 INFO - starting webserver on 'localhost:49252' 01:35:19 INFO - SUITE-START | Running 2 tests 01:35:19 INFO - TEST-START | dromaeo_css 01:35:19 INFO - operating with platform_type : mac_ 01:35:19 INFO - Initialising browser for dromaeo_css test... 01:35:19 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpf2pZZJ/profile http://localhost:49252/getInfo.html) 01:35:22 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 01:35:22 INFO - PROCESS | 1649 | colorDepth:24 01:35:22 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 01:35:22 INFO - PROCESS | 1649 | __metrics 01:35:22 INFO - PROCESS | 1649 | 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" 01:35:22 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:35:23 INFO - TEST-INFO | 1649: exit 0 01:35:23 INFO - Browser initialized. 01:35:23 INFO - Running cycle 1/1 for dromaeo_css test... 01:35:23 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpf2pZZJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:35:35 INFO - PROCESS | 1653 | RSS: Main: 214355968 01:35:35 INFO - PROCESS | 1653 | 01:38:40 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49252/tests/dromaeo/cssquery-ext.html) 01:38:42 INFO - PROCESS | 1653 | RSS: Main: 317886464 01:38:42 INFO - PROCESS | 1653 | 01:40:26 INFO - PROCESS | 1653 | ************************* 01:40:26 INFO - PROCESS | 1653 | A coding exception was thrown and uncaught in a Task. 01:40:26 INFO - PROCESS | 1653 | 01:40:26 ERROR - PROCESS | 1653 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:40:26 INFO - PROCESS | 1653 | Full stack: 01:40:26 INFO - PROCESS | 1653 | ************************* 01:41:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-ext.html (next: http://localhost:49252/tests/dromaeo/cssquery-jquery.html) 01:41:46 INFO - PROCESS | 1653 | RSS: Main: 350195712 01:41:46 INFO - PROCESS | 1653 | 01:44:48 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49252/tests/dromaeo/cssquery-mootools.html) 01:44:49 INFO - PROCESS | 1653 | RSS: Main: 323784704 01:44:49 INFO - PROCESS | 1653 | 01:47:52 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49252/tests/dromaeo/cssquery-prototype.html) 01:47:52 INFO - PROCESS | 1653 | RSS: Main: 341266432 01:47:52 INFO - PROCESS | 1653 | 01:50:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49252/tests/dromaeo/cssquery-yui.html) 01:50:57 INFO - PROCESS | 1653 | RSS: Main: 314404864 01:50:57 INFO - PROCESS | 1653 | 01:54:00 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-yui.html (next: http://localhost:49252/tests/dromaeo/cssquery-dojo.html) 01:54:00 INFO - PROCESS | 1653 | RSS: Main: 378617856 01:54:00 INFO - PROCESS | 1653 | 01:54:00 INFO - PROCESS | 1653 | __start_tp_report 01:54:00 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 01:54:00 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 01:54:00 INFO - PROCESS | 1653 | |i|pagename|runs| 01:54:00 INFO - PROCESS | 1653 | |0;dojo.html;3427.1260828488716;3436.9484457733124;3451.5167876497285;3453.6703369202855;3474.0967348489385;6028.4041112261975;6035.9698201509045;6052.092186172076;6059.545534084939;6059.969700151504;6021.277446706401;6090.634561926277;6098.207233059696;6098.359672234407;6130.724117414716;5403.78384864606;5439.809606663767;5463.863403414926;5478.780848766064;5570.303712035996;5348.197770334442;5371.677699338033;5394.163904594774;5547.528460080878;5567.137093750475;5448.809291674792;5479.561635069204;5512.283403157584;5531.640443371188;5553.16702494625;5508.063629183009;5523.558115350762;5526.917096243559;5527.309086364185;5544.556435485192;5235.345581802275;5325.840224793263;5441;5442.591805614556;5490.313710786152;5852.414758524156;5866.061430171152;5883.764649414061;5885.44088311614;5893.116032595102;5565.747706765986;6142.6350854921175;6355.8411039723915;6356.491480681534;6364.236291644986;6230.096635987757;6308.085327627514;6324.873502529969;6327.936720632781;6381.234251889757;6132.8144489347815;6227.221597300338;6250.4374606285655;6251.156093927352;6256.249250089927;6591.110200122922;6617.2059352877;6622.966885165543;6633.369829866155;6634.203895532567;5706.828795136153;5988.490978266809;6194.318624951252;6343.175387199634;6363.9045414318825;6351.301356850743;6367.172267605181;6408.967955160194;6427.903581446282;6455.225372955181;6391.584547004522;6393.840153996187;6393.968030159819;6394.136791533084;6398.168238129014;6301.52738544611;6351.9682401588625;6354.904676429857;6362.204724409449;6373.1714877066615;5156.484351564814;5199.844004679866;5203.947960520422;5207.843764687065;5241.764120614582;4474.351219073216;4618.67669263155;4624.953750462452;4673.3690951721765;4693.624510039189;5940.524758019348;5948.196993405922;6043.214382130383;6084.5436592255755;6138.296437970319;6453.903191452132;6490.740370385226;6491.51313651478;6503.057056726842;6518.934810651927;6096.817095487054;6104.908426373608;6117;6128.693565321716;6142.232220972379;5450.31871016123;5567.47109024642;5687.544996400278;5701.173329867146;5716.885662286814;5511.421300763523;6343.492520598434;6390.808275751735;6551.80344589663;6690.330966903271;6455.354464553695;6478.3197764235965;6481.092647029325;6492.058651495412;6505.41451269388;6624.768133115318;6625.304343043911;6642.070110184674;6656.7004484797335;6664.200295964515;6086.539230584716;6279.71741271653;6312.810615681353;6420.036994450869;6429.7749578764515;6172.290186628596;6378.1070650108095;6438.517111216771;6458.580192287486;6462.063000864754;6275.780347687809;6307.684615769102;6329.208848893888;6335.90496142549;6337.207849018872;6210.72051757681;6325.240971083499;6344;6349.047642853424;6353.269374022047;6168.19813424252;6222.595531290452;6227.065940108839;6265.4361107500545;6290.685465726604;5128.025675121715;5981.880362392815;6228.190335256388;6338.619682819046;6339.683015849097;6287.96856015717;6288.874222515616;6313.873722525432;6314.242290925118;6336.493080553452 01:54:00 INFO - PROCESS | 1653 | |1;ext.html;795.192879227584;810.4893916832394;876.2551830943698;891.5720454181989;894.7718331825383;32789.508157377655;39450.013749656275;39571;39666.80166599167;40872.38691419631;32878.506822397685;39860.80069599648;39906.80046599763;39946.20107597846;40163.19673606526;7168.534045287066;7341.77974660761;8879.822403551942;9029.367944243906;9042.638294468214;10562.471876406149;10852.945735271313;10855.348679079241;10858.619948301812;10966.122710183166;10806.945965270203;10826.025657690807;10826.404547749871;10841.403722795283;10844.945775271151;7217.170025447088;7391.519551229207;10780.40707761073;10789.676309710721;10816.134709223243;9173.587188576463;10428.89571104287;10757.193210509244;10817.567297308098;10826.18803589734;38304.85085447441;38483.65307214262;38488.23023539514;38533.61466385328;38638;3830.4254361845947;3833.9041523961846;3856.382978723391;3864.6908247340425;3932.2528719543197;27185.320366990785;27514;27626.585601215997;27675.72324276772;28754.712452875414;3074.2621770775077;3135.357251763383;3148.921276968094;3153.8896138635037;3181;348514.5148548507;350361;354007.99999999744;354742;354832;42836.57163428388;43379.78310108429;43874;51224.23163652548;52838.73580632072;44786.55213447889;54323.72838135784;54396.45603543993;54495.72752136293;54653;12508.437120329607;14709.92645036768;14720.484783032542;14725.852741472663;14751.483698070517;12610.495580176874;12637.810432843515;12657.493700252071;12659.11386202957;12670.239785612892;12507.124501284823;12528.561500347445;12540.122191446693;12575.937120314522;12659.556915507914;5365.946340536622;5406.648567843077;5436.510714035756;5462.6995515247045;5465.9726701366235;1096.1180800126665;1100.9504572294106;1110.4725255503572;1116.4473585575192;1134.6312448454285;20818.79181208199;25953.091641792445;26100.34749131287;26292.948282068886;26401;1109.5728144664201;1206.5535751771902;1218.3725381428394;1257.503286201945;1270.3330751355427;10606.363618182933;11739;13193.20840749558;13541.187528748307;13741.656458588615;449451;450287;450764;451709;451729;54995;55178.44821551813;55194.72402638041;55308;55372.44627553673;1378.3866179550205;1438.2880474165147;1439.5969128643997;1440.5606290081626;1444.1046551138152;24952.87712052998;25384.619230711924;25694.218800770424;25700.614490783028;26694.46611067729;45564;45851.08297833958;45891.62325130252;45897;45922.31116533188;450226;451416;452131;452532;453015;24478.388040299134;24876.12933547317;25555.233342999738;27980.44039119247;28774;30986.845065774527;36360;38447.23105537929;38508.614913850506;38563.807180963915;26629;26860.59709104404;27455;27547.586786197822;28276.15171544857;22363.993620287452;26792.866035669696;26953.921843126056;27640;27674.5848812272;26243;31263;31851.36297274088;32394.83802580972;32459;26907.596386054618;27214;27893.302667433476;27964.30089247785;28436.86252549875;18214.45356639303;21068.894655526623;21670.34988950334;22529.549409012056;22684 01:54:00 INFO - PROCESS | 1653 | |2;jquery.html;384.36266445337026;433.6920786241768;433.7334981852989;441.11996566849143;450.19415246708394;16362.672746545062;20361;22039.779602203973;22085.668714969288;22289.2198773043;21711.3486595402;22007;22465.87670616471;22710;22766.88616556915;6610.768623098193;6746.224184218816;6798.52410331277;6877.105976223084;6883.036374907517;3687.1703866629928;4428.446444194476;6759.357861003196;6892.896606550906;6893.448524118058;7356.521826081314;7687.192844751305;7804.843903121934;7807.180246074166;7832.56920869352;7633.6564854581675;7698.384129269645;7721.53670779755;7798.649060792278;7807.336376408012;6874.621895795729;7180.066591343144;7352.338289553966;7587.924120758777;7611.581363025031;25572.488550229078;26182.607260890913;26324.73675263242;26351.34121646955;26619.733802661918;2728.890844366223;2878.5394336905993;2924.780641451878;2932.4428358611794;2932.4868148074215;13746.381412836447;15713.292901819446;15745.527634170992;15807;16450.012999220085;1983.8214560689462;2021.050106449966;2036.5010572409853;2044.6932960055963;2045.1308194017631;150571.2471437647;152439;159616;160376;162775.18612406982;14794.52328702754;19589.706154407697;19932.90033549823;20472.897635511727;20673.483162920747;30143.09570712882;31039.689603104132;31077.844610777254;31761.682383175874;31876.681233187835;9881.654142105135;10181.33821301613;10345.74135646615;10380.169586433067;10502.474876256156;8634.827303453896;8647.740567782977;8663.480191188422;8797.956010220036;8808.20726134651;9258.370814592703;9283.791813764878;9471.147596716328;9479.905200947902;9487.90512094884;3846.538415390171;3892.863749768801;3930.1702774002674;3936.287714844052;3950.7827069510877;948.4593781544592;1022.8925962773801;1035.7669524357111;1040.2614143957874;1042.3797840285017;21491.355259342246;21962.670559941613;21972.89013554922;21980.89009554942;22013;1047.9214058945608;1061.5382308695741;1075.2258373970728;1079.1744315598573;1079.2067830144838;10452.32059916103;11230;11267.605633802941;11280.830787538194;11300.265482743594;658790;662833;665022;684188;685612;140239;144454.27772861067;144891.2755436216;145761.25432474085;145953;1167.3404526442532;1168.1589255735857;1187.6971372300181;1192;1194.9581764638197;17755;18632.254709811456;18663;18719;18737.812621874153;34601.30797383988;47467;53960.73019634877;56725.71637141788;61564.38435615587;79015.81476277976;81933.59033204796;82243;82515.34969300701;82560;11179.60871369498;11376.94311528437;11510.82733759011;11830.881691183322;11846.644600661994;12725.490980361052;12880.613581592566;12912.483500660244;13344.132631378929;13355.198688078746;10831.458427078773;11005.724856878642;11064.28082174656;11306.49120789583;11314.660560183207;9998.500074996367;10320.43237621908;10418.739531511774;10464.947675261576;10467.94766026165;11560.30638161713;11620.360880151335;11694.824577631172;11969.760604788029;12024.158308918642;11488.96599306033;11538;11586.768264634491;11914.463849126636;11975.820362694392;11094.167937404565;11171.273867198606;11191.2725672831;11522.96293333604;11530.769384612093 01:54:00 INFO - PROCESS | 1653 | |3;mootools.html;1459.9635009124775;1502.519193857965;1537.5387383784869;1543.822460417051;1591.2203020519944;10546.156307495401;10924.399158046304;11129.998300152985;11156.609518666848;11225.158113141517;10990.010899019107;11162.218644694874;11175.552977880896;11187.769345372002;11196.328220306787;2386.7255265644458;2419.9153029643967;2420.818438617102;2422.3580751100885;2427.7329493755674;2321.58211521926;2391.222852572912;2401.399650087478;2401.8799060046927;2411.3007227903886;2059.4336557446672;2313.3985163857433;2355.1756885090253;2374.857508549484;2387.1167667962877;2305.2392710405525;2352.0591763294647;2357.26924653358;2362.338545207336;2368.4315764216462;2369.1234243330077;2373.8457000294925;2393.4495066134714;2399.040383846458;2401.087586717036;10969.286996345292;11220.607278745205;11233.831492527619;11235.83146252807;11265.380404077772;5620.494155526022;5809.186713860063;5810.564207684441;5810.5932584719085;5810.970945145247;3503.8423270952867;3578.177019285579;3587.964120358789;3591.1560783215923;3681.3005528949416;1174.9001334886545;1183.2663748475914;1208.993955030228;1219.62191720566;1231.1566576894857;13617.591472255848;13956.720865582733;14205.644858878612;15559.922200389039;15800.92099539495;4561.817527298937;4704.294355846582;4730.455997560256;4732.053589282157;4745.0509898019845;9757.804843903083;11814.763704725858;11819.586314478953;11842.94078529619;11843.46704398304;4796.232602783538;4982.177940639826;5345.572354211654;5470.234167216593;5542.085555883315;5089.898202036013;5222.947770522323;5247.370315562157;5305.946940530545;5307.734613269321;3894.2600905827803;3912.0219945013746;3979.8010099495486;3987.282289187974;4052.2705912935953;1029.2023681646633;1039.6725031615017;1054.1935419404163;1058.444316733721;1059.0944742245424;917.156216281023;939.5396255834728;951.6098399656108;959.6209497248688;993.5926270229171;6639.203295604559;6686.398224159849;6802.625855577891;6888.896666550006;6897.827554311082;779.8284377436955;966.5843687214565;987.511181964932;1019.0522813783252;1032.492560861136;4187.6021777931655;4487.708298960557;4647.55848194421;4793;4870.4155501339355;13584.932075339757;13653.658658533615;13828.585142445743;14111.435542578387;14174.929125354514;13661.590152295446;13941.372638231303;14013.649658758613;14048.648783780487;14122.64693382653;10114.949425252827;10123.645672401577;10269.537870795682;10426.635067772744;10428.530716117793;6869.381755642016;6890.414314783099;6901.447884169354;6939.861202775815;7122.038524799086;12185.390730463265;12262.75474490523;12601.621951341474;12606.936965315115;12739.98080153604;12640.747185056063;12691.175073620185;12870.292133932724;12875.227486350848;12976.740465190833;9263.953680231556;9560.613711012003;9579.377340472847;9584.808303834025;9586.616535338508;10195.796084078425;10405.375677459377;10485.056344928993;10504.789904202025;10534.262601617813;8748;8857.955710221408;8932.240759535513;8942.46345219289;9065.32010099232;8638.91361086381;8658.870116948377;8667.263282621048;8717.346199034972;8744.606492707717;7809.960950195213;8008.439409241297;8009;8037.477563958324;8038.557879316693;5814.447627475383;5860.765569377348;5910.940890591039;6028.306744724413;6088.208532890696;5867.823965280878;6068.423499767515;6099.634021958696;6151;6152.138700581832 01:54:00 INFO - PROCESS | 1653 | |4;prototype.html;371.79737043311394;381.6107570278316;382.69958082904924;388.4445243302077;393.60442755031187;3947.913909104078;4361.825526978917;5108.7956481740775;5256.86857828554;5328.786848526064;4556.589906908378;4955.207166853304;4967.950320496794;5074.391073071228;5105.285260063594;3804.08701911542;4392.450943632046;4425.446819147606;4439.424004478412;4492.505824359318;3908.612442582885;4334.631556317717;4335.0763665396635;4494.325851122325;4530.841420550281;4187.790610469479;4235.639970602502;4236.66545038312;4286.721363111404;4439.247666446808;3644.927101457956;3715.90710232245;3793.886183414502;4349.086691794695;4388.49532303786;3752.249550089993;4183.686223533247;4217.40956266123;4246.5116511600945;4271.035323751078;4769.928451073202;4796.5683088521855;4937.876553086166;4945.530174633404;5064.721440320781;4556.015809644688;4825.396825396825;5134.948650513485;5159.355080614923;5206.895862082775;5462.20797984294;5487.835364939018;5494.203340515643;5513.959834861127;5564.10974244123;4012.612495565134;4414.955850441486;4466.3747075409465;4743.881402964919;4817.9036419271415;4766.4261298898555;5491.945080549183;5722.971385143048;5759.902486299655;5766.971165144148;4468.553144685506;4635.513271106485;4968.627352948543;4968.652194346361;4995.925061124086;3634.945475817865;3943.12701466801;4525.705829121097;4960.776765045582;5040.7731652075745;4349.108432771274;4733.881652958704;4820.662553621213;4865.175559165313;4879.1461494238365;4517.312199241446;4743.501932297128;5429.375621803464;5448.782048718086;5462.644928079662;1363.577291039781;1474.9188794616184;1483.9703205936037;1546.9458568950033;1561.8203906550664;1130.598637483698;1140.0252783869837;1147.6843867936384;1156.5778490850946;1162.4013632979022;4103.373840741928;4196.419202190631;4422.425084738963;5016.592035822826;5103.770330335144;4806.855794326176;5389.278414400781;5659.35878595211;5683.943160568424;5817.767289308465;4040.696947728932;4399.670024748093;4729.62163026957;4811.927821082687;4884.95115048852;2649.3109493863744;2764.797313168778;2776.514110030777;2903.6515618125536;2945.3372991076835;4959.7272150032095;5447.618666693294;5508.502101165788;5821.505172060338;5895.551102605024;5325.37576039304;5503.862403439866;5878.412158784173;5912.793052243151;5920.970395147997;5441.809536666118;5672.107225315037;5837.643355070766;5916.49709774674;5924.318703349084;5021.472745361684;5702.372738998624;5731;5751.309842818721;5783.537317014713;4764.046291299416;5667.8866422672145;5689.2319536862;5699.715014249188;5741.598088133791;5443.428440013741;5702.372738998624;5869.325027621708;5956.583039187215;5995.372799456441;4451.866444006685;4462.709923854939;4466.352378904976;4466.843660471868;4476.7090139140855;5117.801374141161;5620.325560932714;5717.914231286617;5781.4218578141845;5790.986577348863;5362.973185134049;5469.671819690831;5487.533559647474;5510.291809538895;5523.7790488380015;4592.563706447882;4820.275715377099;5423.90837222795;5432.9185062223305;5498.367687715964;4227.87316380509;4866.537678920497;5055.368078990126;5414.079606466831;5437.293151890229;4921.3356196912955;4941.058941058941;4969.503049695001;5342.679439233659;5478.424765399735;4327.0480494291205;4693.812247510062;4791.736454494897;5323;5355 01:54:00 INFO - PROCESS | 1653 | |5;yui.html;763.4236151705461;765.5445010218917;791.2404092071611;807.2613558593887;815.9428839981202;14954.252287385629;15712.842871571282;15714.685706285896;15731.37074517018;15738.291776870039;14250.501232456865;14359.35382907769;14375;14379.281035948214;15034.774478382833;929.3680297397767;934.4019827310493;941.9199368053723;947.6114792934898;959.2182371367348;949.4682977532569;952.2762700347716;953.0897992417225;953.323140570196;953.7949340891707;997.6957028106425;997.9800403991916;998.2213873178896;999.9350042247268;1001.1790331927785;989.4557993103764;991.1921783746224;991.6083147156833;992.3896803465889;994.7165057958483;736.9115706115247;737.0933751485649;737.4321772235348;737.8044818123202;738.4756822655921;15578.610534736608;15807.577318041316;15820.288087036111;16261.51215463538;16438.75341869861;14114.012019158663;14183.503577374742;14262.57212283633;14341.21123338216;14354.784678229835;9996.90003099967;11546.422678866023;11761.235519691192;11847.703807404798;12360.38198090101;3682.6869716074166;3687.870924517656;3728.7949162796035;3776.1126135358168;3810.942835857464;95264.52367738116;114616.42691786571;119199;120353;121044;10557.47212639365;10602.681919542427;10631.415272160106;10751.139908807276;10772.838407423895;19537.902310488356;19672.704909426084;21343.67984480234;21358.78641213568;21411.464713381978;7516.173220945691;7517.849643007218;7522.887156692654;7555.584442855696;7760.883586746203;4202.3696445533415;4202.495700515958;4281.850135245251;4434.512203657595;4460.843870464518;3081.8921337753072;3127.218195451137;3127.8748850045745;3151.416987857254;3152.1489197916435;592.9851753706106;598.2491972574392;598.5241732822329;599.3437186281016;601.3445344574347;600.6996501749126;609.1989034419723;629.235478893147;648.2286079565303;688.2979361051699;8165.63254653542;8724.11776759336;9708.563114659857;9851.261155413373;9874.061964113398;644.4135836388864;680.3060877904609;680.3706571421515;685.8148299959083;695.2181469762435;4533.977330113395;4789.449213340441;4793.1372352976105;4795;4810.759462026885;101879.96240075157;105025.47487262514;105169;105808.94191058144;107918;45013.549864500936;59464;75810;77612.61193694109;80432;61393.69303153545;68941.62116757636;70353;76073.61963190149;79543.60228198822;10252.231082668979;10280.663513743166;10694.823569407514;10934.289271197347;11147.777044459228;40543.79728101341;48561.757191213816;51834;52209.95580088453;53344.19983700325;52132.69668258324;57156.42843571511;64054.35945640484;64855;66227.66886165731;12392;12410.379481026093;12514;12916.41876115596;13199.934000329937;14111.364988575744;14325.140491570539;14371.13773173613;14697.70604587881;14773.113613183243;12398.81401778992;12449.502019919464;12526.812097818722;12698.873011269769;13101.27942963108;13022.218666879638;13830.930845345709;14024.158550487004;14124.152550846982;14178.645533861736;13013.21920684762;13015.284159371326;13232.338383081;13601.863981360455;14041.859581404055;8626.870596940926;8825.602847871989;8825.735227943173;9166.08339166078;9358.391704539183;10483.52824122901;11344.546218151181;11424.485898134437;11436.19946603763;11645.592404266148 01:54:00 INFO - PROCESS | 1653 | __end_tp_report 01:54:00 INFO - PROCESS | 1653 | __start_cc_report 01:54:00 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2141 01:54:00 INFO - PROCESS | 1653 | __end_cc_report 01:54:00 INFO - PROCESS | 1653 | __startTimestamp1490604840829__endTimestamp 01:54:00 INFO - PROCESS | 1653 | 01:54:00 INFO - PROCESS | 1653 | ------- Summary: start ------- 01:54:00 INFO - PROCESS | 1653 | Number of tests: 6 01:54:00 INFO - PROCESS | 1653 | 01:54:00 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5962.09 Median:6210.72 stddev:649.16 (10.5%) stddev-sans-first:619.94 01:54:00 INFO - PROCESS | 1653 | Values: 3427.1 3436.9 3451.5 3453.7 3474.1 6028.4 6036.0 6052.1 6059.5 6060.0 6021.3 6090.6 6098.2 6098.4 6130.7 5403.8 5439.8 5463.9 5478.8 5570.3 5348.2 5371.7 5394.2 5547.5 5567.1 5448.8 5479.6 5512.3 5531.6 5553.2 5508.1 5523.6 5526.9 5527.3 5544.6 5235.3 5325.8 5441.0 5442.6 5490.3 5852.4 5866.1 5883.8 5885.4 5893.1 5565.7 6142.6 6355.8 6356.5 6364.2 6230.1 6308.1 6324.9 6327.9 6381.2 6132.8 6227.2 6250.4 6251.2 6256.2 6591.1 6617.2 6623.0 6633.4 6634.2 5706.8 5988.5 6194.3 6343.2 6363.9 6351.3 6367.2 6409.0 6427.9 6455.2 6391.6 6393.8 6394.0 6394.1 6398.2 6301.5 6352.0 6354.9 6362.2 6373.2 5156.5 5199.8 5203.9 5207.8 5241.8 4474.4 4618.7 4625.0 4673.4 4693.6 5940.5 5948.2 6043.2 6084.5 6138.3 6453.9 6490.7 6491.5 6503.1 6518.9 6096.8 6104.9 6117.0 6128.7 6142.2 5450.3 5567.5 5687.5 5701.2 5716.9 5511.4 6343.5 6390.8 6551.8 6690.3 6455.4 6478.3 6481.1 6492.1 6505.4 6624.8 6625.3 6642.1 6656.7 6664.2 6086.5 6279.7 6312.8 6420.0 6429.8 6172.3 6378.1 6438.5 6458.6 6462.1 6275.8 6307.7 6329.2 6335.9 6337.2 6210.7 6325.2 6344.0 6349.0 6353.3 6168.2 6222.6 6227.1 6265.4 6290.7 5128.0 5981.9 6228.2 6338.6 6339.7 6288.0 6288.9 6313.9 6314.2 6336.5 01:54:00 INFO - PROCESS | 1653 | 01:54:00 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:54576.04 Median:28595.79 stddev:111865.07 (391.2%) stddev-sans-first:112106.01 01:54:00 INFO - PROCESS | 1653 | Values: 795.2 810.5 876.3 891.6 894.8 32789.5 39450.0 39571.0 39666.8 40872.4 32878.5 39860.8 39906.8 39946.2 40163.2 7168.5 7341.8 8879.8 9029.4 9042.6 10562.5 10852.9 10855.3 10858.6 10966.1 10806.9 10826.0 10826.4 10841.4 10844.9 7217.2 7391.5 10780.4 10789.7 10816.1 9173.6 10428.9 10757.2 10817.6 10826.2 38304.9 38483.7 38488.2 38533.6 38638.0 3830.4 3833.9 3856.4 3864.7 3932.3 27185.3 27514.0 27626.6 27675.7 28754.7 3074.3 3135.4 3148.9 3153.9 3181.0 348514.5 350361.0 354008.0 354742.0 354832.0 42836.6 43379.8 43874.0 51224.2 52838.7 44786.6 54323.7 54396.5 54495.7 54653.0 12508.4 14709.9 14720.5 14725.9 14751.5 12610.5 12637.8 12657.5 12659.1 12670.2 12507.1 12528.6 12540.1 12575.9 12659.6 5365.9 5406.6 5436.5 5462.7 5466.0 1096.1 1101.0 1110.5 1116.4 1134.6 20818.8 25953.1 26100.3 26292.9 26401.0 1109.6 1206.6 1218.4 1257.5 1270.3 10606.4 11739.0 13193.2 13541.2 13741.7 449451.0 450287.0 450764.0 451709.0 451729.0 54995.0 55178.4 55194.7 55308.0 55372.4 1378.4 1438.3 1439.6 1440.6 1444.1 24952.9 25384.6 25694.2 25700.6 26694.5 45564.0 45851.1 45891.6 45897.0 45922.3 450226.0 451416.0 452131.0 452532.0 453015.0 24478.4 24876.1 25555.2 27980.4 28774.0 30986.8 36360.0 38447.2 38508.6 38563.8 26629.0 26860.6 27455.0 27547.6 28276.2 22364.0 26792.9 26953.9 27640.0 27674.6 26243.0 31263.0 31851.4 32394.8 32459.0 26907.6 27214.0 27893.3 27964.3 28436.9 18214.5 21068.9 21670.3 22529.5 22684.0 01:54:00 INFO - PROCESS | 1653 | 01:54:00 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:40238.94 Median:21837.01 stddev:112486.01 (515.1%) stddev-sans-first:112761.76 01:54:00 INFO - PROCESS | 1653 | Values: 384.4 433.7 433.7 441.1 450.2 16362.7 20361.0 22039.8 22085.7 22289.2 21711.3 22007.0 22465.9 22710.0 22766.9 6610.8 6746.2 6798.5 6877.1 6883.0 3687.2 4428.4 6759.4 6892.9 6893.4 7356.5 7687.2 7804.8 7807.2 7832.6 7633.7 7698.4 7721.5 7798.6 7807.3 6874.6 7180.1 7352.3 7587.9 7611.6 25572.5 26182.6 26324.7 26351.3 26619.7 2728.9 2878.5 2924.8 2932.4 2932.5 13746.4 15713.3 15745.5 15807.0 16450.0 1983.8 2021.1 2036.5 2044.7 2045.1 150571.2 152439.0 159616.0 160376.0 162775.2 14794.5 19589.7 19932.9 20472.9 20673.5 30143.1 31039.7 31077.8 31761.7 31876.7 9881.7 10181.3 10345.7 10380.2 10502.5 8634.8 8647.7 8663.5 8798.0 8808.2 9258.4 9283.8 9471.1 9479.9 9487.9 3846.5 3892.9 3930.2 3936.3 3950.8 948.5 1022.9 1035.8 1040.3 1042.4 21491.4 21962.7 21972.9 21980.9 22013.0 1047.9 1061.5 1075.2 1079.2 1079.2 10452.3 11230.0 11267.6 11280.8 11300.3 658790.0 662833.0 665022.0 684188.0 685612.0 140239.0 144454.3 144891.3 145761.3 145953.0 1167.3 1168.2 1187.7 1192.0 1195.0 17755.0 18632.3 18663.0 18719.0 18737.8 34601.3 47467.0 53960.7 56725.7 61564.4 79015.8 81933.6 82243.0 82515.3 82560.0 11179.6 11376.9 11510.8 11830.9 11846.6 12725.5 12880.6 12912.5 13344.1 13355.2 10831.5 11005.7 11064.3 11306.5 11314.7 9998.5 10320.4 10418.7 10464.9 10467.9 11560.3 11620.4 11694.8 11969.8 12024.2 11489.0 11538.0 11586.8 11914.5 11975.8 11094.2 11171.3 11191.3 11523.0 11530.8 01:54:00 INFO - PROCESS | 1653 | 01:54:00 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:6794.82 Median:2406.59 stddev:4246.48 (176.5%) stddev-sans-first:4239.47 01:54:00 INFO - PROCESS | 1653 | Values: 1460.0 1502.5 1537.5 1543.8 1591.2 10546.2 10924.4 11130.0 11156.6 11225.2 10990.0 11162.2 11175.6 11187.8 11196.3 2386.7 2419.9 2420.8 2422.4 2427.7 2321.6 2391.2 2401.4 2401.9 2411.3 2059.4 2313.4 2355.2 2374.9 2387.1 2305.2 2352.1 2357.3 2362.3 2368.4 2369.1 2373.8 2393.4 2399.0 2401.1 10969.3 11220.6 11233.8 11235.8 11265.4 5620.5 5809.2 5810.6 5810.6 5811.0 3503.8 3578.2 3588.0 3591.2 3681.3 1174.9 1183.3 1209.0 1219.6 1231.2 13617.6 13956.7 14205.6 15559.9 15800.9 4561.8 4704.3 4730.5 4732.1 4745.1 9757.8 11814.8 11819.6 11842.9 11843.5 4796.2 4982.2 5345.6 5470.2 5542.1 5089.9 5222.9 5247.4 5305.9 5307.7 3894.3 3912.0 3979.8 3987.3 4052.3 1029.2 1039.7 1054.2 1058.4 1059.1 917.2 939.5 951.6 959.6 993.6 6639.2 6686.4 6802.6 6888.9 6897.8 779.8 966.6 987.5 1019.1 1032.5 4187.6 4487.7 4647.6 4793.0 4870.4 13584.9 13653.7 13828.6 14111.4 14174.9 13661.6 13941.4 14013.6 14048.6 14122.6 10114.9 10123.6 10269.5 10426.6 10428.5 6869.4 6890.4 6901.4 6939.9 7122.0 12185.4 12262.8 12601.6 12606.9 12740.0 12640.7 12691.2 12870.3 12875.2 12976.7 9264.0 9560.6 9579.4 9584.8 9586.6 10195.8 10405.4 10485.1 10504.8 10534.3 8748.0 8858.0 8932.2 8942.5 9065.3 8638.9 8658.9 8667.3 8717.3 8744.6 7810.0 8008.4 8009.0 8037.5 8038.6 5814.4 5860.8 5910.9 6028.3 6088.2 5867.8 6068.4 6099.6 6151.0 6152.1 01:54:00 INFO - PROCESS | 1653 | 01:54:00 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4590.80 Median:4882.05 stddev:1282.51 (26.3%) stddev-sans-first:1246.40 01:54:00 INFO - PROCESS | 1653 | Values: 371.8 381.6 382.7 388.4 393.6 3947.9 4361.8 5108.8 5256.9 5328.8 4556.6 4955.2 4968.0 5074.4 5105.3 3804.1 4392.5 4425.4 4439.4 4492.5 3908.6 4334.6 4335.1 4494.3 4530.8 4187.8 4235.6 4236.7 4286.7 4439.2 3644.9 3715.9 3793.9 4349.1 4388.5 3752.2 4183.7 4217.4 4246.5 4271.0 4769.9 4796.6 4937.9 4945.5 5064.7 4556.0 4825.4 5134.9 5159.4 5206.9 5462.2 5487.8 5494.2 5514.0 5564.1 4012.6 4415.0 4466.4 4743.9 4817.9 4766.4 5491.9 5723.0 5759.9 5767.0 4468.6 4635.5 4968.6 4968.7 4995.9 3634.9 3943.1 4525.7 4960.8 5040.8 4349.1 4733.9 4820.7 4865.2 4879.1 4517.3 4743.5 5429.4 5448.8 5462.6 1363.6 1474.9 1484.0 1546.9 1561.8 1130.6 1140.0 1147.7 1156.6 1162.4 4103.4 4196.4 4422.4 5016.6 5103.8 4806.9 5389.3 5659.4 5683.9 5817.8 4040.7 4399.7 4729.6 4811.9 4885.0 2649.3 2764.8 2776.5 2903.7 2945.3 4959.7 5447.6 5508.5 5821.5 5895.6 5325.4 5503.9 5878.4 5912.8 5921.0 5441.8 5672.1 5837.6 5916.5 5924.3 5021.5 5702.4 5731.0 5751.3 5783.5 4764.0 5667.9 5689.2 5699.7 5741.6 5443.4 5702.4 5869.3 5956.6 5995.4 4451.9 4462.7 4466.4 4466.8 4476.7 5117.8 5620.3 5717.9 5781.4 5791.0 5363.0 5469.7 5487.5 5510.3 5523.8 4592.6 4820.3 5423.9 5432.9 5498.4 4227.9 4866.5 5055.4 5414.1 5437.3 4921.3 4941.1 4969.5 5342.7 5478.4 4327.0 4693.8 4791.7 5323.0 5355.0 01:54:00 INFO - PROCESS | 1653 | 01:54:00 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:19707.00 Median:4202.43 stddev:28598.75 (680.5%) stddev-sans-first:28643.61 01:54:00 INFO - PROCESS | 1653 | Values: 763.4 765.5 791.2 807.3 815.9 14954.3 15712.8 15714.7 15731.4 15738.3 14250.5 14359.4 14375.0 14379.3 15034.8 929.4 934.4 941.9 947.6 959.2 949.5 952.3 953.1 953.3 953.8 997.7 998.0 998.2 999.9 1001.2 989.5 991.2 991.6 992.4 994.7 736.9 737.1 737.4 737.8 738.5 15578.6 15807.6 15820.3 16261.5 16438.8 14114.0 14183.5 14262.6 14341.2 14354.8 9996.9 11546.4 11761.2 11847.7 12360.4 3682.7 3687.9 3728.8 3776.1 3810.9 95264.5 114616.4 119199.0 120353.0 121044.0 10557.5 10602.7 10631.4 10751.1 10772.8 19537.9 19672.7 21343.7 21358.8 21411.5 7516.2 7517.8 7522.9 7555.6 7760.9 4202.4 4202.5 4281.9 4434.5 4460.8 3081.9 3127.2 3127.9 3151.4 3152.1 593.0 598.2 598.5 599.3 601.3 600.7 609.2 629.2 648.2 688.3 8165.6 8724.1 9708.6 9851.3 9874.1 644.4 680.3 680.4 685.8 695.2 4534.0 4789.4 4793.1 4795.0 4810.8 101880.0 105025.5 105169.0 105808.9 107918.0 45013.5 59464.0 75810.0 77612.6 80432.0 61393.7 68941.6 70353.0 76073.6 79543.6 10252.2 10280.7 10694.8 10934.3 11147.8 40543.8 48561.8 51834.0 52210.0 53344.2 52132.7 57156.4 64054.4 64855.0 66227.7 12392.0 12410.4 12514.0 12916.4 13199.9 14111.4 14325.1 14371.1 14697.7 14773.1 12398.8 12449.5 12526.8 12698.9 13101.3 13022.2 13830.9 14024.2 14124.2 14178.6 13013.2 13015.3 13232.3 13601.9 14041.9 8626.9 8825.6 8825.7 9166.1 9358.4 10483.5 11344.5 11424.5 11436.2 11645.6 01:54:00 INFO - PROCESS | 1653 | -------- Summary: end -------- 01:54:00 INFO - PROCESS | 1653 | 01:54:01 INFO - TEST-INFO | 1653: exit 0 01:54:01 INFO - TEST-OK | dromaeo_css | took 1121959ms 01:54:01 INFO - TEST-START | kraken 01:54:01 INFO - operating with platform_type : mac_ 01:54:01 INFO - Initialising browser for kraken test... 01:54:01 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpwnqIyb/profile http://localhost:49252/getInfo.html) 01:54:03 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 01:54:03 INFO - PROCESS | 1658 | colorDepth:24 01:54:03 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 01:54:03 INFO - PROCESS | 1658 | __metrics 01:54:03 INFO - PROCESS | 1658 | 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" 01:54:03 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:54:04 INFO - TEST-INFO | 1658: exit 0 01:54:04 INFO - Browser initialized. 01:54:04 INFO - Running cycle 1/1 for kraken test... 01:54:04 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpwnqIyb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:54:17 INFO - PROCESS | 1660 | RSS: Main: 215117824 01:54:17 INFO - PROCESS | 1660 | 01:54:19 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection) 01:54:20 INFO - PROCESS | 1660 | RSS: Main: 267898880 01:54:20 INFO - PROCESS | 1660 | 01:54:23 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-dft) 01:54:24 INFO - PROCESS | 1660 | RSS: Main: 279101440 01:54:24 INFO - PROCESS | 1660 | 01:54:27 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-fft) 01:54:27 INFO - PROCESS | 1660 | RSS: Main: 375119872 01:54:27 INFO - PROCESS | 1660 | 01:54:29 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator) 01:54:30 INFO - PROCESS | 1660 | RSS: Main: 277815296 01:54:30 INFO - PROCESS | 1660 | 01:54:32 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:54:33 INFO - PROCESS | 1660 | RSS: Main: 279187456 01:54:33 INFO - PROCESS | 1660 | 01:54:36 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom) 01:54:36 INFO - PROCESS | 1660 | RSS: Main: 319885312 01:54:36 INFO - PROCESS | 1660 | 01:54:39 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate) 01:54:40 INFO - PROCESS | 1660 | RSS: Main: 320233472 01:54:40 INFO - PROCESS | 1660 | 01:54:43 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial) 01:54:43 INFO - PROCESS | 1660 | RSS: Main: 317616128 01:54:43 INFO - PROCESS | 1660 | 01:54:45 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:54:46 INFO - PROCESS | 1660 | RSS: Main: 295071744 01:54:46 INFO - PROCESS | 1660 | 01:54:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:54:48 INFO - PROCESS | 1660 | RSS: Main: 297533440 01:54:48 INFO - PROCESS | 1660 | 01:54:50 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:54:51 INFO - PROCESS | 1660 | RSS: Main: 307982336 01:54:51 INFO - PROCESS | 1660 | 01:54:54 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:54:55 INFO - PROCESS | 1660 | RSS: Main: 321867776 01:54:55 INFO - PROCESS | 1660 | 01:54:58 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:54:58 INFO - PROCESS | 1660 | RSS: Main: 314552320 01:54:58 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49252/tests/kraken/driver.html?testName=ai-astar) 01:55:00 INFO - PROCESS | 1660 | RSS: Main: 359542784 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | __start_tp_report 01:55:00 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 01:55:00 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 01:55:00 INFO - PROCESS | 1660 | |i|pagename|runs| 01:55:00 INFO - PROCESS | 1660 | |0;ai-astar;115;115;115;114;114;113;114;114;114;113 01:55:00 INFO - PROCESS | 1660 | |1;audio-beat-detection;143;109;109;156;139;139;107;110;128;112 01:55:00 INFO - PROCESS | 1660 | |2;audio-dft;185;182;183;185;182;184;182;184;183;184 01:55:00 INFO - PROCESS | 1660 | |3;audio-fft;81;62;62;92;62;62;61;61;76;61 01:55:00 INFO - PROCESS | 1660 | |4;audio-oscillator;91;69;87;71;70;69;82;70;69;84 01:55:00 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;86;86;86;86;85;86;86;94;135;86 01:55:00 INFO - PROCESS | 1660 | |6;imaging-darkroom;93;93;93;96;94;93;92;96;93;93 01:55:00 INFO - PROCESS | 1660 | |7;imaging-desaturate;83;86;86;83;86;83;83;83;83;85 01:55:00 INFO - PROCESS | 1660 | |8;json-parse-financial;62;60;60;62;62;65;63;65;63;65 01:55:00 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;58;64;65;56;56;59;60;58;58;58 01:55:00 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;85;85;84;86;82;85;83;89;84;89 01:55:00 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;138;141;140;149;128;154;133;136;200;177 01:55:00 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;203;149;215;227;195;166;165;165;165;167 01:55:00 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;65;65;66;63;67;65;64;64;64;63 01:55:00 INFO - PROCESS | 1660 | __end_tp_report 01:55:00 INFO - PROCESS | 1660 | __start_cc_report 01:55:00 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,2218 01:55:00 INFO - PROCESS | 1660 | __end_cc_report 01:55:00 INFO - PROCESS | 1660 | __startTimestamp1490604900790__endTimestamp 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | ------- Summary: start ------- 01:55:00 INFO - PROCESS | 1660 | Number of tests: 14 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 01:55:00 INFO - PROCESS | 1660 | Values: 115.0 115.0 115.0 114.0 114.0 113.0 114.0 114.0 114.0 113.0 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:125.20 Median:133.50 stddev:18.00 (13.5%) stddev-sans-first:17.90 01:55:00 INFO - PROCESS | 1660 | Values: 143.0 109.0 109.0 156.0 139.0 139.0 107.0 110.0 128.0 112.0 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.17 (0.6%) stddev-sans-first:1.09 01:55:00 INFO - PROCESS | 1660 | Values: 185.0 182.0 183.0 185.0 182.0 184.0 182.0 184.0 183.0 184.0 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:68.00 Median:62.00 stddev:11.06 (17.8%) stddev-sans-first:10.68 01:55:00 INFO - PROCESS | 1660 | Values: 81.0 62.0 62.0 92.0 62.0 62.0 61.0 61.0 76.0 61.0 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:76.50 stddev:8.75 (11.4%) stddev-sans-first:7.47 01:55:00 INFO - PROCESS | 1660 | Values: 91.0 69.0 87.0 71.0 70.0 69.0 82.0 70.0 69.0 84.0 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:91.60 Median:86.00 stddev:15.46 (18.0%) stddev-sans-first:16.27 01:55:00 INFO - PROCESS | 1660 | Values: 86.0 86.0 86.0 86.0 85.0 86.0 86.0 94.0 135.0 86.0 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:93.00 stddev:1.35 (1.5%) stddev-sans-first:1.41 01:55:00 INFO - PROCESS | 1660 | Values: 93.0 93.0 93.0 96.0 94.0 93.0 92.0 96.0 93.0 93.0 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:1.45 (1.7%) stddev-sans-first:1.48 01:55:00 INFO - PROCESS | 1660 | Values: 83.0 86.0 86.0 83.0 86.0 83.0 83.0 83.0 83.0 85.0 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:1.89 (3.0%) stddev-sans-first:1.99 01:55:00 INFO - PROCESS | 1660 | Values: 62.0 60.0 60.0 62.0 62.0 65.0 63.0 65.0 63.0 65.0 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:58.50 stddev:3.05 (5.2%) stddev-sans-first:3.20 01:55:00 INFO - PROCESS | 1660 | Values: 58.0 64.0 65.0 56.0 56.0 59.0 60.0 58.0 58.0 58.0 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:2.30 (2.7%) stddev-sans-first:2.44 01:55:00 INFO - PROCESS | 1660 | Values: 85.0 85.0 84.0 86.0 82.0 85.0 83.0 89.0 84.0 89.0 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:145.00 stddev:22.46 (15.5%) stddev-sans-first:23.42 01:55:00 INFO - PROCESS | 1660 | Values: 138.0 141.0 140.0 149.0 128.0 154.0 133.0 136.0 200.0 177.0 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.70 Median:181.00 stddev:26.16 (14.5%) stddev-sans-first:26.59 01:55:00 INFO - PROCESS | 1660 | Values: 203.0 149.0 215.0 227.0 195.0 166.0 165.0 165.0 165.0 167.0 01:55:00 INFO - PROCESS | 1660 | 01:55:00 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.26 (1.9%) stddev-sans-first:1.33 01:55:00 INFO - PROCESS | 1660 | Values: 65.0 65.0 66.0 63.0 67.0 65.0 64.0 64.0 64.0 63.0 01:55:00 INFO - PROCESS | 1660 | -------- Summary: end -------- 01:55:00 INFO - PROCESS | 1660 | 01:55:01 INFO - TEST-INFO | 1660: exit 0 01:55:01 INFO - TEST-OK | kraken | took 60189ms 01:55:01 INFO - SUITE-END | took 1182s 01:55:01 INFO - Completed test suite (00:19:42) 01:55:01 INFO - javascript benchmark 01:55:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7642.636692330662, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3427.1260828488716, 3436.9484457733124, 3451.5167876497285, 3453.6703369202855, 3474.0967348489385, 6028.4041112261975, 6035.9698201509045, 6052.092186172076, 6059.545534084939, 6059.969700151504, 6021.277446706401, 6090.634561926277, 6098.207233059696, 6098.359672234407, 6130.724117414716, 5403.78384864606, 5439.809606663767, 5463.863403414926, 5478.780848766064, 5570.303712035996, 5348.197770334442, 5371.677699338033, 5394.163904594774, 5547.528460080878, 5567.137093750475, 5448.809291674792, 5479.561635069204, 5512.283403157584, 5531.640443371188, 5553.16702494625, 5508.063629183009, 5523.558115350762, 5526.917096243559, 5527.309086364185, 5544.556435485192, 5235.345581802275, 5325.840224793263, 5441.0, 5442.591805614556, 5490.313710786152, 5852.414758524156, 5866.061430171152, 5883.764649414061, 5885.44088311614, 5893.116032595102, 5565.747706765986, 6142.6350854921175, 6355.8411039723915, 6356.491480681534, 6364.236291644986, 6230.096635987757, 6308.085327627514, 6324.873502529969, 6327.936720632781, 6381.234251889757, 6132.8144489347815, 6227.221597300338, 6250.4374606285655, 6251.156093927352, 6256.249250089927, 6591.110200122922, 6617.2059352877, 6622.966885165543, 6633.369829866155, 6634.203895532567, 5706.828795136153, 5988.490978266809, 6194.318624951252, 6343.175387199634, 6363.9045414318825, 6351.301356850743, 6367.172267605181, 6408.967955160194, 6427.903581446282, 6455.225372955181, 6391.584547004522, 6393.840153996187, 6393.968030159819, 6394.136791533084, 6398.168238129014, 6301.52738544611, 6351.9682401588625, 6354.904676429857, 6362.204724409449, 6373.1714877066615, 5156.484351564814, 5199.844004679866, 5203.947960520422, 5207.843764687065, 5241.764120614582, 4474.351219073216, 4618.67669263155, 4624.953750462452, 4673.3690951721765, 4693.624510039189, 5940.524758019348, 5948.196993405922, 6043.214382130383, 6084.5436592255755, 6138.296437970319, 6453.903191452132, 6490.740370385226, 6491.51313651478, 6503.057056726842, 6518.934810651927, 6096.817095487054, 6104.908426373608, 6117.0, 6128.693565321716, 6142.232220972379, 5450.31871016123, 5567.47109024642, 5687.544996400278, 5701.173329867146, 5716.885662286814, 5511.421300763523, 6343.492520598434, 6390.808275751735, 6551.80344589663, 6690.330966903271, 6455.354464553695, 6478.3197764235965, 6481.092647029325, 6492.058651495412, 6505.41451269388, 6624.768133115318, 6625.304343043911, 6642.070110184674, 6656.7004484797335, 6664.200295964515, 6086.539230584716, 6279.71741271653, 6312.810615681353, 6420.036994450869, 6429.7749578764515, 6172.290186628596, 6378.1070650108095, 6438.517111216771, 6458.580192287486, 6462.063000864754, 6275.780347687809, 6307.684615769102, 6329.208848893888, 6335.90496142549, 6337.207849018872, 6210.72051757681, 6325.240971083499, 6344.0, 6349.047642853424, 6353.269374022047, 6168.19813424252, 6222.595531290452, 6227.065940108839, 6265.4361107500545, 6290.685465726604, 5128.025675121715, 5981.880362392815, 6228.190335256388, 6338.619682819046, 6339.683015849097, 6287.96856015717, 6288.874222515616, 6313.873722525432, 6314.242290925118, 6336.493080553452], "value": 5921.228064260954, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.192879227584, 810.4893916832394, 876.2551830943698, 891.5720454181989, 894.7718331825383, 32789.508157377655, 39450.013749656275, 39571.0, 39666.80166599167, 40872.38691419631, 32878.506822397685, 39860.80069599648, 39906.80046599763, 39946.20107597846, 40163.19673606526, 7168.534045287066, 7341.77974660761, 8879.822403551942, 9029.367944243906, 9042.638294468214, 10562.471876406149, 10852.945735271313, 10855.348679079241, 10858.619948301812, 10966.122710183166, 10806.945965270203, 10826.025657690807, 10826.404547749871, 10841.403722795283, 10844.945775271151, 7217.170025447088, 7391.519551229207, 10780.40707761073, 10789.676309710721, 10816.134709223243, 9173.587188576463, 10428.89571104287, 10757.193210509244, 10817.567297308098, 10826.18803589734, 38304.85085447441, 38483.65307214262, 38488.23023539514, 38533.61466385328, 38638.0, 3830.4254361845947, 3833.9041523961846, 3856.382978723391, 3864.6908247340425, 3932.2528719543197, 27185.320366990785, 27514.0, 27626.585601215997, 27675.72324276772, 28754.712452875414, 3074.2621770775077, 3135.357251763383, 3148.921276968094, 3153.8896138635037, 3181.0, 348514.5148548507, 350361.0, 354007.99999999744, 354742.0, 354832.0, 42836.57163428388, 43379.78310108429, 43874.0, 51224.23163652548, 52838.73580632072, 44786.55213447889, 54323.72838135784, 54396.45603543993, 54495.72752136293, 54653.0, 12508.437120329607, 14709.92645036768, 14720.484783032542, 14725.852741472663, 14751.483698070517, 12610.495580176874, 12637.810432843515, 12657.493700252071, 12659.11386202957, 12670.239785612892, 12507.124501284823, 12528.561500347445, 12540.122191446693, 12575.937120314522, 12659.556915507914, 5365.946340536622, 5406.648567843077, 5436.510714035756, 5462.6995515247045, 5465.9726701366235, 1096.1180800126665, 1100.9504572294106, 1110.4725255503572, 1116.4473585575192, 1134.6312448454285, 20818.79181208199, 25953.091641792445, 26100.34749131287, 26292.948282068886, 26401.0, 1109.5728144664201, 1206.5535751771902, 1218.3725381428394, 1257.503286201945, 1270.3330751355427, 10606.363618182933, 11739.0, 13193.20840749558, 13541.187528748307, 13741.656458588615, 449451.0, 450287.0, 450764.0, 451709.0, 451729.0, 54995.0, 55178.44821551813, 55194.72402638041, 55308.0, 55372.44627553673, 1378.3866179550205, 1438.2880474165147, 1439.5969128643997, 1440.5606290081626, 1444.1046551138152, 24952.87712052998, 25384.619230711924, 25694.218800770424, 25700.614490783028, 26694.46611067729, 45564.0, 45851.08297833958, 45891.62325130252, 45897.0, 45922.31116533188, 450226.0, 451416.0, 452131.0, 452532.0, 453015.0, 24478.388040299134, 24876.12933547317, 25555.233342999738, 27980.44039119247, 28774.0, 30986.845065774527, 36360.0, 38447.23105537929, 38508.614913850506, 38563.807180963915, 26629.0, 26860.59709104404, 27455.0, 27547.586786197822, 28276.15171544857, 22363.993620287452, 26792.866035669696, 26953.921843126056, 27640.0, 27674.5848812272, 26243.0, 31263.0, 31851.36297274088, 32394.83802580972, 32459.0, 26907.596386054618, 27214.0, 27893.302667433476, 27964.30089247785, 28436.86252549875, 18214.45356639303, 21068.894655526623, 21670.34988950334, 22529.549409012056, 22684.0], "value": 18042.467264310017, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.36266445337026, 433.6920786241768, 433.7334981852989, 441.11996566849143, 450.19415246708394, 16362.672746545062, 20361.0, 22039.779602203973, 22085.668714969288, 22289.2198773043, 21711.3486595402, 22007.0, 22465.87670616471, 22710.0, 22766.88616556915, 6610.768623098193, 6746.224184218816, 6798.52410331277, 6877.105976223084, 6883.036374907517, 3687.1703866629928, 4428.446444194476, 6759.357861003196, 6892.896606550906, 6893.448524118058, 7356.521826081314, 7687.192844751305, 7804.843903121934, 7807.180246074166, 7832.56920869352, 7633.6564854581675, 7698.384129269645, 7721.53670779755, 7798.649060792278, 7807.336376408012, 6874.621895795729, 7180.066591343144, 7352.338289553966, 7587.924120758777, 7611.581363025031, 25572.488550229078, 26182.607260890913, 26324.73675263242, 26351.34121646955, 26619.733802661918, 2728.890844366223, 2878.5394336905993, 2924.780641451878, 2932.4428358611794, 2932.4868148074215, 13746.381412836447, 15713.292901819446, 15745.527634170992, 15807.0, 16450.012999220085, 1983.8214560689462, 2021.050106449966, 2036.5010572409853, 2044.6932960055963, 2045.1308194017631, 150571.2471437647, 152439.0, 159616.0, 160376.0, 162775.18612406982, 14794.52328702754, 19589.706154407697, 19932.90033549823, 20472.897635511727, 20673.483162920747, 30143.09570712882, 31039.689603104132, 31077.844610777254, 31761.682383175874, 31876.681233187835, 9881.654142105135, 10181.33821301613, 10345.74135646615, 10380.169586433067, 10502.474876256156, 8634.827303453896, 8647.740567782977, 8663.480191188422, 8797.956010220036, 8808.20726134651, 9258.370814592703, 9283.791813764878, 9471.147596716328, 9479.905200947902, 9487.90512094884, 3846.538415390171, 3892.863749768801, 3930.1702774002674, 3936.287714844052, 3950.7827069510877, 948.4593781544592, 1022.8925962773801, 1035.7669524357111, 1040.2614143957874, 1042.3797840285017, 21491.355259342246, 21962.670559941613, 21972.89013554922, 21980.89009554942, 22013.0, 1047.9214058945608, 1061.5382308695741, 1075.2258373970728, 1079.1744315598573, 1079.2067830144838, 10452.32059916103, 11230.0, 11267.605633802941, 11280.830787538194, 11300.265482743594, 658790.0, 662833.0, 665022.0, 684188.0, 685612.0, 140239.0, 144454.27772861067, 144891.2755436216, 145761.25432474085, 145953.0, 1167.3404526442532, 1168.1589255735857, 1187.6971372300181, 1192.0, 1194.9581764638197, 17755.0, 18632.254709811456, 18663.0, 18719.0, 18737.812621874153, 34601.30797383988, 47467.0, 53960.73019634877, 56725.71637141788, 61564.38435615587, 79015.81476277976, 81933.59033204796, 82243.0, 82515.34969300701, 82560.0, 11179.60871369498, 11376.94311528437, 11510.82733759011, 11830.881691183322, 11846.644600661994, 12725.490980361052, 12880.613581592566, 12912.483500660244, 13344.132631378929, 13355.198688078746, 10831.458427078773, 11005.724856878642, 11064.28082174656, 11306.49120789583, 11314.660560183207, 9998.500074996367, 10320.43237621908, 10418.739531511774, 10464.947675261576, 10467.94766026165, 11560.30638161713, 11620.360880151335, 11694.824577631172, 11969.760604788029, 12024.158308918642, 11488.96599306033, 11538.0, 11586.768264634491, 11914.463849126636, 11975.820362694392, 11094.167937404565, 11171.273867198606, 11191.2725672831, 11522.96293333604, 11530.769384612093], "value": 11500.120982141529, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.9635009124775, 1502.519193857965, 1537.5387383784869, 1543.822460417051, 1591.2203020519944, 10546.156307495401, 10924.399158046304, 11129.998300152985, 11156.609518666848, 11225.158113141517, 10990.010899019107, 11162.218644694874, 11175.552977880896, 11187.769345372002, 11196.328220306787, 2386.7255265644458, 2419.9153029643967, 2420.818438617102, 2422.3580751100885, 2427.7329493755674, 2321.58211521926, 2391.222852572912, 2401.399650087478, 2401.8799060046927, 2411.3007227903886, 2059.4336557446672, 2313.3985163857433, 2355.1756885090253, 2374.857508549484, 2387.1167667962877, 2305.2392710405525, 2352.0591763294647, 2357.26924653358, 2362.338545207336, 2368.4315764216462, 2369.1234243330077, 2373.8457000294925, 2393.4495066134714, 2399.040383846458, 2401.087586717036, 10969.286996345292, 11220.607278745205, 11233.831492527619, 11235.83146252807, 11265.380404077772, 5620.494155526022, 5809.186713860063, 5810.564207684441, 5810.5932584719085, 5810.970945145247, 3503.8423270952867, 3578.177019285579, 3587.964120358789, 3591.1560783215923, 3681.3005528949416, 1174.9001334886545, 1183.2663748475914, 1208.993955030228, 1219.62191720566, 1231.1566576894857, 13617.591472255848, 13956.720865582733, 14205.644858878612, 15559.922200389039, 15800.92099539495, 4561.817527298937, 4704.294355846582, 4730.455997560256, 4732.053589282157, 4745.0509898019845, 9757.804843903083, 11814.763704725858, 11819.586314478953, 11842.94078529619, 11843.46704398304, 4796.232602783538, 4982.177940639826, 5345.572354211654, 5470.234167216593, 5542.085555883315, 5089.898202036013, 5222.947770522323, 5247.370315562157, 5305.946940530545, 5307.734613269321, 3894.2600905827803, 3912.0219945013746, 3979.8010099495486, 3987.282289187974, 4052.2705912935953, 1029.2023681646633, 1039.6725031615017, 1054.1935419404163, 1058.444316733721, 1059.0944742245424, 917.156216281023, 939.5396255834728, 951.6098399656108, 959.6209497248688, 993.5926270229171, 6639.203295604559, 6686.398224159849, 6802.625855577891, 6888.896666550006, 6897.827554311082, 779.8284377436955, 966.5843687214565, 987.511181964932, 1019.0522813783252, 1032.492560861136, 4187.6021777931655, 4487.708298960557, 4647.55848194421, 4793.0, 4870.4155501339355, 13584.932075339757, 13653.658658533615, 13828.585142445743, 14111.435542578387, 14174.929125354514, 13661.590152295446, 13941.372638231303, 14013.649658758613, 14048.648783780487, 14122.64693382653, 10114.949425252827, 10123.645672401577, 10269.537870795682, 10426.635067772744, 10428.530716117793, 6869.381755642016, 6890.414314783099, 6901.447884169354, 6939.861202775815, 7122.038524799086, 12185.390730463265, 12262.75474490523, 12601.621951341474, 12606.936965315115, 12739.98080153604, 12640.747185056063, 12691.175073620185, 12870.292133932724, 12875.227486350848, 12976.740465190833, 9263.953680231556, 9560.613711012003, 9579.377340472847, 9584.808303834025, 9586.616535338508, 10195.796084078425, 10405.375677459377, 10485.056344928993, 10504.789904202025, 10534.262601617813, 8748.0, 8857.955710221408, 8932.240759535513, 8942.46345219289, 9065.32010099232, 8638.91361086381, 8658.870116948377, 8667.263282621048, 8717.346199034972, 8744.606492707717, 7809.960950195213, 8008.439409241297, 8009.0, 8037.477563958324, 8038.557879316693, 5814.447627475383, 5860.765569377348, 5910.940890591039, 6028.306744724413, 6088.208532890696, 5867.823965280878, 6068.423499767515, 6099.634021958696, 6151.0, 6152.138700581832], "value": 5168.591881228652, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.79737043311394, 381.6107570278316, 382.69958082904924, 388.4445243302077, 393.60442755031187, 3947.913909104078, 4361.825526978917, 5108.7956481740775, 5256.86857828554, 5328.786848526064, 4556.589906908378, 4955.207166853304, 4967.950320496794, 5074.391073071228, 5105.285260063594, 3804.08701911542, 4392.450943632046, 4425.446819147606, 4439.424004478412, 4492.505824359318, 3908.612442582885, 4334.631556317717, 4335.0763665396635, 4494.325851122325, 4530.841420550281, 4187.790610469479, 4235.639970602502, 4236.66545038312, 4286.721363111404, 4439.247666446808, 3644.927101457956, 3715.90710232245, 3793.886183414502, 4349.086691794695, 4388.49532303786, 3752.249550089993, 4183.686223533247, 4217.40956266123, 4246.5116511600945, 4271.035323751078, 4769.928451073202, 4796.5683088521855, 4937.876553086166, 4945.530174633404, 5064.721440320781, 4556.015809644688, 4825.396825396825, 5134.948650513485, 5159.355080614923, 5206.895862082775, 5462.20797984294, 5487.835364939018, 5494.203340515643, 5513.959834861127, 5564.10974244123, 4012.612495565134, 4414.955850441486, 4466.3747075409465, 4743.881402964919, 4817.9036419271415, 4766.4261298898555, 5491.945080549183, 5722.971385143048, 5759.902486299655, 5766.971165144148, 4468.553144685506, 4635.513271106485, 4968.627352948543, 4968.652194346361, 4995.925061124086, 3634.945475817865, 3943.12701466801, 4525.705829121097, 4960.776765045582, 5040.7731652075745, 4349.108432771274, 4733.881652958704, 4820.662553621213, 4865.175559165313, 4879.1461494238365, 4517.312199241446, 4743.501932297128, 5429.375621803464, 5448.782048718086, 5462.644928079662, 1363.577291039781, 1474.9188794616184, 1483.9703205936037, 1546.9458568950033, 1561.8203906550664, 1130.598637483698, 1140.0252783869837, 1147.6843867936384, 1156.5778490850946, 1162.4013632979022, 4103.373840741928, 4196.419202190631, 4422.425084738963, 5016.592035822826, 5103.770330335144, 4806.855794326176, 5389.278414400781, 5659.35878595211, 5683.943160568424, 5817.767289308465, 4040.696947728932, 4399.670024748093, 4729.62163026957, 4811.927821082687, 4884.95115048852, 2649.3109493863744, 2764.797313168778, 2776.514110030777, 2903.6515618125536, 2945.3372991076835, 4959.7272150032095, 5447.618666693294, 5508.502101165788, 5821.505172060338, 5895.551102605024, 5325.37576039304, 5503.862403439866, 5878.412158784173, 5912.793052243151, 5920.970395147997, 5441.809536666118, 5672.107225315037, 5837.643355070766, 5916.49709774674, 5924.318703349084, 5021.472745361684, 5702.372738998624, 5731.0, 5751.309842818721, 5783.537317014713, 4764.046291299416, 5667.8866422672145, 5689.2319536862, 5699.715014249188, 5741.598088133791, 5443.428440013741, 5702.372738998624, 5869.325027621708, 5956.583039187215, 5995.372799456441, 4451.866444006685, 4462.709923854939, 4466.352378904976, 4466.843660471868, 4476.7090139140855, 5117.801374141161, 5620.325560932714, 5717.914231286617, 5781.4218578141845, 5790.986577348863, 5362.973185134049, 5469.671819690831, 5487.533559647474, 5510.291809538895, 5523.7790488380015, 4592.563706447882, 4820.275715377099, 5423.90837222795, 5432.9185062223305, 5498.367687715964, 4227.87316380509, 4866.537678920497, 5055.368078990126, 5414.079606466831, 5437.293151890229, 4921.3356196912955, 4941.058941058941, 4969.503049695001, 5342.679439233659, 5478.424765399735, 4327.0480494291205, 4693.812247510062, 4791.736454494897, 5323.0, 5355.0], "value": 4218.826407399086, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.4236151705461, 765.5445010218917, 791.2404092071611, 807.2613558593887, 815.9428839981202, 14954.252287385629, 15712.842871571282, 15714.685706285896, 15731.37074517018, 15738.291776870039, 14250.501232456865, 14359.35382907769, 14375.0, 14379.281035948214, 15034.774478382833, 929.3680297397767, 934.4019827310493, 941.9199368053723, 947.6114792934898, 959.2182371367348, 949.4682977532569, 952.2762700347716, 953.0897992417225, 953.323140570196, 953.7949340891707, 997.6957028106425, 997.9800403991916, 998.2213873178896, 999.9350042247268, 1001.1790331927785, 989.4557993103764, 991.1921783746224, 991.6083147156833, 992.3896803465889, 994.7165057958483, 736.9115706115247, 737.0933751485649, 737.4321772235348, 737.8044818123202, 738.4756822655921, 15578.610534736608, 15807.577318041316, 15820.288087036111, 16261.51215463538, 16438.75341869861, 14114.012019158663, 14183.503577374742, 14262.57212283633, 14341.21123338216, 14354.784678229835, 9996.90003099967, 11546.422678866023, 11761.235519691192, 11847.703807404798, 12360.38198090101, 3682.6869716074166, 3687.870924517656, 3728.7949162796035, 3776.1126135358168, 3810.942835857464, 95264.52367738116, 114616.42691786571, 119199.0, 120353.0, 121044.0, 10557.47212639365, 10602.681919542427, 10631.415272160106, 10751.139908807276, 10772.838407423895, 19537.902310488356, 19672.704909426084, 21343.67984480234, 21358.78641213568, 21411.464713381978, 7516.173220945691, 7517.849643007218, 7522.887156692654, 7555.584442855696, 7760.883586746203, 4202.3696445533415, 4202.495700515958, 4281.850135245251, 4434.512203657595, 4460.843870464518, 3081.8921337753072, 3127.218195451137, 3127.8748850045745, 3151.416987857254, 3152.1489197916435, 592.9851753706106, 598.2491972574392, 598.5241732822329, 599.3437186281016, 601.3445344574347, 600.6996501749126, 609.1989034419723, 629.235478893147, 648.2286079565303, 688.2979361051699, 8165.63254653542, 8724.11776759336, 9708.563114659857, 9851.261155413373, 9874.061964113398, 644.4135836388864, 680.3060877904609, 680.3706571421515, 685.8148299959083, 695.2181469762435, 4533.977330113395, 4789.449213340441, 4793.1372352976105, 4795.0, 4810.759462026885, 101879.96240075157, 105025.47487262514, 105169.0, 105808.94191058144, 107918.0, 45013.549864500936, 59464.0, 75810.0, 77612.61193694109, 80432.0, 61393.69303153545, 68941.62116757636, 70353.0, 76073.61963190149, 79543.60228198822, 10252.231082668979, 10280.663513743166, 10694.823569407514, 10934.289271197347, 11147.777044459228, 40543.79728101341, 48561.757191213816, 51834.0, 52209.95580088453, 53344.19983700325, 52132.69668258324, 57156.42843571511, 64054.35945640484, 64855.0, 66227.66886165731, 12392.0, 12410.379481026093, 12514.0, 12916.41876115596, 13199.934000329937, 14111.364988575744, 14325.140491570539, 14371.13773173613, 14697.70604587881, 14773.113613183243, 12398.81401778992, 12449.502019919464, 12526.812097818722, 12698.873011269769, 13101.27942963108, 13022.218666879638, 13830.930845345709, 14024.158550487004, 14124.152550846982, 14178.645533861736, 13013.21920684762, 13015.284159371326, 13232.338383081, 13601.863981360455, 14041.859581404055, 8626.870596940926, 8825.602847871989, 8825.735227943173, 9166.08339166078, 9358.391704539183, 10483.52824122901, 11344.546218151181, 11424.485898134437, 11436.19946603763, 11645.592404266148], "value": 7437.820497855256, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1439.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 109.0, 156.0, 139.0, 139.0, 107.0, 110.0, 128.0, 112.0], "value": 125.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 183.0, 185.0, 182.0, 184.0, 182.0, 184.0, 183.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 62.0, 62.0, 92.0, 62.0, 62.0, 61.0, 61.0, 76.0, 61.0], "value": 68.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 69.0, 87.0, 71.0, 70.0, 69.0, 82.0, 70.0, 69.0, 84.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 86.0, 85.0, 86.0, 86.0, 94.0, 135.0, 86.0], "value": 91.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 96.0, 94.0, 93.0, 92.0, 96.0, 93.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 86.0, 83.0, 86.0, 83.0, 83.0, 83.0, 83.0, 85.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 60.0, 62.0, 62.0, 65.0, 63.0, 65.0, 63.0, 65.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 64.0, 65.0, 56.0, 56.0, 59.0, 60.0, 58.0, 58.0, 58.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 86.0, 82.0, 85.0, 83.0, 89.0, 84.0, 89.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 141.0, 140.0, 149.0, 128.0, 154.0, 133.0, 136.0, 200.0, 177.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 149.0, 215.0, 227.0, 195.0, 166.0, 165.0, 165.0, 165.0, 167.0], "value": 181.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 63.0, 67.0, 65.0, 64.0, 64.0, 64.0, 63.0], "value": 64.6, "unit": "score"}]}]} 01:55:02 INFO - Return code: 0 01:55:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:55:02 ERROR - # TBPL SUCCESS # 01:55:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:55:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:55:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:55:02 INFO - 2017-03-27 01:55:02.131 screenresolution[1664:11341] starting screenresolution argv=screenresolution get 01:55:02 INFO - 2017-03-27 01:55:02.134 screenresolution[1664:11341] Display 0: 1600x1200x32@60 01:55:02 INFO - 2017-03-27 01:55:02.140 screenresolution[1665:11344] starting screenresolution argv=screenresolution list 01:55:02 INFO - Available Modes on Display 0 01:55:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:55:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:55:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:55:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:55:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:55:02 INFO - Intel Iris: 01:55:02 INFO - Chipset Model: Intel Iris 01:55:02 INFO - Type: GPU 01:55:02 INFO - Bus: Built-In 01:55:02 INFO - VRAM (Dynamic, Max): 1536 MB 01:55:02 INFO - Vendor: Intel (0x8086) 01:55:02 INFO - Device ID: 0x0a2e 01:55:02 INFO - Revision ID: 0x0009 01:55:02 INFO - Displays: 01:55:02 INFO - Display: 01:55:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:55:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:55:02 INFO - Display Serial Number: 1600x1200 60 01:55:02 INFO - Main Display: Yes 01:55:02 INFO - Mirror: Off 01:55:02 INFO - Online: Yes 01:55:02 INFO - Rotation: Supported 01:55:02 INFO - Return code: 0 01:55:02 INFO - Running post-action listener: _resource_record_post_action 01:55:02 INFO - [mozharness: 2017-03-27 08:55:02.376988Z] Finished run-tests step (success) 01:55:02 INFO - Running post-run listener: _resource_record_post_run 01:55:02 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 33303552; Write bytes: 509750784; Read time: 439; Write time: 1690 01:55:02 INFO - TinderboxPrint: CPU usage
53.7% 01:55:02 INFO - TinderboxPrint: I/O read bytes / time
33,303,552 / 439 01:55:02 INFO - TinderboxPrint: I/O write bytes / time
509,750,784 / 1,690 01:55:02 INFO - TinderboxPrint: CPU idle
2,227.0 (46.3%) 01:55:02 INFO - TinderboxPrint: CPU system
955.1 (19.8%) 01:55:02 INFO - TinderboxPrint: CPU user
1,631.6 (33.9%) 01:55:02 INFO - TinderboxPrint: Swap in / out
236,982,272 / 0 01:55:02 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207833600; Write bytes: 202385408; Read time: 15826; Write time: 416 01:55:02 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 28945408; Write bytes: 297240064; Read time: 407; Write time: 1244 01:55:02 INFO - Running post-run listener: _upload_blobber_files 01:55:02 INFO - Blob upload gear active. 01:55:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:55:02 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 01:55:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:55:03 INFO - (blobuploader) - INFO - Open directory for files ... 01:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:55:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:04 INFO - (blobuploader) - INFO - Done attempting. 01:55:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:55:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:55:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:05 INFO - (blobuploader) - INFO - Done attempting. 01:55:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:55:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:55:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:06 INFO - (blobuploader) - INFO - Done attempting. 01:55:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:55:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:08 INFO - (blobuploader) - INFO - Done attempting. 01:55:08 INFO - (blobuploader) - INFO - Iteration through files over. 01:55:08 INFO - Return code: 0 01:55:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:55:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:55:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6eda8e3f5afb94fe468e1c9a2325d92dbabee212b745efcac1133ba87df71992be81b1958187ff5fbf9c27328d9a14bcdfc6fba960904bae425da1a5debf4757", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca46da0ade0cc8d6aa2fb3834dfdc726b072f826cbe76f134bf7961041697c4debfcd297539235fc65d2fd6aece0561c30062e8b08a7cfbb20199d79d94ca6b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e34e84e710d6ca9cd38f2721dfa50787a71bb0be4fe0c36e0c125bc0bb1055cff35abdf614fe13303ce94cfc8f3cbc1080eddfcb6318283c0345d64c419ffb22", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4d85997e6d01a2afbd5943110f844cc7a99984138ab33db7285249d62b76e411164cddc668909b7c0271ac4a4776460c404c0ee82ff64091509dfe3a66ab6d3"} 01:55:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:55:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:55:08 INFO - Contents: 01:55:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6eda8e3f5afb94fe468e1c9a2325d92dbabee212b745efcac1133ba87df71992be81b1958187ff5fbf9c27328d9a14bcdfc6fba960904bae425da1a5debf4757", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca46da0ade0cc8d6aa2fb3834dfdc726b072f826cbe76f134bf7961041697c4debfcd297539235fc65d2fd6aece0561c30062e8b08a7cfbb20199d79d94ca6b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e34e84e710d6ca9cd38f2721dfa50787a71bb0be4fe0c36e0c125bc0bb1055cff35abdf614fe13303ce94cfc8f3cbc1080eddfcb6318283c0345d64c419ffb22", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4d85997e6d01a2afbd5943110f844cc7a99984138ab33db7285249d62b76e411164cddc668909b7c0271ac4a4776460c404c0ee82ff64091509dfe3a66ab6d3"} 01:55:08 INFO - Running post-run listener: copy_logs_to_upload_dir 01:55:08 INFO - Copying logs to upload dir... 01:55:08 INFO - mkdir: /builds/slave/test/build/upload/logs 01:55:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.021932 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-27 01:55:08.498615) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 01:55:08.501726) ========= 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.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6eda8e3f5afb94fe468e1c9a2325d92dbabee212b745efcac1133ba87df71992be81b1958187ff5fbf9c27328d9a14bcdfc6fba960904bae425da1a5debf4757", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca46da0ade0cc8d6aa2fb3834dfdc726b072f826cbe76f134bf7961041697c4debfcd297539235fc65d2fd6aece0561c30062e8b08a7cfbb20199d79d94ca6b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e34e84e710d6ca9cd38f2721dfa50787a71bb0be4fe0c36e0c125bc0bb1055cff35abdf614fe13303ce94cfc8f3cbc1080eddfcb6318283c0345d64c419ffb22", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4d85997e6d01a2afbd5943110f844cc7a99984138ab33db7285249d62b76e411164cddc668909b7c0271ac4a4776460c404c0ee82ff64091509dfe3a66ab6d3"} build_url:https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011120 build_url: 'https://queue.taskcluster.net/v1/task/ehaYEvQjRcC5PKQ_dWv5rQ/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6eda8e3f5afb94fe468e1c9a2325d92dbabee212b745efcac1133ba87df71992be81b1958187ff5fbf9c27328d9a14bcdfc6fba960904bae425da1a5debf4757", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ca46da0ade0cc8d6aa2fb3834dfdc726b072f826cbe76f134bf7961041697c4debfcd297539235fc65d2fd6aece0561c30062e8b08a7cfbb20199d79d94ca6b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e34e84e710d6ca9cd38f2721dfa50787a71bb0be4fe0c36e0c125bc0bb1055cff35abdf614fe13303ce94cfc8f3cbc1080eddfcb6318283c0345d64c419ffb22", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b4d85997e6d01a2afbd5943110f844cc7a99984138ab33db7285249d62b76e411164cddc668909b7c0271ac4a4776460c404c0ee82ff64091509dfe3a66ab6d3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 01:55:08.535785) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 01:55:08.536114) ========= 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.jhMjL95CUQ/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.VVhGCqf6SQ/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.005134 ========= master_lag: 0.34 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 01:55:08.881467) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 01:55:08.881857) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 01:55:08.882255) ========= ========= Total master_lag: 0.48 =========