builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0192 starttime: 1489453391.3 results: success (0) buildid: 20170313163836 builduid: 0a36c738e3374d6fb28bcda29dfd85c1 revision: ea823a8262ac96b7150df0a41beb2ba5e40fe89c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 18:03:11.299012) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-13 18:03:11.299607) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 18:03:11.299945) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-13 18:03:11.380128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-13 18:03:11.383518) ========= 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.3w1yn73MeT/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.BE2mYtcmzP/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-13 18:03:11-- 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% 11.3M=0.001s 2017-03-13 18:03:11 (11.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082368 ========= master_lag: 3.36 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-13 18:03:14.827333) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 18:03:14.827725) ========= 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.3w1yn73MeT/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.BE2mYtcmzP/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.028164 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 18:03:14.878719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-13 18:03:14.879106) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ea823a8262ac96b7150df0a41beb2ba5e40fe89c --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 ea823a8262ac96b7150df0a41beb2ba5e40fe89c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3w1yn73MeT/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.BE2mYtcmzP/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-13 18:03:14,981 truncating revision to first 12 chars 2017-03-13 18:03:14,981 Setting DEBUG logging. 2017-03-13 18:03:14,981 attempt 1/10 2017-03-13 18:03:14,981 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ea823a8262ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-13 18:03:15,786 unpacking tar archive at: mozilla-beta-ea823a8262ac/testing/mozharness/ program finished with exit code 0 elapsedTime=1.071323 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-13 18:03:15.974694) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 18:03:15.975061) ========= script_repo_revision: ea823a8262ac96b7150df0a41beb2ba5e40fe89c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-13 18:03:15.975511) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 18:03:15.975814) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-13 18:03:15.996175) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-13 18:03:15.996577) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.3w1yn73MeT/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.BE2mYtcmzP/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 18:03:16 INFO - MultiFileLogger online at 20170313 18:03:16 in /builds/slave/test 18:03:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 18:03:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:03:16 INFO - {'append_to_log': False, 18:03:16 INFO - 'base_work_dir': '/builds/slave/test', 18:03:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:03:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:03:16 INFO - 'branch': 'Mozilla-Beta', 18:03:16 INFO - 'buildbot_json_path': 'buildprops.json', 18:03:16 INFO - 'config_files': ('talos/mac_config.py',), 18:03:16 INFO - 'default_actions': ('clobber', 18:03:16 INFO - 'read-buildbot-config', 18:03:16 INFO - 'download-and-extract', 18:03:16 INFO - 'populate-webroot', 18:03:16 INFO - 'create-virtualenv', 18:03:16 INFO - 'install', 18:03:16 INFO - 'run-tests'), 18:03:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:03:16 INFO - 'download_minidump_stackwalk': True, 18:03:16 INFO - 'download_symbols': 'ondemand', 18:03:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:03:16 INFO - 'tooltool.py': '/tools/tooltool.py', 18:03:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:03:16 INFO - '/tools/misc-python/virtualenv.py')}, 18:03:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:03:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:03:16 INFO - 'installer_path': 'installer.exe', 18:03:16 INFO - 'log_level': 'info', 18:03:16 INFO - 'log_name': 'talos', 18:03:16 INFO - 'log_to_console': True, 18:03:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:03:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:03:16 INFO - 'opt_config_files': (), 18:03:16 INFO - 'pip_index': False, 18:03:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:03:16 INFO - 'cmd': ('bash', 18:03:16 INFO - '-c', 18:03:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:03:16 INFO - 'enabled': True, 18:03:16 INFO - 'halt_on_failure': False, 18:03:16 INFO - 'name': 'check_screen_resolution'},), 18:03:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:03:16 INFO - 'cmd': ('bash', 18:03:16 INFO - '-c', 18:03:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:03:16 INFO - 'enabled': True, 18:03:16 INFO - 'halt_on_failure': False, 18:03:16 INFO - 'name': 'check_screen_resolution'},), 18:03:16 INFO - 'run_cmd_checks_enabled': True, 18:03:16 INFO - 'sps_profile': False, 18:03:16 INFO - 'sps_profile_interval': 0, 18:03:16 INFO - 'suite': 'dromaeojs', 18:03:16 INFO - 'system_bits': '32', 18:03:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:03:16 INFO - 'title': 't-yosemite-r7-0192', 18:03:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:03:16 INFO - 'use_talos_json': True, 18:03:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:03:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:03:16 INFO - 'work_dir': 'build'} 18:03:16 INFO - [mozharness: 2017-03-14 01:03:16.210205Z] Running clobber step. 18:03:16 INFO - Running pre-action listener: _resource_record_pre_action 18:03:16 INFO - Running main action method: clobber 18:03:16 INFO - rmtree: /builds/slave/test/build 18:03:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:03:18 INFO - Running post-action listener: _resource_record_post_action 18:03:18 INFO - [mozharness: 2017-03-14 01:03:18.757267Z] Finished clobber step (success) 18:03:18 INFO - [mozharness: 2017-03-14 01:03:18.757406Z] Running read-buildbot-config step. 18:03:18 INFO - Running pre-action listener: _resource_record_pre_action 18:03:18 INFO - Running main action method: read_buildbot_config 18:03:18 INFO - Using buildbot properties: 18:03:18 INFO - { 18:03:18 INFO - "project": "", 18:03:18 INFO - "product": "firefox", 18:03:18 INFO - "script_repo_revision": "production", 18:03:18 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 18:03:18 INFO - "repository": "", 18:03:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 18:03:18 INFO - "buildid": "20170313163836", 18:03:18 INFO - "pgo_build": "False", 18:03:18 INFO - "basedir": "/builds/slave/test", 18:03:18 INFO - "buildnumber": 5, 18:03:18 INFO - "slavename": "t-yosemite-r7-0192", 18:03:18 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 18:03:18 INFO - "platform": "yosemite_r7", 18:03:18 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 18:03:18 INFO - "branch": "mozilla-beta", 18:03:18 INFO - "repo_path": "releases/mozilla-beta", 18:03:18 INFO - "revision": "ea823a8262ac96b7150df0a41beb2ba5e40fe89c", 18:03:18 INFO - "stage_platform": "macosx64", 18:03:18 INFO - "builduid": "0a36c738e3374d6fb28bcda29dfd85c1", 18:03:18 INFO - "slavebuilddir": "test" 18:03:18 INFO - } 18:03:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 18:03:18 INFO - Running post-action listener: _resource_record_post_action 18:03:18 INFO - [mozharness: 2017-03-14 01:03:18.760841Z] Finished read-buildbot-config step (success) 18:03:18 INFO - [mozharness: 2017-03-14 01:03:18.760948Z] Running download-and-extract step. 18:03:18 INFO - Running pre-action listener: _resource_record_pre_action 18:03:18 INFO - Running main action method: download_and_extract 18:03:18 INFO - mkdir: /builds/slave/test/build/tests 18:03:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:18 INFO - trying https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 18:03:18 INFO - Downloading https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 18:03:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 18:03:19 INFO - Downloaded 1165 bytes. 18:03:19 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 18:03:19 INFO - Using the following test package requirements: 18:03:19 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 18:03:19 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 18:03:19 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 18:03:19 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 18:03:19 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 18:03:19 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 18:03:19 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 18:03:19 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 18:03:19 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 18:03:19 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 18:03:19 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 18:03:19 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 18:03:19 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 18:03:19 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 18:03:19 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 18:03:19 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 18:03:19 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 18:03:19 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 18:03:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 18:03:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 18:03:19 INFO - Fetch https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 18:03:20 INFO - Expected file size: 16105394 18:03:20 INFO - Obtained file size: 16105394 18:03:27 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 18:03:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 18:03:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 18:03:27 INFO - Fetch https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 18:03:28 INFO - Expected file size: 16105394 18:03:28 INFO - Obtained file size: 16105394 18:03:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 18:03:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 18:03:34 INFO - Fetch https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 18:03:35 INFO - Expected file size: 14403650 18:03:35 INFO - Obtained file size: 14403650 18:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:36 INFO - trying https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 18:03:36 INFO - Downloading https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 18:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 18:03:37 INFO - Downloaded 58695061 bytes. 18:03:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 18:03:37 INFO - mkdir: /builds/slave/test/properties 18:03:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:03:37 INFO - Writing to file /builds/slave/test/properties/build_url 18:03:37 INFO - Contents: 18:03:37 INFO - build_url:https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 18:03:38 INFO - Running post-action listener: _resource_record_post_action 18:03:38 INFO - Running post-action listener: set_extra_try_arguments 18:03:38 INFO - [mozharness: 2017-03-14 01:03:38.554362Z] Finished download-and-extract step (success) 18:03:38 INFO - [mozharness: 2017-03-14 01:03:38.554485Z] Running populate-webroot step. 18:03:38 INFO - Running pre-action listener: _resource_record_pre_action 18:03:38 INFO - Running main action method: populate_webroot 18:03:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:03:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:03:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:03:38 INFO - '--tppagecycles', 18:03:38 INFO - '7'], 18:03:38 INFO - 'tests': ['tsvgm']}}, 18:03:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:03:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:03:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:03:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:03:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:03:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:03:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:03:38 INFO - 'talos_options': ['--disable-e10s'], 18:03:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:03:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:03:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:03:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:03:38 INFO - 'talos_options': ['--disable-e10s'], 18:03:38 INFO - 'tests': ['damp', 'tps']}, 18:03:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:03:38 INFO - 'tests': ['damp', 'tps']}, 18:03:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:03:38 INFO - 'tests': ['dromaeo_dom']}, 18:03:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:03:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:03:38 INFO - 'tests': ['basic_compositor_video']}, 18:03:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:03:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:03:38 INFO - 'tests': ['a11yr', 18:03:38 INFO - 'ts_paint', 18:03:38 INFO - 'tpaint', 18:03:38 INFO - 'sessionrestore', 18:03:38 INFO - 'sessionrestore_no_auto_restore', 18:03:38 INFO - 'tabpaint']}, 18:03:38 INFO - 'other-e10s': {'tests': ['a11yr', 18:03:38 INFO - 'ts_paint', 18:03:38 INFO - 'tpaint', 18:03:38 INFO - 'sessionrestore', 18:03:38 INFO - 'sessionrestore_no_auto_restore', 18:03:38 INFO - 'tabpaint']}, 18:03:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:03:38 INFO - 'ts_paint', 18:03:38 INFO - 'tpaint', 18:03:38 INFO - 'sessionrestore', 18:03:38 INFO - 'sessionrestore_no_auto_restore', 18:03:38 INFO - 'tabpaint']}, 18:03:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:03:38 INFO - 'ts_paint', 18:03:38 INFO - 'tpaint', 18:03:38 INFO - 'sessionrestore', 18:03:38 INFO - 'sessionrestore_no_auto_restore', 18:03:38 INFO - 'tabpaint']}, 18:03:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:03:38 INFO - 'tests': ['a11yr', 18:03:38 INFO - 'ts_paint', 18:03:38 INFO - 'tpaint', 18:03:38 INFO - 'sessionrestore', 18:03:38 INFO - 'sessionrestore_no_auto_restore', 18:03:38 INFO - 'tabpaint']}, 18:03:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:03:38 INFO - 'tests': ['a11yr', 18:03:38 INFO - 'ts_paint', 18:03:38 INFO - 'tpaint', 18:03:38 INFO - 'sessionrestore', 18:03:38 INFO - 'sessionrestore_no_auto_restore', 18:03:38 INFO - 'tabpaint']}, 18:03:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:03:38 INFO - 'tests': ['tsvgx', 18:03:38 INFO - 'tsvgr_opacity', 18:03:38 INFO - 'tart', 18:03:38 INFO - 'tscrollx', 18:03:38 INFO - 'cart', 18:03:38 INFO - 'tsvg_static']}, 18:03:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:03:38 INFO - 'tsvgr_opacity', 18:03:38 INFO - 'tart', 18:03:38 INFO - 'tscrollx', 18:03:38 INFO - 'cart', 18:03:38 INFO - 'tsvg_static']}, 18:03:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:03:38 INFO - 'talos_options': ['--disable-e10s'], 18:03:38 INFO - 'tests': ['tp5o']}, 18:03:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:03:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:03:38 INFO - 'talos_options': ['--disable-e10s', 18:03:38 INFO - '--xperf_path', 18:03:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:03:38 INFO - 'tests': ['tp5n']}, 18:03:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:03:38 INFO - 'talos_options': ['--xperf_path', 18:03:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:03:38 INFO - 'tests': ['tp5n']}}, 18:03:38 INFO - 'talos.zip': {'path': '', 18:03:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:03:38 INFO - Running post-action listener: _resource_record_post_action 18:03:38 INFO - [mozharness: 2017-03-14 01:03:38.572912Z] Finished populate-webroot step (success) 18:03:38 INFO - [mozharness: 2017-03-14 01:03:38.573029Z] Running create-virtualenv step. 18:03:38 INFO - Running pre-action listener: _resource_record_pre_action 18:03:38 INFO - Running main action method: create_virtualenv 18:03:38 INFO - Creating virtualenv /builds/slave/test/build/venv 18:03:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:03:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:03:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:03:38 INFO - Using real prefix '/tools/python27' 18:03:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:03:39 INFO - Installing distribute.............................................................................................................................................................................................done. 18:03:42 INFO - Installing pip.................done. 18:03:42 INFO - Return code: 0 18:03:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:03:42 INFO - Reading from file tmpfile_stdout 18:03:42 INFO - Output received: 18:03:42 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:03:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bd1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b0c7d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bafad30>, '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 0x10ba21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baefbe8>, '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.3w1yn73MeT/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.BE2mYtcmzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:03:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:03:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3w1yn73MeT/Render', 18:03:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:42 INFO - 'HOME': '/Users/cltbld', 18:03:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:42 INFO - 'LOGNAME': 'cltbld', 18:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:42 INFO - 'MOZ_NO_REMOTE': '1', 18:03:42 INFO - 'NO_EM_RESTART': '1', 18:03:42 INFO - 'PAGER': '/bin/cat', 18:03:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:42 INFO - 'PWD': '/builds/slave/test', 18:03:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:42 INFO - 'SHELL': '/bin/bash', 18:03:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BE2mYtcmzP/Listeners', 18:03:42 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 18:03:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:42 INFO - 'USER': 'cltbld', 18:03:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:42 INFO - 'XPC_FLAGS': '0x0', 18:03:42 INFO - 'XPC_SERVICE_NAME': '0', 18:03:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:03:42 INFO - Cleaning up... 18:03:42 INFO - Return code: 0 18:03:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bd1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b0c7d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bafad30>, '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 0x10ba21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baefbe8>, '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.3w1yn73MeT/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.BE2mYtcmzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:03:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:03:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3w1yn73MeT/Render', 18:03:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:42 INFO - 'HOME': '/Users/cltbld', 18:03:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:42 INFO - 'LOGNAME': 'cltbld', 18:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:42 INFO - 'MOZ_NO_REMOTE': '1', 18:03:42 INFO - 'NO_EM_RESTART': '1', 18:03:42 INFO - 'PAGER': '/bin/cat', 18:03:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:42 INFO - 'PWD': '/builds/slave/test', 18:03:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:42 INFO - 'SHELL': '/bin/bash', 18:03:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BE2mYtcmzP/Listeners', 18:03:42 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 18:03:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:42 INFO - 'USER': 'cltbld', 18:03:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:42 INFO - 'XPC_FLAGS': '0x0', 18:03:42 INFO - 'XPC_SERVICE_NAME': '0', 18:03:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:43 INFO - Downloading/unpacking psutil>=3.1.1 18:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:03:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:03:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:03:46 INFO - Installing collected packages: psutil 18:03:46 INFO - Running setup.py install for psutil 18:03:46 INFO - building 'psutil._psutil_osx' extension 18:03:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:03:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 18:03:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 18:03:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 18:03:47 INFO - building 'psutil._psutil_posix' extension 18:03:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 18:03:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:03:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:03:47 INFO - ^ 18:03:47 INFO - 1 warning generated. 18:03:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 18:03:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:03:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:03:47 INFO - Successfully installed psutil 18:03:47 INFO - Cleaning up... 18:03:47 INFO - Return code: 0 18:03:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:47 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 0x10bd1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b0c7d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bafad30>, '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 0x10ba21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baefbe8>, '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.3w1yn73MeT/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.BE2mYtcmzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:03:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3w1yn73MeT/Render', 18:03:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:47 INFO - 'HOME': '/Users/cltbld', 18:03:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:47 INFO - 'LOGNAME': 'cltbld', 18:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:47 INFO - 'MOZ_NO_REMOTE': '1', 18:03:47 INFO - 'NO_EM_RESTART': '1', 18:03:47 INFO - 'PAGER': '/bin/cat', 18:03:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:47 INFO - 'PWD': '/builds/slave/test', 18:03:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:47 INFO - 'SHELL': '/bin/bash', 18:03:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BE2mYtcmzP/Listeners', 18:03:47 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 18:03:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:47 INFO - 'USER': 'cltbld', 18:03:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:47 INFO - 'XPC_FLAGS': '0x0', 18:03:47 INFO - 'XPC_SERVICE_NAME': '0', 18:03:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:03:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:03:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:03:50 INFO - Installing collected packages: mozsystemmonitor 18:03:50 INFO - Running setup.py install for mozsystemmonitor 18:03:51 INFO - Successfully installed mozsystemmonitor 18:03:51 INFO - Cleaning up... 18:03:51 INFO - Return code: 0 18:03:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:51 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 0x10bd1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b0c7d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bafad30>, '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 0x10ba21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baefbe8>, '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.3w1yn73MeT/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.BE2mYtcmzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:03:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:03:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3w1yn73MeT/Render', 18:03:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:51 INFO - 'HOME': '/Users/cltbld', 18:03:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:51 INFO - 'LOGNAME': 'cltbld', 18:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:51 INFO - 'MOZ_NO_REMOTE': '1', 18:03:51 INFO - 'NO_EM_RESTART': '1', 18:03:51 INFO - 'PAGER': '/bin/cat', 18:03:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:51 INFO - 'PWD': '/builds/slave/test', 18:03:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:51 INFO - 'SHELL': '/bin/bash', 18:03:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BE2mYtcmzP/Listeners', 18:03:51 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 18:03:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:51 INFO - 'USER': 'cltbld', 18:03:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:51 INFO - 'XPC_FLAGS': '0x0', 18:03:51 INFO - 'XPC_SERVICE_NAME': '0', 18:03:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:51 INFO - Downloading/unpacking jsonschema==2.5.1 18:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:03:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:54 INFO - Downloading functools32-3.2.3-2.tar.gz 18:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:03:54 INFO - warning: no files found matching '*.txt' 18:03:54 INFO - no previously-included directories found matching 'build' 18:03:54 INFO - no previously-included directories found matching 'dist' 18:03:54 INFO - no previously-included directories found matching '.git*' 18:03:54 INFO - Installing collected packages: jsonschema, functools32 18:03:54 INFO - Running setup.py install for functools32 18:03:54 INFO - warning: no files found matching '*.txt' 18:03:54 INFO - no previously-included directories found matching 'build' 18:03:54 INFO - no previously-included directories found matching 'dist' 18:03:54 INFO - no previously-included directories found matching '.git*' 18:03:54 INFO - Successfully installed jsonschema functools32 18:03:54 INFO - Cleaning up... 18:03:54 INFO - Return code: 0 18:03:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10bd1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b0c7d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bafad30>, '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 0x10ba21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baefbe8>, '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.3w1yn73MeT/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.BE2mYtcmzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:03:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:03:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3w1yn73MeT/Render', 18:03:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:54 INFO - 'HOME': '/Users/cltbld', 18:03:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:54 INFO - 'LOGNAME': 'cltbld', 18:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:54 INFO - 'MOZ_NO_REMOTE': '1', 18:03:54 INFO - 'NO_EM_RESTART': '1', 18:03:54 INFO - 'PAGER': '/bin/cat', 18:03:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:54 INFO - 'PWD': '/builds/slave/test', 18:03:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:54 INFO - 'SHELL': '/bin/bash', 18:03:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BE2mYtcmzP/Listeners', 18:03:54 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 18:03:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:54 INFO - 'USER': 'cltbld', 18:03:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:54 INFO - 'XPC_FLAGS': '0x0', 18:03:54 INFO - 'XPC_SERVICE_NAME': '0', 18:03:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:03:55 INFO - Cleaning up... 18:03:55 INFO - Return code: 0 18:03:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:55 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 0x10bd1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b0c7d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bafad30>, '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 0x10ba21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baefbe8>, '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.3w1yn73MeT/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.BE2mYtcmzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:03:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:03:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3w1yn73MeT/Render', 18:03:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:03:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:03:55 INFO - 'HOME': '/Users/cltbld', 18:03:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:03:55 INFO - 'LOGNAME': 'cltbld', 18:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:55 INFO - 'MOZ_NO_REMOTE': '1', 18:03:55 INFO - 'NO_EM_RESTART': '1', 18:03:55 INFO - 'PAGER': '/bin/cat', 18:03:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:55 INFO - 'PWD': '/builds/slave/test', 18:03:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:03:55 INFO - 'SHELL': '/bin/bash', 18:03:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BE2mYtcmzP/Listeners', 18:03:55 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 18:03:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:03:55 INFO - 'USER': 'cltbld', 18:03:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:03:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:55 INFO - 'XPC_FLAGS': '0x0', 18:03:55 INFO - 'XPC_SERVICE_NAME': '0', 18:03:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:55 INFO - Downloading/unpacking blobuploader==1.2.4 18:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:03:57 INFO - Downloading blobuploader-1.2.4.tar.gz 18:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:03:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:03:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03:59 INFO - Downloading docopt-0.6.1.tar.gz 18:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:03:59 INFO - Installing collected packages: blobuploader, requests, docopt 18:03:59 INFO - Running setup.py install for blobuploader 18:03:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:03:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:03:59 INFO - Running setup.py install for requests 18:04:00 INFO - Running setup.py install for docopt 18:04:00 INFO - Successfully installed blobuploader requests docopt 18:04:00 INFO - Cleaning up... 18:04:00 INFO - Return code: 0 18:04:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:00 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 0x10bd1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b0c7d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bafad30>, '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 0x10ba21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baefbe8>, '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.3w1yn73MeT/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.BE2mYtcmzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:04:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3w1yn73MeT/Render', 18:04:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:00 INFO - 'HOME': '/Users/cltbld', 18:04:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:00 INFO - 'LOGNAME': 'cltbld', 18:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:00 INFO - 'MOZ_NO_REMOTE': '1', 18:04:00 INFO - 'NO_EM_RESTART': '1', 18:04:00 INFO - 'PAGER': '/bin/cat', 18:04:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:00 INFO - 'PWD': '/builds/slave/test', 18:04:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:00 INFO - 'SHELL': '/bin/bash', 18:04:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BE2mYtcmzP/Listeners', 18:04:00 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 18:04:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:00 INFO - 'USER': 'cltbld', 18:04:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:00 INFO - 'XPC_FLAGS': '0x0', 18:04:00 INFO - 'XPC_SERVICE_NAME': '0', 18:04:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:04:00 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-7dHUnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:04:00 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-H7Jkiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:04:00 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-AsHdv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:04:00 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-7r0OwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:04:00 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Ic_aBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:04:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Y81wcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:04:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Ty66UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:04:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-pMRJNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:04:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-5YNZkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:04:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-1FX_wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:04:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-ZY9DVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:04:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-WSgelu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:04:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-HFpivH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:04:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-F9wXXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:01 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-QZKunM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:04:02 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-5YFiuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:04:02 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-oo_luV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:04:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:04:02 INFO - Running setup.py install for manifestparser 18:04:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:04:02 INFO - Running setup.py install for mozcrash 18:04:02 INFO - Running setup.py install for mozdebug 18:04:02 INFO - Running setup.py install for mozdevice 18:04:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:04:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:04:02 INFO - Running setup.py install for mozfile 18:04:03 INFO - Running setup.py install for mozhttpd 18:04:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:04:03 INFO - Running setup.py install for mozinfo 18:04:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:04:03 INFO - Running setup.py install for mozInstall 18:04:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:04:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:04:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:04:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:04:03 INFO - Running setup.py install for mozleak 18:04:03 INFO - Running setup.py install for mozlog 18:04:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:04:03 INFO - Running setup.py install for moznetwork 18:04:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:04:03 INFO - Running setup.py install for mozprocess 18:04:04 INFO - Running setup.py install for mozprofile 18:04:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:04:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:04:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:04:04 INFO - Running setup.py install for mozrunner 18:04:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:04:04 INFO - Running setup.py install for mozscreenshot 18:04:04 INFO - Running setup.py install for moztest 18:04:04 INFO - Running setup.py install for mozversion 18:04:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:04:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:04:04 INFO - Cleaning up... 18:04:04 INFO - Return code: 0 18:04:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:04 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 0x10bd1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b0c7d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bafad30>, '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 0x10ba21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baefbe8>, '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.3w1yn73MeT/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.BE2mYtcmzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:04:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:04:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:04:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3w1yn73MeT/Render', 18:04:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:04 INFO - 'HOME': '/Users/cltbld', 18:04:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:04 INFO - 'LOGNAME': 'cltbld', 18:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:04 INFO - 'MOZ_NO_REMOTE': '1', 18:04:04 INFO - 'NO_EM_RESTART': '1', 18:04:04 INFO - 'PAGER': '/bin/cat', 18:04:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:04 INFO - 'PWD': '/builds/slave/test', 18:04:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:04 INFO - 'SHELL': '/bin/bash', 18:04:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BE2mYtcmzP/Listeners', 18:04:04 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 18:04:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:04 INFO - 'USER': 'cltbld', 18:04:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:04 INFO - 'XPC_FLAGS': '0x0', 18:04:04 INFO - 'XPC_SERVICE_NAME': '0', 18:04:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:04:05 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-82C_Xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:04:05 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-x4y_tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:04:05 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-LoROId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:04:05 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-HcN9QR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:04:05 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Z32_fX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:04:05 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-95ERaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:04:05 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-o9U4QX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:04:05 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-7oACbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:04:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:04:05 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-TCpN6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:04:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-MQKKlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:04:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-BdWxYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:04:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-JxOgJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:04:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-lXKCSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:04:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-K3trgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-rAx_EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:04:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-8fZyFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:04:06 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Jyp5Zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:04:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:04:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:04:09 INFO - Downloading blessings-1.6.tar.gz 18:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:04:10 INFO - Installing collected packages: blessings 18:04:10 INFO - Running setup.py install for blessings 18:04:10 INFO - Successfully installed blessings 18:04:10 INFO - Cleaning up... 18:04:10 INFO - Return code: 0 18:04:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:04:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:04:10 INFO - Reading from file tmpfile_stdout 18:04:10 INFO - Current package versions: 18:04:10 INFO - blessings == 1.6 18:04:10 INFO - blobuploader == 1.2.4 18:04:10 INFO - docopt == 0.6.1 18:04:10 INFO - functools32 == 3.2.3-2 18:04:10 INFO - jsonschema == 2.5.1 18:04:10 INFO - manifestparser == 1.1 18:04:10 INFO - mozInstall == 1.12 18:04:10 INFO - mozcrash == 1.0 18:04:10 INFO - mozdebug == 0.1 18:04:10 INFO - mozdevice == 0.49 18:04:10 INFO - mozfile == 1.2 18:04:10 INFO - mozhttpd == 0.7 18:04:10 INFO - mozinfo == 0.9 18:04:10 INFO - mozleak == 0.1 18:04:10 INFO - mozlog == 3.4 18:04:10 INFO - moznetwork == 0.27 18:04:10 INFO - mozprocess == 0.24 18:04:10 INFO - mozprofile == 0.28 18:04:10 INFO - mozrunner == 6.13 18:04:10 INFO - mozscreenshot == 0.1 18:04:10 INFO - mozsystemmonitor == 0.3 18:04:10 INFO - moztest == 0.8 18:04:10 INFO - mozversion == 1.4 18:04:10 INFO - psutil == 3.1.1 18:04:10 INFO - requests == 1.2.3 18:04:10 INFO - wsgiref == 0.1.2 18:04:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:11 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 0x10bd1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b0c7d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bafad30>, '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 0x10ba21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baefbe8>, '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.3w1yn73MeT/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.BE2mYtcmzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:04:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:04:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3w1yn73MeT/Render', 18:04:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:11 INFO - 'HOME': '/Users/cltbld', 18:04:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:11 INFO - 'LOGNAME': 'cltbld', 18:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:11 INFO - 'MOZ_NO_REMOTE': '1', 18:04:11 INFO - 'NO_EM_RESTART': '1', 18:04:11 INFO - 'PAGER': '/bin/cat', 18:04:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:11 INFO - 'PWD': '/builds/slave/test', 18:04:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:11 INFO - 'SHELL': '/bin/bash', 18:04:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BE2mYtcmzP/Listeners', 18:04:11 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 18:04:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:11 INFO - 'USER': 'cltbld', 18:04:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:11 INFO - 'XPC_FLAGS': '0x0', 18:04:11 INFO - 'XPC_SERVICE_NAME': '0', 18:04:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:04:11 INFO - Cleaning up... 18:04:11 INFO - Return code: 0 18:04:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:11 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 0x10bd1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bd1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b0c7d4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bafad30>, '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 0x10ba21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baefbe8>, '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.3w1yn73MeT/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.BE2mYtcmzP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:04:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:04:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3w1yn73MeT/Render', 18:04:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:11 INFO - 'HOME': '/Users/cltbld', 18:04:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:11 INFO - 'LOGNAME': 'cltbld', 18:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:11 INFO - 'MOZ_NO_REMOTE': '1', 18:04:11 INFO - 'NO_EM_RESTART': '1', 18:04:11 INFO - 'PAGER': '/bin/cat', 18:04:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:11 INFO - 'PWD': '/builds/slave/test', 18:04:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:11 INFO - 'SHELL': '/bin/bash', 18:04:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BE2mYtcmzP/Listeners', 18:04:11 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 18:04:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:11 INFO - 'USER': 'cltbld', 18:04:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:11 INFO - 'XPC_FLAGS': '0x0', 18:04:11 INFO - 'XPC_SERVICE_NAME': '0', 18:04:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:04:11 INFO - Cleaning up... 18:04:11 INFO - Return code: 0 18:04:11 INFO - Running post-action listener: _resource_record_post_action 18:04:11 INFO - Running post-action listener: _start_resource_monitoring 18:04:11 INFO - Starting resource monitoring. 18:04:11 INFO - [mozharness: 2017-03-14 01:04:11.583794Z] Finished create-virtualenv step (success) 18:04:11 INFO - [mozharness: 2017-03-14 01:04:11.584712Z] Running install step. 18:04:11 INFO - Running pre-action listener: _resource_record_pre_action 18:04:11 INFO - Running main action method: install 18:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:04:11 INFO - Reading from file tmpfile_stdout 18:04:11 INFO - Detecting whether we're running mozinstall >=1.0... 18:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:04:11 INFO - Reading from file tmpfile_stdout 18:04:11 INFO - Output received: 18:04:11 INFO - Usage: mozinstall [options] installer 18:04:11 INFO - Options: 18:04:11 INFO - -h, --help show this help message and exit 18:04:11 INFO - -d DEST, --destination=DEST 18:04:11 INFO - Directory to install application into. [default: 18:04:11 INFO - "/builds/slave/test"] 18:04:11 INFO - --app=APP Application being installed. [default: firefox] 18:04:11 INFO - mkdir: /builds/slave/test/build/application 18:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 18:04:26 INFO - Reading from file tmpfile_stdout 18:04:26 INFO - Output received: 18:04:26 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 18:04:26 INFO - Running post-action listener: _resource_record_post_action 18:04:26 INFO - [mozharness: 2017-03-14 01:04:26.666331Z] Finished install step (success) 18:04:26 INFO - [mozharness: 2017-03-14 01:04:26.666488Z] Running run-tests step. 18:04:26 INFO - Running pre-action listener: _resource_record_pre_action 18:04:26 INFO - Running main action method: run_tests 18:04:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:04:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:04:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:04:26 INFO - 2017-03-13 18:04:26.680 screenresolution[1632:7291] starting screenresolution argv=screenresolution get 18:04:26 INFO - 2017-03-13 18:04:26.683 screenresolution[1632:7291] Display 0: 1600x1200x32@60 18:04:26 INFO - 2017-03-13 18:04:26.689 screenresolution[1633:7293] starting screenresolution argv=screenresolution list 18:04:26 INFO - Available Modes on Display 0 18:04:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:04:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:04:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:04:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:04:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:04:26 INFO - Intel Iris: 18:04:26 INFO - Chipset Model: Intel Iris 18:04:26 INFO - Type: GPU 18:04:26 INFO - Bus: Built-In 18:04:26 INFO - VRAM (Dynamic, Max): 1536 MB 18:04:26 INFO - Vendor: Intel (0x8086) 18:04:26 INFO - Device ID: 0x0a2e 18:04:26 INFO - Revision ID: 0x0009 18:04:26 INFO - Displays: 18:04:26 INFO - Display: 18:04:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:04:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:04:26 INFO - Display Serial Number: 1600x1200 60 18:04:26 INFO - Main Display: Yes 18:04:26 INFO - Mirror: Off 18:04:26 INFO - Online: Yes 18:04:26 INFO - Rotation: Supported 18:04:26 INFO - Return code: 0 18:04:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:04:26 INFO - Python 2.7.3 18:04:26 INFO - Return code: 0 18:04:26 INFO - grabbing minidump binary from tooltool 18:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:04:26 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 0x10bafad30>, '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 0x10ba21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10baefbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:04:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:04:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:04:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:04:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:04:27 INFO - Return code: 0 18:04:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:04:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:04:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:04:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:04:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:04:27 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', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:04:27 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 --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0192 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:04:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3w1yn73MeT/Render', 18:04:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:04:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:04:27 INFO - 'HOME': '/Users/cltbld', 18:04:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:04:27 INFO - 'LOGNAME': 'cltbld', 18:04:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:04:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:27 INFO - 'MOZ_NO_REMOTE': '1', 18:04:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:04:27 INFO - 'NO_EM_RESTART': '1', 18:04:27 INFO - 'PAGER': '/bin/cat', 18:04:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:27 INFO - 'PWD': '/builds/slave/test', 18:04:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:04:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:04:27 INFO - 'SHELL': '/bin/bash', 18:04:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BE2mYtcmzP/Listeners', 18:04:27 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 18:04:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:04:27 INFO - 'USER': 'cltbld', 18:04:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:04:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:27 INFO - 'XPC_FLAGS': '0x0', 18:04:27 INFO - 'XPC_SERVICE_NAME': '0', 18:04:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:04:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:04:27 INFO - mozversion application_buildid: 20170313163836 18:04:27 INFO - mozversion application_changeset: ea823a8262ac96b7150df0a41beb2ba5e40fe89c 18:04:27 INFO - mozversion application_display_name: Firefox 18:04:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:04:27 INFO - mozversion application_name: Firefox 18:04:27 INFO - mozversion application_remotingname: firefox 18:04:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:04:27 INFO - mozversion application_vendor: Mozilla 18:04:27 INFO - mozversion application_version: 53.0 18:04:27 INFO - mozversion platform_buildid: 20170313163836 18:04:27 INFO - mozversion platform_changeset: ea823a8262ac96b7150df0a41beb2ba5e40fe89c 18:04:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:04:27 INFO - mozversion platform_version: 53.0 18:04:27 INFO - using testdate: 1489453467 18:04:27 INFO - actual date: 1489453467 18:04:27 INFO - starting webserver on 'localhost:49246' 18:04:27 INFO - SUITE-START | Running 2 tests 18:04:27 INFO - TEST-START | dromaeo_css 18:04:27 INFO - operating with platform_type : mac_ 18:04:27 INFO - Initialising browser for dromaeo_css test... 18:04:27 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpkl_deZ/profile http://localhost:49246/getInfo.html) 18:04:29 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 18:04:29 INFO - PROCESS | 1643 | colorDepth:24 18:04:29 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 18:04:29 INFO - PROCESS | 1643 | __metrics 18:04:29 INFO - PROCESS | 1643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:04:29 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:04:30 INFO - TEST-INFO | 1643: exit 0 18:04:30 INFO - Browser initialized. 18:04:30 INFO - Running cycle 1/1 for dromaeo_css test... 18:04:30 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpkl_deZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:04:42 INFO - PROCESS | 1646 | RSS: Main: 166989824 18:04:42 INFO - PROCESS | 1646 | 18:07:44 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 18:07:46 INFO - PROCESS | 1646 | RSS: Main: 304291840 18:07:46 INFO - PROCESS | 1646 | 18:10:49 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 18:10:49 INFO - PROCESS | 1646 | RSS: Main: 327020544 18:10:49 INFO - PROCESS | 1646 | 18:13:51 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 18:13:52 INFO - PROCESS | 1646 | RSS: Main: 285876224 18:13:52 INFO - PROCESS | 1646 | 18:16:54 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 18:16:55 INFO - PROCESS | 1646 | RSS: Main: 276692992 18:16:55 INFO - PROCESS | 1646 | 18:19:58 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 18:19:59 INFO - PROCESS | 1646 | RSS: Main: 269238272 18:19:59 INFO - PROCESS | 1646 | 18:23:02 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 18:23:03 INFO - PROCESS | 1646 | RSS: Main: 308764672 18:23:03 INFO - PROCESS | 1646 | 18:23:03 INFO - PROCESS | 1646 | __start_tp_report 18:23:03 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 18:23:03 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 18:23:03 INFO - PROCESS | 1646 | |i|pagename|runs| 18:23:03 INFO - PROCESS | 1646 | |0;dojo.html;3340.2150494633765;3357.244619960508;3364.27668051369;3365.2932884094325;3407.2844702612465;5554.444555544449;5567.248421463101;5576.442355764421;5583.888322233553;5603.299587551556;5599.916001259984;5710;5723.456271654197;5729.39841316662;5737.770489180438;5089.872753181172;5101.285819985205;5139.820106296281;5150.381954165506;5189.42916279209;4951.480094590071;5112.105381558231;5121.897562048757;5217.217417387385;5267;5101.4133374662015;5112.130937740593;5145.74271286436;5155.510226528474;5194.2208668699805;5148.691078535281;5179.559737422323;5180.2488639147305;5186.377634683824;5190.4031036430915;5033.597312215014;5112.769925353331;5151.278820965068;5170.819021334235;5193.532582067632;4660.883477913046;5499.807506737245;5551.444855514456;5555.694436805974;5557.72211389433;6136.447719705248;6173.783917562864;6177.351378105279;6185.41238582334;6191.102290167945;6228.96885515574;6260.968695156541;6285.748570057192;6305.369463053704;6309.274433440167;5645.379008309083;5662.094064949588;5729.971350143306;5767.1349297605275;5768.7980920668;5903.970480147572;6302.1492098566105;6341.8097457076365;6368;6382.585131966407;6109.890546867989;6111.77406523465;6133.622130947029;6136.004954352043;6147.44672979434;6179.2584889812615;6211.627302361872;6226.941419958618;6237.781677641261;6256.937430625727;5994.6403215807195;6068.787592434243;6074.240719910012;6182.412670796267;6196.256449226032;6125.788171442211;6128.319797384577;6139.447449729546;6142.007694998198;6145.508359331243;4907.092187945242;4939.802407903644;4980.8256711015665;4982.07831551157;4987.1771157759285;4405.625521830681;4427.2252355838245;4432.84485043022;4451.532589078165;4463.955360446354;5716.571257155647;5832.416758324219;5855.4730074292665;5862.091375836752;5865.794697185664;6154.415330543681;6177.752889884354;6213.130161777355;6222.62664240147;6236.03341482071;4998.500149984972;5757.165211044459;5874.030784920526;5911.645301281937;5922.407759224129;5381.623286369917;5406.135018397038;5417.079096553595;5423.593230507728;5430.56555475561;6246.843828904313;6250.343713909974;6276.089966954674;6315.810525684236;6326.683665816783;5163.225516172454;6225.31521532622;6253.062040693932;6266;6268.623882567061;6327.810165695037;6345.1434056401795;6364.109024736448;6367.267764207176;6373;5995.340512543704;6079.1793107931635;6111.572189946839;6129.417705317987;6150.846228844314;6162.691865406801;6261.436470717657;6306.527010474141;6307.936920630735;6311.147995020797;6086.786962456293;6096.603720758137;6113.57204995646;6113.755449781959;6115.510759139347;5926.4666180044005;6006.219191505251;6035.547333949883;6103.969480152571;6104;5060.7095190727605;5683.119116536944;5846.123081537803;5952.880942381042;5980.790672326448;6051.727672254671;6064.605800622945;6070.908936366046;6080.0575910733905;6097.695115244309;5687.090065589651;5878.118282257696;5891.528677705859;5896.941030589811;5898.528117750484 18:23:03 INFO - PROCESS | 1646 | |1;ext.html;479.5683884503946;481.6435837480266;500.1871958068139;541.6966498760694;554.970529667467;33996.83001584992;42471.78764106179;43888.12223755523;44239.55760442395;45676.314855277196;45271.773641131746;45613.7719311403;45803;45803.31295030577;45942.62172134833;9001.234895033896;9511.571979260916;9727.854082188773;9751.317407781458;9772.560234789451;8947.910520894773;11637.069034477265;11835.644930652052;11876.52493900243;11980.64058078259;11578.131640127023;11589.594364197255;11635.24370915892;11636.418179091053;11745.471453784558;11698.707532311675;11773.587924422603;11780.764384712344;11783.939445449865;11802.881971180306;11601.825972610417;11683.883161168449;11690.415479226005;11691.766164676745;11697.23967942081;41580;42374;42685.14629707419;42752;42799.572004280184;4100.897477563055;4147.066909945268;4150.377443383486;4156.521999969982;4171.300613925302;30416.39167216643;31732.206694832585;32889.17777055593;33280.500792488136;33522.99431017073;3096.086654436924;3137.2784259620416;3140.1521589170798;3161.4783560712685;3195.7123858852583;516108;516428;517027.41486292705;517139;518312;63670;64172.67913660402;64186.358136418974;64294;64318.678406608604;66317.66841165764;67412.98880516796;67457;67483.66258168677;67486.32513674899;17586.560335991446;17834.46496605078;17849.28602855897;17864.642707146046;17878.731819022723;12510.74978500425;12940.223586584834;13776.862231377758;13850.238236897067;13912.93043534796;12475.313857737912;16433.178341082898;16745.581360465843;16748.078855663054;16878.662426751398;6212.97485914819;7093.82265443368;7224.399216282134;7297.671604777798;7302.160251571137;901.724973882972;904.3579058868146;910.5310764955921;942.2744486745167;950.3442624589012;30360.84819575932;30953.53569696456;31322.219457576513;31672.683273167433;31780.523292150174;1025.5077562769911;1141.0985321596013;1143.5825923537848;1163.5752950173126;1213.2356615332285;15712.450064247696;15895.284712187748;15918.76121858173;16094.733191299469;16363.509094727176;672233;674251;675362;676873.2312676909;678226;63899.88800895917;64249.715005699625;64413.677931610044;64573.03140452803;64645.67677161678;1357.1856885868597;1400.8038874557367;1475.2697414779539;1494.9476768313057;1524.923753812327;28423.857880710464;31018.0694579163;31884.043478695676;32880.50679239765;32891.01326960195;52377.7381113092;53380.46619533755;54726;54765.726171368886;56749.43250567441;609773;616378;617239;618038;619586;23129.306120816404;23659.40851478658;23671.408214794767;24176.637350439407;25105;37184.62815371811;42378;45613.08773824571;45675.62973110812;46475.3028704563;32584;35323.40297910565;36569.45145822762;37939.81030094942;38139.80930095332;36387.54449821977;36559.63440365669;37147.25705485929;37491.43762843614;37883.81058094692;36614;37169.25661486701;37535.62464375431;37583.81208093942;37600.2479950394;29089.563656544746;32217.838910805294;32711.69153233844;32715.34569308553;32908.67091329152;24508.019679212633;24758.38104047413;24765.752342476346;24851.982833982012;25198.24405267845 18:23:03 INFO - PROCESS | 1646 | |2;jquery.html;403.7214322117739;405.1896207584832;409.76029023021533;418.7278269125068;434.2942718083115;18863;20974.7211339306;21896.014679339427;22095.44761380966;22257.332280031584;21945.01247443865;22254.221102261425;22624.773752262474;22718.318450446473;23038.769612303913;5946.672932988695;6259.718312675917;6260.499160067184;6282.497400207995;6282.560220784547;5117.513836185575;5982.401759824026;5998.370171132034;6089.847753806146;6128.203333566652;6060.909086363708;6064.848378790522;6069.484093852006;6071.301800292957;6075.270967483908;5399.758055647204;5881.206037184989;6120.785772497941;6122.051082082262;6124.203853499062;5253.159494480903;5369.48989845964;5371.650842695212;5373.220882971987;5376.811811586615;13210.471581136742;13953.953453490927;13954.441822327095;13959.65100872476;17564.560885977953;2639.6700412448445;2644.418227989839;2655.668041494813;2676.6921803992595;2697.5144473994674;9436.433813971184;9548.42709437436;10561.366318020944;10570.101541368993;10573.524191411405;1658.3118006027485;1806.8283513066237;1832.7067669172868;1839.6504664113775;1843.3916807453509;116732.41633791862;125245.37377313146;129465.35267323698;131229.6877031227;133298;9922.355046921926;11740;11807.468663910146;11831.343611894341;12162.209456385306;15848.60378490547;15860.52418427449;15864.365425382855;15874.365025398854;15905.204739762965;8800.47197168172;8912.73261802147;8969.865452018224;8970.596323165473;9075.773105672279;8681.609327580149;8701.129887011248;8741.781455463664;8873.378863479624;8907.777305567282;4832.371791667131;4847.563719265213;4870.8782280442565;4881.316615673809;4939.802407903716;2012.2454079720105;2067.3487851327086;2075.98962005189;2079.1059844266806;2079.4073688998565;912.5665308978182;979.5200351827554;990.6483198464585;999.5402115027024;1007.5365331947386;20962.161513539286;21481.892590536947;21571.67642485364;21633.35099947004;21685.02417391221;992.6873034993954;1002.283367392318;1026.3226270661478;1032.230987914009;1038.6520515627199;10742.838857417146;11137.331760094421;11140.941610546985;11808.822867656992;12606.243625382507;472542;546497;775006;780599;848641;149294;152515.2374238144;155375.22312388365;163364;169087;1116.4083035990939;1130.739929816147;1164.4992653159054;1166.2419427372276;1170.6605084525393;19377.684319112603;20484.590308193456;20545.691814622493;20567.177312907315;20574.588508230052;60344.90472615896;60664;61069;61472.69263653653;61980.69009654923;83913.34996475239;83952;84015;84724.57637711772;85921.57039214764;8302.294304983903;8359.582020899052;8618.008928972997;8859.64561417536;8879.822403551763;12754.936225318814;13076.673083172996;13152.342382881008;13771.173729576258;13795.724085518434;11035.834462482908;11428.314301141958;11639.88360116388;11817.704557386134;11989.460474278503;9245.630174792934;11579.942100289445;11602.825957610812;11956.983656389304;12093.213941093802;11596.130290228099;11690.357030363411;11943.522259109886;12027.75944481088;12174.269543827399;8491.915080849112;8547.914520854712;8605;8669;8682.956585217033;11211.26225435059;11269.211155219056;11420.600278990196;11717.414129293671;11923.642290731292 18:23:03 INFO - PROCESS | 1646 | |3;mootools.html;1236.2953116723465;1363.7477066742647;1464.9780253296203;1489.7318482673115;1498.3856618786297;7767.22327767223;8269.173082691728;8487.363447741413;8503.404761666678;8623.65505379784;8391.87412188816;8452.070272270046;8469;8476.32189424846;8490.320774338054;2144.860584062039;2388.653645221442;2425.1269542964606;2426.5268272686835;2427.757224277576;2225.5660146271484;2234.944126396837;2239.876806775627;2242.8990695418747;2365.325882123595;2397.496525729599;2405.1581946318825;2408.5303365843665;2409.204962362425;2416.0577374823833;2348.9530209395716;2378.250850981935;2379.6430535419654;2380.95238095238;2382.452036031705;2241.4396400899777;2262.490939538607;2268.432891777056;2303.4702018535663;2305.9308220753237;8472.915270847336;8475.152484751537;8557.400981931267;8558.871616925751;8564.143585641448;5160.638755287131;5298.735063246861;5301.019311427398;5316.813911513117;5323.920141197885;2750.6561679790025;2939.8971036013636;3524.400851855191;3529.5588051493564;3595.0652830264057;1205.3189947679532;1209.830623712681;1225.6874497003207;1234.666640007202;1253.7053792358788;10865.83701244482;10877.129829613612;10941.398223097727;10950.959658832398;10956.945215273872;4278.4865816102265;4511.962248682756;4587.403637527167;4590.334401511829;4591.586757191869;8822.38243322974;8823.470591764515;8829.823403532022;8842.425242359226;8842.734717958472;5204.479552044765;5207.973960130251;5210.895782084337;5215.400228973641;5215.6609820361555;4640.211164102043;4813.229883218738;4818.566329030404;4886.267059940967;4909.729964851967;3452.6374730653424;3650.452432135201;3684.8526058957877;3711.5917249102577;3782.243551289753;1179.2688533109356;1188.7265928836243;1200.8018676918384;1201.7596480703894;1205.4997176171792;911.40758506971;918.4718786697675;928.972130836076;930.2697382554662;957.636098282662;5550.888982220333;5639.251423272873;5776.942230577641;5814.13344649413;6028.3971602839365;1020.7244044108049;1044.7179261599326;1055.377327376836;1063.4044934836515;1072.554889720757;3760.6051364606324;3779.149691319431;3802.524684414448;3857.0935830079907;3864.401017842239;9819.509024548744;10079.798404031879;10166.440845753406;10193.796124077477;10194.235432342604;10124.949375253076;10134.23993200513;10138.138258247984;10139.391636501834;10140.2901796875;6628.966855165693;6799.626020568818;7861.331786798072;7870.212978702084;7910.090339611018;5838.153467747068;5868.002439585366;5922.911156332572;5956.434138756811;6033.0045542484995;7470.402367810453;9185.265178785547;9393.718188454357;9453.95273023658;9487.57305921249;9544.141027307576;9560.187384072153;9618.278629102706;9629.711108666752;9679.66121185755;6295.779647712308;7363.595002274927;7429.665665044978;7450.701971921062;7516.060492438445;7345.522541034816;7607.733729319447;8015.358771298165;8067.959660201896;8079.596020198849;6066.605670631395;6584.308647591934;7258.419326453976;7340.302671246223;7365.226651201761;7119.679614417467;7171.533850299714;7183.461240406886;7197.964010179916;7226.349628533457;5600.93582219377;6533.18335208099;6622.039804228456;6655.267920528835;6658.234303055211;4940.802367905244;4949.604031677529;4955.2567114933045;5093.439721630543;5229.032628963501;5059.266406371129;5097.260897169964;5150.9227361588855;5154.381474222967;5307.150855863043 18:23:03 INFO - PROCESS | 1646 | |4;prototype.html;318.1695774029782;367.73155596414614;370.69602925601004;383.7467271600744;385.06045249590994;4649.953500464994;4837.540433658797;5230.686158830473;5337.973310133444;5381.381141168762;4356.695031347799;4572.3133787867455;4953.380827396575;5185.766640501177;5188.740562971855;3289.8684052637864;3429.6913277804993;3641.7632853864548;4089.5501494835694;4110.609492098246;3616.945745813815;4114.120115918869;4124.175164967019;4144.756573028079;4167.312393455076;3748.2008635854804;3966.761994280338;3999.2001599680034;4124.649404800595;4127.669786417079;3770.0781894032343;3954.1498577805623;3976.005998500375;3981.412082146599;3984.402339649047;3476.165720227127;3479.408500554912;3480.443129099332;3485.634008429129;3485.8779942701885;4287.614114729689;5125.384953805567;5143.948560514385;5155.278261043457;5165.690058596496;4181.372794080882;4220.0293932395725;4530.773461326953;4557.680962332638;4637.86086417408;5181.5077567631015;5482.5613950883835;5498.752556134984;5501.257330260403;5515.393306736256;3538.9469157962653;3826.330392181357;3831.731778775487;3852.114013776847;3868.12967082407;5184.637075404686;5369.677819330853;5483.75323110457;5765.472149880243;5780.277465316835;3580.480830279647;3662.6520480554304;3901.902452438712;3902.1610353774076;3925.4111883217747;3958.2281455115976;3980.820863061111;4005.2189822984237;4010.6590939769862;4013.618706222904;4236.364545318227;4517.887052823706;4577.977110114428;4585;4617.953820461752;5521.972390138104;5569.972150139223;5598.748056337475;5630.465105814941;5636.055560831506;1108.894655007773;1168.6727716239297;1285.0233822294936;1288.1305119044794;1291.6189724031433;736.9926300737031;853.3599800149888;853.8804567360575;857.1685465098844;858.7076449942796;4487.708298960557;4493.842715504941;4918.409331495742;5272.9736351318;5326.334208223972;4769.76151192439;4782.450018247946;5442.401335853053;5449.482299181572;5700.515456186187;4529.935465165683;4607.101615185007;4977.626677999092;5023.7298296447725;5252.947470525246;2614.6078088286527;2620.882060307291;2817.29567608098;2854.557543580748;2864.1980245530867;4460.665450091256;4858.46556878743;4982.501749825061;5129.7178655173575;5608.336040380868;4449;4736.881577960578;5025.698458092453;5148.6910785353;5230.8169214077325;4966;5134.407124402153;5307.761150748225;5631.63394379364;5681.687507187062;4611.677182597186;4634.884127896695;5123.026624941249;5141.53726164647;5433.8369848904595;4430.62339701129;4856.975715121402;5195.376554813295;5297.576193904555;5355.955588660174;4858.514148585114;5125.79496820123;5159.613029022763;5619.852882385877;5714.457126572969;3006.8496575171594;3523.8766643167364;3613.4579813027203;3666.789959313367;3694.506208309434;4302.806373713128;4364.890877728082;4871.952530206023;5328.8276579152525;5341.062415671287;4682.625389968726;4902.852914412573;5230.398504172069;5252.763625636779;5269.394019687785;4971.911797045322;5025.422076461254;5138.948610513997;5176.922346164886;5305.973470132624;4607.723536587815;5062.848114556569;5109.642325037212;5229.555487783429;5381.73091345439;5309.36287645485;5395.70323632204;5516.420775818642;5531.455530455874;5556.611037227355;4523.773811309487;4750.311204875205;5393.7033463159905;5434.891302174014;5442.809501667422 18:23:03 INFO - PROCESS | 1646 | |5;yui.html;745.2919726260047;761.7410080572604;794.0352471746827;862.8101817600128;873.1399571422148;15529.378824846992;15631.062136271803;15677.059376437423;15691.293891774869;15756.76364854528;14300.570982870531;14482.637934051654;14595.124292542429;14607.780883286732;14620.268986550684;713.1371041040347;737.7454778101574;739.2422766664185;741.1587847792767;896.838569057571;738.0405472885254;739.8890166475018;884.6903583745702;913.9086091390874;919.9696340099098;946.5693109635134;955.1212884146568;960.8702825118589;960.9711708648716;962.302330810164;967.0957654592978;967.3567077893192;967.6081187119228;968.7868668892868;969.3941286695815;719.4855678190119;720.6828995242076;721.6319676964733;723.489939592586;724.6231959381092;13538.59384218475;13707.109037912604;13754.174749515061;14566.417343306255;14795.630109247248;14685.339159737838;14702.926485367612;14730.337134828958;14765.852341476662;14856.034357766819;11464.770704585862;11632.476538555786;11854.466549005228;11857.525698972031;12457.314847683374;3841.154945911895;3860.208657225262;3879.3792993121247;3975.8608448704445;4005.178938317638;111258.33112503319;112141;112292.43853780761;113592;115786.6842663142;9671.70984870455;10676.733081672865;10943.890561094446;11120.499577519031;11570.710732231762;22051.22820701268;22542.774572254395;22574.661380079313;22824.543509129726;22871.428214294774;6580.506462015368;6635.435987940982;7690.730824421118;7937.126916039231;8000.919990800017;4375.453068366454;4490.753008584494;4494.056248187851;4513.074819661962;4575.794089265991;3546.113471632092;3636.8363423646;3637.418013117888;3638.1450359165574;3644.7630903991158;663.2704025571928;673.4814193071405;683.1426559667585;705.1186017478152;705.3123204875205;637.4900079936033;647.5305403582365;661.9375901677834;684.9726010959605;695.04778453519;8435.915640843636;8616.612252448655;9856.556454959544;10104.74738131538;11039.503222355013;486.3094405943569;616.7872084130968;618.653554009756;668.4218151299091;738.5716284554945;4834.5890599299455;5140.151874940593;5215.973920130451;5245.449227831099;5275.261463395128;98140.03719925562;98481;98666.50666746621;100544;101580;86063;87107;88092;88937.55531222431;89009;62012;76009.23990760132;77696;78193;78320;10146.644867429604;10153.746156345855;10168.796624067329;10172.08451239392;10206.897931020594;45801.77099114483;47808;47968.760156198994;49217.75391123021;49944.250836238214;58701.412985869596;63964.68017659882;68748;70253;70838;13427.462901483832;13805.378757955716;13916.860831391961;13924.303784810516;13945.930270348583;14606.196659183846;14941.103533788008;15320.310586023434;15773.369065237262;16129.032258064553;13230.536931207362;14123.717525649636;14413.351399186851;14505.274736263356;14522.49171279;13737.519186828413;14644.194569298365;14704.41182352694;14704.41182352694;14994.361341156144;13029.804552931902;13734.45062197501;13926.373313200727;13965.720685586028;14345.426182952566;10642.414667193068;11363.602273920373;11498.310101393943;11506.482208300815;11587.884121159017;10689.732756681145;10729.570817167227;10939.499360204976;11083.944580277048;11092.778144437227 18:23:03 INFO - PROCESS | 1646 | __end_tp_report 18:23:03 INFO - PROCESS | 1646 | __start_cc_report 18:23:03 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1374 18:23:03 INFO - PROCESS | 1646 | __end_cc_report 18:23:03 INFO - PROCESS | 1646 | __startTimestamp1489454583030__endTimestamp 18:23:03 INFO - PROCESS | 1646 | 18:23:03 INFO - PROCESS | 1646 | ------- Summary: start ------- 18:23:03 INFO - PROCESS | 1646 | Number of tests: 6 18:23:03 INFO - PROCESS | 1646 | 18:23:03 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5699.29 Median:5903.97 stddev:647.14 (11.0%) stddev-sans-first:622.10 18:23:03 INFO - PROCESS | 1646 | Values: 3340.2 3357.2 3364.3 3365.3 3407.3 5554.4 5567.2 5576.4 5583.9 5603.3 5599.9 5710.0 5723.5 5729.4 5737.8 5089.9 5101.3 5139.8 5150.4 5189.4 4951.5 5112.1 5121.9 5217.2 5267.0 5101.4 5112.1 5145.7 5155.5 5194.2 5148.7 5179.6 5180.2 5186.4 5190.4 5033.6 5112.8 5151.3 5170.8 5193.5 4660.9 5499.8 5551.4 5555.7 5557.7 6136.4 6173.8 6177.4 6185.4 6191.1 6229.0 6261.0 6285.7 6305.4 6309.3 5645.4 5662.1 5730.0 5767.1 5768.8 5904.0 6302.1 6341.8 6368.0 6382.6 6109.9 6111.8 6133.6 6136.0 6147.4 6179.3 6211.6 6226.9 6237.8 6256.9 5994.6 6068.8 6074.2 6182.4 6196.3 6125.8 6128.3 6139.4 6142.0 6145.5 4907.1 4939.8 4980.8 4982.1 4987.2 4405.6 4427.2 4432.8 4451.5 4464.0 5716.6 5832.4 5855.5 5862.1 5865.8 6154.4 6177.8 6213.1 6222.6 6236.0 4998.5 5757.2 5874.0 5911.6 5922.4 5381.6 5406.1 5417.1 5423.6 5430.6 6246.8 6250.3 6276.1 6315.8 6326.7 5163.2 6225.3 6253.1 6266.0 6268.6 6327.8 6345.1 6364.1 6367.3 6373.0 5995.3 6079.2 6111.6 6129.4 6150.8 6162.7 6261.4 6306.5 6307.9 6311.1 6086.8 6096.6 6113.6 6113.8 6115.5 5926.5 6006.2 6035.5 6104.0 6104.0 5060.7 5683.1 5846.1 5952.9 5980.8 6051.7 6064.6 6070.9 6080.1 6097.7 5687.1 5878.1 5891.5 5896.9 5898.5 18:23:03 INFO - PROCESS | 1646 | 18:23:03 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:73773.34 Median:36880.63 stddev:162174.88 (439.7%) stddev-sans-first:162536.46 18:23:03 INFO - PROCESS | 1646 | Values: 479.6 481.6 500.2 541.7 555.0 33996.8 42471.8 43888.1 44239.6 45676.3 45271.8 45613.8 45803.0 45803.3 45942.6 9001.2 9511.6 9727.9 9751.3 9772.6 8947.9 11637.1 11835.6 11876.5 11980.6 11578.1 11589.6 11635.2 11636.4 11745.5 11698.7 11773.6 11780.8 11783.9 11802.9 11601.8 11683.9 11690.4 11691.8 11697.2 41580.0 42374.0 42685.1 42752.0 42799.6 4100.9 4147.1 4150.4 4156.5 4171.3 30416.4 31732.2 32889.2 33280.5 33523.0 3096.1 3137.3 3140.2 3161.5 3195.7 516108.0 516428.0 517027.4 517139.0 518312.0 63670.0 64172.7 64186.4 64294.0 64318.7 66317.7 67413.0 67457.0 67483.7 67486.3 17586.6 17834.5 17849.3 17864.6 17878.7 12510.7 12940.2 13776.9 13850.2 13912.9 12475.3 16433.2 16745.6 16748.1 16878.7 6213.0 7093.8 7224.4 7297.7 7302.2 901.7 904.4 910.5 942.3 950.3 30360.8 30953.5 31322.2 31672.7 31780.5 1025.5 1141.1 1143.6 1163.6 1213.2 15712.5 15895.3 15918.8 16094.7 16363.5 672233.0 674251.0 675362.0 676873.2 678226.0 63899.9 64249.7 64413.7 64573.0 64645.7 1357.2 1400.8 1475.3 1494.9 1524.9 28423.9 31018.1 31884.0 32880.5 32891.0 52377.7 53380.5 54726.0 54765.7 56749.4 609773.0 616378.0 617239.0 618038.0 619586.0 23129.3 23659.4 23671.4 24176.6 25105.0 37184.6 42378.0 45613.1 45675.6 46475.3 32584.0 35323.4 36569.5 37939.8 38139.8 36387.5 36559.6 37147.3 37491.4 37883.8 36614.0 37169.3 37535.6 37583.8 37600.2 29089.6 32217.8 32711.7 32715.3 32908.7 24508.0 24758.4 24765.8 24852.0 25198.2 18:23:03 INFO - PROCESS | 1646 | 18:23:03 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:38980.65 Median:22174.83 stddev:117195.46 (528.5%) stddev-sans-first:117488.42 18:23:03 INFO - PROCESS | 1646 | Values: 403.7 405.2 409.8 418.7 434.3 18863.0 20974.7 21896.0 22095.4 22257.3 21945.0 22254.2 22624.8 22718.3 23038.8 5946.7 6259.7 6260.5 6282.5 6282.6 5117.5 5982.4 5998.4 6089.8 6128.2 6060.9 6064.8 6069.5 6071.3 6075.3 5399.8 5881.2 6120.8 6122.1 6124.2 5253.2 5369.5 5371.7 5373.2 5376.8 13210.5 13954.0 13954.4 13959.7 17564.6 2639.7 2644.4 2655.7 2676.7 2697.5 9436.4 9548.4 10561.4 10570.1 10573.5 1658.3 1806.8 1832.7 1839.7 1843.4 116732.4 125245.4 129465.4 131229.7 133298.0 9922.4 11740.0 11807.5 11831.3 12162.2 15848.6 15860.5 15864.4 15874.4 15905.2 8800.5 8912.7 8969.9 8970.6 9075.8 8681.6 8701.1 8741.8 8873.4 8907.8 4832.4 4847.6 4870.9 4881.3 4939.8 2012.2 2067.3 2076.0 2079.1 2079.4 912.6 979.5 990.6 999.5 1007.5 20962.2 21481.9 21571.7 21633.4 21685.0 992.7 1002.3 1026.3 1032.2 1038.7 10742.8 11137.3 11140.9 11808.8 12606.2 472542.0 546497.0 775006.0 780599.0 848641.0 149294.0 152515.2 155375.2 163364.0 169087.0 1116.4 1130.7 1164.5 1166.2 1170.7 19377.7 20484.6 20545.7 20567.2 20574.6 60344.9 60664.0 61069.0 61472.7 61980.7 83913.3 83952.0 84015.0 84724.6 85921.6 8302.3 8359.6 8618.0 8859.6 8879.8 12754.9 13076.7 13152.3 13771.2 13795.7 11035.8 11428.3 11639.9 11817.7 11989.5 9245.6 11579.9 11602.8 11957.0 12093.2 11596.1 11690.4 11943.5 12027.8 12174.3 8491.9 8547.9 8605.0 8669.0 8683.0 11211.3 11269.2 11420.6 11717.4 11923.6 18:23:03 INFO - PROCESS | 1646 | 18:23:03 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5466.09 Median:5152.65 stddev:2967.85 (57.6%) stddev-sans-first:2959.14 18:23:03 INFO - PROCESS | 1646 | Values: 1236.3 1363.7 1465.0 1489.7 1498.4 7767.2 8269.2 8487.4 8503.4 8623.7 8391.9 8452.1 8469.0 8476.3 8490.3 2144.9 2388.7 2425.1 2426.5 2427.8 2225.6 2234.9 2239.9 2242.9 2365.3 2397.5 2405.2 2408.5 2409.2 2416.1 2349.0 2378.3 2379.6 2381.0 2382.5 2241.4 2262.5 2268.4 2303.5 2305.9 8472.9 8475.2 8557.4 8558.9 8564.1 5160.6 5298.7 5301.0 5316.8 5323.9 2750.7 2939.9 3524.4 3529.6 3595.1 1205.3 1209.8 1225.7 1234.7 1253.7 10865.8 10877.1 10941.4 10951.0 10956.9 4278.5 4512.0 4587.4 4590.3 4591.6 8822.4 8823.5 8829.8 8842.4 8842.7 5204.5 5208.0 5210.9 5215.4 5215.7 4640.2 4813.2 4818.6 4886.3 4909.7 3452.6 3650.5 3684.9 3711.6 3782.2 1179.3 1188.7 1200.8 1201.8 1205.5 911.4 918.5 929.0 930.3 957.6 5550.9 5639.3 5776.9 5814.1 6028.4 1020.7 1044.7 1055.4 1063.4 1072.6 3760.6 3779.1 3802.5 3857.1 3864.4 9819.5 10079.8 10166.4 10193.8 10194.2 10124.9 10134.2 10138.1 10139.4 10140.3 6629.0 6799.6 7861.3 7870.2 7910.1 5838.2 5868.0 5922.9 5956.4 6033.0 7470.4 9185.3 9393.7 9454.0 9487.6 9544.1 9560.2 9618.3 9629.7 9679.7 6295.8 7363.6 7429.7 7450.7 7516.1 7345.5 7607.7 8015.4 8068.0 8079.6 6066.6 6584.3 7258.4 7340.3 7365.2 7119.7 7171.5 7183.5 7198.0 7226.3 5600.9 6533.2 6622.0 6655.3 6658.2 4940.8 4949.6 4955.3 5093.4 5229.0 5059.3 5097.3 5150.9 5154.4 5307.2 18:23:03 INFO - PROCESS | 1646 | 18:23:03 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4335.27 Median:4776.11 stddev:1290.85 (27.0%) stddev-sans-first:1258.77 18:23:03 INFO - PROCESS | 1646 | Values: 318.2 367.7 370.7 383.7 385.1 4650.0 4837.5 5230.7 5338.0 5381.4 4356.7 4572.3 4953.4 5185.8 5188.7 3289.9 3429.7 3641.8 4089.6 4110.6 3616.9 4114.1 4124.2 4144.8 4167.3 3748.2 3966.8 3999.2 4124.6 4127.7 3770.1 3954.1 3976.0 3981.4 3984.4 3476.2 3479.4 3480.4 3485.6 3485.9 4287.6 5125.4 5143.9 5155.3 5165.7 4181.4 4220.0 4530.8 4557.7 4637.9 5181.5 5482.6 5498.8 5501.3 5515.4 3538.9 3826.3 3831.7 3852.1 3868.1 5184.6 5369.7 5483.8 5765.5 5780.3 3580.5 3662.7 3901.9 3902.2 3925.4 3958.2 3980.8 4005.2 4010.7 4013.6 4236.4 4517.9 4578.0 4585.0 4618.0 5522.0 5570.0 5598.7 5630.5 5636.1 1108.9 1168.7 1285.0 1288.1 1291.6 737.0 853.4 853.9 857.2 858.7 4487.7 4493.8 4918.4 5273.0 5326.3 4769.8 4782.5 5442.4 5449.5 5700.5 4529.9 4607.1 4977.6 5023.7 5252.9 2614.6 2620.9 2817.3 2854.6 2864.2 4460.7 4858.5 4982.5 5129.7 5608.3 4449.0 4736.9 5025.7 5148.7 5230.8 4966.0 5134.4 5307.8 5631.6 5681.7 4611.7 4634.9 5123.0 5141.5 5433.8 4430.6 4857.0 5195.4 5297.6 5356.0 4858.5 5125.8 5159.6 5619.9 5714.5 3006.8 3523.9 3613.5 3666.8 3694.5 4302.8 4364.9 4872.0 5328.8 5341.1 4682.6 4902.9 5230.4 5252.8 5269.4 4971.9 5025.4 5138.9 5176.9 5306.0 4607.7 5062.8 5109.6 5229.6 5381.7 5309.4 5395.7 5516.4 5531.5 5556.6 4523.8 4750.3 5393.7 5434.9 5442.8 18:23:03 INFO - PROCESS | 1646 | 18:23:03 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:20525.21 Median:3927.62 stddev:29340.09 (747.0%) stddev-sans-first:29384.80 18:23:03 INFO - PROCESS | 1646 | Values: 745.3 761.7 794.0 862.8 873.1 15529.4 15631.1 15677.1 15691.3 15756.8 14300.6 14482.6 14595.1 14607.8 14620.3 713.1 737.7 739.2 741.2 896.8 738.0 739.9 884.7 913.9 920.0 946.6 955.1 960.9 961.0 962.3 967.1 967.4 967.6 968.8 969.4 719.5 720.7 721.6 723.5 724.6 13538.6 13707.1 13754.2 14566.4 14795.6 14685.3 14702.9 14730.3 14765.9 14856.0 11464.8 11632.5 11854.5 11857.5 12457.3 3841.2 3860.2 3879.4 3975.9 4005.2 111258.3 112141.0 112292.4 113592.0 115786.7 9671.7 10676.7 10943.9 11120.5 11570.7 22051.2 22542.8 22574.7 22824.5 22871.4 6580.5 6635.4 7690.7 7937.1 8000.9 4375.5 4490.8 4494.1 4513.1 4575.8 3546.1 3636.8 3637.4 3638.1 3644.8 663.3 673.5 683.1 705.1 705.3 637.5 647.5 661.9 685.0 695.0 8435.9 8616.6 9856.6 10104.7 11039.5 486.3 616.8 618.7 668.4 738.6 4834.6 5140.2 5216.0 5245.4 5275.3 98140.0 98481.0 98666.5 100544.0 101580.0 86063.0 87107.0 88092.0 88937.6 89009.0 62012.0 76009.2 77696.0 78193.0 78320.0 10146.6 10153.7 10168.8 10172.1 10206.9 45801.8 47808.0 47968.8 49217.8 49944.3 58701.4 63964.7 68748.0 70253.0 70838.0 13427.5 13805.4 13916.9 13924.3 13945.9 14606.2 14941.1 15320.3 15773.4 16129.0 13230.5 14123.7 14413.4 14505.3 14522.5 13737.5 14644.2 14704.4 14704.4 14994.4 13029.8 13734.5 13926.4 13965.7 14345.4 10642.4 11363.6 11498.3 11506.5 11587.9 10689.7 10729.6 10939.5 11083.9 11092.8 18:23:03 INFO - PROCESS | 1646 | -------- Summary: end -------- 18:23:03 INFO - PROCESS | 1646 | 18:23:03 INFO - TEST-INFO | 1646: exit 0 18:23:03 INFO - TEST-OK | dromaeo_css | took 1116343ms 18:23:03 INFO - TEST-START | kraken 18:23:03 INFO - operating with platform_type : mac_ 18:23:03 INFO - Initialising browser for kraken test... 18:23:03 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpADJZfI/profile http://localhost:49246/getInfo.html) 18:23:05 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 18:23:05 INFO - PROCESS | 1656 | colorDepth:24 18:23:05 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 18:23:05 INFO - PROCESS | 1656 | __metrics 18:23:05 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:23:05 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:23:06 INFO - TEST-INFO | 1656: exit 0 18:23:06 INFO - Browser initialized. 18:23:06 INFO - Running cycle 1/1 for kraken test... 18:23:06 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpADJZfI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:23:18 INFO - PROCESS | 1658 | RSS: Main: 166612992 18:23:18 INFO - PROCESS | 1658 | 18:23:21 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 18:23:22 INFO - PROCESS | 1658 | RSS: Main: 215011328 18:23:22 INFO - PROCESS | 1658 | 18:23:24 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 18:23:25 INFO - PROCESS | 1658 | RSS: Main: 229437440 18:23:25 INFO - PROCESS | 1658 | 18:23:28 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 18:23:29 INFO - PROCESS | 1658 | RSS: Main: 325677056 18:23:29 INFO - PROCESS | 1658 | 18:23:31 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 18:23:31 INFO - PROCESS | 1658 | RSS: Main: 229355520 18:23:31 INFO - PROCESS | 1658 | 18:23:33 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:23:34 INFO - PROCESS | 1658 | RSS: Main: 230834176 18:23:34 INFO - PROCESS | 1658 | 18:23:37 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 18:23:37 INFO - PROCESS | 1658 | RSS: Main: 271278080 18:23:37 INFO - PROCESS | 1658 | 18:23:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 18:23:41 INFO - PROCESS | 1658 | RSS: Main: 271982592 18:23:41 INFO - PROCESS | 1658 | 18:23:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 18:23:44 INFO - PROCESS | 1658 | RSS: Main: 270569472 18:23:44 INFO - PROCESS | 1658 | 18:23:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:23:46 INFO - PROCESS | 1658 | RSS: Main: 245211136 18:23:46 INFO - PROCESS | 1658 | 18:23:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:23:49 INFO - PROCESS | 1658 | RSS: Main: 250302464 18:23:49 INFO - PROCESS | 1658 | 18:23:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:23:52 INFO - PROCESS | 1658 | RSS: Main: 255766528 18:23:52 INFO - PROCESS | 1658 | 18:23:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:23:55 INFO - PROCESS | 1658 | RSS: Main: 270864384 18:23:55 INFO - PROCESS | 1658 | 18:23:58 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:23:59 INFO - PROCESS | 1658 | RSS: Main: 265216000 18:23:59 INFO - PROCESS | 1658 | 18:24:00 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 18:24:01 INFO - PROCESS | 1658 | RSS: Main: 309612544 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | __start_tp_report 18:24:01 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 18:24:01 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 18:24:01 INFO - PROCESS | 1658 | |i|pagename|runs| 18:24:01 INFO - PROCESS | 1658 | |0;ai-astar;110;115;158;165;114;115;114;114;114;113 18:24:01 INFO - PROCESS | 1658 | |1;audio-beat-detection;137;103;105;138;108;107;105;111;154;92 18:24:01 INFO - PROCESS | 1658 | |2;audio-dft;185;183;185;200;255;185;184;183;183;183 18:24:01 INFO - PROCESS | 1658 | |3;audio-fft;80;57;57;90;74;82;72;56;72;58 18:24:01 INFO - PROCESS | 1658 | |4;audio-oscillator;86;70;86;71;92;99;113;67;68;81 18:24:01 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;88;87;90;86;89;85;90;87;88;86 18:24:01 INFO - PROCESS | 1658 | |6;imaging-darkroom;94;99;139;150;94;96;95;95;94;96 18:24:01 INFO - PROCESS | 1658 | |7;imaging-desaturate;87;87;87;85;88;88;87;87;88;86 18:24:01 INFO - PROCESS | 1658 | |8;json-parse-financial;56;51;48;50;53;55;57;54;55;55 18:24:01 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;63;73;67;74;68;66;69;69;68;70 18:24:01 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;83;81;83;83;87;99;97;98;100;85 18:24:01 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;140;142;149;143;131;129;134;136;171;132 18:24:01 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;161;164;160;161;161;159;161;162;160;205 18:24:01 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;67;63;66;63;64;63;62;64;61;62 18:24:01 INFO - PROCESS | 1658 | __end_tp_report 18:24:01 INFO - PROCESS | 1658 | __start_cc_report 18:24:01 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1972 18:24:01 INFO - PROCESS | 1658 | __end_cc_report 18:24:01 INFO - PROCESS | 1658 | __startTimestamp1489454641123__endTimestamp 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | ------- Summary: start ------- 18:24:01 INFO - PROCESS | 1658 | Number of tests: 14 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:123.20 Median:114.50 stddev:20.30 (17.7%) stddev-sans-first:20.96 18:24:01 INFO - PROCESS | 1658 | Values: 110.0 115.0 158.0 165.0 114.0 115.0 114.0 114.0 114.0 113.0 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:116.00 Median:124.00 stddev:19.79 (16.0%) stddev-sans-first:19.48 18:24:01 INFO - PROCESS | 1658 | Values: 137.0 103.0 105.0 138.0 108.0 107.0 105.0 111.0 154.0 92.0 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:192.60 Median:185.00 stddev:22.52 (12.2%) stddev-sans-first:23.72 18:24:01 INFO - PROCESS | 1658 | Values: 185.0 183.0 185.0 200.0 255.0 185.0 184.0 183.0 183.0 183.0 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:69.80 Median:73.00 stddev:12.23 (16.7%) stddev-sans-first:12.40 18:24:01 INFO - PROCESS | 1658 | Values: 80.0 57.0 57.0 90.0 74.0 82.0 72.0 56.0 72.0 58.0 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:83.30 Median:83.50 stddev:15.10 (18.1%) stddev-sans-first:15.98 18:24:01 INFO - PROCESS | 1658 | Values: 86.0 70.0 86.0 71.0 92.0 99.0 113.0 67.0 68.0 81.0 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.00 stddev:1.71 (1.9%) stddev-sans-first:1.81 18:24:01 INFO - PROCESS | 1658 | Values: 88.0 87.0 90.0 86.0 89.0 85.0 90.0 87.0 88.0 86.0 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:105.20 Median:95.00 stddev:20.93 (22.0%) stddev-sans-first:21.80 18:24:01 INFO - PROCESS | 1658 | Values: 94.0 99.0 139.0 150.0 94.0 96.0 95.0 95.0 94.0 96.0 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:87.00 Median:87.00 stddev:0.94 (1.1%) stddev-sans-first:1.00 18:24:01 INFO - PROCESS | 1658 | Values: 87.0 87.0 87.0 85.0 88.0 88.0 87.0 87.0 88.0 86.0 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:55.00 stddev:2.88 (5.2%) stddev-sans-first:2.89 18:24:01 INFO - PROCESS | 1658 | Values: 56.0 51.0 48.0 50.0 53.0 55.0 57.0 54.0 55.0 55.0 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:3.20 (4.6%) stddev-sans-first:2.65 18:24:01 INFO - PROCESS | 1658 | Values: 63.0 73.0 67.0 74.0 68.0 66.0 69.0 69.0 68.0 70.0 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:86.00 stddev:7.85 (9.1%) stddev-sans-first:7.95 18:24:01 INFO - PROCESS | 1658 | Values: 83.0 81.0 83.0 83.0 87.0 99.0 97.0 98.0 100.0 85.0 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:141.00 stddev:12.33 (8.7%) stddev-sans-first:13.07 18:24:01 INFO - PROCESS | 1658 | Values: 140.0 142.0 149.0 143.0 131.0 129.0 134.0 136.0 171.0 132.0 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.40 Median:161.00 stddev:13.98 (8.7%) stddev-sans-first:14.73 18:24:01 INFO - PROCESS | 1658 | Values: 161.0 164.0 160.0 161.0 161.0 159.0 161.0 162.0 160.0 205.0 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.50 stddev:1.84 (2.9%) stddev-sans-first:1.45 18:24:01 INFO - PROCESS | 1658 | Values: 67.0 63.0 66.0 63.0 64.0 63.0 62.0 64.0 61.0 62.0 18:24:01 INFO - PROCESS | 1658 | -------- Summary: end -------- 18:24:01 INFO - PROCESS | 1658 | 18:24:01 INFO - TEST-INFO | 1658: exit 0 18:24:01 INFO - TEST-OK | kraken | took 58324ms 18:24:01 INFO - SUITE-END | took 1174s 18:24:02 INFO - Completed test suite (00:19:35) 18:24:02 INFO - javascript benchmark 18:24:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3340.2150494633765, 3357.244619960508, 3364.27668051369, 3365.2932884094325, 3407.2844702612465, 5554.444555544449, 5567.248421463101, 5576.442355764421, 5583.888322233553, 5603.299587551556, 5599.916001259984, 5710.0, 5723.456271654197, 5729.39841316662, 5737.770489180438, 5089.872753181172, 5101.285819985205, 5139.820106296281, 5150.381954165506, 5189.42916279209, 4951.480094590071, 5112.105381558231, 5121.897562048757, 5217.217417387385, 5267.0, 5101.4133374662015, 5112.130937740593, 5145.74271286436, 5155.510226528474, 5194.2208668699805, 5148.691078535281, 5179.559737422323, 5180.2488639147305, 5186.377634683824, 5190.4031036430915, 5033.597312215014, 5112.769925353331, 5151.278820965068, 5170.819021334235, 5193.532582067632, 4660.883477913046, 5499.807506737245, 5551.444855514456, 5555.694436805974, 5557.72211389433, 6136.447719705248, 6173.783917562864, 6177.351378105279, 6185.41238582334, 6191.102290167945, 6228.96885515574, 6260.968695156541, 6285.748570057192, 6305.369463053704, 6309.274433440167, 5645.379008309083, 5662.094064949588, 5729.971350143306, 5767.1349297605275, 5768.7980920668, 5903.970480147572, 6302.1492098566105, 6341.8097457076365, 6368.0, 6382.585131966407, 6109.890546867989, 6111.77406523465, 6133.622130947029, 6136.004954352043, 6147.44672979434, 6179.2584889812615, 6211.627302361872, 6226.941419958618, 6237.781677641261, 6256.937430625727, 5994.6403215807195, 6068.787592434243, 6074.240719910012, 6182.412670796267, 6196.256449226032, 6125.788171442211, 6128.319797384577, 6139.447449729546, 6142.007694998198, 6145.508359331243, 4907.092187945242, 4939.802407903644, 4980.8256711015665, 4982.07831551157, 4987.1771157759285, 4405.625521830681, 4427.2252355838245, 4432.84485043022, 4451.532589078165, 4463.955360446354, 5716.571257155647, 5832.416758324219, 5855.4730074292665, 5862.091375836752, 5865.794697185664, 6154.415330543681, 6177.752889884354, 6213.130161777355, 6222.62664240147, 6236.03341482071, 4998.500149984972, 5757.165211044459, 5874.030784920526, 5911.645301281937, 5922.407759224129, 5381.623286369917, 5406.135018397038, 5417.079096553595, 5423.593230507728, 5430.56555475561, 6246.843828904313, 6250.343713909974, 6276.089966954674, 6315.810525684236, 6326.683665816783, 5163.225516172454, 6225.31521532622, 6253.062040693932, 6266.0, 6268.623882567061, 6327.810165695037, 6345.1434056401795, 6364.109024736448, 6367.267764207176, 6373.0, 5995.340512543704, 6079.1793107931635, 6111.572189946839, 6129.417705317987, 6150.846228844314, 6162.691865406801, 6261.436470717657, 6306.527010474141, 6307.936920630735, 6311.147995020797, 6086.786962456293, 6096.603720758137, 6113.57204995646, 6113.755449781959, 6115.510759139347, 5926.4666180044005, 6006.219191505251, 6035.547333949883, 6103.969480152571, 6104.0, 5060.7095190727605, 5683.119116536944, 5846.123081537803, 5952.880942381042, 5980.790672326448, 6051.727672254671, 6064.605800622945, 6070.908936366046, 6080.0575910733905, 6097.695115244309, 5687.090065589651, 5878.118282257696, 5891.528677705859, 5896.941030589811, 5898.528117750484], "value": 5658.228797583274, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.5683884503946, 481.6435837480266, 500.1871958068139, 541.6966498760694, 554.970529667467, 33996.83001584992, 42471.78764106179, 43888.12223755523, 44239.55760442395, 45676.314855277196, 45271.773641131746, 45613.7719311403, 45803.0, 45803.31295030577, 45942.62172134833, 9001.234895033896, 9511.571979260916, 9727.854082188773, 9751.317407781458, 9772.560234789451, 8947.910520894773, 11637.069034477265, 11835.644930652052, 11876.52493900243, 11980.64058078259, 11578.131640127023, 11589.594364197255, 11635.24370915892, 11636.418179091053, 11745.471453784558, 11698.707532311675, 11773.587924422603, 11780.764384712344, 11783.939445449865, 11802.881971180306, 11601.825972610417, 11683.883161168449, 11690.415479226005, 11691.766164676745, 11697.23967942081, 41580.0, 42374.0, 42685.14629707419, 42752.0, 42799.572004280184, 4100.897477563055, 4147.066909945268, 4150.377443383486, 4156.521999969982, 4171.300613925302, 30416.39167216643, 31732.206694832585, 32889.17777055593, 33280.500792488136, 33522.99431017073, 3096.086654436924, 3137.2784259620416, 3140.1521589170798, 3161.4783560712685, 3195.7123858852583, 516108.0, 516428.0, 517027.41486292705, 517139.0, 518312.0, 63670.0, 64172.67913660402, 64186.358136418974, 64294.0, 64318.678406608604, 66317.66841165764, 67412.98880516796, 67457.0, 67483.66258168677, 67486.32513674899, 17586.560335991446, 17834.46496605078, 17849.28602855897, 17864.642707146046, 17878.731819022723, 12510.74978500425, 12940.223586584834, 13776.862231377758, 13850.238236897067, 13912.93043534796, 12475.313857737912, 16433.178341082898, 16745.581360465843, 16748.078855663054, 16878.662426751398, 6212.97485914819, 7093.82265443368, 7224.399216282134, 7297.671604777798, 7302.160251571137, 901.724973882972, 904.3579058868146, 910.5310764955921, 942.2744486745167, 950.3442624589012, 30360.84819575932, 30953.53569696456, 31322.219457576513, 31672.683273167433, 31780.523292150174, 1025.5077562769911, 1141.0985321596013, 1143.5825923537848, 1163.5752950173126, 1213.2356615332285, 15712.450064247696, 15895.284712187748, 15918.76121858173, 16094.733191299469, 16363.509094727176, 672233.0, 674251.0, 675362.0, 676873.2312676909, 678226.0, 63899.88800895917, 64249.715005699625, 64413.677931610044, 64573.03140452803, 64645.67677161678, 1357.1856885868597, 1400.8038874557367, 1475.2697414779539, 1494.9476768313057, 1524.923753812327, 28423.857880710464, 31018.0694579163, 31884.043478695676, 32880.50679239765, 32891.01326960195, 52377.7381113092, 53380.46619533755, 54726.0, 54765.726171368886, 56749.43250567441, 609773.0, 616378.0, 617239.0, 618038.0, 619586.0, 23129.306120816404, 23659.40851478658, 23671.408214794767, 24176.637350439407, 25105.0, 37184.62815371811, 42378.0, 45613.08773824571, 45675.62973110812, 46475.3028704563, 32584.0, 35323.40297910565, 36569.45145822762, 37939.81030094942, 38139.80930095332, 36387.54449821977, 36559.63440365669, 37147.25705485929, 37491.43762843614, 37883.81058094692, 36614.0, 37169.25661486701, 37535.62464375431, 37583.81208093942, 37600.2479950394, 29089.563656544746, 32217.838910805294, 32711.69153233844, 32715.34569308553, 32908.67091329152, 24508.019679212633, 24758.38104047413, 24765.752342476346, 24851.982833982012, 25198.24405267845], "value": 20748.916043913294, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.7214322117739, 405.1896207584832, 409.76029023021533, 418.7278269125068, 434.2942718083115, 18863.0, 20974.7211339306, 21896.014679339427, 22095.44761380966, 22257.332280031584, 21945.01247443865, 22254.221102261425, 22624.773752262474, 22718.318450446473, 23038.769612303913, 5946.672932988695, 6259.718312675917, 6260.499160067184, 6282.497400207995, 6282.560220784547, 5117.513836185575, 5982.401759824026, 5998.370171132034, 6089.847753806146, 6128.203333566652, 6060.909086363708, 6064.848378790522, 6069.484093852006, 6071.301800292957, 6075.270967483908, 5399.758055647204, 5881.206037184989, 6120.785772497941, 6122.051082082262, 6124.203853499062, 5253.159494480903, 5369.48989845964, 5371.650842695212, 5373.220882971987, 5376.811811586615, 13210.471581136742, 13953.953453490927, 13954.441822327095, 13959.65100872476, 17564.560885977953, 2639.6700412448445, 2644.418227989839, 2655.668041494813, 2676.6921803992595, 2697.5144473994674, 9436.433813971184, 9548.42709437436, 10561.366318020944, 10570.101541368993, 10573.524191411405, 1658.3118006027485, 1806.8283513066237, 1832.7067669172868, 1839.6504664113775, 1843.3916807453509, 116732.41633791862, 125245.37377313146, 129465.35267323698, 131229.6877031227, 133298.0, 9922.355046921926, 11740.0, 11807.468663910146, 11831.343611894341, 12162.209456385306, 15848.60378490547, 15860.52418427449, 15864.365425382855, 15874.365025398854, 15905.204739762965, 8800.47197168172, 8912.73261802147, 8969.865452018224, 8970.596323165473, 9075.773105672279, 8681.609327580149, 8701.129887011248, 8741.781455463664, 8873.378863479624, 8907.777305567282, 4832.371791667131, 4847.563719265213, 4870.8782280442565, 4881.316615673809, 4939.802407903716, 2012.2454079720105, 2067.3487851327086, 2075.98962005189, 2079.1059844266806, 2079.4073688998565, 912.5665308978182, 979.5200351827554, 990.6483198464585, 999.5402115027024, 1007.5365331947386, 20962.161513539286, 21481.892590536947, 21571.67642485364, 21633.35099947004, 21685.02417391221, 992.6873034993954, 1002.283367392318, 1026.3226270661478, 1032.230987914009, 1038.6520515627199, 10742.838857417146, 11137.331760094421, 11140.941610546985, 11808.822867656992, 12606.243625382507, 472542.0, 546497.0, 775006.0, 780599.0, 848641.0, 149294.0, 152515.2374238144, 155375.22312388365, 163364.0, 169087.0, 1116.4083035990939, 1130.739929816147, 1164.4992653159054, 1166.2419427372276, 1170.6605084525393, 19377.684319112603, 20484.590308193456, 20545.691814622493, 20567.177312907315, 20574.588508230052, 60344.90472615896, 60664.0, 61069.0, 61472.69263653653, 61980.69009654923, 83913.34996475239, 83952.0, 84015.0, 84724.57637711772, 85921.57039214764, 8302.294304983903, 8359.582020899052, 8618.008928972997, 8859.64561417536, 8879.822403551763, 12754.936225318814, 13076.673083172996, 13152.342382881008, 13771.173729576258, 13795.724085518434, 11035.834462482908, 11428.314301141958, 11639.88360116388, 11817.704557386134, 11989.460474278503, 9245.630174792934, 11579.942100289445, 11602.825957610812, 11956.983656389304, 12093.213941093802, 11596.130290228099, 11690.357030363411, 11943.522259109886, 12027.75944481088, 12174.269543827399, 8491.915080849112, 8547.914520854712, 8605.0, 8669.0, 8682.956585217033, 11211.26225435059, 11269.211155219056, 11420.600278990196, 11717.414129293671, 11923.642290731292], "value": 10004.34625346382, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1236.2953116723465, 1363.7477066742647, 1464.9780253296203, 1489.7318482673115, 1498.3856618786297, 7767.22327767223, 8269.173082691728, 8487.363447741413, 8503.404761666678, 8623.65505379784, 8391.87412188816, 8452.070272270046, 8469.0, 8476.32189424846, 8490.320774338054, 2144.860584062039, 2388.653645221442, 2425.1269542964606, 2426.5268272686835, 2427.757224277576, 2225.5660146271484, 2234.944126396837, 2239.876806775627, 2242.8990695418747, 2365.325882123595, 2397.496525729599, 2405.1581946318825, 2408.5303365843665, 2409.204962362425, 2416.0577374823833, 2348.9530209395716, 2378.250850981935, 2379.6430535419654, 2380.95238095238, 2382.452036031705, 2241.4396400899777, 2262.490939538607, 2268.432891777056, 2303.4702018535663, 2305.9308220753237, 8472.915270847336, 8475.152484751537, 8557.400981931267, 8558.871616925751, 8564.143585641448, 5160.638755287131, 5298.735063246861, 5301.019311427398, 5316.813911513117, 5323.920141197885, 2750.6561679790025, 2939.8971036013636, 3524.400851855191, 3529.5588051493564, 3595.0652830264057, 1205.3189947679532, 1209.830623712681, 1225.6874497003207, 1234.666640007202, 1253.7053792358788, 10865.83701244482, 10877.129829613612, 10941.398223097727, 10950.959658832398, 10956.945215273872, 4278.4865816102265, 4511.962248682756, 4587.403637527167, 4590.334401511829, 4591.586757191869, 8822.38243322974, 8823.470591764515, 8829.823403532022, 8842.425242359226, 8842.734717958472, 5204.479552044765, 5207.973960130251, 5210.895782084337, 5215.400228973641, 5215.6609820361555, 4640.211164102043, 4813.229883218738, 4818.566329030404, 4886.267059940967, 4909.729964851967, 3452.6374730653424, 3650.452432135201, 3684.8526058957877, 3711.5917249102577, 3782.243551289753, 1179.2688533109356, 1188.7265928836243, 1200.8018676918384, 1201.7596480703894, 1205.4997176171792, 911.40758506971, 918.4718786697675, 928.972130836076, 930.2697382554662, 957.636098282662, 5550.888982220333, 5639.251423272873, 5776.942230577641, 5814.13344649413, 6028.3971602839365, 1020.7244044108049, 1044.7179261599326, 1055.377327376836, 1063.4044934836515, 1072.554889720757, 3760.6051364606324, 3779.149691319431, 3802.524684414448, 3857.0935830079907, 3864.401017842239, 9819.509024548744, 10079.798404031879, 10166.440845753406, 10193.796124077477, 10194.235432342604, 10124.949375253076, 10134.23993200513, 10138.138258247984, 10139.391636501834, 10140.2901796875, 6628.966855165693, 6799.626020568818, 7861.331786798072, 7870.212978702084, 7910.090339611018, 5838.153467747068, 5868.002439585366, 5922.911156332572, 5956.434138756811, 6033.0045542484995, 7470.402367810453, 9185.265178785547, 9393.718188454357, 9453.95273023658, 9487.57305921249, 9544.141027307576, 9560.187384072153, 9618.278629102706, 9629.711108666752, 9679.66121185755, 6295.779647712308, 7363.595002274927, 7429.665665044978, 7450.701971921062, 7516.060492438445, 7345.522541034816, 7607.733729319447, 8015.358771298165, 8067.959660201896, 8079.596020198849, 6066.605670631395, 6584.308647591934, 7258.419326453976, 7340.302671246223, 7365.226651201761, 7119.679614417467, 7171.533850299714, 7183.461240406886, 7197.964010179916, 7226.349628533457, 5600.93582219377, 6533.18335208099, 6622.039804228456, 6655.267920528835, 6658.234303055211, 4940.802367905244, 4949.604031677529, 4955.2567114933045, 5093.439721630543, 5229.032628963501, 5059.266406371129, 5097.260897169964, 5150.9227361588855, 5154.381474222967, 5307.150855863043], "value": 4456.793870046364, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.1695774029782, 367.73155596414614, 370.69602925601004, 383.7467271600744, 385.06045249590994, 4649.953500464994, 4837.540433658797, 5230.686158830473, 5337.973310133444, 5381.381141168762, 4356.695031347799, 4572.3133787867455, 4953.380827396575, 5185.766640501177, 5188.740562971855, 3289.8684052637864, 3429.6913277804993, 3641.7632853864548, 4089.5501494835694, 4110.609492098246, 3616.945745813815, 4114.120115918869, 4124.175164967019, 4144.756573028079, 4167.312393455076, 3748.2008635854804, 3966.761994280338, 3999.2001599680034, 4124.649404800595, 4127.669786417079, 3770.0781894032343, 3954.1498577805623, 3976.005998500375, 3981.412082146599, 3984.402339649047, 3476.165720227127, 3479.408500554912, 3480.443129099332, 3485.634008429129, 3485.8779942701885, 4287.614114729689, 5125.384953805567, 5143.948560514385, 5155.278261043457, 5165.690058596496, 4181.372794080882, 4220.0293932395725, 4530.773461326953, 4557.680962332638, 4637.86086417408, 5181.5077567631015, 5482.5613950883835, 5498.752556134984, 5501.257330260403, 5515.393306736256, 3538.9469157962653, 3826.330392181357, 3831.731778775487, 3852.114013776847, 3868.12967082407, 5184.637075404686, 5369.677819330853, 5483.75323110457, 5765.472149880243, 5780.277465316835, 3580.480830279647, 3662.6520480554304, 3901.902452438712, 3902.1610353774076, 3925.4111883217747, 3958.2281455115976, 3980.820863061111, 4005.2189822984237, 4010.6590939769862, 4013.618706222904, 4236.364545318227, 4517.887052823706, 4577.977110114428, 4585.0, 4617.953820461752, 5521.972390138104, 5569.972150139223, 5598.748056337475, 5630.465105814941, 5636.055560831506, 1108.894655007773, 1168.6727716239297, 1285.0233822294936, 1288.1305119044794, 1291.6189724031433, 736.9926300737031, 853.3599800149888, 853.8804567360575, 857.1685465098844, 858.7076449942796, 4487.708298960557, 4493.842715504941, 4918.409331495742, 5272.9736351318, 5326.334208223972, 4769.76151192439, 4782.450018247946, 5442.401335853053, 5449.482299181572, 5700.515456186187, 4529.935465165683, 4607.101615185007, 4977.626677999092, 5023.7298296447725, 5252.947470525246, 2614.6078088286527, 2620.882060307291, 2817.29567608098, 2854.557543580748, 2864.1980245530867, 4460.665450091256, 4858.46556878743, 4982.501749825061, 5129.7178655173575, 5608.336040380868, 4449.0, 4736.881577960578, 5025.698458092453, 5148.6910785353, 5230.8169214077325, 4966.0, 5134.407124402153, 5307.761150748225, 5631.63394379364, 5681.687507187062, 4611.677182597186, 4634.884127896695, 5123.026624941249, 5141.53726164647, 5433.8369848904595, 4430.62339701129, 4856.975715121402, 5195.376554813295, 5297.576193904555, 5355.955588660174, 4858.514148585114, 5125.79496820123, 5159.613029022763, 5619.852882385877, 5714.457126572969, 3006.8496575171594, 3523.8766643167364, 3613.4579813027203, 3666.789959313367, 3694.506208309434, 4302.806373713128, 4364.890877728082, 4871.952530206023, 5328.8276579152525, 5341.062415671287, 4682.625389968726, 4902.852914412573, 5230.398504172069, 5252.763625636779, 5269.394019687785, 4971.911797045322, 5025.422076461254, 5138.948610513997, 5176.922346164886, 5305.973470132624, 4607.723536587815, 5062.848114556569, 5109.642325037212, 5229.555487783429, 5381.73091345439, 5309.36287645485, 5395.70323632204, 5516.420775818642, 5531.455530455874, 5556.611037227355, 4523.773811309487, 4750.311204875205, 5393.7033463159905, 5434.891302174014, 5442.809501667422], "value": 3938.726006971108, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.2919726260047, 761.7410080572604, 794.0352471746827, 862.8101817600128, 873.1399571422148, 15529.378824846992, 15631.062136271803, 15677.059376437423, 15691.293891774869, 15756.76364854528, 14300.570982870531, 14482.637934051654, 14595.124292542429, 14607.780883286732, 14620.268986550684, 713.1371041040347, 737.7454778101574, 739.2422766664185, 741.1587847792767, 896.838569057571, 738.0405472885254, 739.8890166475018, 884.6903583745702, 913.9086091390874, 919.9696340099098, 946.5693109635134, 955.1212884146568, 960.8702825118589, 960.9711708648716, 962.302330810164, 967.0957654592978, 967.3567077893192, 967.6081187119228, 968.7868668892868, 969.3941286695815, 719.4855678190119, 720.6828995242076, 721.6319676964733, 723.489939592586, 724.6231959381092, 13538.59384218475, 13707.109037912604, 13754.174749515061, 14566.417343306255, 14795.630109247248, 14685.339159737838, 14702.926485367612, 14730.337134828958, 14765.852341476662, 14856.034357766819, 11464.770704585862, 11632.476538555786, 11854.466549005228, 11857.525698972031, 12457.314847683374, 3841.154945911895, 3860.208657225262, 3879.3792993121247, 3975.8608448704445, 4005.178938317638, 111258.33112503319, 112141.0, 112292.43853780761, 113592.0, 115786.6842663142, 9671.70984870455, 10676.733081672865, 10943.890561094446, 11120.499577519031, 11570.710732231762, 22051.22820701268, 22542.774572254395, 22574.661380079313, 22824.543509129726, 22871.428214294774, 6580.506462015368, 6635.435987940982, 7690.730824421118, 7937.126916039231, 8000.919990800017, 4375.453068366454, 4490.753008584494, 4494.056248187851, 4513.074819661962, 4575.794089265991, 3546.113471632092, 3636.8363423646, 3637.418013117888, 3638.1450359165574, 3644.7630903991158, 663.2704025571928, 673.4814193071405, 683.1426559667585, 705.1186017478152, 705.3123204875205, 637.4900079936033, 647.5305403582365, 661.9375901677834, 684.9726010959605, 695.04778453519, 8435.915640843636, 8616.612252448655, 9856.556454959544, 10104.74738131538, 11039.503222355013, 486.3094405943569, 616.7872084130968, 618.653554009756, 668.4218151299091, 738.5716284554945, 4834.5890599299455, 5140.151874940593, 5215.973920130451, 5245.449227831099, 5275.261463395128, 98140.03719925562, 98481.0, 98666.50666746621, 100544.0, 101580.0, 86063.0, 87107.0, 88092.0, 88937.55531222431, 89009.0, 62012.0, 76009.23990760132, 77696.0, 78193.0, 78320.0, 10146.644867429604, 10153.746156345855, 10168.796624067329, 10172.08451239392, 10206.897931020594, 45801.77099114483, 47808.0, 47968.760156198994, 49217.75391123021, 49944.250836238214, 58701.412985869596, 63964.68017659882, 68748.0, 70253.0, 70838.0, 13427.462901483832, 13805.378757955716, 13916.860831391961, 13924.303784810516, 13945.930270348583, 14606.196659183846, 14941.103533788008, 15320.310586023434, 15773.369065237262, 16129.032258064553, 13230.536931207362, 14123.717525649636, 14413.351399186851, 14505.274736263356, 14522.49171279, 13737.519186828413, 14644.194569298365, 14704.41182352694, 14704.41182352694, 14994.361341156144, 13029.804552931902, 13734.45062197501, 13926.373313200727, 13965.720685586028, 14345.426182952566, 10642.414667193068, 11363.602273920373, 11498.310101393943, 11506.482208300815, 11587.884121159017, 10689.732756681145, 10729.570817167227, 10939.499360204976, 11083.944580277048, 11092.778144437227], "value": 7620.098112079997, "unit": "score"}], "name": "dromaeo_css", "value": 7345.856303928013, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 158.0, 165.0, 114.0, 115.0, 114.0, 114.0, 114.0, 113.0], "value": 123.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 103.0, 105.0, 138.0, 108.0, 107.0, 105.0, 111.0, 154.0, 92.0], "value": 116.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 185.0, 200.0, 255.0, 185.0, 184.0, 183.0, 183.0, 183.0], "value": 192.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 57.0, 90.0, 74.0, 82.0, 72.0, 56.0, 72.0, 58.0], "value": 69.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 86.0, 71.0, 92.0, 99.0, 113.0, 67.0, 68.0, 81.0], "value": 83.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 90.0, 86.0, 89.0, 85.0, 90.0, 87.0, 88.0, 86.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 99.0, 139.0, 150.0, 94.0, 96.0, 95.0, 95.0, 94.0, 96.0], "value": 105.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 85.0, 88.0, 88.0, 87.0, 87.0, 88.0, 86.0], "value": 87.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 51.0, 48.0, 50.0, 53.0, 55.0, 57.0, 54.0, 55.0, 55.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 73.0, 67.0, 74.0, 68.0, 66.0, 69.0, 69.0, 68.0, 70.0], "value": 68.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 83.0, 83.0, 87.0, 99.0, 97.0, 98.0, 100.0, 85.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 149.0, 143.0, 131.0, 129.0, 134.0, 136.0, 171.0, 132.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 160.0, 161.0, 161.0, 159.0, 161.0, 162.0, 160.0, 205.0], "value": 165.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 66.0, 63.0, 64.0, 63.0, 62.0, 64.0, 61.0, 62.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1446.0000000000002, "alertThreshold": 2.0}]} 18:24:02 INFO - Return code: 0 18:24:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:24:02 INFO - # TBPL SUCCESS # 18:24:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:24:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:24:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:24:02 INFO - 2017-03-13 18:24:02.447 screenresolution[1662:9712] starting screenresolution argv=screenresolution get 18:24:02 INFO - 2017-03-13 18:24:02.450 screenresolution[1662:9712] Display 0: 1600x1200x32@60 18:24:02 INFO - 2017-03-13 18:24:02.455 screenresolution[1663:9715] starting screenresolution argv=screenresolution list 18:24:02 INFO - Available Modes on Display 0 18:24:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:24:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:24:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:24:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:24:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:24:02 INFO - Intel Iris: 18:24:02 INFO - Chipset Model: Intel Iris 18:24:02 INFO - Type: GPU 18:24:02 INFO - Bus: Built-In 18:24:02 INFO - VRAM (Dynamic, Max): 1536 MB 18:24:02 INFO - Vendor: Intel (0x8086) 18:24:02 INFO - Device ID: 0x0a2e 18:24:02 INFO - Revision ID: 0x0009 18:24:02 INFO - Displays: 18:24:02 INFO - Display: 18:24:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:24:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:24:02 INFO - Display Serial Number: 1600x1200 60 18:24:02 INFO - Main Display: Yes 18:24:02 INFO - Mirror: Off 18:24:02 INFO - Online: Yes 18:24:02 INFO - Rotation: Supported 18:24:02 INFO - Return code: 0 18:24:02 INFO - Running post-action listener: _resource_record_post_action 18:24:02 INFO - [mozharness: 2017-03-14 01:24:02.690956Z] Finished run-tests step (success) 18:24:02 INFO - Running post-run listener: _resource_record_post_run 18:24:02 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 38691840; Write bytes: 421290496; Read time: 377; Write time: 1626 18:24:02 INFO - TinderboxPrint: CPU usage
53.9% 18:24:02 INFO - TinderboxPrint: I/O read bytes / time
38,691,840 / 377 18:24:02 INFO - TinderboxPrint: I/O write bytes / time
421,290,496 / 1,626 18:24:02 INFO - TinderboxPrint: CPU idle
2,195.6 (46.1%) 18:24:02 INFO - TinderboxPrint: CPU system
955.3 (20.1%) 18:24:02 INFO - TinderboxPrint: CPU user
1,610.8 (33.8%) 18:24:02 INFO - TinderboxPrint: Swap in / out
160,907,264 / 0 18:24:02 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122984960; Write bytes: 122748928; Read time: 11000; Write time: 263 18:24:02 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 34403328; Write bytes: 297169408; Read time: 346; Write time: 1359 18:24:03 INFO - Running post-run listener: _upload_blobber_files 18:24:03 INFO - Blob upload gear active. 18:24:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:24:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:24:03 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'] 18:24:03 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 18:24:03 INFO - (blobuploader) - INFO - Open directory for files ... 18:24:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:24:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:24:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:24:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:24:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:24:04 INFO - (blobuploader) - INFO - Done attempting. 18:24:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:24:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:24:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:24:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:24:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:24:05 INFO - (blobuploader) - INFO - Done attempting. 18:24:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:24:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:24:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:24:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:24:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:24:06 INFO - (blobuploader) - INFO - Done attempting. 18:24:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:24:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:24:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:24:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:24:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:24:08 INFO - (blobuploader) - INFO - Done attempting. 18:24:08 INFO - (blobuploader) - INFO - Iteration through files over. 18:24:08 INFO - Return code: 0 18:24:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:24:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:24:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4b0e2b57b11ac8d3936abf7345ff15999652c94e4251d55163274f34834100255fe72a0481130cef1fcc01dedc09c1c9a5fe420846d52a62796dca27f41e477", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2eacd59c8d0e26b2dd0d9cf3de5bd6c8a533f26971ba5e8e16c229849a7492f5325d1e347168793d48c2c6b77dde387e7950d13e509ddf7c33d2a6aa321fc7cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01a067203acb80a71c8dba30615cab9ffa832dbeafe4c646133d7ead70769bf4ec7fbc26c7bd94d6dc7919b9feac7eaeb39fe9149ff14cfe671e2be610e91fa0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf8e62171ad0e9a48d2d9840ebefca922b48c27d980063a08703ba0c3c9030af315c4c08d871c9827aa8dcde4fc5e4cc923c10b432cc5e124ee87a96a26a958b"} 18:24:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:24:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:24:08 INFO - Contents: 18:24:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4b0e2b57b11ac8d3936abf7345ff15999652c94e4251d55163274f34834100255fe72a0481130cef1fcc01dedc09c1c9a5fe420846d52a62796dca27f41e477", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2eacd59c8d0e26b2dd0d9cf3de5bd6c8a533f26971ba5e8e16c229849a7492f5325d1e347168793d48c2c6b77dde387e7950d13e509ddf7c33d2a6aa321fc7cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01a067203acb80a71c8dba30615cab9ffa832dbeafe4c646133d7ead70769bf4ec7fbc26c7bd94d6dc7919b9feac7eaeb39fe9149ff14cfe671e2be610e91fa0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf8e62171ad0e9a48d2d9840ebefca922b48c27d980063a08703ba0c3c9030af315c4c08d871c9827aa8dcde4fc5e4cc923c10b432cc5e124ee87a96a26a958b"} 18:24:08 INFO - Running post-run listener: copy_logs_to_upload_dir 18:24:08 INFO - Copying logs to upload dir... 18:24:08 INFO - mkdir: /builds/slave/test/build/upload/logs 18:24:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.819302 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-13 18:24:08.854953) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 18:24:08.858841) ========= 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.3w1yn73MeT/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.BE2mYtcmzP/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4b0e2b57b11ac8d3936abf7345ff15999652c94e4251d55163274f34834100255fe72a0481130cef1fcc01dedc09c1c9a5fe420846d52a62796dca27f41e477", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2eacd59c8d0e26b2dd0d9cf3de5bd6c8a533f26971ba5e8e16c229849a7492f5325d1e347168793d48c2c6b77dde387e7950d13e509ddf7c33d2a6aa321fc7cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01a067203acb80a71c8dba30615cab9ffa832dbeafe4c646133d7ead70769bf4ec7fbc26c7bd94d6dc7919b9feac7eaeb39fe9149ff14cfe671e2be610e91fa0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf8e62171ad0e9a48d2d9840ebefca922b48c27d980063a08703ba0c3c9030af315c4c08d871c9827aa8dcde4fc5e4cc923c10b432cc5e124ee87a96a26a958b"} build_url:https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011110 build_url: 'https://queue.taskcluster.net/v1/task/YPM2H-XwQ52Y8hannSs6GQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a4b0e2b57b11ac8d3936abf7345ff15999652c94e4251d55163274f34834100255fe72a0481130cef1fcc01dedc09c1c9a5fe420846d52a62796dca27f41e477", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2eacd59c8d0e26b2dd0d9cf3de5bd6c8a533f26971ba5e8e16c229849a7492f5325d1e347168793d48c2c6b77dde387e7950d13e509ddf7c33d2a6aa321fc7cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01a067203acb80a71c8dba30615cab9ffa832dbeafe4c646133d7ead70769bf4ec7fbc26c7bd94d6dc7919b9feac7eaeb39fe9149ff14cfe671e2be610e91fa0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bf8e62171ad0e9a48d2d9840ebefca922b48c27d980063a08703ba0c3c9030af315c4c08d871c9827aa8dcde4fc5e4cc923c10b432cc5e124ee87a96a26a958b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-13 18:24:08.893799) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 18:24:08.894134) ========= 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.3w1yn73MeT/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.BE2mYtcmzP/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005221 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-13 18:24:08.942331) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 18:24:08.942654) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-13 18:24:08.942986) ========= ========= Total master_lag: 3.51 =========