builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0037 starttime: 1493072825.25 results: success (0) buildid: 20170424135726 builduid: b2d61d8d46da46a8abd04e49e4d89fd9 revision: 953ebf1c32152dca8b633aa8d5a3fe3e684a56c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 15:27:05.254501) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 15:27:05.254965) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 15:27:05.255256) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 15:27:05.282691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 15:27:05.283077) ========= 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.oHEkEdSgR7/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.ahA65XnC7Q/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-04-24 15:27:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 125M=0s 2017-04-24 15:27:05 (125 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115913 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 15:27:05.424298) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 15:27:05.424615) ========= 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.oHEkEdSgR7/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.ahA65XnC7Q/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.028099 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 15:27:05.475345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-24 15:27:05.475699) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 953ebf1c32152dca8b633aa8d5a3fe3e684a56c5 --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-beta --rev 953ebf1c32152dca8b633aa8d5a3fe3e684a56c5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oHEkEdSgR7/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.ahA65XnC7Q/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-04-24 15:27:05,578 truncating revision to first 12 chars 2017-04-24 15:27:05,578 Setting DEBUG logging. 2017-04-24 15:27:05,578 attempt 1/10 2017-04-24 15:27:05,578 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/953ebf1c3215?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-24 15:27:06,789 unpacking tar archive at: mozilla-beta-953ebf1c3215/testing/mozharness/ program finished with exit code 0 elapsedTime=1.480482 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-24 15:27:06.980646) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 15:27:06.980970) ========= script_repo_revision: 953ebf1c32152dca8b633aa8d5a3fe3e684a56c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 15:27:06.981368) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 15:27:06.981634) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 15:27:07.002749) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-04-24 15:27:07.003146) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oHEkEdSgR7/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.ahA65XnC7Q/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 15:27:07 INFO - MultiFileLogger online at 20170424 15:27:07 in /builds/slave/test 15:27:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:27:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:27:07 INFO - {'append_to_log': False, 15:27:07 INFO - 'base_work_dir': '/builds/slave/test', 15:27:07 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:27:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:27:07 INFO - 'branch': 'Mozilla-Beta', 15:27:07 INFO - 'buildbot_json_path': 'buildprops.json', 15:27:07 INFO - 'config_files': ('talos/mac_config.py',), 15:27:07 INFO - 'default_actions': ('clobber', 15:27:07 INFO - 'read-buildbot-config', 15:27:07 INFO - 'download-and-extract', 15:27:07 INFO - 'populate-webroot', 15:27:07 INFO - 'create-virtualenv', 15:27:07 INFO - 'install', 15:27:07 INFO - 'run-tests'), 15:27:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:27:07 INFO - 'download_minidump_stackwalk': True, 15:27:07 INFO - 'download_symbols': 'ondemand', 15:27:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:27:07 INFO - 'tooltool.py': '/tools/tooltool.py', 15:27:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:27:07 INFO - '/tools/misc-python/virtualenv.py')}, 15:27:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:27:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:27:07 INFO - 'gecko_profile': False, 15:27:07 INFO - 'gecko_profile_interval': 0, 15:27:07 INFO - 'installer_path': 'installer.exe', 15:27:07 INFO - 'log_level': 'info', 15:27:07 INFO - 'log_name': 'talos', 15:27:07 INFO - 'log_to_console': True, 15:27:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:27:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:27:07 INFO - 'opt_config_files': (), 15:27:07 INFO - 'pip_index': False, 15:27:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:27:07 INFO - 'cmd': ('bash', 15:27:07 INFO - '-c', 15:27:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:27:07 INFO - 'enabled': True, 15:27:07 INFO - 'halt_on_failure': False, 15:27:07 INFO - 'name': 'check_screen_resolution'},), 15:27:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:27:07 INFO - 'cmd': ('bash', 15:27:07 INFO - '-c', 15:27:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:27:07 INFO - 'enabled': True, 15:27:07 INFO - 'halt_on_failure': False, 15:27:07 INFO - 'name': 'check_screen_resolution'},), 15:27:07 INFO - 'run_cmd_checks_enabled': True, 15:27:07 INFO - 'suite': 'dromaeojs-e10s', 15:27:07 INFO - 'system_bits': '32', 15:27:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:27:07 INFO - 'title': 't-yosemite-r7-0037', 15:27:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:27:07 INFO - 'use_talos_json': True, 15:27:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:27:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:27:07 INFO - 'work_dir': 'build'} 15:27:07 INFO - [mozharness: 2017-04-24 22:27:07.220990Z] Running clobber step. 15:27:07 INFO - Running pre-action listener: _resource_record_pre_action 15:27:07 INFO - Running main action method: clobber 15:27:07 INFO - rmtree: /builds/slave/test/build 15:27:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:27:09 INFO - Running post-action listener: _resource_record_post_action 15:27:09 INFO - [mozharness: 2017-04-24 22:27:09.883066Z] Finished clobber step (success) 15:27:09 INFO - [mozharness: 2017-04-24 22:27:09.883324Z] Running read-buildbot-config step. 15:27:09 INFO - Running pre-action listener: _resource_record_pre_action 15:27:09 INFO - Running main action method: read_buildbot_config 15:27:09 INFO - Using buildbot properties: 15:27:09 INFO - { 15:27:09 INFO - "project": "", 15:27:09 INFO - "product": "firefox", 15:27:09 INFO - "script_repo_revision": "production", 15:27:09 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 15:27:09 INFO - "repository": "", 15:27:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 15:27:09 INFO - "buildid": "20170424135726", 15:27:09 INFO - "pgo_build": "False", 15:27:09 INFO - "basedir": "/builds/slave/test", 15:27:09 INFO - "buildnumber": 4, 15:27:09 INFO - "slavename": "t-yosemite-r7-0037", 15:27:09 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:27:09 INFO - "platform": "yosemite_r7", 15:27:09 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:27:09 INFO - "branch": "mozilla-beta", 15:27:09 INFO - "repo_path": "releases/mozilla-beta", 15:27:09 INFO - "revision": "953ebf1c32152dca8b633aa8d5a3fe3e684a56c5", 15:27:09 INFO - "stage_platform": "macosx64", 15:27:09 INFO - "builduid": "b2d61d8d46da46a8abd04e49e4d89fd9", 15:27:09 INFO - "slavebuilddir": "test" 15:27:09 INFO - } 15:27:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 15:27:09 INFO - Running post-action listener: _resource_record_post_action 15:27:09 INFO - [mozharness: 2017-04-24 22:27:09.888854Z] Finished read-buildbot-config step (success) 15:27:09 INFO - [mozharness: 2017-04-24 22:27:09.889069Z] Running download-and-extract step. 15:27:09 INFO - Running pre-action listener: _resource_record_pre_action 15:27:09 INFO - Running main action method: download_and_extract 15:27:09 INFO - mkdir: /builds/slave/test/build/tests 15:27:09 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')]} 15:27:09 INFO - trying https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 15:27:09 INFO - Downloading https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 15:27:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 15:27:10 INFO - Downloaded 1165 bytes. 15:27:10 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 15:27:10 INFO - Using the following test package requirements: 15:27:10 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 15:27:10 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:27:10 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 15:27:10 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:27:10 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 15:27:10 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:27:10 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:27:10 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 15:27:10 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 15:27:10 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:27:10 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 15:27:10 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:27:10 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 15:27:10 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:27:10 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 15:27:10 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:27:10 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 15:27:10 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 15:27:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 15:27:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 15:27:10 INFO - Fetch https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 15:27:12 INFO - Expected file size: 51221188 15:27:12 INFO - Obtained file size: 51221188 15:27:28 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:27:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 15:27:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 15:27:28 INFO - Fetch https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 15:27:30 INFO - Expected file size: 51221188 15:27:30 INFO - Obtained file size: 51221188 15:27:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 15:27:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 15:27:45 INFO - Fetch https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 15:27:46 INFO - Expected file size: 14404449 15:27:46 INFO - Obtained file size: 14404449 15:27: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')]} 15:27:46 INFO - trying https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 15:27:46 INFO - Downloading https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 15:27:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 15:27:48 INFO - Downloaded 59532221 bytes. 15:27:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 15:27:48 INFO - mkdir: /builds/slave/test/properties 15:27:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:27:48 INFO - Writing to file /builds/slave/test/properties/build_url 15:27:48 INFO - Contents: 15:27:48 INFO - build_url:https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 15:27:49 INFO - Running post-action listener: _resource_record_post_action 15:27:49 INFO - Running post-action listener: set_extra_try_arguments 15:27:49 INFO - [mozharness: 2017-04-24 22:27:49.043382Z] Finished download-and-extract step (success) 15:27:49 INFO - [mozharness: 2017-04-24 22:27:49.043487Z] Running populate-webroot step. 15:27:49 INFO - Running pre-action listener: _resource_record_pre_action 15:27:49 INFO - Running main action method: populate_webroot 15:27:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:27:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:27:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:27:49 INFO - '--tppagecycles', 15:27:49 INFO - '7'], 15:27:49 INFO - 'tests': ['tsvgm']}}, 15:27:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:27:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:27:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:27:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:27:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:27:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:27:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:27:49 INFO - 'talos_options': ['--disable-e10s'], 15:27:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:27:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:27:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:27:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:27:49 INFO - 'talos_options': ['--disable-e10s'], 15:27:49 INFO - 'tests': ['damp', 'tps']}, 15:27:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:27:49 INFO - 'tests': ['damp', 'tps']}, 15:27:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:27:49 INFO - 'tests': ['dromaeo_dom']}, 15:27:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:27:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:27:49 INFO - 'tests': ['basic_compositor_video']}, 15:27:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:27:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:27:49 INFO - 'tests': ['a11yr', 15:27:49 INFO - 'ts_paint', 15:27:49 INFO - 'tpaint', 15:27:49 INFO - 'sessionrestore', 15:27:49 INFO - 'sessionrestore_no_auto_restore', 15:27:49 INFO - 'tabpaint']}, 15:27:49 INFO - 'other-e10s': {'tests': ['a11yr', 15:27:49 INFO - 'ts_paint', 15:27:49 INFO - 'tpaint', 15:27:49 INFO - 'sessionrestore', 15:27:49 INFO - 'sessionrestore_no_auto_restore', 15:27:49 INFO - 'tabpaint']}, 15:27:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:27:49 INFO - 'ts_paint', 15:27:49 INFO - 'tpaint', 15:27:49 INFO - 'sessionrestore', 15:27:49 INFO - 'sessionrestore_no_auto_restore', 15:27:49 INFO - 'tabpaint']}, 15:27:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:27:49 INFO - 'ts_paint', 15:27:49 INFO - 'tpaint', 15:27:49 INFO - 'sessionrestore', 15:27:49 INFO - 'sessionrestore_no_auto_restore', 15:27:49 INFO - 'tabpaint']}, 15:27:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:27:49 INFO - 'tests': ['a11yr', 15:27:49 INFO - 'ts_paint', 15:27:49 INFO - 'tpaint', 15:27:49 INFO - 'sessionrestore', 15:27:49 INFO - 'sessionrestore_no_auto_restore', 15:27:49 INFO - 'tabpaint']}, 15:27:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:27:49 INFO - 'tests': ['a11yr', 15:27:49 INFO - 'ts_paint', 15:27:49 INFO - 'tpaint', 15:27:49 INFO - 'sessionrestore', 15:27:49 INFO - 'sessionrestore_no_auto_restore', 15:27:49 INFO - 'tabpaint']}, 15:27:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:27:49 INFO - 'tests': ['tsvgx', 15:27:49 INFO - 'tsvgr_opacity', 15:27:49 INFO - 'tart', 15:27:49 INFO - 'tscrollx', 15:27:49 INFO - 'cart', 15:27:49 INFO - 'tsvg_static']}, 15:27:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:27:49 INFO - 'tsvgr_opacity', 15:27:49 INFO - 'tart', 15:27:49 INFO - 'tscrollx', 15:27:49 INFO - 'cart', 15:27:49 INFO - 'tsvg_static']}, 15:27:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:27:49 INFO - 'talos_options': ['--disable-e10s'], 15:27:49 INFO - 'tests': ['tp5o']}, 15:27:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:27:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:27:49 INFO - 'talos_options': ['--disable-e10s', 15:27:49 INFO - '--xperf_path', 15:27:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:27:49 INFO - 'tests': ['tp5n']}, 15:27:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:27:49 INFO - 'talos_options': ['--xperf_path', 15:27:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:27:49 INFO - 'tests': ['tp5n']}}, 15:27:49 INFO - 'talos.zip': {'path': '', 15:27:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:27:49 INFO - Running post-action listener: _resource_record_post_action 15:27:49 INFO - [mozharness: 2017-04-24 22:27:49.062302Z] Finished populate-webroot step (success) 15:27:49 INFO - [mozharness: 2017-04-24 22:27:49.062406Z] Running create-virtualenv step. 15:27:49 INFO - Running pre-action listener: _resource_record_pre_action 15:27:49 INFO - Running main action method: create_virtualenv 15:27:49 INFO - Creating virtualenv /builds/slave/test/build/venv 15:27:49 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 15:27:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:27:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:27:49 INFO - Using real prefix '/tools/python27' 15:27:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:27:49 INFO - Installing distribute.............................................................................................................................................................................................done. 15:27:52 INFO - Installing pip.................done. 15:27:52 INFO - Return code: 0 15:27:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:27:53 INFO - Reading from file tmpfile_stdout 15:27:53 INFO - Output received: 15:27:53 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) 15:27:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:27:53 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')]} 15:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:53 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')]} 15:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:53 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 0x10605ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f950b4e4060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e38d30>, '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 0x105d5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e2dbe8>, '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.oHEkEdSgR7/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.ahA65XnC7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 15:27:53 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 15:27:53 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 15:27:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHEkEdSgR7/Render', 15:27:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:53 INFO - 'HOME': '/Users/cltbld', 15:27:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:53 INFO - 'LOGNAME': 'cltbld', 15:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:53 INFO - 'MOZ_NO_REMOTE': '1', 15:27:53 INFO - 'NO_EM_RESTART': '1', 15:27:53 INFO - 'PAGER': '/bin/cat', 15:27:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:53 INFO - 'PWD': '/builds/slave/test', 15:27:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:53 INFO - 'SHELL': '/bin/bash', 15:27:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ahA65XnC7Q/Listeners', 15:27:53 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 15:27:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:53 INFO - 'USER': 'cltbld', 15:27:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:53 INFO - 'XPC_FLAGS': '0x0', 15:27:53 INFO - 'XPC_SERVICE_NAME': '0', 15:27:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:53 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 15:27:53 INFO - Cleaning up... 15:27:53 INFO - Return code: 0 15:27:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:27:53 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')]} 15:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:53 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')]} 15:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:53 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 0x10605ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f950b4e4060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e38d30>, '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 0x105d5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e2dbe8>, '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.oHEkEdSgR7/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.ahA65XnC7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 15:27:53 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 15:27:53 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 15:27:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHEkEdSgR7/Render', 15:27:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:53 INFO - 'HOME': '/Users/cltbld', 15:27:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:53 INFO - 'LOGNAME': 'cltbld', 15:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:53 INFO - 'MOZ_NO_REMOTE': '1', 15:27:53 INFO - 'NO_EM_RESTART': '1', 15:27:53 INFO - 'PAGER': '/bin/cat', 15:27:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:53 INFO - 'PWD': '/builds/slave/test', 15:27:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:53 INFO - 'SHELL': '/bin/bash', 15:27:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ahA65XnC7Q/Listeners', 15:27:53 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 15:27:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:53 INFO - 'USER': 'cltbld', 15:27:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:53 INFO - 'XPC_FLAGS': '0x0', 15:27:53 INFO - 'XPC_SERVICE_NAME': '0', 15:27:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:53 INFO - Downloading/unpacking psutil>=3.1.1 15:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:27:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:27:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:27:57 INFO - Installing collected packages: psutil 15:27:57 INFO - Running setup.py install for psutil 15:27:57 INFO - building 'psutil._psutil_osx' extension 15:27:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:27:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:27:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:27:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:27:58 INFO - building 'psutil._psutil_posix' extension 15:27:58 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 15:27:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:27:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:27:58 INFO - ^ 15:27:58 INFO - 1 warning generated. 15:27:58 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 15:27:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:27:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:27:58 INFO - Successfully installed psutil 15:27:58 INFO - Cleaning up... 15:27:58 INFO - Return code: 0 15:27:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10605ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f950b4e4060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e38d30>, '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 0x105d5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e2dbe8>, '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.oHEkEdSgR7/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.ahA65XnC7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 15:27:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:27:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHEkEdSgR7/Render', 15:27:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:58 INFO - 'HOME': '/Users/cltbld', 15:27:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:58 INFO - 'LOGNAME': 'cltbld', 15:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:58 INFO - 'MOZ_NO_REMOTE': '1', 15:27:58 INFO - 'NO_EM_RESTART': '1', 15:27:58 INFO - 'PAGER': '/bin/cat', 15:27:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:58 INFO - 'PWD': '/builds/slave/test', 15:27:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:58 INFO - 'SHELL': '/bin/bash', 15:27:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ahA65XnC7Q/Listeners', 15:27:58 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 15:27:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:58 INFO - 'USER': 'cltbld', 15:27:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:58 INFO - 'XPC_FLAGS': '0x0', 15:27:58 INFO - 'XPC_SERVICE_NAME': '0', 15:27:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:28:01 INFO - Installing collected packages: mozsystemmonitor 15:28:01 INFO - Running setup.py install for mozsystemmonitor 15:28:01 INFO - Successfully installed mozsystemmonitor 15:28:01 INFO - Cleaning up... 15:28:01 INFO - Return code: 0 15:28:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:02 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')]} 15:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:02 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 0x10605ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f950b4e4060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e38d30>, '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 0x105d5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e2dbe8>, '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.oHEkEdSgR7/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.ahA65XnC7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 15:28:02 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 15:28:02 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 15:28:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHEkEdSgR7/Render', 15:28:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:02 INFO - 'HOME': '/Users/cltbld', 15:28:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:02 INFO - 'LOGNAME': 'cltbld', 15:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:02 INFO - 'MOZ_NO_REMOTE': '1', 15:28:02 INFO - 'NO_EM_RESTART': '1', 15:28:02 INFO - 'PAGER': '/bin/cat', 15:28:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:02 INFO - 'PWD': '/builds/slave/test', 15:28:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:02 INFO - 'SHELL': '/bin/bash', 15:28:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ahA65XnC7Q/Listeners', 15:28:02 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 15:28:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:02 INFO - 'USER': 'cltbld', 15:28:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:02 INFO - 'XPC_FLAGS': '0x0', 15:28:02 INFO - 'XPC_SERVICE_NAME': '0', 15:28:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:02 INFO - Downloading/unpacking jsonschema==2.5.1 15:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:28:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:06 INFO - Downloading functools32-3.2.3-2.tar.gz 15:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:28:06 INFO - warning: no files found matching '*.txt' 15:28:06 INFO - no previously-included directories found matching 'build' 15:28:06 INFO - no previously-included directories found matching 'dist' 15:28:06 INFO - no previously-included directories found matching '.git*' 15:28:06 INFO - Installing collected packages: jsonschema, functools32 15:28:06 INFO - Running setup.py install for functools32 15:28:06 INFO - warning: no files found matching '*.txt' 15:28:06 INFO - no previously-included directories found matching 'build' 15:28:06 INFO - no previously-included directories found matching 'dist' 15:28:06 INFO - no previously-included directories found matching '.git*' 15:28:06 INFO - Successfully installed jsonschema functools32 15:28:06 INFO - Cleaning up... 15:28:06 INFO - Return code: 0 15:28:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10605ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f950b4e4060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e38d30>, '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 0x105d5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e2dbe8>, '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.oHEkEdSgR7/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.ahA65XnC7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 15:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:28:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHEkEdSgR7/Render', 15:28:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:06 INFO - 'HOME': '/Users/cltbld', 15:28:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:06 INFO - 'LOGNAME': 'cltbld', 15:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:06 INFO - 'MOZ_NO_REMOTE': '1', 15:28:06 INFO - 'NO_EM_RESTART': '1', 15:28:06 INFO - 'PAGER': '/bin/cat', 15:28:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:06 INFO - 'PWD': '/builds/slave/test', 15:28:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:06 INFO - 'SHELL': '/bin/bash', 15:28:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ahA65XnC7Q/Listeners', 15:28:06 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 15:28:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:06 INFO - 'USER': 'cltbld', 15:28:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:06 INFO - 'XPC_FLAGS': '0x0', 15:28:06 INFO - 'XPC_SERVICE_NAME': '0', 15:28:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:28:06 INFO - Cleaning up... 15:28:06 INFO - Return code: 0 15:28:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10605ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f950b4e4060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e38d30>, '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 0x105d5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e2dbe8>, '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.oHEkEdSgR7/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.ahA65XnC7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 15:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:28:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHEkEdSgR7/Render', 15:28:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:06 INFO - 'HOME': '/Users/cltbld', 15:28:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:06 INFO - 'LOGNAME': 'cltbld', 15:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:06 INFO - 'MOZ_NO_REMOTE': '1', 15:28:06 INFO - 'NO_EM_RESTART': '1', 15:28:06 INFO - 'PAGER': '/bin/cat', 15:28:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:06 INFO - 'PWD': '/builds/slave/test', 15:28:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:06 INFO - 'SHELL': '/bin/bash', 15:28:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ahA65XnC7Q/Listeners', 15:28:06 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 15:28:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:06 INFO - 'USER': 'cltbld', 15:28:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:06 INFO - 'XPC_FLAGS': '0x0', 15:28:06 INFO - 'XPC_SERVICE_NAME': '0', 15:28:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:07 INFO - Downloading/unpacking blobuploader==1.2.4 15:28:07 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 15:28:07 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 15:28:07 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 15:28:07 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 15:28:07 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 15:28:07 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 15:28:09 INFO - Downloading blobuploader-1.2.4.tar.gz 15:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:28:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:28:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:28:10 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 15:28:10 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 15:28:10 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 15:28:10 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 15:28:10 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 15:28:10 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 15:28:11 INFO - Downloading docopt-0.6.1.tar.gz 15:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:28:11 INFO - Installing collected packages: blobuploader, requests, docopt 15:28:11 INFO - Running setup.py install for blobuploader 15:28:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:28:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:28:11 INFO - Running setup.py install for requests 15:28:11 INFO - Running setup.py install for docopt 15:28:12 INFO - Successfully installed blobuploader requests docopt 15:28:12 INFO - Cleaning up... 15:28:12 INFO - Return code: 0 15:28:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:12 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 0x10605ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f950b4e4060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e38d30>, '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 0x105d5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e2dbe8>, '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.oHEkEdSgR7/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.ahA65XnC7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 15:28:12 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 15:28:12 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 15:28:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHEkEdSgR7/Render', 15:28:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:12 INFO - 'HOME': '/Users/cltbld', 15:28:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:12 INFO - 'LOGNAME': 'cltbld', 15:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:12 INFO - 'MOZ_NO_REMOTE': '1', 15:28:12 INFO - 'NO_EM_RESTART': '1', 15:28:12 INFO - 'PAGER': '/bin/cat', 15:28:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:12 INFO - 'PWD': '/builds/slave/test', 15:28:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:12 INFO - 'SHELL': '/bin/bash', 15:28:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ahA65XnC7Q/Listeners', 15:28:12 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 15:28:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:12 INFO - 'USER': 'cltbld', 15:28:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:12 INFO - 'XPC_FLAGS': '0x0', 15:28:12 INFO - 'XPC_SERVICE_NAME': '0', 15:28:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:28:12 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-HRjZ5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:28:12 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Ry4lH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:28:12 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-h2jNQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:28:12 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Ba8WrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:28:12 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-aomESH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:28:12 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Gk1y78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:28:13 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-LIbtYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:28:13 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-8glOHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:28:13 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-jQqD8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:28:13 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-lyz6nW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:28:13 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-gQGL5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:28:13 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-U5FlJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:28:13 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-FmMdne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:28:13 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-pBBsyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:13 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-S6o8qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:28:13 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-q2y9g8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:28:14 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-DbNRhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:28:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:28:14 INFO - Running setup.py install for manifestparser 15:28:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:28:14 INFO - Running setup.py install for mozcrash 15:28:14 INFO - Running setup.py install for mozdebug 15:28:14 INFO - Running setup.py install for mozdevice 15:28:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:28:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:28:14 INFO - Running setup.py install for mozfile 15:28:14 INFO - Running setup.py install for mozhttpd 15:28:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:28:15 INFO - Running setup.py install for mozinfo 15:28:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:28:15 INFO - Running setup.py install for mozInstall 15:28:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:28:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:28:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:28:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:28:15 INFO - Running setup.py install for mozleak 15:28:15 INFO - Running setup.py install for mozlog 15:28:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:28:15 INFO - Running setup.py install for moznetwork 15:28:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:28:15 INFO - Running setup.py install for mozprocess 15:28:15 INFO - Running setup.py install for mozprofile 15:28:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:28:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:28:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:28:16 INFO - Running setup.py install for mozrunner 15:28:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:28:16 INFO - Running setup.py install for mozscreenshot 15:28:16 INFO - Running setup.py install for moztest 15:28:16 INFO - Running setup.py install for mozversion 15:28:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:28:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:28:16 INFO - Cleaning up... 15:28:16 INFO - Return code: 0 15:28:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:16 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 0x10605ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f950b4e4060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e38d30>, '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 0x105d5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e2dbe8>, '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.oHEkEdSgR7/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.ahA65XnC7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 15:28:16 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 15:28:16 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 15:28:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHEkEdSgR7/Render', 15:28:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:16 INFO - 'HOME': '/Users/cltbld', 15:28:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:16 INFO - 'LOGNAME': 'cltbld', 15:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:16 INFO - 'MOZ_NO_REMOTE': '1', 15:28:16 INFO - 'NO_EM_RESTART': '1', 15:28:16 INFO - 'PAGER': '/bin/cat', 15:28:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:16 INFO - 'PWD': '/builds/slave/test', 15:28:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:16 INFO - 'SHELL': '/bin/bash', 15:28:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ahA65XnC7Q/Listeners', 15:28:16 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 15:28:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:16 INFO - 'USER': 'cltbld', 15:28:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:16 INFO - 'XPC_FLAGS': '0x0', 15:28:16 INFO - 'XPC_SERVICE_NAME': '0', 15:28:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:28:17 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-dgnO3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:28:17 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)) 15:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:28:17 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-CSxGDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:28:17 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)) 15:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:28:17 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-IJ_uGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:28:17 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)) 15:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:28:17 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-YSw69M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:28:17 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)) 15:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:28:17 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-j3abKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:28:17 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)) 15:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:28:17 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-cEjzTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:28:17 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)) 15:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:28:17 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ltyD5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:28:17 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)) 15:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:28:17 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Phs1Ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:28:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:28:17 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-FcZ80u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:28:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:28:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:28:17 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-AhHmGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:28:18 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)) 15:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:28:18 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Z8cYFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:28:18 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)) 15:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:28:18 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-CJIKFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:28:18 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)) 15:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:28:18 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-dcdFbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:28:18 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)) 15:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:28:18 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-2YCKin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:28:18 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)) 15:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:18 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-pqp8CD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:28:18 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)) 15:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:28:18 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-G88awY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:28:18 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)) 15:28:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:28:18 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-gaJa_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:28:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:28:21 INFO - Downloading blessings-1.6.tar.gz 15:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:28:21 INFO - Installing collected packages: blessings 15:28:21 INFO - Running setup.py install for blessings 15:28:21 INFO - Successfully installed blessings 15:28:21 INFO - Cleaning up... 15:28:21 INFO - Return code: 0 15:28:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:28:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:28:22 INFO - Reading from file tmpfile_stdout 15:28:22 INFO - Current package versions: 15:28:22 INFO - blessings == 1.6 15:28:22 INFO - blobuploader == 1.2.4 15:28:22 INFO - docopt == 0.6.1 15:28:22 INFO - functools32 == 3.2.3-2 15:28:22 INFO - jsonschema == 2.5.1 15:28:22 INFO - manifestparser == 1.1 15:28:22 INFO - mozInstall == 1.12 15:28:22 INFO - mozcrash == 1.0 15:28:22 INFO - mozdebug == 0.1 15:28:22 INFO - mozdevice == 0.49 15:28:22 INFO - mozfile == 1.2 15:28:22 INFO - mozhttpd == 0.7 15:28:22 INFO - mozinfo == 0.9 15:28:22 INFO - mozleak == 0.1 15:28:22 INFO - mozlog == 3.4 15:28:22 INFO - moznetwork == 0.27 15:28:22 INFO - mozprocess == 0.25 15:28:22 INFO - mozprofile == 0.28 15:28:22 INFO - mozrunner == 6.13 15:28:22 INFO - mozscreenshot == 0.1 15:28:22 INFO - mozsystemmonitor == 0.3 15:28:22 INFO - moztest == 0.8 15:28:22 INFO - mozversion == 1.4 15:28:22 INFO - psutil == 3.1.1 15:28:22 INFO - requests == 1.2.3 15:28:22 INFO - wsgiref == 0.1.2 15:28:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:28:22 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')]} 15:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:22 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')]} 15:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:22 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 0x10605ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f950b4e4060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e38d30>, '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 0x105d5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e2dbe8>, '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.oHEkEdSgR7/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.ahA65XnC7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 15:28:22 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 15:28:22 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 15:28:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHEkEdSgR7/Render', 15:28:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:22 INFO - 'HOME': '/Users/cltbld', 15:28:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:22 INFO - 'LOGNAME': 'cltbld', 15:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:22 INFO - 'MOZ_NO_REMOTE': '1', 15:28:22 INFO - 'NO_EM_RESTART': '1', 15:28:22 INFO - 'PAGER': '/bin/cat', 15:28:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:22 INFO - 'PWD': '/builds/slave/test', 15:28:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:22 INFO - 'SHELL': '/bin/bash', 15:28:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ahA65XnC7Q/Listeners', 15:28:22 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 15:28:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:22 INFO - 'USER': 'cltbld', 15:28:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:22 INFO - 'XPC_FLAGS': '0x0', 15:28:22 INFO - 'XPC_SERVICE_NAME': '0', 15:28:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:22 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)) 15:28:22 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)) 15:28:22 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)) 15:28:22 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)) 15:28:22 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)) 15:28:22 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)) 15:28:22 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)) 15:28:22 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)) 15:28:22 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)) 15:28:22 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)) 15:28:22 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)) 15:28:22 INFO - Cleaning up... 15:28:22 INFO - Return code: 0 15:28:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:28:22 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')]} 15:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:22 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')]} 15:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:28:22 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 0x10605ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f950b4e4060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e38d30>, '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 0x105d5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e2dbe8>, '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.oHEkEdSgR7/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.ahA65XnC7Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 15:28:22 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 15:28:22 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 15:28:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHEkEdSgR7/Render', 15:28:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:22 INFO - 'HOME': '/Users/cltbld', 15:28:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:22 INFO - 'LOGNAME': 'cltbld', 15:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:22 INFO - 'MOZ_NO_REMOTE': '1', 15:28:22 INFO - 'NO_EM_RESTART': '1', 15:28:22 INFO - 'PAGER': '/bin/cat', 15:28:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:22 INFO - 'PWD': '/builds/slave/test', 15:28:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:22 INFO - 'SHELL': '/bin/bash', 15:28:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ahA65XnC7Q/Listeners', 15:28:22 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 15:28:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:22 INFO - 'USER': 'cltbld', 15:28:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:22 INFO - 'XPC_FLAGS': '0x0', 15:28:22 INFO - 'XPC_SERVICE_NAME': '0', 15:28:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:28:22 INFO - Cleaning up... 15:28:22 INFO - Return code: 0 15:28:22 INFO - Running post-action listener: _resource_record_post_action 15:28:22 INFO - Running post-action listener: _start_resource_monitoring 15:28:22 INFO - Starting resource monitoring. 15:28:22 INFO - [mozharness: 2017-04-24 22:28:22.711603Z] Finished create-virtualenv step (success) 15:28:22 INFO - [mozharness: 2017-04-24 22:28:22.712580Z] Running install step. 15:28:22 INFO - Running pre-action listener: _resource_record_pre_action 15:28:22 INFO - Running main action method: install 15:28:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:28:22 INFO - Reading from file tmpfile_stdout 15:28:22 INFO - Detecting whether we're running mozinstall >=1.0... 15:28:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:28:23 INFO - Reading from file tmpfile_stdout 15:28:23 INFO - Output received: 15:28:23 INFO - Usage: mozinstall [options] installer 15:28:23 INFO - Options: 15:28:23 INFO - -h, --help show this help message and exit 15:28:23 INFO - -d DEST, --destination=DEST 15:28:23 INFO - Directory to install application into. [default: 15:28:23 INFO - "/builds/slave/test"] 15:28:23 INFO - --app=APP Application being installed. [default: firefox] 15:28:23 INFO - mkdir: /builds/slave/test/build/application 15:28:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:28:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:28:37 INFO - Reading from file tmpfile_stdout 15:28:37 INFO - Output received: 15:28:37 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:28:37 INFO - Running post-action listener: _resource_record_post_action 15:28:37 INFO - [mozharness: 2017-04-24 22:28:37.827015Z] Finished install step (success) 15:28:37 INFO - [mozharness: 2017-04-24 22:28:37.827143Z] Running run-tests step. 15:28:37 INFO - Running pre-action listener: _resource_record_pre_action 15:28:37 INFO - Running main action method: run_tests 15:28:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:28:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:28:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:28:37 INFO - 2017-04-24 15:28:37.841 screenresolution[1624:7293] starting screenresolution argv=screenresolution get 15:28:37 INFO - 2017-04-24 15:28:37.844 screenresolution[1624:7293] Display 0: 1600x1200x32@60 15:28:37 INFO - 2017-04-24 15:28:37.850 screenresolution[1625:7295] starting screenresolution argv=screenresolution list 15:28:37 INFO - Available Modes on Display 0 15:28:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:28:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:28:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:28:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:28:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:28:38 INFO - Intel Iris: 15:28:38 INFO - Chipset Model: Intel Iris 15:28:38 INFO - Type: GPU 15:28:38 INFO - Bus: Built-In 15:28:38 INFO - VRAM (Dynamic, Max): 1536 MB 15:28:38 INFO - Vendor: Intel (0x8086) 15:28:38 INFO - Device ID: 0x0a2e 15:28:38 INFO - Revision ID: 0x0009 15:28:38 INFO - Displays: 15:28:38 INFO - Display: 15:28:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:28:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:28:38 INFO - Display Serial Number: 1600x1200 60 15:28:38 INFO - Main Display: Yes 15:28:38 INFO - Mirror: Off 15:28:38 INFO - Online: Yes 15:28:38 INFO - Rotation: Supported 15:28:38 INFO - Return code: 0 15:28:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:28:38 INFO - Python 2.7.3 15:28:38 INFO - Return code: 0 15:28:38 INFO - grabbing minidump binary from tooltool 15:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:28:38 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 0x105e38d30>, '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 0x105d5fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105e2dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:28:38 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 15:28:38 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 15:28:38 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 15:28:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:28:38 INFO - Return code: 0 15:28:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:28:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:28:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:28:38 INFO - ENV: RUST_BACKTRACE is now 1 15:28:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:28:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:28:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:28:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oHEkEdSgR7/Render', 15:28:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:28:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:28:38 INFO - 'HOME': '/Users/cltbld', 15:28:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:28:38 INFO - 'LOGNAME': 'cltbld', 15:28:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:28:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:28:38 INFO - 'MOZ_NO_REMOTE': '1', 15:28:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:28:38 INFO - 'NO_EM_RESTART': '1', 15:28:38 INFO - 'PAGER': '/bin/cat', 15:28:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:28:38 INFO - 'PWD': '/builds/slave/test', 15:28:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:28:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:28:38 INFO - 'RUST_BACKTRACE': '1', 15:28:38 INFO - 'SHELL': '/bin/bash', 15:28:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ahA65XnC7Q/Listeners', 15:28:38 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 15:28:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:28:38 INFO - 'USER': 'cltbld', 15:28:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:28:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:28:38 INFO - 'XPC_FLAGS': '0x0', 15:28:38 INFO - 'XPC_SERVICE_NAME': '0', 15:28:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:28:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:28:38 INFO - mozversion application_buildid: 20170424135726 15:28:38 INFO - mozversion application_changeset: 953ebf1c32152dca8b633aa8d5a3fe3e684a56c5 15:28:38 INFO - mozversion application_display_name: Firefox 15:28:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:28:38 INFO - mozversion application_name: Firefox 15:28:38 INFO - mozversion application_remotingname: firefox 15:28:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:28:38 INFO - mozversion application_vendor: Mozilla 15:28:38 INFO - mozversion application_version: 54.0 15:28:38 INFO - mozversion platform_buildid: 20170424135726 15:28:38 INFO - mozversion platform_changeset: 953ebf1c32152dca8b633aa8d5a3fe3e684a56c5 15:28:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:28:38 INFO - mozversion platform_version: 54.0 15:28:38 INFO - using testdate: 1493072918 15:28:38 INFO - actual date: 1493072918 15:28:38 INFO - starting webserver on 'localhost:49236' 15:28:38 INFO - SUITE-START | Running 2 tests 15:28:38 INFO - TEST-START | dromaeo_css 15:28:38 INFO - operating with platform_type : mac_ 15:28:38 INFO - Initialising browser for dromaeo_css test... 15:28:38 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpUA2ygk/profile http://localhost:49236/getInfo.html) 15:28:41 INFO - PROCESS | 1635 | 2017-04-24 15:28:41.385 plugin-container[1638:7461] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d47, name = 'com.apple.tsm.portname' 15:28:41 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:28:41 INFO - PROCESS | 1635 | 2017-04-24 15:28:41.387 plugin-container[1638:7461] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x921f, name = 'com.apple.CFPasteboardClient' 15:28:41 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:28:41 INFO - PROCESS | 1635 | 2017-04-24 15:28:41.388 plugin-container[1638:7461] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:28:41 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 15:28:41 INFO - PROCESS | 1635 | colorDepth:24 15:28:41 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 15:28:41 INFO - PROCESS | 1635 | __metrics 15:28:41 ERROR - PROCESS | 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 15:28:42 INFO - TEST-INFO | 1635: exit 0 15:28:42 INFO - Browser initialized. 15:28:42 INFO - Running cycle 1/1 for dromaeo_css test... 15:28:42 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpUA2ygk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:28:44 INFO - PROCESS | 1639 | 2017-04-24 15:28:44.433 plugin-container[1640:7597] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833b, name = 'com.apple.tsm.portname' 15:28:44 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:28:44 INFO - PROCESS | 1639 | 2017-04-24 15:28:44.434 plugin-container[1640:7597] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8813, name = 'com.apple.CFPasteboardClient' 15:28:44 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:28:44 INFO - PROCESS | 1639 | 2017-04-24 15:28:44.434 plugin-container[1640:7597] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:28:54 INFO - PROCESS | 1639 | RSS: Main: 174403584 15:28:54 INFO - PROCESS | 1639 | 15:31:56 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 15:31:58 INFO - PROCESS | 1639 | RSS: Main: 197640192 15:31:58 INFO - PROCESS | 1639 | 15:35:00 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 15:35:01 INFO - PROCESS | 1639 | RSS: Main: 205959168 15:35:01 INFO - PROCESS | 1639 | 15:38:03 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 15:38:03 INFO - PROCESS | 1639 | RSS: Main: 207470592 15:38:03 INFO - PROCESS | 1639 | 15:41:05 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 15:41:06 INFO - PROCESS | 1639 | RSS: Main: 210546688 15:41:06 INFO - PROCESS | 1639 | 15:44:08 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 15:44:09 INFO - PROCESS | 1639 | RSS: Main: 213041152 15:44:09 INFO - PROCESS | 1639 | 15:47:12 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 15:47:12 INFO - PROCESS | 1639 | RSS: Main: 211111936 15:47:12 INFO - PROCESS | 1639 | 15:47:12 INFO - PROCESS | 1639 | __start_tp_report 15:47:12 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 15:47:12 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 15:47:12 INFO - PROCESS | 1639 | |i|pagename|runs| 15:47:12 INFO - PROCESS | 1639 | |0;dojo.html;2660.587608920617;3532.664396882297;3572.803495807731;3587.9461808072874;3594.101474631342;5166.328377310953;6001.399860014002;6018.398160183985;6072.392760723931;6096.298925623554;6057.969710151443;6095.933211687959;6102.084687296908;6146.385361463851;6150.384961503847;5450.345958484977;5512.283403157584;5522.116461366182;5532.225488431623;5612.747426365803;5543.695096769676;5547.72261386931;5548.55611551075;5552.139418390156;5563.610547261694;5294.9939511492885;5308.150695888658;5551.1673249012765;5566.944330556704;5577.358603760558;5434.967356202329;5487.122060470346;5524.502794748492;5534.1145416733125;5549.5005449509335;5345.652532585408;5456.345238571357;5474.2609747683955;5476.26070480484;5512.118061110244;5745.6265342753;6052.21321228242;6126.448619624211;6156.4766994805495;6216.564840461169;5194.948050519484;6268.1851359323455;6276.560640755149;6304.338044505353;6311.495080393557;6500.837479063014;6509.99095140254;6511.023346498016;6530.020496925452;6533.150690410263;6052.636841789463;6172.321044685081;6175.96912015437;6182.969085154636;6203.0075187970615;6280;6371.299157092716;6486.578372405778;6520.934790652128;6606.438452731475;6329.113924050636;6354.17395738551;6359.141515895388;6367.808965731036;6385.233771947396;6458.806235812933;6470.061841033118;6476.514261430411;6484.286728459866;6499.317571655003;6203.937960620336;6284.622922624657;6289.245290565162;6330.082138090043;6415.582987105823;6293.905591416133;6317.684115794284;6354.745810167634;6369.299377068519;6372.267189273293;4865.1242776300605;5178.896422071537;5189.662671926313;5191.377034755778;5208.270842082112;4512.029913568598;4583.152116858392;4618.214903466419;4629.712456888409;4650.395448591661;5069.290299358093;6108.949222962717;6119.624418755179;6126.908096378558;6144.03390914903;6379.298277189506;6432.614043157332;6433.195850518685;6446.065320528497;6478.384553467413;4888.755562221874;6039.365866584033;6195.81412557624;6198.752049918043;6214.694914068006;4782.210935195723;5575.107982722826;5685.317761868602;5696.629719068247;5722.971385143131;6663.200415949923;6688.732450702015;6744.5278830482375;6744.662766861736;6797.9660101700165;5908.291005079418;6034.2155519782145;6132.386102851662;6511.772087976898;6541.280459149585;6647.567908085959;6713.295104014203;6717.865642687217;6728.966355168192;6734.393904548614;6397.808065758035;6404.935950640434;6421.678916054272;6422.165118534561;6469.708863101077;6196.287426945959;6262.3111457738705;6469.547131700736;6515.218173819172;6541.215054193337;5129.74351282427;6203.286622038523;6226.159468471698;6252.062190671436;6259.061140828912;6276.592021518587;6288.434040936155;6303.4642055423965;6318.020706790455;6326.114343991753;6099.603525770811;6189.50483961273;6232.439080482778;6271.749130034747;6282.591631543935;5129.204973229155;6181.227346581677;6234.937650623436;6240.157578726814;6259.718312675849;6233.501319894488;6271.749130034747;6288.056791481132;6293.433590976834;6312.14786003902 15:47:12 INFO - PROCESS | 1639 | |1;ext.html;759.9468037237392;822.7326119011321;849.4351256414485;982.1798798003666;988.5650313861901;41473;42351.941201469905;42419.363709544385;42462.787686061565;42482.99999999996;40503.392449113286;40721.79639101808;40763.18473630526;40770.38844417336;41411;8263.421560490753;8399.454035487674;11377.772444551145;11655.533778648844;11831.290122592629;11487.138464615145;11546.36494992775;11603.361815100166;11618.825717614243;11627.360495172763;11607.6517704469;11616.012638925658;11635.592754253603;11653.300801951867;11656.892595203442;11482.196246262765;11519.539218431295;11561.710957226052;11573;11606.129540284512;9013.819723605557;9903.405795652212;11226.270292431047;11251.718707032307;11320.830187547193;36557.817210913774;36623.4506482403;36701.44947825785;36777.63222367769;36894.262114757556;3959.5644479107564;3966;3968.464257325282;4008.6793056555407;4034.6167114124405;26808;27862.860685696643;28086.438271234667;28107.43785124286;28754.712452875414;3188.2507610711464;3235.2795277543623;3243.789153705002;3266.575345205108;3290.901272961815;388900;390689.99999999715;390797.0920290789;391016;392558.03720981214;46799.76600116977;47219.29171062437;47318;47427.05145897063;48260.517394826304;49204.523864283416;49212;49270;49317.26024109641;49498;14679.706405872037;14817.555473335817;15069.849301506845;15090.924545377204;15093.47172848945;12635.43140558677;12815.102942793916;12829.23024618526;12836.871631283755;12841.743165136832;9946.552405141785;10191.679285885126;12534.874651253553;12546.996240300754;12708.809367859489;5850.853728656818;5871.3541510433815;5887.735051922674;5891.3814049525035;5899.351071382144;1147.9024282935877;1198.964031079069;1199.8560172779323;1209.608949707843;1224.6264889208699;21105.78894211069;27369.45261094807;28897.844086236735;29142;29722.85138574293;1104.812181929074;1287.9613611591667;1288.774464468733;1340.8860246879124;1358.3344161360862;14692.706145877022;15154.696906061818;15351;15380;15390.923045384925;506150.4692476514;650996;654550;658291;659375;45057.549424505334;53558.73220633872;53579.46420535823;54154;54229.64425889305;1310.3055380648082;1475.266561789914;1485.1831492678984;1493.596728883217;1493.865552100316;23866.642000369662;28539.42921141607;29094.56358154587;29440;30210;40932;41760.58239417567;41769.79115104405;41881;41891.7905410471;469061;471817;472475.27524725685;472744;473420;30944.71483838762;31255;31439.52840707437;31755.20611984719;31765.364692705552;39482.60517394904;40055.59944400519;40332.798336008134;40748.98127546835;40921.59078409297;27050.594241086004;29154.854225729585;29470;29888.953886613865;30150.246243844078;28915.277118072216;29186.56220156742;29450.852745736993;30072.69927300699;30254.941077062198;34177.80377686769;34377.48433773445;35017.824910875286;35050.82474587611;35133.472997904544;29346.70653293525;30117.69882301149;31002.379952400373;31746.365072697954;32010.039698809072;18247.635047299245;23731.644025339287;25024.74975250297;25051.749482504943;25134.240603157603 15:47:12 INFO - PROCESS | 1639 | |2;jquery.html;387.9146587750695;427.9657627389809;431.37019950871723;433.08618814301815;459.41883517350556;20166;21001.15995360186;21999;22152.778472215272;22211.6668249976;21914;22041.779582204173;22911.541769164607;23033.4241643959;23311.533769324604;6804.557703749265;6907.896381554281;7143.89284160738;7144.357007869291;7184.604846733428;6961.269066747995;7076;7132.6077065761365;7133.964330178368;7147.928520714804;6555.606663600175;7089.291070892895;7106.609136497491;7481.13966893806;7583.924160758377;7416.295451932057;7509.286617771303;7532.096148462192;7555.395568354518;7891.8027049323655;7687.884681729778;7693.19221481742;7708.267714567107;7721;7723.575203363813;25718;26571.601425978624;26573.734262657512;26754.19737407881;27046;2895.971040289591;2950.645922489315;3033.620797400325;3035.969640303613;3068.432340017104;15823.841761582353;16240.675186496323;16272.267747951371;16626.916865415715;16801.66396672072;1781.6971114910496;1919.8560107991816;1997.2610134250276;2069.7053613751377;2074.4399012266604;130744.6925530742;163894;169662;173179.26820731885;176171;20464.283750068676;20649.17403303851;20768.857712825637;20799.376018719464;21267.46831329229;31214;31635.525467118012;31719;31778.364432711678;31783;8814.294856411472;10447;10543.630972916064;10657.307275027253;10792.78414431707;8998.775030624287;9035.45787252767;9048.095190480899;9225.261979041661;9241.214496767716;7644;8615.61229744663;8825.852639156998;9555.378900371454;9755.756106097262;3413.6415676354122;3665.9083522911606;4074.4499492568716;4260.467441569804;4292.227399068198;926.9432846554932;1061.5382308695741;1062.644014255233;1078.8759292681443;1094.9397783121844;18641.627167456576;21021.78978210229;21096.367108986757;21431.571368572542;21465.356039318845;965.35803690545;1009.4094954451728;1009.5406590001531;1046.6650671784955;1049.4857519815237;10648.840267395995;10836.94581527103;11048.171387145996;11174.60888868902;11208.27146235492;723554.8960242199;788306;806141;816036;824882;87877;124381;124776;131935;168115.63768724556;1347.3061373392711;1362.8909687224998;1372.4921778941855;1378.5588611644378;1379.544750232421;18329.26682932721;18963.810361896205;19080;19106.33127840519;19117.23531058742;41567.58432415637;49220.50779492159;61841.690791545756;63676.68161659162;65321.02018469632;95315.61710957282;95924.52037739767;97838;97971.02028979904;98230;9502.762430939281;11528.884711153116;11791.29252244868;11923.165378423428;11955.282683039046;12595.244285342542;12828.973682105223;12880.457874084701;12934.417951192407;12999.545015924397;10946.17903657213;11006.614768483065;11082.501287441923;11319.547218111184;11343.943280283545;10343.586256549654;10479.68560943173;10529.420881851265;10765.30025548337;10792.514336854703;10034.799304013733;11410.714732131763;11597.6520704379;11617.76764464689;11719.472623731783;8545.572721364031;9133.725988220363;11565.942170289094;11873.881261187624;11928.701782455508;10963.616273430393;11182.161337899854;11185.776284474428;11304.83042754343;11409.828852567052 15:47:12 INFO - PROCESS | 1639 | |3;mootools.html;1632.126812155497;1655.793025871766;1672.1889883406554;1678.5048410718837;1681.571199344167;9863.013698630133;10123.848142277871;11060.612878549253;11618.941905290483;11654.825177622342;11172.553097876074;11472;11491.712707182325;11527.481263343148;11548.422578871065;2041.7243672104298;2461.9507609847838;2490.0537795637633;2491.1032028469735;2495.301315631626;2291.2209848651455;2474.9010039598393;2484.5527804995095;2500.462400583874;2513.3590934311815;2427.8421902576365;2482.8386154899963;2486.689163854518;2522.4576716006054;2526.759957804006;2457.103157347573;2457.5576396248666;2467.543504451673;2470.925872223836;2513.5852584323566;2464.617984212432;2486.639437281602;2489.4523204894895;2493.738157493455;2498.5127900059497;11435.656930292105;11567.53729850805;11572.479238434207;11586.826197607043;11764.411779410995;5956.255468066492;6034.96982515089;6116.847078823065;6122.112293717386;6125.173101631267;2818.5772134179833;3669.6146904574903;3705.2959937611768;3711.758735682199;3888.552816426119;1265.3989355056367;1276.8212450256972;1297.5653156192686;1315.7631626307261;1327.8008298755167;15996.4401245957;16110;16132.112733799637;16161.757573636405;16164.353425862952;4999.775010124553;5163.586913046947;5191.039657663345;5195.168772996302;5218.947810521922;12245.387730613435;12292.323922184365;12313.56902508408;12319.199252048587;12336.136470447162;5939.287285525765;6071.51427885768;6110.877782444326;6112.052631842072;6135.294441139326;4336.73979561221;5374.838754837361;5415;5417.620766546304;5427.83716488506;3409.488576713513;3942.8619998300496;4086.7956602169775;4091.1817636472824;4117.835286588503;1091.0834898685143;1094.5238821112841;1096.7751610919743;1109.578360223126;1109.5949978257877;844.3835999720238;845.602566793606;862.6542593554076;885.6457417033109;886.742844575079;6868.7252509900045;6949.339812717783;7020.543664661781;7037.753678621224;7183.604901730455;1016.903394177552;1021.7649940513724;1053.5469748008277;1070.5658989473322;1077.8760442549208;4282.850100246476;4339.956600434019;4445.866624001285;4562.543745625411;4603.263477843596;13728;13955.441782328797;14345.569632911029;14365.20991345486;14454.132752034911;13929.024968252124;13962.650933726534;14154.787678184835;14297.857021429652;14315.28423578817;10570.577176912837;10572.735681608021;10591.152707783358;10661.84007239892;10695.786084278427;6791.592504449749;6799.626020568719;6924.792256232321;6978.720851165896;6993.370596646327;12503.4373453193;12519;12779.74440511166;12807.61577152687;12832.550860720203;11297.604583839526;13087.952963762686;13196.60410187696;13271.601851944457;13278.668033299246;7223.891641625275;8606.78483037904;8700;8767;8783;10612.469376531297;10638.468076596295;10682.519286631965;10734.302270352402;10785.514651840844;9134.908650913405;9179.265658747418;9242.537873106452;9398.530073496435;9411.905880941104;7318.560886346836;9004.684836030707;9009.504477253813;9056.818863622822;9089.045650206897;8146.2261085196815;8190.303824175012;8267.338612910833;8270.710525131832;8272.090070092165;5933.792317268875;5940.851478712894;5968.701564921824;6125.387461254018;6130.478909292582;5065.594752419724;6130.601510901777;6140.692965351804;6234.609579791911;6361.840953976002 15:47:12 INFO - PROCESS | 1639 | |4;prototype.html;390.65036792071095;391.1160776644782;394.5718894998926;397.7602428222132;398.03873645146973;4432.734035957845;4507.594316511513;4544.727316361016;4785.759593245395;5217.4260831308575;4400.603945644892;4904.730239836807;5164.896702065957;5222.817201397952;5232.555232805206;3362.033210571806;4067.5118985721756;4088.5093788745394;4121.443605113316;4128.483939507561;3547.8935631930954;3883.7570628525214;3892.9026774330587;4014.6149578395407;4121.587841215869;3240;3633.1462106404974;3804.695624350059;3880.8059597020037;4150.58494150584;3596.8741094061584;3846.615338466145;4014.558398576154;4335.544767799399;4339.197248509005;3540.486629438717;3671.3575124353133;3798.6771124454453;4022.4368588397647;4053.7365071270274;3937.4290727844586;4086.9386959195635;5000.624953128494;5012.598992080625;5082.745862706887;4490.618297444721;4539.638108567417;4694.342792009122;5020.171671674169;5054.3176671149295;4966.6904889226325;5348.866278343034;5635.267415236034;5639.6877280314875;5652.463016013472;3826.693864490834;4257.424752841437;4324.416203812477;4513;4536.5522203125865;5596.664200148004;5750.539956803445;5753.971230143822;5809.738561764731;6017.578769486137;4479.588929487201;4630.175592888336;4670.155288661028;4673.38290557289;4692.95307046932;3746.2507498499863;4140.852951756687;4237.427947227146;4699.224627936353;4797.56821886032;4713.3872596562915;4953.801847926043;4992.2511623256805;5009.423916249678;5038.773255203451;5104.106781313255;5116.948830511722;5426.810061647902;5534.142207957773;5561.972190139023;1412.2585642537545;1429.8704023821272;1540.6302487403166;1578.7843360612494;1598.3846219205689;1118.8992990630882;1202.5790973159324;1212.2241765270235;1215.4834195466892;1237.2761934268374;4781.784819683123;5302.602304827154;5386.48828361305;5400.540954018874;5479.999800072945;4806.3805226151835;5400.081986062379;5477.75350109238;5809.2738407699035;5852.853678658068;5089.05852417304;5183.766730497061;5429.755660995185;5468.371137319259;5514.420985796433;2479.801615870726;2530.70896846865;2804.1867858320857;3026.4552380571267;3054.480738274499;5351.879053129069;5596.384397716248;5798.652080875161;5988.251468566429;6037.607555508878;5004.824831130893;5119.48805119485;5171.224316352577;5944.524438044946;5952.57138286808;5306.787728490817;5310.52205301517;6059.363766804422;6063.120847477179;6076.354187487561;4869.683470574401;5068.59451243907;5768;5775.162601422854;5778.595498315078;5377.516023557742;5481.698506582176;5711.885762284648;5745.9425405745405;5785.652860828363;5675.921574900755;5955.821325360246;6080.908786368296;6113.23584551931;6123.89769841415;4291.82832686689;4434.933475997798;4619.630429565559;4652.534746525321;4709.869631288398;5481.369642491165;5495.175723641326;5552.52803511706;5757;5783.640844401646;5404.459554044564;5581.888362232814;5619.353774316006;5621.269234999424;5644.520215781705;4579.9543303703995;4975.328330675457;5626.85932851682;5636.718164091861;5686.886262274814;4461.933071003873;4841.757912104451;5058.54473097423;5526.2592283430595;5542.168674698666;4826.203676393497;5626.2967129108865;5638.746256418389;5642.852503409908;5657.264555607745;4657.627389808739;5146.819861304836;5231.607629427732;5425.972870135624;5497.900419916113 15:47:12 INFO - PROCESS | 1639 | |5;yui.html;753.939684825214;759.8822182561703;792.843465773097;817.0644611919353;898.8112496375762;16413.015219086865;17511.824881751196;17531.82468175318;17533.473995780147;17542.64914701705;16032.719836400807;16062.437814676488;16115.033098014128;16307.673846523063;16314.347426102971;906.3293163059338;958.650092716157;1008.3848852200152;1027.075631931264;1028.408665017614;1021.2136654775818;1023.6212601337515;1024.866767320251;1027.152599105737;1029.4235228272191;1035.177034257767;1081.4268437727978;1084.6258040975852;1084.8589683341154;1086.440483151178;1056.5351245451977;1058.7194393485731;1063.3194755356617;1063.4257500949477;1065.8720953485592;779.9548604869445;782.9608519573999;783.3067735054461;784.9607519623996;787.3543694170783;16787.160641967854;17013.23440445183;17071.231794569274;18102.27590896376;18396.724049139273;14336.354864031144;14366;14425.422983080663;14640.487582934653;14718.190499522629;12013.159078864483;12107.697307567294;12212.633620991384;12232.571859984946;12704.047196460302;3879.5538513071074;3882.1265215326325;3910.5502867170353;3910.863119790822;4053.067794407273;89782.55108724479;91177;111084.4445777766;113921.86078139195;117660.99999999914;11258.605948791754;11280.887191128148;11544.365059921616;11633.243839150427;11686.883131168579;23778.762212378002;23844.16545420902;24315.027398903847;24367.025318987042;24441.87779061093;8135.3491720662205;8209;8244.134365891616;8258.380621453414;8298.253157215879;4526.79629416677;4608.216603177468;4655.3947986761505;4658.189100413951;4672.159011377917;3643.908902277464;3713.6843368313994;3740.1958578905123;3743.981280093582;3758.7368884177845;572.802383177803;644.5616980453243;645.3062957320805;656.3666062249856;684.8424862281703;687.7524091327118;708.2987842036347;708.6456771614193;721.1994685898649;753.3107206905729;9156.633734650539;9263;9515.258542005711;10808.675739727663;11045.668629941114;663.847315117516;707.9079719636414;726.5858460677363;728.9088863892014;732.3701616609711;3990.700697447703;4542.212359572832;5078.339815823993;5236.607254455931;5244.370675518962;95826.08347833143;99065;101457.49271253744;106844.46577767062;109773.45113274542;58521.24436266919;68448;81614;82559.3488130234;85766.71349929756;77495.61252193815;79899.20100799034;81285;81375;81751.5912420434;10842.783144337227;11214.943925280648;11344.20590558653;11416.600418985296;11434.799346068543;38351.04122396851;49302.50697492979;50575.74712126416;51722;52059.479405205464;54613;56507.43492565022;62326.37673623206;62712.37287627065;63829.3617063842;14390.424383024561;14555.5390481851;14700.926495367456;14767.852321476648;14901.627459313604;15094.39622415091;15933.601659958595;16112.3304910494;16367;16379.754303685217;13951.162930224218;14005.859941400455;14075.507357242448;14362.928185359424;15052.021618594756;14748.410063597765;15106.471273505374;15207.543773686808;15309.387624494895;15523.45667901618;14304.499342522962;14592.978491505493;14987.625309367353;15037.211182821513;15213.087214766707;10045.648402305884;10257.435841028815;10266.178705703376;10543.89456105429;10795.244332896937;11711.648650540497;11898;12087.659973466487;12409.255444673348;12485.687857803627 15:47:12 INFO - PROCESS | 1639 | __end_tp_report 15:47:12 INFO - PROCESS | 1639 | __start_cc_report 15:47:12 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,393 15:47:12 INFO - PROCESS | 1639 | __end_cc_report 15:47:12 INFO - PROCESS | 1639 | __startTimestamp1493074032712__endTimestamp 15:47:12 INFO - PROCESS | 1639 | 15:47:12 INFO - PROCESS | 1639 | ------- Summary: start ------- 15:47:12 INFO - PROCESS | 1639 | Number of tests: 6 15:47:12 INFO - PROCESS | 1639 | 15:47:12 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5951.02 Median:6203.01 stddev:687.95 (11.1%) stddev-sans-first:639.81 15:47:12 INFO - PROCESS | 1639 | Values: 2660.6 3532.7 3572.8 3587.9 3594.1 5166.3 6001.4 6018.4 6072.4 6096.3 6058.0 6095.9 6102.1 6146.4 6150.4 5450.3 5512.3 5522.1 5532.2 5612.7 5543.7 5547.7 5548.6 5552.1 5563.6 5295.0 5308.2 5551.2 5566.9 5577.4 5435.0 5487.1 5524.5 5534.1 5549.5 5345.7 5456.3 5474.3 5476.3 5512.1 5745.6 6052.2 6126.4 6156.5 6216.6 5194.9 6268.2 6276.6 6304.3 6311.5 6500.8 6510.0 6511.0 6530.0 6533.2 6052.6 6172.3 6176.0 6183.0 6203.0 6280.0 6371.3 6486.6 6520.9 6606.4 6329.1 6354.2 6359.1 6367.8 6385.2 6458.8 6470.1 6476.5 6484.3 6499.3 6203.9 6284.6 6289.2 6330.1 6415.6 6293.9 6317.7 6354.7 6369.3 6372.3 4865.1 5178.9 5189.7 5191.4 5208.3 4512.0 4583.2 4618.2 4629.7 4650.4 5069.3 6108.9 6119.6 6126.9 6144.0 6379.3 6432.6 6433.2 6446.1 6478.4 4888.8 6039.4 6195.8 6198.8 6214.7 4782.2 5575.1 5685.3 5696.6 5723.0 6663.2 6688.7 6744.5 6744.7 6798.0 5908.3 6034.2 6132.4 6511.8 6541.3 6647.6 6713.3 6717.9 6729.0 6734.4 6397.8 6404.9 6421.7 6422.2 6469.7 6196.3 6262.3 6469.5 6515.2 6541.2 5129.7 6203.3 6226.2 6252.1 6259.1 6276.6 6288.4 6303.5 6318.0 6326.1 6099.6 6189.5 6232.4 6271.7 6282.6 5129.2 6181.2 6234.9 6240.2 6259.7 6233.5 6271.7 6288.1 6293.4 6312.1 15:47:12 INFO - PROCESS | 1639 | 15:47:12 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:61937.80 Median:31592.95 stddev:135509.78 (428.9%) stddev-sans-first:135812.07 15:47:12 INFO - PROCESS | 1639 | Values: 759.9 822.7 849.4 982.2 988.6 41473.0 42351.9 42419.4 42462.8 42483.0 40503.4 40721.8 40763.2 40770.4 41411.0 8263.4 8399.5 11377.8 11655.5 11831.3 11487.1 11546.4 11603.4 11618.8 11627.4 11607.7 11616.0 11635.6 11653.3 11656.9 11482.2 11519.5 11561.7 11573.0 11606.1 9013.8 9903.4 11226.3 11251.7 11320.8 36557.8 36623.5 36701.4 36777.6 36894.3 3959.6 3966.0 3968.5 4008.7 4034.6 26808.0 27862.9 28086.4 28107.4 28754.7 3188.3 3235.3 3243.8 3266.6 3290.9 388900.0 390690.0 390797.1 391016.0 392558.0 46799.8 47219.3 47318.0 47427.1 48260.5 49204.5 49212.0 49270.0 49317.3 49498.0 14679.7 14817.6 15069.8 15090.9 15093.5 12635.4 12815.1 12829.2 12836.9 12841.7 9946.6 10191.7 12534.9 12547.0 12708.8 5850.9 5871.4 5887.7 5891.4 5899.4 1147.9 1199.0 1199.9 1209.6 1224.6 21105.8 27369.5 28897.8 29142.0 29722.9 1104.8 1288.0 1288.8 1340.9 1358.3 14692.7 15154.7 15351.0 15380.0 15390.9 506150.5 650996.0 654550.0 658291.0 659375.0 45057.5 53558.7 53579.5 54154.0 54229.6 1310.3 1475.3 1485.2 1493.6 1493.9 23866.6 28539.4 29094.6 29440.0 30210.0 40932.0 41760.6 41769.8 41881.0 41891.8 469061.0 471817.0 472475.3 472744.0 473420.0 30944.7 31255.0 31439.5 31755.2 31765.4 39482.6 40055.6 40332.8 40749.0 40921.6 27050.6 29154.9 29470.0 29889.0 30150.2 28915.3 29186.6 29450.9 30072.7 30254.9 34177.8 34377.5 35017.8 35050.8 35133.5 29346.7 30117.7 31002.4 31746.4 32010.0 18247.6 23731.6 25024.7 25051.7 25134.2 15:47:12 INFO - PROCESS | 1639 | 15:47:12 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:43944.00 Median:21956.50 stddev:131683.62 (599.7%) stddev-sans-first:132012.41 15:47:12 INFO - PROCESS | 1639 | Values: 387.9 428.0 431.4 433.1 459.4 20166.0 21001.2 21999.0 22152.8 22211.7 21914.0 22041.8 22911.5 23033.4 23311.5 6804.6 6907.9 7143.9 7144.4 7184.6 6961.3 7076.0 7132.6 7134.0 7147.9 6555.6 7089.3 7106.6 7481.1 7583.9 7416.3 7509.3 7532.1 7555.4 7891.8 7687.9 7693.2 7708.3 7721.0 7723.6 25718.0 26571.6 26573.7 26754.2 27046.0 2896.0 2950.6 3033.6 3036.0 3068.4 15823.8 16240.7 16272.3 16626.9 16801.7 1781.7 1919.9 1997.3 2069.7 2074.4 130744.7 163894.0 169662.0 173179.3 176171.0 20464.3 20649.2 20768.9 20799.4 21267.5 31214.0 31635.5 31719.0 31778.4 31783.0 8814.3 10447.0 10543.6 10657.3 10792.8 8998.8 9035.5 9048.1 9225.3 9241.2 7644.0 8615.6 8825.9 9555.4 9755.8 3413.6 3665.9 4074.4 4260.5 4292.2 926.9 1061.5 1062.6 1078.9 1094.9 18641.6 21021.8 21096.4 21431.6 21465.4 965.4 1009.4 1009.5 1046.7 1049.5 10648.8 10836.9 11048.2 11174.6 11208.3 723554.9 788306.0 806141.0 816036.0 824882.0 87877.0 124381.0 124776.0 131935.0 168115.6 1347.3 1362.9 1372.5 1378.6 1379.5 18329.3 18963.8 19080.0 19106.3 19117.2 41567.6 49220.5 61841.7 63676.7 65321.0 95315.6 95924.5 97838.0 97971.0 98230.0 9502.8 11528.9 11791.3 11923.2 11955.3 12595.2 12829.0 12880.5 12934.4 12999.5 10946.2 11006.6 11082.5 11319.5 11343.9 10343.6 10479.7 10529.4 10765.3 10792.5 10034.8 11410.7 11597.7 11617.8 11719.5 8545.6 9133.7 11565.9 11873.9 11928.7 10963.6 11182.2 11185.8 11304.8 11409.8 15:47:12 INFO - PROCESS | 1639 | 15:47:12 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:6962.87 Median:2492.42 stddev:4379.51 (175.7%) stddev-sans-first:4373.48 15:47:12 INFO - PROCESS | 1639 | Values: 1632.1 1655.8 1672.2 1678.5 1681.6 9863.0 10123.8 11060.6 11618.9 11654.8 11172.6 11472.0 11491.7 11527.5 11548.4 2041.7 2462.0 2490.1 2491.1 2495.3 2291.2 2474.9 2484.6 2500.5 2513.4 2427.8 2482.8 2486.7 2522.5 2526.8 2457.1 2457.6 2467.5 2470.9 2513.6 2464.6 2486.6 2489.5 2493.7 2498.5 11435.7 11567.5 11572.5 11586.8 11764.4 5956.3 6035.0 6116.8 6122.1 6125.2 2818.6 3669.6 3705.3 3711.8 3888.6 1265.4 1276.8 1297.6 1315.8 1327.8 15996.4 16110.0 16132.1 16161.8 16164.4 4999.8 5163.6 5191.0 5195.2 5218.9 12245.4 12292.3 12313.6 12319.2 12336.1 5939.3 6071.5 6110.9 6112.1 6135.3 4336.7 5374.8 5415.0 5417.6 5427.8 3409.5 3942.9 4086.8 4091.2 4117.8 1091.1 1094.5 1096.8 1109.6 1109.6 844.4 845.6 862.7 885.6 886.7 6868.7 6949.3 7020.5 7037.8 7183.6 1016.9 1021.8 1053.5 1070.6 1077.9 4282.9 4340.0 4445.9 4562.5 4603.3 13728.0 13955.4 14345.6 14365.2 14454.1 13929.0 13962.7 14154.8 14297.9 14315.3 10570.6 10572.7 10591.2 10661.8 10695.8 6791.6 6799.6 6924.8 6978.7 6993.4 12503.4 12519.0 12779.7 12807.6 12832.6 11297.6 13088.0 13196.6 13271.6 13278.7 7223.9 8606.8 8700.0 8767.0 8783.0 10612.5 10638.5 10682.5 10734.3 10785.5 9134.9 9179.3 9242.5 9398.5 9411.9 7318.6 9004.7 9009.5 9056.8 9089.0 8146.2 8190.3 8267.3 8270.7 8272.1 5933.8 5940.9 5968.7 6125.4 6130.5 5065.6 6130.6 6140.7 6234.6 6361.8 15:47:12 INFO - PROCESS | 1639 | 15:47:12 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4612.05 Median:5007.12 stddev:1328.95 (26.5%) stddev-sans-first:1294.36 15:47:12 INFO - PROCESS | 1639 | Values: 390.7 391.1 394.6 397.8 398.0 4432.7 4507.6 4544.7 4785.8 5217.4 4400.6 4904.7 5164.9 5222.8 5232.6 3362.0 4067.5 4088.5 4121.4 4128.5 3547.9 3883.8 3892.9 4014.6 4121.6 3240.0 3633.1 3804.7 3880.8 4150.6 3596.9 3846.6 4014.6 4335.5 4339.2 3540.5 3671.4 3798.7 4022.4 4053.7 3937.4 4086.9 5000.6 5012.6 5082.7 4490.6 4539.6 4694.3 5020.2 5054.3 4966.7 5348.9 5635.3 5639.7 5652.5 3826.7 4257.4 4324.4 4513.0 4536.6 5596.7 5750.5 5754.0 5809.7 6017.6 4479.6 4630.2 4670.2 4673.4 4693.0 3746.3 4140.9 4237.4 4699.2 4797.6 4713.4 4953.8 4992.3 5009.4 5038.8 5104.1 5116.9 5426.8 5534.1 5562.0 1412.3 1429.9 1540.6 1578.8 1598.4 1118.9 1202.6 1212.2 1215.5 1237.3 4781.8 5302.6 5386.5 5400.5 5480.0 4806.4 5400.1 5477.8 5809.3 5852.9 5089.1 5183.8 5429.8 5468.4 5514.4 2479.8 2530.7 2804.2 3026.5 3054.5 5351.9 5596.4 5798.7 5988.3 6037.6 5004.8 5119.5 5171.2 5944.5 5952.6 5306.8 5310.5 6059.4 6063.1 6076.4 4869.7 5068.6 5768.0 5775.2 5778.6 5377.5 5481.7 5711.9 5745.9 5785.7 5675.9 5955.8 6080.9 6113.2 6123.9 4291.8 4434.9 4619.6 4652.5 4709.9 5481.4 5495.2 5552.5 5757.0 5783.6 5404.5 5581.9 5619.4 5621.3 5644.5 4580.0 4975.3 5626.9 5636.7 5686.9 4461.9 4841.8 5058.5 5526.3 5542.2 4826.2 5626.3 5638.7 5642.9 5657.3 4657.6 5146.8 5231.6 5426.0 5497.9 15:47:12 INFO - PROCESS | 1639 | 15:47:12 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20459.95 Median:17521.82 stddev:28223.77 (161.1%) stddev-sans-first:28264.15 15:47:12 INFO - PROCESS | 1639 | Values: 753.9 759.9 792.8 817.1 898.8 16413.0 17511.8 17531.8 17533.5 17542.6 16032.7 16062.4 16115.0 16307.7 16314.3 906.3 958.7 1008.4 1027.1 1028.4 1021.2 1023.6 1024.9 1027.2 1029.4 1035.2 1081.4 1084.6 1084.9 1086.4 1056.5 1058.7 1063.3 1063.4 1065.9 780.0 783.0 783.3 785.0 787.4 16787.2 17013.2 17071.2 18102.3 18396.7 14336.4 14366.0 14425.4 14640.5 14718.2 12013.2 12107.7 12212.6 12232.6 12704.0 3879.6 3882.1 3910.6 3910.9 4053.1 89782.6 91177.0 111084.4 113921.9 117661.0 11258.6 11280.9 11544.4 11633.2 11686.9 23778.8 23844.2 24315.0 24367.0 24441.9 8135.3 8209.0 8244.1 8258.4 8298.3 4526.8 4608.2 4655.4 4658.2 4672.2 3643.9 3713.7 3740.2 3744.0 3758.7 572.8 644.6 645.3 656.4 684.8 687.8 708.3 708.6 721.2 753.3 9156.6 9263.0 9515.3 10808.7 11045.7 663.8 707.9 726.6 728.9 732.4 3990.7 4542.2 5078.3 5236.6 5244.4 95826.1 99065.0 101457.5 106844.5 109773.5 58521.2 68448.0 81614.0 82559.3 85766.7 77495.6 79899.2 81285.0 81375.0 81751.6 10842.8 11214.9 11344.2 11416.6 11434.8 38351.0 49302.5 50575.7 51722.0 52059.5 54613.0 56507.4 62326.4 62712.4 63829.4 14390.4 14555.5 14700.9 14767.9 14901.6 15094.4 15933.6 16112.3 16367.0 16379.8 13951.2 14005.9 14075.5 14362.9 15052.0 14748.4 15106.5 15207.5 15309.4 15523.5 14304.5 14593.0 14987.6 15037.2 15213.1 10045.6 10257.4 10266.2 10543.9 10795.2 11711.6 11898.0 12087.7 12409.3 12485.7 15:47:12 INFO - PROCESS | 1639 | -------- Summary: end -------- 15:47:12 INFO - PROCESS | 1639 | 15:47:13 INFO - TEST-INFO | 1639: exit 0 15:47:13 INFO - TEST-OK | dromaeo_css | took 1114857ms 15:47:13 INFO - TEST-START | kraken 15:47:13 INFO - operating with platform_type : mac_ 15:47:13 INFO - Initialising browser for kraken test... 15:47:13 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmphbQY4S/profile http://localhost:49236/getInfo.html) 15:47:15 INFO - PROCESS | 1652 | 2017-04-24 15:47:15.881 plugin-container[1654:10058] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8543, name = 'com.apple.tsm.portname' 15:47:15 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:47:15 INFO - PROCESS | 1652 | 2017-04-24 15:47:15.882 plugin-container[1654:10058] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8727, name = 'com.apple.CFPasteboardClient' 15:47:15 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:47:15 INFO - PROCESS | 1652 | 2017-04-24 15:47:15.882 plugin-container[1654:10058] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:47:15 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 15:47:15 INFO - PROCESS | 1652 | colorDepth:24 15:47:15 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 15:47:15 INFO - PROCESS | 1652 | __metrics 15:47:16 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 15:47:16 INFO - TEST-INFO | 1652: exit 0 15:47:16 INFO - Browser initialized. 15:47:16 INFO - Running cycle 1/1 for kraken test... 15:47:16 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmphbQY4S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:47:19 INFO - PROCESS | 1655 | 2017-04-24 15:47:19.074 plugin-container[1656:10185] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8443, name = 'com.apple.tsm.portname' 15:47:19 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:47:19 INFO - PROCESS | 1655 | 2017-04-24 15:47:19.075 plugin-container[1656:10185] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 15:47:19 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:47:19 INFO - PROCESS | 1655 | 2017-04-24 15:47:19.075 plugin-container[1656:10185] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:47:28 INFO - PROCESS | 1655 | RSS: Main: 174358528 15:47:28 INFO - PROCESS | 1655 | 15:47:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 15:47:32 INFO - PROCESS | 1655 | RSS: Main: 188067840 15:47:32 INFO - PROCESS | 1655 | 15:47:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 15:47:36 INFO - PROCESS | 1655 | RSS: Main: 196009984 15:47:36 INFO - PROCESS | 1655 | 15:47:39 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 15:47:40 INFO - PROCESS | 1655 | RSS: Main: 199757824 15:47:40 INFO - PROCESS | 1655 | 15:47:42 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 15:47:42 INFO - PROCESS | 1655 | RSS: Main: 200065024 15:47:42 INFO - PROCESS | 1655 | 15:47:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:47:45 INFO - PROCESS | 1655 | RSS: Main: 201469952 15:47:45 INFO - PROCESS | 1655 | 15:47:48 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 15:47:48 INFO - PROCESS | 1655 | RSS: Main: 205901824 15:47:48 INFO - PROCESS | 1655 | 15:47:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 15:47:52 INFO - PROCESS | 1655 | RSS: Main: 204578816 15:47:52 INFO - PROCESS | 1655 | 15:47:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 15:47:56 INFO - PROCESS | 1655 | RSS: Main: 204689408 15:47:56 INFO - PROCESS | 1655 | 15:47:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:47:58 INFO - PROCESS | 1655 | RSS: Main: 204427264 15:47:58 INFO - PROCESS | 1655 | 15:48:00 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:48:01 INFO - PROCESS | 1655 | RSS: Main: 204419072 15:48:01 INFO - PROCESS | 1655 | 15:48:03 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:48:04 INFO - PROCESS | 1655 | RSS: Main: 204443648 15:48:04 INFO - PROCESS | 1655 | 15:48:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:48:07 INFO - PROCESS | 1655 | RSS: Main: 204853248 15:48:07 INFO - PROCESS | 1655 | 15:48:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:48:11 INFO - PROCESS | 1655 | RSS: Main: 204562432 15:48:11 INFO - PROCESS | 1655 | 15:48:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 15:48:13 INFO - PROCESS | 1655 | RSS: Main: 206327808 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | __start_tp_report 15:48:13 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 15:48:13 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 15:48:13 INFO - PROCESS | 1655 | |i|pagename|runs| 15:48:13 INFO - PROCESS | 1655 | |0;ai-astar;110;121;124;121;121;120;120;122;121;122 15:48:13 INFO - PROCESS | 1655 | |1;audio-beat-detection;145;114;93;168;138;147;134;112;136;122 15:48:13 INFO - PROCESS | 1655 | |2;audio-dft;203;194;194;198;221;198;220;196;181;256 15:48:13 INFO - PROCESS | 1655 | |3;audio-fft;82;58;62;86;63;63;83;53;94;85 15:48:13 INFO - PROCESS | 1655 | |4;audio-oscillator;86;74;111;81;70;69;82;72;70;87 15:48:13 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;99;88;89;90;89;104;105;110;100;86 15:48:13 INFO - PROCESS | 1655 | |6;imaging-darkroom;135;120;116;93;155;154;114;153;155;95 15:48:13 INFO - PROCESS | 1655 | |7;imaging-desaturate;91;109;89;93;100;128;89;124;86;140 15:48:13 INFO - PROCESS | 1655 | |8;json-parse-financial;65;64;65;65;69;67;69;68;69;69 15:48:13 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;60;61;63;66;63;59;59;60;60;60 15:48:13 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;84;84;86;86;84;81;81;90;83;80 15:48:13 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;138;139;132;138;142;152;147;144;181;136 15:48:13 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;165;163;167;162;211;219;194;164;167;162 15:48:13 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;64;67;64;66;65;64;64;64;64;63 15:48:13 INFO - PROCESS | 1655 | __end_tp_report 15:48:13 INFO - PROCESS | 1655 | __start_cc_report 15:48:13 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,986 15:48:13 INFO - PROCESS | 1655 | __end_cc_report 15:48:13 INFO - PROCESS | 1655 | __startTimestamp1493074093179__endTimestamp 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | ------- Summary: start ------- 15:48:13 INFO - PROCESS | 1655 | Number of tests: 14 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:120.20 Median:121.00 stddev:3.77 (3.1%) stddev-sans-first:1.22 15:48:13 INFO - PROCESS | 1655 | Values: 110.0 121.0 124.0 121.0 121.0 120.0 120.0 122.0 121.0 122.0 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:130.90 Median:141.50 stddev:21.29 (15.0%) stddev-sans-first:21.96 15:48:13 INFO - PROCESS | 1655 | Values: 145.0 114.0 93.0 168.0 138.0 147.0 134.0 112.0 136.0 122.0 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:206.10 Median:200.50 stddev:21.27 (10.6%) stddev-sans-first:22.53 15:48:13 INFO - PROCESS | 1655 | Values: 203.0 194.0 194.0 198.0 221.0 198.0 220.0 196.0 181.0 256.0 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:72.90 Median:82.50 stddev:14.46 (17.5%) stddev-sans-first:14.95 15:48:13 INFO - PROCESS | 1655 | Values: 82.0 58.0 62.0 86.0 63.0 63.0 83.0 53.0 94.0 85.0 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:77.50 stddev:12.79 (16.5%) stddev-sans-first:13.39 15:48:13 INFO - PROCESS | 1655 | Values: 86.0 74.0 111.0 81.0 70.0 69.0 82.0 72.0 70.0 87.0 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:96.00 Median:88.50 stddev:8.59 (9.7%) stddev-sans-first:9.04 15:48:13 INFO - PROCESS | 1655 | Values: 99.0 88.0 89.0 90.0 89.0 104.0 105.0 110.0 100.0 86.0 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:129.00 Median:154.50 stddev:24.76 (16.0%) stddev-sans-first:26.16 15:48:13 INFO - PROCESS | 1655 | Values: 135.0 120.0 116.0 93.0 155.0 154.0 114.0 153.0 155.0 95.0 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:104.90 Median:87.50 stddev:19.35 (22.1%) stddev-sans-first:19.86 15:48:13 INFO - PROCESS | 1655 | Values: 91.0 109.0 89.0 93.0 100.0 128.0 89.0 124.0 86.0 140.0 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:68.50 stddev:2.05 (3.0%) stddev-sans-first:2.05 15:48:13 INFO - PROCESS | 1655 | Values: 65.0 64.0 65.0 65.0 69.0 67.0 69.0 68.0 69.0 69.0 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:60.50 stddev:2.23 (3.7%) stddev-sans-first:2.33 15:48:13 INFO - PROCESS | 1655 | Values: 60.0 61.0 63.0 66.0 63.0 59.0 59.0 60.0 60.0 60.0 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:2.96 (3.5%) stddev-sans-first:3.14 15:48:13 INFO - PROCESS | 1655 | Values: 84.0 84.0 86.0 86.0 84.0 81.0 81.0 90.0 83.0 80.0 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:143.00 stddev:13.92 (9.7%) stddev-sans-first:14.53 15:48:13 INFO - PROCESS | 1655 | Values: 138.0 139.0 132.0 138.0 142.0 152.0 147.0 144.0 181.0 136.0 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:167.00 stddev:22.03 (13.2%) stddev-sans-first:22.90 15:48:13 INFO - PROCESS | 1655 | Values: 165.0 163.0 167.0 162.0 211.0 219.0 194.0 164.0 167.0 162.0 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 15:48:13 INFO - PROCESS | 1655 | Values: 64.0 67.0 64.0 66.0 65.0 64.0 64.0 64.0 64.0 63.0 15:48:13 INFO - PROCESS | 1655 | -------- Summary: end -------- 15:48:13 INFO - PROCESS | 1655 | 15:48:13 INFO - TEST-INFO | 1655: exit 0 15:48:14 INFO - TEST-OK | kraken | took 60736ms 15:48:14 INFO - SUITE-END | took 1175s 15:48:14 INFO - Completed test suite (00:19:35) 15:48:14 INFO - javascript benchmark 15:48:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7881.7559807847565, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2660.587608920617, 3532.664396882297, 3572.803495807731, 3587.9461808072874, 3594.101474631342, 5166.328377310953, 6001.399860014002, 6018.398160183985, 6072.392760723931, 6096.298925623554, 6057.969710151443, 6095.933211687959, 6102.084687296908, 6146.385361463851, 6150.384961503847, 5450.345958484977, 5512.283403157584, 5522.116461366182, 5532.225488431623, 5612.747426365803, 5543.695096769676, 5547.72261386931, 5548.55611551075, 5552.139418390156, 5563.610547261694, 5294.9939511492885, 5308.150695888658, 5551.1673249012765, 5566.944330556704, 5577.358603760558, 5434.967356202329, 5487.122060470346, 5524.502794748492, 5534.1145416733125, 5549.5005449509335, 5345.652532585408, 5456.345238571357, 5474.2609747683955, 5476.26070480484, 5512.118061110244, 5745.6265342753, 6052.21321228242, 6126.448619624211, 6156.4766994805495, 6216.564840461169, 5194.948050519484, 6268.1851359323455, 6276.560640755149, 6304.338044505353, 6311.495080393557, 6500.837479063014, 6509.99095140254, 6511.023346498016, 6530.020496925452, 6533.150690410263, 6052.636841789463, 6172.321044685081, 6175.96912015437, 6182.969085154636, 6203.0075187970615, 6280.0, 6371.299157092716, 6486.578372405778, 6520.934790652128, 6606.438452731475, 6329.113924050636, 6354.17395738551, 6359.141515895388, 6367.808965731036, 6385.233771947396, 6458.806235812933, 6470.061841033118, 6476.514261430411, 6484.286728459866, 6499.317571655003, 6203.937960620336, 6284.622922624657, 6289.245290565162, 6330.082138090043, 6415.582987105823, 6293.905591416133, 6317.684115794284, 6354.745810167634, 6369.299377068519, 6372.267189273293, 4865.1242776300605, 5178.896422071537, 5189.662671926313, 5191.377034755778, 5208.270842082112, 4512.029913568598, 4583.152116858392, 4618.214903466419, 4629.712456888409, 4650.395448591661, 5069.290299358093, 6108.949222962717, 6119.624418755179, 6126.908096378558, 6144.03390914903, 6379.298277189506, 6432.614043157332, 6433.195850518685, 6446.065320528497, 6478.384553467413, 4888.755562221874, 6039.365866584033, 6195.81412557624, 6198.752049918043, 6214.694914068006, 4782.210935195723, 5575.107982722826, 5685.317761868602, 5696.629719068247, 5722.971385143131, 6663.200415949923, 6688.732450702015, 6744.5278830482375, 6744.662766861736, 6797.9660101700165, 5908.291005079418, 6034.2155519782145, 6132.386102851662, 6511.772087976898, 6541.280459149585, 6647.567908085959, 6713.295104014203, 6717.865642687217, 6728.966355168192, 6734.393904548614, 6397.808065758035, 6404.935950640434, 6421.678916054272, 6422.165118534561, 6469.708863101077, 6196.287426945959, 6262.3111457738705, 6469.547131700736, 6515.218173819172, 6541.215054193337, 5129.74351282427, 6203.286622038523, 6226.159468471698, 6252.062190671436, 6259.061140828912, 6276.592021518587, 6288.434040936155, 6303.4642055423965, 6318.020706790455, 6326.114343991753, 6099.603525770811, 6189.50483961273, 6232.439080482778, 6271.749130034747, 6282.591631543935, 5129.204973229155, 6181.227346581677, 6234.937650623436, 6240.157578726814, 6259.718312675849, 6233.501319894488, 6271.749130034747, 6288.056791481132, 6293.433590976834, 6312.14786003902], "value": 5907.88261637757, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [759.9468037237392, 822.7326119011321, 849.4351256414485, 982.1798798003666, 988.5650313861901, 41473.0, 42351.941201469905, 42419.363709544385, 42462.787686061565, 42482.99999999996, 40503.392449113286, 40721.79639101808, 40763.18473630526, 40770.38844417336, 41411.0, 8263.421560490753, 8399.454035487674, 11377.772444551145, 11655.533778648844, 11831.290122592629, 11487.138464615145, 11546.36494992775, 11603.361815100166, 11618.825717614243, 11627.360495172763, 11607.6517704469, 11616.012638925658, 11635.592754253603, 11653.300801951867, 11656.892595203442, 11482.196246262765, 11519.539218431295, 11561.710957226052, 11573.0, 11606.129540284512, 9013.819723605557, 9903.405795652212, 11226.270292431047, 11251.718707032307, 11320.830187547193, 36557.817210913774, 36623.4506482403, 36701.44947825785, 36777.63222367769, 36894.262114757556, 3959.5644479107564, 3966.0, 3968.464257325282, 4008.6793056555407, 4034.6167114124405, 26808.0, 27862.860685696643, 28086.438271234667, 28107.43785124286, 28754.712452875414, 3188.2507610711464, 3235.2795277543623, 3243.789153705002, 3266.575345205108, 3290.901272961815, 388900.0, 390689.99999999715, 390797.0920290789, 391016.0, 392558.03720981214, 46799.76600116977, 47219.29171062437, 47318.0, 47427.05145897063, 48260.517394826304, 49204.523864283416, 49212.0, 49270.0, 49317.26024109641, 49498.0, 14679.706405872037, 14817.555473335817, 15069.849301506845, 15090.924545377204, 15093.47172848945, 12635.43140558677, 12815.102942793916, 12829.23024618526, 12836.871631283755, 12841.743165136832, 9946.552405141785, 10191.679285885126, 12534.874651253553, 12546.996240300754, 12708.809367859489, 5850.853728656818, 5871.3541510433815, 5887.735051922674, 5891.3814049525035, 5899.351071382144, 1147.9024282935877, 1198.964031079069, 1199.8560172779323, 1209.608949707843, 1224.6264889208699, 21105.78894211069, 27369.45261094807, 28897.844086236735, 29142.0, 29722.85138574293, 1104.812181929074, 1287.9613611591667, 1288.774464468733, 1340.8860246879124, 1358.3344161360862, 14692.706145877022, 15154.696906061818, 15351.0, 15380.0, 15390.923045384925, 506150.4692476514, 650996.0, 654550.0, 658291.0, 659375.0, 45057.549424505334, 53558.73220633872, 53579.46420535823, 54154.0, 54229.64425889305, 1310.3055380648082, 1475.266561789914, 1485.1831492678984, 1493.596728883217, 1493.865552100316, 23866.642000369662, 28539.42921141607, 29094.56358154587, 29440.0, 30210.0, 40932.0, 41760.58239417567, 41769.79115104405, 41881.0, 41891.7905410471, 469061.0, 471817.0, 472475.27524725685, 472744.0, 473420.0, 30944.71483838762, 31255.0, 31439.52840707437, 31755.20611984719, 31765.364692705552, 39482.60517394904, 40055.59944400519, 40332.798336008134, 40748.98127546835, 40921.59078409297, 27050.594241086004, 29154.854225729585, 29470.0, 29888.953886613865, 30150.246243844078, 28915.277118072216, 29186.56220156742, 29450.852745736993, 30072.69927300699, 30254.941077062198, 34177.80377686769, 34377.48433773445, 35017.824910875286, 35050.82474587611, 35133.472997904544, 29346.70653293525, 30117.69882301149, 31002.379952400373, 31746.365072697954, 32010.039698809072, 18247.635047299245, 23731.644025339287, 25024.74975250297, 25051.749482504943, 25134.240603157603], "value": 19284.589463900065, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.9146587750695, 427.9657627389809, 431.37019950871723, 433.08618814301815, 459.41883517350556, 20166.0, 21001.15995360186, 21999.0, 22152.778472215272, 22211.6668249976, 21914.0, 22041.779582204173, 22911.541769164607, 23033.4241643959, 23311.533769324604, 6804.557703749265, 6907.896381554281, 7143.89284160738, 7144.357007869291, 7184.604846733428, 6961.269066747995, 7076.0, 7132.6077065761365, 7133.964330178368, 7147.928520714804, 6555.606663600175, 7089.291070892895, 7106.609136497491, 7481.13966893806, 7583.924160758377, 7416.295451932057, 7509.286617771303, 7532.096148462192, 7555.395568354518, 7891.8027049323655, 7687.884681729778, 7693.19221481742, 7708.267714567107, 7721.0, 7723.575203363813, 25718.0, 26571.601425978624, 26573.734262657512, 26754.19737407881, 27046.0, 2895.971040289591, 2950.645922489315, 3033.620797400325, 3035.969640303613, 3068.432340017104, 15823.841761582353, 16240.675186496323, 16272.267747951371, 16626.916865415715, 16801.66396672072, 1781.6971114910496, 1919.8560107991816, 1997.2610134250276, 2069.7053613751377, 2074.4399012266604, 130744.6925530742, 163894.0, 169662.0, 173179.26820731885, 176171.0, 20464.283750068676, 20649.17403303851, 20768.857712825637, 20799.376018719464, 21267.46831329229, 31214.0, 31635.525467118012, 31719.0, 31778.364432711678, 31783.0, 8814.294856411472, 10447.0, 10543.630972916064, 10657.307275027253, 10792.78414431707, 8998.775030624287, 9035.45787252767, 9048.095190480899, 9225.261979041661, 9241.214496767716, 7644.0, 8615.61229744663, 8825.852639156998, 9555.378900371454, 9755.756106097262, 3413.6415676354122, 3665.9083522911606, 4074.4499492568716, 4260.467441569804, 4292.227399068198, 926.9432846554932, 1061.5382308695741, 1062.644014255233, 1078.8759292681443, 1094.9397783121844, 18641.627167456576, 21021.78978210229, 21096.367108986757, 21431.571368572542, 21465.356039318845, 965.35803690545, 1009.4094954451728, 1009.5406590001531, 1046.6650671784955, 1049.4857519815237, 10648.840267395995, 10836.94581527103, 11048.171387145996, 11174.60888868902, 11208.27146235492, 723554.8960242199, 788306.0, 806141.0, 816036.0, 824882.0, 87877.0, 124381.0, 124776.0, 131935.0, 168115.63768724556, 1347.3061373392711, 1362.8909687224998, 1372.4921778941855, 1378.5588611644378, 1379.544750232421, 18329.26682932721, 18963.810361896205, 19080.0, 19106.33127840519, 19117.23531058742, 41567.58432415637, 49220.50779492159, 61841.690791545756, 63676.68161659162, 65321.02018469632, 95315.61710957282, 95924.52037739767, 97838.0, 97971.02028979904, 98230.0, 9502.762430939281, 11528.884711153116, 11791.29252244868, 11923.165378423428, 11955.282683039046, 12595.244285342542, 12828.973682105223, 12880.457874084701, 12934.417951192407, 12999.545015924397, 10946.17903657213, 11006.614768483065, 11082.501287441923, 11319.547218111184, 11343.943280283545, 10343.586256549654, 10479.68560943173, 10529.420881851265, 10765.30025548337, 10792.514336854703, 10034.799304013733, 11410.714732131763, 11597.6520704379, 11617.76764464689, 11719.472623731783, 8545.572721364031, 9133.725988220363, 11565.942170289094, 11873.881261187624, 11928.701782455508, 10963.616273430393, 11182.161337899854, 11185.776284474428, 11304.83042754343, 11409.828852567052], "value": 11728.782588859485, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1632.126812155497, 1655.793025871766, 1672.1889883406554, 1678.5048410718837, 1681.571199344167, 9863.013698630133, 10123.848142277871, 11060.612878549253, 11618.941905290483, 11654.825177622342, 11172.553097876074, 11472.0, 11491.712707182325, 11527.481263343148, 11548.422578871065, 2041.7243672104298, 2461.9507609847838, 2490.0537795637633, 2491.1032028469735, 2495.301315631626, 2291.2209848651455, 2474.9010039598393, 2484.5527804995095, 2500.462400583874, 2513.3590934311815, 2427.8421902576365, 2482.8386154899963, 2486.689163854518, 2522.4576716006054, 2526.759957804006, 2457.103157347573, 2457.5576396248666, 2467.543504451673, 2470.925872223836, 2513.5852584323566, 2464.617984212432, 2486.639437281602, 2489.4523204894895, 2493.738157493455, 2498.5127900059497, 11435.656930292105, 11567.53729850805, 11572.479238434207, 11586.826197607043, 11764.411779410995, 5956.255468066492, 6034.96982515089, 6116.847078823065, 6122.112293717386, 6125.173101631267, 2818.5772134179833, 3669.6146904574903, 3705.2959937611768, 3711.758735682199, 3888.552816426119, 1265.3989355056367, 1276.8212450256972, 1297.5653156192686, 1315.7631626307261, 1327.8008298755167, 15996.4401245957, 16110.0, 16132.112733799637, 16161.757573636405, 16164.353425862952, 4999.775010124553, 5163.586913046947, 5191.039657663345, 5195.168772996302, 5218.947810521922, 12245.387730613435, 12292.323922184365, 12313.56902508408, 12319.199252048587, 12336.136470447162, 5939.287285525765, 6071.51427885768, 6110.877782444326, 6112.052631842072, 6135.294441139326, 4336.73979561221, 5374.838754837361, 5415.0, 5417.620766546304, 5427.83716488506, 3409.488576713513, 3942.8619998300496, 4086.7956602169775, 4091.1817636472824, 4117.835286588503, 1091.0834898685143, 1094.5238821112841, 1096.7751610919743, 1109.578360223126, 1109.5949978257877, 844.3835999720238, 845.602566793606, 862.6542593554076, 885.6457417033109, 886.742844575079, 6868.7252509900045, 6949.339812717783, 7020.543664661781, 7037.753678621224, 7183.604901730455, 1016.903394177552, 1021.7649940513724, 1053.5469748008277, 1070.5658989473322, 1077.8760442549208, 4282.850100246476, 4339.956600434019, 4445.866624001285, 4562.543745625411, 4603.263477843596, 13728.0, 13955.441782328797, 14345.569632911029, 14365.20991345486, 14454.132752034911, 13929.024968252124, 13962.650933726534, 14154.787678184835, 14297.857021429652, 14315.28423578817, 10570.577176912837, 10572.735681608021, 10591.152707783358, 10661.84007239892, 10695.786084278427, 6791.592504449749, 6799.626020568719, 6924.792256232321, 6978.720851165896, 6993.370596646327, 12503.4373453193, 12519.0, 12779.74440511166, 12807.61577152687, 12832.550860720203, 11297.604583839526, 13087.952963762686, 13196.60410187696, 13271.601851944457, 13278.668033299246, 7223.891641625275, 8606.78483037904, 8700.0, 8767.0, 8783.0, 10612.469376531297, 10638.468076596295, 10682.519286631965, 10734.302270352402, 10785.514651840844, 9134.908650913405, 9179.265658747418, 9242.537873106452, 9398.530073496435, 9411.905880941104, 7318.560886346836, 9004.684836030707, 9009.504477253813, 9056.818863622822, 9089.045650206897, 8146.2261085196815, 8190.303824175012, 8267.338612910833, 8270.710525131832, 8272.090070092165, 5933.792317268875, 5940.851478712894, 5968.701564921824, 6125.387461254018, 6130.478909292582, 5065.594752419724, 6130.601510901777, 6140.692965351804, 6234.609579791911, 6361.840953976002], "value": 5304.956772563429, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.65036792071095, 391.1160776644782, 394.5718894998926, 397.7602428222132, 398.03873645146973, 4432.734035957845, 4507.594316511513, 4544.727316361016, 4785.759593245395, 5217.4260831308575, 4400.603945644892, 4904.730239836807, 5164.896702065957, 5222.817201397952, 5232.555232805206, 3362.033210571806, 4067.5118985721756, 4088.5093788745394, 4121.443605113316, 4128.483939507561, 3547.8935631930954, 3883.7570628525214, 3892.9026774330587, 4014.6149578395407, 4121.587841215869, 3240.0, 3633.1462106404974, 3804.695624350059, 3880.8059597020037, 4150.58494150584, 3596.8741094061584, 3846.615338466145, 4014.558398576154, 4335.544767799399, 4339.197248509005, 3540.486629438717, 3671.3575124353133, 3798.6771124454453, 4022.4368588397647, 4053.7365071270274, 3937.4290727844586, 4086.9386959195635, 5000.624953128494, 5012.598992080625, 5082.745862706887, 4490.618297444721, 4539.638108567417, 4694.342792009122, 5020.171671674169, 5054.3176671149295, 4966.6904889226325, 5348.866278343034, 5635.267415236034, 5639.6877280314875, 5652.463016013472, 3826.693864490834, 4257.424752841437, 4324.416203812477, 4513.0, 4536.5522203125865, 5596.664200148004, 5750.539956803445, 5753.971230143822, 5809.738561764731, 6017.578769486137, 4479.588929487201, 4630.175592888336, 4670.155288661028, 4673.38290557289, 4692.95307046932, 3746.2507498499863, 4140.852951756687, 4237.427947227146, 4699.224627936353, 4797.56821886032, 4713.3872596562915, 4953.801847926043, 4992.2511623256805, 5009.423916249678, 5038.773255203451, 5104.106781313255, 5116.948830511722, 5426.810061647902, 5534.142207957773, 5561.972190139023, 1412.2585642537545, 1429.8704023821272, 1540.6302487403166, 1578.7843360612494, 1598.3846219205689, 1118.8992990630882, 1202.5790973159324, 1212.2241765270235, 1215.4834195466892, 1237.2761934268374, 4781.784819683123, 5302.602304827154, 5386.48828361305, 5400.540954018874, 5479.999800072945, 4806.3805226151835, 5400.081986062379, 5477.75350109238, 5809.2738407699035, 5852.853678658068, 5089.05852417304, 5183.766730497061, 5429.755660995185, 5468.371137319259, 5514.420985796433, 2479.801615870726, 2530.70896846865, 2804.1867858320857, 3026.4552380571267, 3054.480738274499, 5351.879053129069, 5596.384397716248, 5798.652080875161, 5988.251468566429, 6037.607555508878, 5004.824831130893, 5119.48805119485, 5171.224316352577, 5944.524438044946, 5952.57138286808, 5306.787728490817, 5310.52205301517, 6059.363766804422, 6063.120847477179, 6076.354187487561, 4869.683470574401, 5068.59451243907, 5768.0, 5775.162601422854, 5778.595498315078, 5377.516023557742, 5481.698506582176, 5711.885762284648, 5745.9425405745405, 5785.652860828363, 5675.921574900755, 5955.821325360246, 6080.908786368296, 6113.23584551931, 6123.89769841415, 4291.82832686689, 4434.933475997798, 4619.630429565559, 4652.534746525321, 4709.869631288398, 5481.369642491165, 5495.175723641326, 5552.52803511706, 5757.0, 5783.640844401646, 5404.459554044564, 5581.888362232814, 5619.353774316006, 5621.269234999424, 5644.520215781705, 4579.9543303703995, 4975.328330675457, 5626.85932851682, 5636.718164091861, 5686.886262274814, 4461.933071003873, 4841.757912104451, 5058.54473097423, 5526.2592283430595, 5542.168674698666, 4826.203676393497, 5626.2967129108865, 5638.746256418389, 5642.852503409908, 5657.264555607745, 4657.627389808739, 5146.819861304836, 5231.607629427732, 5425.972870135624, 5497.900419916113], "value": 4232.366683202045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.939684825214, 759.8822182561703, 792.843465773097, 817.0644611919353, 898.8112496375762, 16413.015219086865, 17511.824881751196, 17531.82468175318, 17533.473995780147, 17542.64914701705, 16032.719836400807, 16062.437814676488, 16115.033098014128, 16307.673846523063, 16314.347426102971, 906.3293163059338, 958.650092716157, 1008.3848852200152, 1027.075631931264, 1028.408665017614, 1021.2136654775818, 1023.6212601337515, 1024.866767320251, 1027.152599105737, 1029.4235228272191, 1035.177034257767, 1081.4268437727978, 1084.6258040975852, 1084.8589683341154, 1086.440483151178, 1056.5351245451977, 1058.7194393485731, 1063.3194755356617, 1063.4257500949477, 1065.8720953485592, 779.9548604869445, 782.9608519573999, 783.3067735054461, 784.9607519623996, 787.3543694170783, 16787.160641967854, 17013.23440445183, 17071.231794569274, 18102.27590896376, 18396.724049139273, 14336.354864031144, 14366.0, 14425.422983080663, 14640.487582934653, 14718.190499522629, 12013.159078864483, 12107.697307567294, 12212.633620991384, 12232.571859984946, 12704.047196460302, 3879.5538513071074, 3882.1265215326325, 3910.5502867170353, 3910.863119790822, 4053.067794407273, 89782.55108724479, 91177.0, 111084.4445777766, 113921.86078139195, 117660.99999999914, 11258.605948791754, 11280.887191128148, 11544.365059921616, 11633.243839150427, 11686.883131168579, 23778.762212378002, 23844.16545420902, 24315.027398903847, 24367.025318987042, 24441.87779061093, 8135.3491720662205, 8209.0, 8244.134365891616, 8258.380621453414, 8298.253157215879, 4526.79629416677, 4608.216603177468, 4655.3947986761505, 4658.189100413951, 4672.159011377917, 3643.908902277464, 3713.6843368313994, 3740.1958578905123, 3743.981280093582, 3758.7368884177845, 572.802383177803, 644.5616980453243, 645.3062957320805, 656.3666062249856, 684.8424862281703, 687.7524091327118, 708.2987842036347, 708.6456771614193, 721.1994685898649, 753.3107206905729, 9156.633734650539, 9263.0, 9515.258542005711, 10808.675739727663, 11045.668629941114, 663.847315117516, 707.9079719636414, 726.5858460677363, 728.9088863892014, 732.3701616609711, 3990.700697447703, 4542.212359572832, 5078.339815823993, 5236.607254455931, 5244.370675518962, 95826.08347833143, 99065.0, 101457.49271253744, 106844.46577767062, 109773.45113274542, 58521.24436266919, 68448.0, 81614.0, 82559.3488130234, 85766.71349929756, 77495.61252193815, 79899.20100799034, 81285.0, 81375.0, 81751.5912420434, 10842.783144337227, 11214.943925280648, 11344.20590558653, 11416.600418985296, 11434.799346068543, 38351.04122396851, 49302.50697492979, 50575.74712126416, 51722.0, 52059.479405205464, 54613.0, 56507.43492565022, 62326.37673623206, 62712.37287627065, 63829.3617063842, 14390.424383024561, 14555.5390481851, 14700.926495367456, 14767.852321476648, 14901.627459313604, 15094.39622415091, 15933.601659958595, 16112.3304910494, 16367.0, 16379.754303685217, 13951.162930224218, 14005.859941400455, 14075.507357242448, 14362.928185359424, 15052.021618594756, 14748.410063597765, 15106.471273505374, 15207.543773686808, 15309.387624494895, 15523.45667901618, 14304.499342522962, 14592.978491505493, 14987.625309367353, 15037.211182821513, 15213.087214766707, 10045.648402305884, 10257.435841028815, 10266.178705703376, 10543.89456105429, 10795.244332896937, 11711.648650540497, 11898.0, 12087.659973466487, 12409.255444673348, 12485.687857803627], "value": 7989.807315936626, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 121.0, 124.0, 121.0, 121.0, 120.0, 120.0, 122.0, 121.0, 122.0], "value": 120.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 114.0, 93.0, 168.0, 138.0, 147.0, 134.0, 112.0, 136.0, 122.0], "value": 130.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 194.0, 194.0, 198.0, 221.0, 198.0, 220.0, 196.0, 181.0, 256.0], "value": 206.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 62.0, 86.0, 63.0, 63.0, 83.0, 53.0, 94.0, 85.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 74.0, 111.0, 81.0, 70.0, 69.0, 82.0, 72.0, 70.0, 87.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 88.0, 89.0, 90.0, 89.0, 104.0, 105.0, 110.0, 100.0, 86.0], "value": 96.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 120.0, 116.0, 93.0, 155.0, 154.0, 114.0, 153.0, 155.0, 95.0], "value": 129.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 109.0, 89.0, 93.0, 100.0, 128.0, 89.0, 124.0, 86.0, 140.0], "value": 104.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 69.0, 67.0, 69.0, 68.0, 69.0, 69.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 63.0, 66.0, 63.0, 59.0, 59.0, 60.0, 60.0, 60.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 86.0, 84.0, 81.0, 81.0, 90.0, 83.0, 80.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 132.0, 138.0, 142.0, 152.0, 147.0, 144.0, 181.0, 136.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 167.0, 162.0, 211.0, 219.0, 194.0, 164.0, 167.0, 162.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 64.0, 66.0, 65.0, 64.0, 64.0, 64.0, 64.0, 63.0], "value": 64.5, "unit": "score"}]}]} 15:48:14 INFO - Return code: 0 15:48:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:48:14 ERROR - # TBPL SUCCESS # 15:48:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:48:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:48:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:48:14 INFO - 2017-04-24 15:48:14.525 screenresolution[1660:10566] starting screenresolution argv=screenresolution get 15:48:14 INFO - 2017-04-24 15:48:14.527 screenresolution[1660:10566] Display 0: 1600x1200x32@60 15:48:14 INFO - 2017-04-24 15:48:14.533 screenresolution[1661:10569] starting screenresolution argv=screenresolution list 15:48:14 INFO - Available Modes on Display 0 15:48:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:48:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:48:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:48:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:48:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:48:14 INFO - Intel Iris: 15:48:14 INFO - Chipset Model: Intel Iris 15:48:14 INFO - Type: GPU 15:48:14 INFO - Bus: Built-In 15:48:14 INFO - VRAM (Dynamic, Max): 1536 MB 15:48:14 INFO - Vendor: Intel (0x8086) 15:48:14 INFO - Device ID: 0x0a2e 15:48:14 INFO - Revision ID: 0x0009 15:48:14 INFO - Displays: 15:48:14 INFO - Display: 15:48:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:48:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:48:14 INFO - Display Serial Number: 1600x1200 60 15:48:14 INFO - Main Display: Yes 15:48:14 INFO - Mirror: Off 15:48:14 INFO - Online: Yes 15:48:14 INFO - Rotation: Supported 15:48:14 INFO - Return code: 0 15:48:14 INFO - Running post-action listener: _resource_record_post_action 15:48:14 INFO - [mozharness: 2017-04-24 22:48:14.768900Z] Finished run-tests step (success) 15:48:14 INFO - Running post-run listener: _resource_record_post_run 15:48:14 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 48048128; Write bytes: 427680768; Read time: 525; Write time: 1521 15:48:14 INFO - TinderboxPrint: CPU usage
54.4% 15:48:14 INFO - TinderboxPrint: I/O read bytes / time
48,048,128 / 525 15:48:14 INFO - TinderboxPrint: I/O write bytes / time
427,680,768 / 1,521 15:48:14 INFO - TinderboxPrint: CPU idle
2,173.8 (45.6%) 15:48:14 INFO - TinderboxPrint: CPU system
960.0 (20.1%) 15:48:14 INFO - TinderboxPrint: CPU user
1,632.0 (34.2%) 15:48:14 INFO - TinderboxPrint: Swap in / out
163,409,920 / 0 15:48:14 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 123040256; Write bytes: 125179904; Read time: 11048; Write time: 289 15:48:14 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 42694656; Write bytes: 300977152; Read time: 487; Write time: 1226 15:48:15 INFO - Running post-run listener: _upload_blobber_files 15:48:15 INFO - Blob upload gear active. 15:48:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:48:15 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 15:48:15 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:48:15 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:48:15 INFO - (blobuploader) - INFO - Open directory for files ... 15:48:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:48:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:48:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:16 INFO - (blobuploader) - INFO - Done attempting. 15:48:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:48:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:48:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:17 INFO - (blobuploader) - INFO - Done attempting. 15:48:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:48:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:48:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:18 INFO - (blobuploader) - INFO - Done attempting. 15:48:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:48:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:48:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:48:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:48:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:48:21 INFO - (blobuploader) - INFO - Done attempting. 15:48:21 INFO - (blobuploader) - INFO - Iteration through files over. 15:48:21 INFO - Return code: 0 15:48:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:48:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:48:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/097bd48b356dce7aea70c66fe2762aa15e9f7b83779038ba31b4412802e302ecffbc1da2eae788aa78a997057ade80fef4ab0b62739a47c4065aaf5d58b17c3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/754734f16d37be765f2373bbe3f18a6cc6d133a68f780b3af77e93de470d738c9f7b5d2e4c1df7b0f6ea91e58f6eb9c178810f270f8c51ec3790705ef8162a11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c254a479de4d24eaf3813f9a0fbfcebab350e67018c2cdce975c0c049996ace7c2ec30e3585eb7f7910308e9f27e30b35739015907fbdf71ab4bfe4695b108e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae986ffd5ea68b09172bc1ce8081f64909b262195c891502e881233e21244c23a1368f0fb6757d63bf08db0e195db44d406408a6e4ef1c2c59057e2c1ab407bb"} 15:48:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:48:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:48:21 INFO - Contents: 15:48:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/097bd48b356dce7aea70c66fe2762aa15e9f7b83779038ba31b4412802e302ecffbc1da2eae788aa78a997057ade80fef4ab0b62739a47c4065aaf5d58b17c3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/754734f16d37be765f2373bbe3f18a6cc6d133a68f780b3af77e93de470d738c9f7b5d2e4c1df7b0f6ea91e58f6eb9c178810f270f8c51ec3790705ef8162a11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c254a479de4d24eaf3813f9a0fbfcebab350e67018c2cdce975c0c049996ace7c2ec30e3585eb7f7910308e9f27e30b35739015907fbdf71ab4bfe4695b108e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae986ffd5ea68b09172bc1ce8081f64909b262195c891502e881233e21244c23a1368f0fb6757d63bf08db0e195db44d406408a6e4ef1c2c59057e2c1ab407bb"} 15:48:21 INFO - Running post-run listener: copy_logs_to_upload_dir 15:48:21 INFO - Copying logs to upload dir... 15:48:21 INFO - mkdir: /builds/slave/test/build/upload/logs 15:48:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.035510 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-04-24 15:48:21.284537) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 15:48:21.287547) ========= 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.oHEkEdSgR7/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.ahA65XnC7Q/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/097bd48b356dce7aea70c66fe2762aa15e9f7b83779038ba31b4412802e302ecffbc1da2eae788aa78a997057ade80fef4ab0b62739a47c4065aaf5d58b17c3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/754734f16d37be765f2373bbe3f18a6cc6d133a68f780b3af77e93de470d738c9f7b5d2e4c1df7b0f6ea91e58f6eb9c178810f270f8c51ec3790705ef8162a11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c254a479de4d24eaf3813f9a0fbfcebab350e67018c2cdce975c0c049996ace7c2ec30e3585eb7f7910308e9f27e30b35739015907fbdf71ab4bfe4695b108e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae986ffd5ea68b09172bc1ce8081f64909b262195c891502e881233e21244c23a1368f0fb6757d63bf08db0e195db44d406408a6e4ef1c2c59057e2c1ab407bb"} build_url:https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/XBnagr59SoCzASBwKnqkmw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/097bd48b356dce7aea70c66fe2762aa15e9f7b83779038ba31b4412802e302ecffbc1da2eae788aa78a997057ade80fef4ab0b62739a47c4065aaf5d58b17c3e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/754734f16d37be765f2373bbe3f18a6cc6d133a68f780b3af77e93de470d738c9f7b5d2e4c1df7b0f6ea91e58f6eb9c178810f270f8c51ec3790705ef8162a11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c254a479de4d24eaf3813f9a0fbfcebab350e67018c2cdce975c0c049996ace7c2ec30e3585eb7f7910308e9f27e30b35739015907fbdf71ab4bfe4695b108e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae986ffd5ea68b09172bc1ce8081f64909b262195c891502e881233e21244c23a1368f0fb6757d63bf08db0e195db44d406408a6e4ef1c2c59057e2c1ab407bb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 15:48:21.326245) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 15:48:21.326554) ========= 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.oHEkEdSgR7/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.ahA65XnC7Q/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005137 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 15:48:21.375016) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 15:48:21.375348) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 15:48:21.375665) ========= ========= Total master_lag: 0.39 =========