builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0286 starttime: 1490633352.67 results: success (0) buildid: 20170327081421 builduid: 641a2acbc7ed4eb6a3b76fa07ab6fee1 revision: 46d5fe92c82d36b922703faeb7dd3a17b5df55e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 09:49:12.672461) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-27 09:49:12.672911) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 09:49:12.673214) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-27 09:49:12.701864) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 09:49:12.702258) ========= 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.jVimvm6Kkp/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.eRu5MKEdfs/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-27 09:49:12-- 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% 166M=0s 2017-03-27 09:49:12 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126637 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 09:49:12.852635) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 09:49:12.852954) ========= 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.jVimvm6Kkp/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.eRu5MKEdfs/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.026425 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 09:49:12.905024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 09:49:12.908480) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 46d5fe92c82d36b922703faeb7dd3a17b5df55e1 --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 46d5fe92c82d36b922703faeb7dd3a17b5df55e1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jVimvm6Kkp/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.eRu5MKEdfs/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-27 09:49:13,017 truncating revision to first 12 chars 2017-03-27 09:49:13,017 Setting DEBUG logging. 2017-03-27 09:49:13,017 attempt 1/10 2017-03-27 09:49:13,017 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/46d5fe92c82d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-27 09:49:14,544 unpacking tar archive at: mozilla-beta-46d5fe92c82d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.795363 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-27 09:49:14.730580) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 09:49:14.730964) ========= script_repo_revision: 46d5fe92c82d36b922703faeb7dd3a17b5df55e1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-27 09:49:14.731409) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 09:49:14.731680) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-27 09:49:14.751863) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-27 09:49:14.752273) ========= /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.jVimvm6Kkp/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.eRu5MKEdfs/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 09:49:14 INFO - MultiFileLogger online at 20170327 09:49:14 in /builds/slave/test 09:49:14 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 09:49:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:49:14 INFO - {'append_to_log': False, 09:49:14 INFO - 'base_work_dir': '/builds/slave/test', 09:49:14 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:49:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:49:14 INFO - 'branch': 'Mozilla-Beta', 09:49:14 INFO - 'buildbot_json_path': 'buildprops.json', 09:49:14 INFO - 'config_files': ('talos/mac_config.py',), 09:49:14 INFO - 'default_actions': ('clobber', 09:49:14 INFO - 'read-buildbot-config', 09:49:14 INFO - 'download-and-extract', 09:49:14 INFO - 'populate-webroot', 09:49:14 INFO - 'create-virtualenv', 09:49:14 INFO - 'install', 09:49:14 INFO - 'run-tests'), 09:49:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:49:14 INFO - 'download_minidump_stackwalk': True, 09:49:14 INFO - 'download_symbols': 'ondemand', 09:49:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:49:14 INFO - 'tooltool.py': '/tools/tooltool.py', 09:49:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:49:14 INFO - '/tools/misc-python/virtualenv.py')}, 09:49:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:49:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:49:14 INFO - 'installer_path': 'installer.exe', 09:49:14 INFO - 'log_level': 'info', 09:49:14 INFO - 'log_name': 'talos', 09:49:14 INFO - 'log_to_console': True, 09:49:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:49:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:49:14 INFO - 'opt_config_files': (), 09:49:14 INFO - 'pip_index': False, 09:49:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:49:14 INFO - 'cmd': ('bash', 09:49:14 INFO - '-c', 09:49:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:49:14 INFO - 'enabled': True, 09:49:14 INFO - 'halt_on_failure': False, 09:49:14 INFO - 'name': 'check_screen_resolution'},), 09:49:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:49:14 INFO - 'cmd': ('bash', 09:49:14 INFO - '-c', 09:49:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:49:14 INFO - 'enabled': True, 09:49:14 INFO - 'halt_on_failure': False, 09:49:14 INFO - 'name': 'check_screen_resolution'},), 09:49:14 INFO - 'run_cmd_checks_enabled': True, 09:49:14 INFO - 'sps_profile': False, 09:49:14 INFO - 'sps_profile_interval': 0, 09:49:14 INFO - 'suite': 'dromaeojs', 09:49:14 INFO - 'system_bits': '32', 09:49:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:49:14 INFO - 'title': 't-yosemite-r7-0286', 09:49:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:49:14 INFO - 'use_talos_json': True, 09:49:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:49:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:49:14 INFO - 'work_dir': 'build'} 09:49:14 INFO - [mozharness: 2017-03-27 16:49:14.965107Z] Running clobber step. 09:49:14 INFO - Running pre-action listener: _resource_record_pre_action 09:49:14 INFO - Running main action method: clobber 09:49:14 INFO - rmtree: /builds/slave/test/build 09:49:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:49:17 INFO - Running post-action listener: _resource_record_post_action 09:49:17 INFO - [mozharness: 2017-03-27 16:49:17.469113Z] Finished clobber step (success) 09:49:17 INFO - [mozharness: 2017-03-27 16:49:17.469385Z] Running read-buildbot-config step. 09:49:17 INFO - Running pre-action listener: _resource_record_pre_action 09:49:17 INFO - Running main action method: read_buildbot_config 09:49:17 INFO - Using buildbot properties: 09:49:17 INFO - { 09:49:17 INFO - "project": "", 09:49:17 INFO - "product": "firefox", 09:49:17 INFO - "script_repo_revision": "production", 09:49:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 09:49:17 INFO - "repository": "", 09:49:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 09:49:17 INFO - "buildid": "20170327081421", 09:49:17 INFO - "pgo_build": "False", 09:49:17 INFO - "basedir": "/builds/slave/test", 09:49:17 INFO - "buildnumber": 3, 09:49:17 INFO - "slavename": "t-yosemite-r7-0286", 09:49:17 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:49:17 INFO - "platform": "yosemite_r7", 09:49:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 09:49:17 INFO - "branch": "mozilla-beta", 09:49:17 INFO - "repo_path": "releases/mozilla-beta", 09:49:17 INFO - "revision": "46d5fe92c82d36b922703faeb7dd3a17b5df55e1", 09:49:17 INFO - "stage_platform": "macosx64", 09:49:17 INFO - "builduid": "641a2acbc7ed4eb6a3b76fa07ab6fee1", 09:49:17 INFO - "slavebuilddir": "test" 09:49:17 INFO - } 09:49:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 09:49:17 INFO - Running post-action listener: _resource_record_post_action 09:49:17 INFO - [mozharness: 2017-03-27 16:49:17.474883Z] Finished read-buildbot-config step (success) 09:49:17 INFO - [mozharness: 2017-03-27 16:49:17.475033Z] Running download-and-extract step. 09:49:17 INFO - Running pre-action listener: _resource_record_pre_action 09:49:17 INFO - Running main action method: download_and_extract 09:49:17 INFO - mkdir: /builds/slave/test/build/tests 09:49:17 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')]} 09:49:17 INFO - trying https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 09:49:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/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 09:49:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/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 09:49:18 INFO - Downloaded 1165 bytes. 09:49:18 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 09:49:18 INFO - Using the following test package requirements: 09:49:18 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 09:49:18 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 09:49:18 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 09:49:18 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 09:49:18 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 09:49:18 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 09:49:18 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 09:49:18 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 09:49:18 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 09:49:18 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 09:49:18 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 09:49:18 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 09:49:18 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 09:49:18 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 09:49:18 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 09:49:18 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 09:49:18 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 09:49:18 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 09:49:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 09:49:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 09:49:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 09:49:19 INFO - Expected file size: 16108467 09:49:19 INFO - Obtained file size: 16108467 09:49:26 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 09:49:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 09:49:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 09:49:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 09:49:27 INFO - Expected file size: 16108467 09:49:27 INFO - Obtained file size: 16108467 09:49:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 09:49:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 09:49:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 09:49:34 INFO - Expected file size: 14403663 09:49:34 INFO - Obtained file size: 14403663 09:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:35 INFO - trying https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 09:49:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 09:49:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/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 09:49:37 INFO - Downloaded 58682826 bytes. 09:49:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 09:49:37 INFO - mkdir: /builds/slave/test/properties 09:49:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:49:37 INFO - Writing to file /builds/slave/test/properties/build_url 09:49:37 INFO - Contents: 09:49:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 09:49:38 INFO - Running post-action listener: _resource_record_post_action 09:49:38 INFO - Running post-action listener: set_extra_try_arguments 09:49:38 INFO - [mozharness: 2017-03-27 16:49:38.091982Z] Finished download-and-extract step (success) 09:49:38 INFO - [mozharness: 2017-03-27 16:49:38.092096Z] Running populate-webroot step. 09:49:38 INFO - Running pre-action listener: _resource_record_pre_action 09:49:38 INFO - Running main action method: populate_webroot 09:49:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:49:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:49:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:49:38 INFO - '--tppagecycles', 09:49:38 INFO - '7'], 09:49:38 INFO - 'tests': ['tsvgm']}}, 09:49:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:49:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:49:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:49:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:49:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:49:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:49:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:49:38 INFO - 'talos_options': ['--disable-e10s'], 09:49:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:49:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:49:38 INFO - 'talos_options': ['--disable-e10s'], 09:49:38 INFO - 'tests': ['damp', 'tps']}, 09:49:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:49:38 INFO - 'tests': ['damp', 'tps']}, 09:49:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:49:38 INFO - 'tests': ['dromaeo_dom']}, 09:49:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:49:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:49:38 INFO - 'tests': ['basic_compositor_video']}, 09:49:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:49:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:49:38 INFO - 'tests': ['a11yr', 09:49:38 INFO - 'ts_paint', 09:49:38 INFO - 'tpaint', 09:49:38 INFO - 'sessionrestore', 09:49:38 INFO - 'sessionrestore_no_auto_restore', 09:49:38 INFO - 'tabpaint']}, 09:49:38 INFO - 'other-e10s': {'tests': ['a11yr', 09:49:38 INFO - 'ts_paint', 09:49:38 INFO - 'tpaint', 09:49:38 INFO - 'sessionrestore', 09:49:38 INFO - 'sessionrestore_no_auto_restore', 09:49:38 INFO - 'tabpaint']}, 09:49:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:49:38 INFO - 'ts_paint', 09:49:38 INFO - 'tpaint', 09:49:38 INFO - 'sessionrestore', 09:49:38 INFO - 'sessionrestore_no_auto_restore', 09:49:38 INFO - 'tabpaint']}, 09:49:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:49:38 INFO - 'ts_paint', 09:49:38 INFO - 'tpaint', 09:49:38 INFO - 'sessionrestore', 09:49:38 INFO - 'sessionrestore_no_auto_restore', 09:49:38 INFO - 'tabpaint']}, 09:49:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:49:38 INFO - 'tests': ['a11yr', 09:49:38 INFO - 'ts_paint', 09:49:38 INFO - 'tpaint', 09:49:38 INFO - 'sessionrestore', 09:49:38 INFO - 'sessionrestore_no_auto_restore', 09:49:38 INFO - 'tabpaint']}, 09:49:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:49:38 INFO - 'tests': ['a11yr', 09:49:38 INFO - 'ts_paint', 09:49:38 INFO - 'tpaint', 09:49:38 INFO - 'sessionrestore', 09:49:38 INFO - 'sessionrestore_no_auto_restore', 09:49:38 INFO - 'tabpaint']}, 09:49:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:49:38 INFO - 'tests': ['tsvgx', 09:49:38 INFO - 'tsvgr_opacity', 09:49:38 INFO - 'tart', 09:49:38 INFO - 'tscrollx', 09:49:38 INFO - 'cart', 09:49:38 INFO - 'tsvg_static']}, 09:49:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:49:38 INFO - 'tsvgr_opacity', 09:49:38 INFO - 'tart', 09:49:38 INFO - 'tscrollx', 09:49:38 INFO - 'cart', 09:49:38 INFO - 'tsvg_static']}, 09:49:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:49:38 INFO - 'talos_options': ['--disable-e10s'], 09:49:38 INFO - 'tests': ['tp5o']}, 09:49:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:49:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:49:38 INFO - 'talos_options': ['--disable-e10s', 09:49:38 INFO - '--xperf_path', 09:49:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:38 INFO - 'tests': ['tp5n']}, 09:49:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:49:38 INFO - 'talos_options': ['--xperf_path', 09:49:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:38 INFO - 'tests': ['tp5n']}}, 09:49:38 INFO - 'talos.zip': {'path': '', 09:49:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:49:38 INFO - Running post-action listener: _resource_record_post_action 09:49:38 INFO - [mozharness: 2017-03-27 16:49:38.110806Z] Finished populate-webroot step (success) 09:49:38 INFO - [mozharness: 2017-03-27 16:49:38.110940Z] Running create-virtualenv step. 09:49:38 INFO - Running pre-action listener: _resource_record_pre_action 09:49:38 INFO - Running main action method: create_virtualenv 09:49:38 INFO - Creating virtualenv /builds/slave/test/build/venv 09:49: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 09:49:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:49:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:49:38 INFO - Using real prefix '/tools/python27' 09:49:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:49:38 INFO - Installing distribute.............................................................................................................................................................................................done. 09:49:41 INFO - Installing pip.................done. 09:49:41 INFO - Return code: 0 09:49:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:49:42 INFO - Reading from file tmpfile_stdout 09:49:42 INFO - Output received: 09:49: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) 09:49:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:49: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')]} 09:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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 0x108c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe522d72300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a0bd30>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a00be8>, '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.jVimvm6Kkp/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.eRu5MKEdfs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 09:49: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 09:49: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 09:49:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jVimvm6Kkp/Render', 09:49:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:42 INFO - 'HOME': '/Users/cltbld', 09:49:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:42 INFO - 'LOGNAME': 'cltbld', 09:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:42 INFO - 'MOZ_NO_REMOTE': '1', 09:49:42 INFO - 'NO_EM_RESTART': '1', 09:49:42 INFO - 'PAGER': '/bin/cat', 09:49:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:42 INFO - 'PWD': '/builds/slave/test', 09:49:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:42 INFO - 'SHELL': '/bin/bash', 09:49:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRu5MKEdfs/Listeners', 09:49:42 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 09:49:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:42 INFO - 'USER': 'cltbld', 09:49:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:42 INFO - 'XPC_FLAGS': '0x0', 09:49:42 INFO - 'XPC_SERVICE_NAME': '0', 09:49:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49: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 09:49:42 INFO - Cleaning up... 09:49:42 INFO - Return code: 0 09:49:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:49: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')]} 09:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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 0x108c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe522d72300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a0bd30>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a00be8>, '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.jVimvm6Kkp/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.eRu5MKEdfs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 09:49: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 09:49: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 09:49:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jVimvm6Kkp/Render', 09:49:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:42 INFO - 'HOME': '/Users/cltbld', 09:49:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:42 INFO - 'LOGNAME': 'cltbld', 09:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:42 INFO - 'MOZ_NO_REMOTE': '1', 09:49:42 INFO - 'NO_EM_RESTART': '1', 09:49:42 INFO - 'PAGER': '/bin/cat', 09:49:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:42 INFO - 'PWD': '/builds/slave/test', 09:49:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:42 INFO - 'SHELL': '/bin/bash', 09:49:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRu5MKEdfs/Listeners', 09:49:42 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 09:49:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:42 INFO - 'USER': 'cltbld', 09:49:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:42 INFO - 'XPC_FLAGS': '0x0', 09:49:42 INFO - 'XPC_SERVICE_NAME': '0', 09:49:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:42 INFO - Downloading/unpacking psutil>=3.1.1 09:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:49:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:46 INFO - Installing collected packages: psutil 09:49:46 INFO - Running setup.py install for psutil 09:49:46 INFO - building 'psutil._psutil_osx' extension 09:49: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 09:49: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:49: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 09:49: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 09:49:47 INFO - building 'psutil._psutil_posix' extension 09:49: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 09:49:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:49:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:49:47 INFO - ^ 09:49:47 INFO - 1 warning generated. 09:49: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 09:49:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:47 INFO - Successfully installed psutil 09:49:47 INFO - Cleaning up... 09:49:47 INFO - Return code: 0 09:49:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:49: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')]} 09:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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 0x108c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe522d72300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a0bd30>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a00be8>, '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.jVimvm6Kkp/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.eRu5MKEdfs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 09:49: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 09:49: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 09:49:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jVimvm6Kkp/Render', 09:49:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:47 INFO - 'HOME': '/Users/cltbld', 09:49:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:47 INFO - 'LOGNAME': 'cltbld', 09:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:47 INFO - 'MOZ_NO_REMOTE': '1', 09:49:47 INFO - 'NO_EM_RESTART': '1', 09:49:47 INFO - 'PAGER': '/bin/cat', 09:49:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:47 INFO - 'PWD': '/builds/slave/test', 09:49:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:47 INFO - 'SHELL': '/bin/bash', 09:49:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRu5MKEdfs/Listeners', 09:49:47 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 09:49:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:47 INFO - 'USER': 'cltbld', 09:49:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:47 INFO - 'XPC_FLAGS': '0x0', 09:49:47 INFO - 'XPC_SERVICE_NAME': '0', 09:49:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:49:47 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 09:49:47 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 09:49:47 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 09:49:47 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 09:49:47 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 09:49:47 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 09:49:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:49:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:49:50 INFO - Installing collected packages: mozsystemmonitor 09:49:50 INFO - Running setup.py install for mozsystemmonitor 09:49:50 INFO - Successfully installed mozsystemmonitor 09:49:50 INFO - Cleaning up... 09:49:50 INFO - Return code: 0 09:49:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:49:50 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')]} 09:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:50 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')]} 09:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:50 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 0x108c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe522d72300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a0bd30>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a00be8>, '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.jVimvm6Kkp/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.eRu5MKEdfs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 09:49:50 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 09:49:50 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 09:49:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jVimvm6Kkp/Render', 09:49:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:50 INFO - 'HOME': '/Users/cltbld', 09:49:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:50 INFO - 'LOGNAME': 'cltbld', 09:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:50 INFO - 'MOZ_NO_REMOTE': '1', 09:49:50 INFO - 'NO_EM_RESTART': '1', 09:49:50 INFO - 'PAGER': '/bin/cat', 09:49:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:50 INFO - 'PWD': '/builds/slave/test', 09:49:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:50 INFO - 'SHELL': '/bin/bash', 09:49:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRu5MKEdfs/Listeners', 09:49:50 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 09:49:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:50 INFO - 'USER': 'cltbld', 09:49:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:50 INFO - 'XPC_FLAGS': '0x0', 09:49:50 INFO - 'XPC_SERVICE_NAME': '0', 09:49:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:50 INFO - Downloading/unpacking jsonschema==2.5.1 09:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:49:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:53 INFO - Downloading functools32-3.2.3-2.tar.gz 09:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:49:54 INFO - warning: no files found matching '*.txt' 09:49:54 INFO - no previously-included directories found matching 'build' 09:49:54 INFO - no previously-included directories found matching 'dist' 09:49:54 INFO - no previously-included directories found matching '.git*' 09:49:54 INFO - Installing collected packages: jsonschema, functools32 09:49:54 INFO - Running setup.py install for functools32 09:49:54 INFO - warning: no files found matching '*.txt' 09:49:54 INFO - no previously-included directories found matching 'build' 09:49:54 INFO - no previously-included directories found matching 'dist' 09:49:54 INFO - no previously-included directories found matching '.git*' 09:49:54 INFO - Successfully installed jsonschema functools32 09:49:54 INFO - Cleaning up... 09:49:54 INFO - Return code: 0 09:49:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:49: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')]} 09:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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 0x108c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe522d72300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a0bd30>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a00be8>, '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.jVimvm6Kkp/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.eRu5MKEdfs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 09:49: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 09:49: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 09:49:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jVimvm6Kkp/Render', 09:49:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:54 INFO - 'HOME': '/Users/cltbld', 09:49:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:54 INFO - 'LOGNAME': 'cltbld', 09:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:54 INFO - 'MOZ_NO_REMOTE': '1', 09:49:54 INFO - 'NO_EM_RESTART': '1', 09:49:54 INFO - 'PAGER': '/bin/cat', 09:49:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:54 INFO - 'PWD': '/builds/slave/test', 09:49:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:54 INFO - 'SHELL': '/bin/bash', 09:49:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRu5MKEdfs/Listeners', 09:49:54 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 09:49:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:54 INFO - 'USER': 'cltbld', 09:49:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:54 INFO - 'XPC_FLAGS': '0x0', 09:49:54 INFO - 'XPC_SERVICE_NAME': '0', 09:49:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:49:54 INFO - Cleaning up... 09:49:54 INFO - Return code: 0 09:49:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:49: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')]} 09:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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')]} 09:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49: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', '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 0x108c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe522d72300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a0bd30>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a00be8>, '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.jVimvm6Kkp/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.eRu5MKEdfs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 09:49: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:49: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 blobuploader==1.2.4 09:49:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jVimvm6Kkp/Render', 09:49:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:54 INFO - 'HOME': '/Users/cltbld', 09:49:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:54 INFO - 'LOGNAME': 'cltbld', 09:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:54 INFO - 'MOZ_NO_REMOTE': '1', 09:49:54 INFO - 'NO_EM_RESTART': '1', 09:49:54 INFO - 'PAGER': '/bin/cat', 09:49:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:54 INFO - 'PWD': '/builds/slave/test', 09:49:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:54 INFO - 'SHELL': '/bin/bash', 09:49:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRu5MKEdfs/Listeners', 09:49:54 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 09:49:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:54 INFO - 'USER': 'cltbld', 09:49:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:54 INFO - 'XPC_FLAGS': '0x0', 09:49:54 INFO - 'XPC_SERVICE_NAME': '0', 09:49:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:54 INFO - Downloading/unpacking blobuploader==1.2.4 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:57 INFO - Downloading blobuploader-1.2.4.tar.gz 09:49:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:49:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:49:57 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 09:49:57 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 09:49:57 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 09:49:57 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 09:49:57 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 09:49:57 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 09:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:49:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49: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 09:49:58 INFO - Downloading docopt-0.6.1.tar.gz 09:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:49:58 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:58 INFO - Running setup.py install for blobuploader 09:49:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:49:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:49:59 INFO - Running setup.py install for requests 09:49:59 INFO - Running setup.py install for docopt 09:49:59 INFO - Successfully installed blobuploader requests docopt 09:49:59 INFO - Cleaning up... 09:49:59 INFO - Return code: 0 09:49:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:59 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')]} 09:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:59 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')]} 09:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:49:59 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 0x108c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe522d72300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a0bd30>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a00be8>, '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.jVimvm6Kkp/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.eRu5MKEdfs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 09:49:59 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 09:49:59 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 09:49:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jVimvm6Kkp/Render', 09:49:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:59 INFO - 'HOME': '/Users/cltbld', 09:49:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:59 INFO - 'LOGNAME': 'cltbld', 09:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:59 INFO - 'MOZ_NO_REMOTE': '1', 09:49:59 INFO - 'NO_EM_RESTART': '1', 09:49:59 INFO - 'PAGER': '/bin/cat', 09:49:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:59 INFO - 'PWD': '/builds/slave/test', 09:49:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:59 INFO - 'SHELL': '/bin/bash', 09:49:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRu5MKEdfs/Listeners', 09:49:59 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 09:49:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:59 INFO - 'USER': 'cltbld', 09:49:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:59 INFO - 'XPC_FLAGS': '0x0', 09:49:59 INFO - 'XPC_SERVICE_NAME': '0', 09:49:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:50:00 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-tKd67l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:50:00 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-tV0WhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:50:00 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-rGnPr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:50:00 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-3kqIte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:50:00 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-GicXSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:50:00 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-SUqYi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:50:00 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-fyjEAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:50:00 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-QExtr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:50:00 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-3CZld0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:50:00 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-z9ZO0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:50:01 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-EmDXBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:50:01 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-2knDYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:50:01 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-K4pj0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:50:01 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-DERCnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:01 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-sY_Ynl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:50:01 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-8ilbC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:50:01 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-8SU289-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:50:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:50:01 INFO - Running setup.py install for manifestparser 09:50:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:50:01 INFO - Running setup.py install for mozcrash 09:50:02 INFO - Running setup.py install for mozdebug 09:50:02 INFO - Running setup.py install for mozdevice 09:50:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:50:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:50:02 INFO - Running setup.py install for mozfile 09:50:02 INFO - Running setup.py install for mozhttpd 09:50:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:50:02 INFO - Running setup.py install for mozinfo 09:50:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:50:02 INFO - Running setup.py install for mozInstall 09:50:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:50:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:50:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:50:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:50:02 INFO - Running setup.py install for mozleak 09:50:03 INFO - Running setup.py install for mozlog 09:50:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:50:03 INFO - Running setup.py install for moznetwork 09:50:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:50:03 INFO - Running setup.py install for mozprocess 09:50:03 INFO - Running setup.py install for mozprofile 09:50:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:50:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:50:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:50:03 INFO - Running setup.py install for mozrunner 09:50:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:50:03 INFO - Running setup.py install for mozscreenshot 09:50:04 INFO - Running setup.py install for moztest 09:50:04 INFO - Running setup.py install for mozversion 09:50:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:50:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:50:04 INFO - Cleaning up... 09:50:04 INFO - Return code: 0 09:50:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:50: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')]} 09:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50: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')]} 09:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50: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 0x108c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe522d72300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a0bd30>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a00be8>, '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.jVimvm6Kkp/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.eRu5MKEdfs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 09:50: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 09:50: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 09:50:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jVimvm6Kkp/Render', 09:50:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:04 INFO - 'HOME': '/Users/cltbld', 09:50:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:04 INFO - 'LOGNAME': 'cltbld', 09:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:04 INFO - 'MOZ_NO_REMOTE': '1', 09:50:04 INFO - 'NO_EM_RESTART': '1', 09:50:04 INFO - 'PAGER': '/bin/cat', 09:50:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:04 INFO - 'PWD': '/builds/slave/test', 09:50:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:04 INFO - 'SHELL': '/bin/bash', 09:50:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRu5MKEdfs/Listeners', 09:50:04 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 09:50:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:04 INFO - 'USER': 'cltbld', 09:50:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:04 INFO - 'XPC_FLAGS': '0x0', 09:50:04 INFO - 'XPC_SERVICE_NAME': '0', 09:50:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:50:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-BAji0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:50:04 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)) 09:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:50:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-B8Hkzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:50:04 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)) 09:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:50:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-yKlDhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:50:04 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)) 09:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:50:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-tcxT_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:50: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)) 09:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:50:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-bPYpM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:50: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)) 09:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:50:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-IDIO7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:50: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)) 09:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:50:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ulvsx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:50: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)) 09:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:50:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ufWZbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:50: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)) 09:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:50:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-Rov_De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:50:05 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)) 09:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:50:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-V6XYYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:50:05 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)) 09:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:50:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-vdrA0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:50:05 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)) 09:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:50:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-KUUBqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:50:05 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)) 09:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:50:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-3bbVJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:50:05 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)) 09:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:50:05 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-IA2gPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:50: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)) 09:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:50:06 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-99o6GC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:50: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)) 09:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:50:06 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-l7ZcvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:50: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)) 09:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:50:06 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-q116fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:50: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)) 09:50: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)) 09:50: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)) 09:50: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)) 09:50: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)) 09:50: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)) 09:50:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50: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 09:50:09 INFO - Downloading blessings-1.6.tar.gz 09:50:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:50:09 INFO - Installing collected packages: blessings 09:50:09 INFO - Running setup.py install for blessings 09:50:09 INFO - Successfully installed blessings 09:50:09 INFO - Cleaning up... 09:50:09 INFO - Return code: 0 09:50:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:50:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:50:09 INFO - Reading from file tmpfile_stdout 09:50:09 INFO - Current package versions: 09:50:09 INFO - blessings == 1.6 09:50:09 INFO - blobuploader == 1.2.4 09:50:09 INFO - docopt == 0.6.1 09:50:09 INFO - functools32 == 3.2.3-2 09:50:09 INFO - jsonschema == 2.5.1 09:50:09 INFO - manifestparser == 1.1 09:50:09 INFO - mozInstall == 1.12 09:50:09 INFO - mozcrash == 1.0 09:50:09 INFO - mozdebug == 0.1 09:50:09 INFO - mozdevice == 0.49 09:50:09 INFO - mozfile == 1.2 09:50:09 INFO - mozhttpd == 0.7 09:50:09 INFO - mozinfo == 0.9 09:50:09 INFO - mozleak == 0.1 09:50:09 INFO - mozlog == 3.4 09:50:09 INFO - moznetwork == 0.27 09:50:09 INFO - mozprocess == 0.24 09:50:09 INFO - mozprofile == 0.28 09:50:09 INFO - mozrunner == 6.13 09:50:09 INFO - mozscreenshot == 0.1 09:50:09 INFO - mozsystemmonitor == 0.3 09:50:09 INFO - moztest == 0.8 09:50:09 INFO - mozversion == 1.4 09:50:09 INFO - psutil == 3.1.1 09:50:09 INFO - requests == 1.2.3 09:50:09 INFO - wsgiref == 0.1.2 09:50:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50: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')]} 09:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50:10 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 0x108c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe522d72300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a0bd30>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a00be8>, '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.jVimvm6Kkp/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.eRu5MKEdfs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 09:50:10 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 09:50:10 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 09:50:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jVimvm6Kkp/Render', 09:50:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:10 INFO - 'HOME': '/Users/cltbld', 09:50:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:10 INFO - 'LOGNAME': 'cltbld', 09:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:10 INFO - 'MOZ_NO_REMOTE': '1', 09:50:10 INFO - 'NO_EM_RESTART': '1', 09:50:10 INFO - 'PAGER': '/bin/cat', 09:50:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:10 INFO - 'PWD': '/builds/slave/test', 09:50:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:10 INFO - 'SHELL': '/bin/bash', 09:50:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRu5MKEdfs/Listeners', 09:50:10 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 09:50:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:10 INFO - 'USER': 'cltbld', 09:50:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:10 INFO - 'XPC_FLAGS': '0x0', 09:50:10 INFO - 'XPC_SERVICE_NAME': '0', 09:50:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:10 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)) 09:50:10 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)) 09:50:10 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)) 09:50:10 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)) 09:50:10 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)) 09:50:10 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)) 09:50:10 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)) 09:50:10 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)) 09:50:10 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)) 09:50:10 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)) 09:50:10 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)) 09:50:10 INFO - Cleaning up... 09:50:10 INFO - Return code: 0 09:50:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:50: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')]} 09:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50: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')]} 09:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:50: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 0x108c2db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108c30768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe522d72300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a0bd30>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a00be8>, '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.jVimvm6Kkp/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.eRu5MKEdfs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 09:50: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 09:50: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 09:50:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jVimvm6Kkp/Render', 09:50:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:11 INFO - 'HOME': '/Users/cltbld', 09:50:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:11 INFO - 'LOGNAME': 'cltbld', 09:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:11 INFO - 'MOZ_NO_REMOTE': '1', 09:50:11 INFO - 'NO_EM_RESTART': '1', 09:50:11 INFO - 'PAGER': '/bin/cat', 09:50:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:11 INFO - 'PWD': '/builds/slave/test', 09:50:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:11 INFO - 'SHELL': '/bin/bash', 09:50:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRu5MKEdfs/Listeners', 09:50:11 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 09:50:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:11 INFO - 'USER': 'cltbld', 09:50:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:11 INFO - 'XPC_FLAGS': '0x0', 09:50:11 INFO - 'XPC_SERVICE_NAME': '0', 09:50:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:50:11 INFO - Cleaning up... 09:50:11 INFO - Return code: 0 09:50:11 INFO - Running post-action listener: _resource_record_post_action 09:50:11 INFO - Running post-action listener: _start_resource_monitoring 09:50:11 INFO - Starting resource monitoring. 09:50:11 INFO - [mozharness: 2017-03-27 16:50:11.538376Z] Finished create-virtualenv step (success) 09:50:11 INFO - [mozharness: 2017-03-27 16:50:11.539282Z] Running install step. 09:50:11 INFO - Running pre-action listener: _resource_record_pre_action 09:50:11 INFO - Running main action method: install 09:50:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:50:11 INFO - Reading from file tmpfile_stdout 09:50:11 INFO - Detecting whether we're running mozinstall >=1.0... 09:50:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:50:11 INFO - Reading from file tmpfile_stdout 09:50:11 INFO - Output received: 09:50:11 INFO - Usage: mozinstall [options] installer 09:50:11 INFO - Options: 09:50:11 INFO - -h, --help show this help message and exit 09:50:11 INFO - -d DEST, --destination=DEST 09:50:11 INFO - Directory to install application into. [default: 09:50:11 INFO - "/builds/slave/test"] 09:50:11 INFO - --app=APP Application being installed. [default: firefox] 09:50:11 INFO - mkdir: /builds/slave/test/build/application 09:50: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'] 09:50: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 09:50:26 INFO - Reading from file tmpfile_stdout 09:50:26 INFO - Output received: 09:50:26 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 09:50:26 INFO - Running post-action listener: _resource_record_post_action 09:50:26 INFO - [mozharness: 2017-03-27 16:50:26.684880Z] Finished install step (success) 09:50:26 INFO - [mozharness: 2017-03-27 16:50:26.685011Z] Running run-tests step. 09:50:26 INFO - Running pre-action listener: _resource_record_pre_action 09:50:26 INFO - Running main action method: run_tests 09:50:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:50:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:50:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:50:26 INFO - 2017-03-27 09:50:26.699 screenresolution[1623:7388] starting screenresolution argv=screenresolution get 09:50:26 INFO - 2017-03-27 09:50:26.701 screenresolution[1623:7388] Display 0: 1600x1200x32@60 09:50:26 INFO - 2017-03-27 09:50:26.707 screenresolution[1624:7390] starting screenresolution argv=screenresolution list 09:50:26 INFO - Available Modes on Display 0 09:50:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:50:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:50:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:50:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:50:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:50:26 INFO - Intel Iris: 09:50:26 INFO - Chipset Model: Intel Iris 09:50:26 INFO - Type: GPU 09:50:26 INFO - Bus: Built-In 09:50:26 INFO - VRAM (Dynamic, Max): 1536 MB 09:50:26 INFO - Vendor: Intel (0x8086) 09:50:26 INFO - Device ID: 0x0a2e 09:50:26 INFO - Revision ID: 0x0009 09:50:26 INFO - Displays: 09:50:26 INFO - Display: 09:50:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:50:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:50:26 INFO - Display Serial Number: 1600x1200 60 09:50:26 INFO - Main Display: Yes 09:50:26 INFO - Mirror: Off 09:50:26 INFO - Online: Yes 09:50:26 INFO - Rotation: Supported 09:50:26 INFO - Return code: 0 09:50:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:50:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:50:26 INFO - Python 2.7.3 09:50:26 INFO - Return code: 0 09:50:26 INFO - grabbing minidump binary from tooltool 09:50: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')]} 09:50: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 0x108a0bd30>, '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 0x108932db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a00be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:50: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 09:50: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 09:50: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 09:50:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:50:27 INFO - Return code: 0 09:50:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:50:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:50:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:50:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:50:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:50: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/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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 09:50: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/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0286 --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 09:50:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jVimvm6Kkp/Render', 09:50:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:50:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:50:27 INFO - 'HOME': '/Users/cltbld', 09:50:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:50:27 INFO - 'LOGNAME': 'cltbld', 09:50:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:50:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:50:27 INFO - 'MOZ_NO_REMOTE': '1', 09:50:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:50:27 INFO - 'NO_EM_RESTART': '1', 09:50:27 INFO - 'PAGER': '/bin/cat', 09:50:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:50:27 INFO - 'PWD': '/builds/slave/test', 09:50:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:50:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:50:27 INFO - 'SHELL': '/bin/bash', 09:50:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRu5MKEdfs/Listeners', 09:50:27 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 09:50:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:50:27 INFO - 'USER': 'cltbld', 09:50:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:50:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:50:27 INFO - 'XPC_FLAGS': '0x0', 09:50:27 INFO - 'XPC_SERVICE_NAME': '0', 09:50:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:50: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/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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 09:50:27 INFO - mozversion application_buildid: 20170327081421 09:50:27 INFO - mozversion application_changeset: 46d5fe92c82d36b922703faeb7dd3a17b5df55e1 09:50:27 INFO - mozversion application_display_name: Firefox 09:50:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:50:27 INFO - mozversion application_name: Firefox 09:50:27 INFO - mozversion application_remotingname: firefox 09:50:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:50:27 INFO - mozversion application_vendor: Mozilla 09:50:27 INFO - mozversion application_version: 53.0 09:50:27 INFO - mozversion platform_buildid: 20170327081421 09:50:27 INFO - mozversion platform_changeset: 46d5fe92c82d36b922703faeb7dd3a17b5df55e1 09:50:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:50:27 INFO - mozversion platform_version: 53.0 09:50:27 INFO - using testdate: 1490633427 09:50:27 INFO - actual date: 1490633427 09:50:27 INFO - starting webserver on 'localhost:49241' 09:50:27 INFO - SUITE-START | Running 2 tests 09:50:27 INFO - TEST-START | dromaeo_css 09:50:27 INFO - operating with platform_type : mac_ 09:50:27 INFO - Initialising browser for dromaeo_css test... 09:50:27 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpX__EEt/profile http://localhost:49241/getInfo.html) 09:50:29 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 09:50:29 INFO - PROCESS | 1634 | colorDepth:24 09:50:29 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 09:50:29 INFO - PROCESS | 1634 | __metrics 09:50:29 INFO - PROCESS | 1634 | 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" 09:50:29 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:50:30 INFO - TEST-INFO | 1634: exit 0 09:50:30 INFO - Browser initialized. 09:50:30 INFO - Running cycle 1/1 for dromaeo_css test... 09:50:30 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpX__EEt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:42 INFO - PROCESS | 1637 | RSS: Main: 167849984 09:50:42 INFO - PROCESS | 1637 | 09:53:45 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:53:46 INFO - PROCESS | 1637 | RSS: Main: 302493696 09:53:46 INFO - PROCESS | 1637 | 09:56:49 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:56:50 INFO - PROCESS | 1637 | RSS: Main: 309084160 09:56:50 INFO - PROCESS | 1637 | 09:59:52 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:59:53 INFO - PROCESS | 1637 | RSS: Main: 305209344 09:59:53 INFO - PROCESS | 1637 | 10:02:55 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 10:02:56 INFO - PROCESS | 1637 | RSS: Main: 287805440 10:02:56 INFO - PROCESS | 1637 | 10:05:59 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 10:06:00 INFO - PROCESS | 1637 | RSS: Main: 261722112 10:06:00 INFO - PROCESS | 1637 | 10:09:03 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 10:09:03 INFO - PROCESS | 1637 | RSS: Main: 357117952 10:09:03 INFO - PROCESS | 1637 | 10:09:03 INFO - PROCESS | 1637 | __start_tp_report 10:09:03 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 10:09:03 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 10:09:03 INFO - PROCESS | 1637 | |i|pagename|runs| 10:09:03 INFO - PROCESS | 1637 | |0;dojo.html;3416.914577135571;3432.0904960185553;3441.3461442325956;3454.84453199606;3491.3715531204375;5585.441455854412;5631.746571404286;5649.943500564993;5656.886862262752;5661.179129026289;5621.213030175769;5696.971515142429;5699.857503562413;5710.200571919934;5716.628419152752;3778.4899038629846;5143.768530416121;5169.431362550116;5185.144451165553;5188.2995795567585;3998.6601138903084;4735.147673418784;5136.58907287418;5267.420583735805;5301.125314323132;5131.486851314858;5192.844214673547;5201.973990130044;5207.218917162437;5208.635395522315;5218.269442278084;5219.660722053054;5245.659032162936;5252.606054545924;5252.737363131847;5107.106256405114;5172.818951336722;5199.558037566811;5212.713300768456;5228.346456692913;5548.91676624851;5588.329400471929;5609.102543593046;5650.773969041234;5671.149327600851;6108.471341378537;6140.057253910601;6165.568410211287;6234.594751341194;6247.5939063960695;6227.408396202353;6294.87410251797;6312.684365781738;6316.210473690789;6316.842078948063;5759.740811663527;5779.826605201809;5789.536837053026;5796.217510636095;5798.985177593904;6212.006079027425;6277.96861015692;6301.842453938688;6338.144350512714;6344.238691356974;5562.193481945095;5804.216430781875;6152.2924863640355;6154.892119418548;6168.9691551542855;5267.446918073547;6222.844428889223;6285.9057114143325;6290.21372328459;6295.213098362705;5981.910271345933;6015.518758499309;6031.095335699592;6137.263528376623;6197.504199664016;6179.84550386235;6239.968800156061;6250.468710159596;6258.311585725566;6288.779892703825;4966.90066198674;4986.227134794112;4992.450830408652;4998.800047998112;5028.798848046037;4383.145286669069;4384.802683879233;4397.164538737629;4448.065906159678;4487.640988720895;5766.682832444172;5770.913436298459;5823.5341172706085;5855.238818953509;5873.676947767828;6100.664463454464;6235.844103897348;6258.15514905491;6284.12022316876;6295.905561416583;5684.8863022739315;5719.828405147852;5724.77100915967;5828.067509198592;5831.154482599999;5382.515573598395;5384.057789886754;5396.730163491889;5398.217258497496;5401.081816091274;5182.585393168538;6304.432601065926;6348.047792831112;6349.301576826545;6362.2683391409655;6234.407731265523;6272.498200143887;6302.369763023661;6318.115463834974;6321.431071203614;6282.2147231596055;6289.528285378524;6291.213598300213;6295.055741638791;6295.213098362705;6041.093835924647;6067.939320606914;6091.8781624366375;6128.32588415265;6210.937890621036;6198.504119670325;6262.029385445263;6279.152314437675;6294.087357333253;6294.244690637152;6029.60807547508;6091.969540152271;6094.7562097517375;6100.2984656763265;6115.388461153849;5471.015217260772;5834.824955251349;5847.415258474119;6076.0278355462915;6089.786857459968;5868.765249389977;5884.882302354014;5937.435943585352;5966.850828729316;6017.729202185999;6103.084537319438;6105.84735381619;6112.480439162543;6118.908216376669;6120.846978825565;5781.68200748946;5926.407359264212;5940.940590594038;5941.079132734433;5955.196048533393 10:09:03 INFO - PROCESS | 1637 | |1;ext.html;459.9260726204313;502.9949700502994;510.52011109557014;521.1583292981835;541.7914103070317;32559.348813023757;42650.36024459632;43089.35365969509;43207.56792432075;44829.10341793162;45720.771396143056;46043.07913841721;46109.76945115278;46180.307295390514;46208;8969.461832290084;9588.616455341795;9805.215582753362;9815.852762208573;9817.116459518642;8893.644254229823;11759.7060073498;11978;12053.457594408274;12214.755704885896;10021;11958.282503049844;11967.2819630822;11981.520739170423;11984.880151198508;11970.461329240205;12039.819402708967;12051.819222711667;12052.819207711891;12063.819042714365;11737.178397512178;11823.94088029563;11831.112666550043;11833.644990650295;11839.408029598486;42443.787781061204;42813.57186428127;42827;42957;43004.56995430037;4079.796010199478;4082.81627326771;4105.363668631367;4118.176364727036;4121.4848143982;31177.064688059396;31802.204944876332;32832.83583582091;33244.50133248003;33447.498287525705;3308.983455082709;3358.613759417674;3359.0762540301366;3489.6335884731993;3494.9650503494895;483086;489508;490598;491527;491843;63778.6811065951;64002.35997640057;64222;64410.67794660997;64435.67782161059;66791;66846.66576667085;66884.6623067536;66907.33092669108;66915.32711682247;17284.395046173322;17813.554661133316;17816.732749008515;17860.732089018675;17873.106344682714;12570.245785252913;13229.735405292033;13736.725265494833;13737.381817818223;13804.309784510735;14500.129992200502;14855.628609284639;14861.851381486047;14872.33074511628;16046.358145674276;6929.336959129873;7044.964775176091;7112.537685050559;7172.175199852084;7218.242084581148;886.8758373827669;888.6401007591936;891.140049851896;911.0889110889111;921.4056933278132;30634.69365306363;30670.693293066783;30851.074467766004;31340.373192536023;31426.685733142833;1001.1890368801294;1077.6066735641434;1108.451316598289;1120.2718233148519;1157.5993048411349;14239.715205695828;14770.70458590822;15725.483922572563;15822;16196.271167797477;535207;538265;539067;539624;540875;61217;61249.77500449966;61378.079328810105;61438;61469;1273.8471383433862;1458.50410860308;1471.0805746408494;1490.903091299062;1491.1873029198896;27626.723732762413;29977;30056.098317050524;30687.539686905162;30926;50705;51004;51017.48982510127;51033;51140.48859511357;492972;496149;497751;497812;498213;25704.742952570236;26323.341916452242;26391.34021649474;40145.99635009148;40495.59504405036;33376.33247334991;37717.245655087296;40751.59248407478;44563.554364455944;45438.772806135756;30335.848320758254;31209;31515.684843152194;31806.84096579502;32286.838565807022;27119.72880271251;31289;32079.518807218377;32193.195170120933;32388.86638967625;36352.09119771921;37010.8149459251;37081;37092.629073708915;37143.814280928425;30356;30681.8465907669;31536.36927261396;31682;32228.71085156661;21566.029528671563;23655.29034128979;24910.875445622656;25304.746952530975;25332.746672533776 10:09:03 INFO - PROCESS | 1637 | |2;jquery.html;375.29070057591156;403.52182663543687;412.19827435637694;412.7193508414277;436.4675096382412;12074.072266816316;18014.369497067604;18974.810251897477;19017.52456188596;20734.066966986484;21734.56530869382;22361;22404.8879755601;22408.439789005242;22645.320640380774;5719.714014299289;6036.305824830157;6037.577369584131;6042.033274676052;6043.788467403641;4878.634102442314;5902.085176797603;6025.397460253984;6625.17185351831;6713.630750308731;6683.398494135527;6700.028495868096;6701.530892837503;6706.12820333356;6719.8656026879435;6410.487161027107;6563.409293163614;6639.3692599203;6640.966795165993;6643.136392268998;5163.948360516384;5532;5832.416758324176;5838.562107841886;5840.474357307863;13287.006948957636;13290.800637990438;13487.393067311896;13639.727205455934;22685.546289074293;2559.270607876746;2604.6613940187844;2635.604659301101;2667.8666066696783;2737.794665400103;9620.663276785279;10053.597856085747;10148.340357876714;10530.999555042259;10606.522706478227;1836.494963884929;1847.5842935339576;1858.8048254933171;1873.9156737946826;1891.4042076745782;132232;132741;134268.65731342658;134692.87764101278;143538.28230858882;10055.59777608902;10506.684799456028;10611.628592999208;10656.307340022873;11912.344821034927;11076.501557429934;13040.673983150496;13182;14765.77851332231;15390.692186156215;8418.368622353348;8676.8698469523;9049.411788233876;9057.09429057089;9066.048064953216;8867.778305542413;8922.73231803047;8964;9101.81796364069;9148;4796.736179510091;4850.6362022848425;4910.90178196434;4949.925751113737;5027;1790.0961617889382;1965.8525610578977;2080.979190208109;2103.5477372364708;2103.842211834088;877.1842186766369;899.67161985876;906.0758026812746;934.1592566690033;935.4153653966271;21918.342449726533;22490.550188996454;22500.549989000127;22524.887375563347;22580.66129008066;906.4334790755778;906.845836207833;911.1617312072909;938.7090002099371;941.5198248892976;9792;11520.73271940086;11672.70818229551;11702.356370399539;11739.47172377228;666889;757870;772200;772556;775778;110540.89459105468;128379.07431388537;153634.46365536202;157316;159662;1072.5495291977388;1073.2648136026846;1092.3664274720643;1092.6831218946415;1096.8848270931596;17972.370967016093;18007.819921800616;18204.90770553771;19516;19718.704219436433;61201;62757.68621156865;62788.68605656942;63130.684346577975;63288;88664;88918;91484.54257728669;93018.53490732503;93037;6642.900356494753;8218.424710270223;8314.750557483285;8508.872366914378;8538.274246689101;12155.878441215475;12667.366631668565;12958.481660733465;12974.870251297367;12994.480220791062;10466.738331541772;10953.671389858317;11101.555937762721;11218.326900386002;11308.208425410143;10301.175905927657;10313.896861031293;10341.896581034094;10502.737431563966;10582.576696932036;11045.944770276097;11261.324320540794;11284.887151128383;11287.266327688674;11329.71675708114;8206.794830129294;8231.218034286732;8293.21214484623;8461.957690211755;8678.696245631372;8261.256486916207;11017;11077.113830893348;11299.3785341807;11350.489227984595 10:09:03 INFO - PROCESS | 1637 | |3;mootools.html;1467.3690313165334;1473.1455755661718;1495.4541592318794;1500.1749038029084;1502.7971223884779;8274.462159959607;8630.352723545735;8665.523396213206;8667.959844818615;8681.00168480625;7764.922350776491;7936.563489008102;7955.641996110175;8321.791955201108;8539.87190192146;2370.9644355334685;2420.878956052199;2422.2369953464604;2422.382292515415;2429.2469334506272;2417.516496700658;2424.1273141668985;2437.31755108569;2456.828022038458;2464.0143942422997;2411.6503107049466;2412.8552286862755;2438.7317395086616;2439.780419762221;2445.08309383981;2379.3575734551573;2384.7734465225776;2407.747186545405;2407.855528668268;2410.9517809643885;2407.879606019692;2408.1691816323514;2431.7446668099947;2433.8783060846886;2434.3914021494625;8611.22498975089;8639.52482613456;8692.652293908237;8695.826083478358;8702.738917832476;5187.740612969336;5364.034473794715;5367.81212657559;5370.785168593252;5371.274877891474;3544.468329750558;3615.7468977171607;3620.583632882226;3647;3695.9630403695887;1101.9008289253925;1247.3202104852876;1270.9618711438673;1278.1755767529985;1291.1155858237044;10869.456527173688;11095.55617775288;11103.222774405795;11190.048845848112;11211.215214934959;4627.892432770455;4738.526147385234;4783.449903261169;4854.805807767721;4875.219964805614;9748.512574371252;9748.756281092888;9754.0733630305;9762.072603102693;9794.902050979541;4642.51253618372;5429.484199001088;5433.972830135903;5440;5442.782288708408;4453.643708503312;4486.371907932892;4923.335349727812;4997.550220480174;4998.450170481244;3895.3183192941124;3976.403539469045;4015.558288588253;4044.595540445932;4045.271851066836;1305.5169587252587;1308.4896890212635;1309.463120120746;1318.815365848782;1320.683036071336;914.7285273469749;915.7298596913927;935.6678379175431;936.3585943628636;986.452518852044;5672.986634167795;5717.514011309086;5906.586538942232;6078.209832721718;6083.6349819011;557.2198921509838;559.8684309187338;567.5119397318302;570.5948776368741;574.6092656993285;3796.202797412519;3809.314323421755;3813.8855834325013;3917.666998305176;3919.980804990666;9307.255419566418;9752.756181095387;9754.02459754033;9759.170470509944;9768.755781105387;9496.857547136799;9737.464439455898;9751.512424378752;9753.804923901482;9756;7713.3443657288635;7757.030371203599;7782.599132156153;7806.258405451473;7811.179826118289;5324.9733751331;5441.945580544302;5526.143447765603;5657.010023245998;5657.688827114548;8895.2883769297;9021.774455638662;9027.548622568976;9045.909540904508;9078.954605226932;8004;9067.183953444222;9074.546272686472;9607.51962401891;9640.517974101127;6891.586504809527;7092.9645351772915;7099.467539934422;7392.704291828267;7542.886856697044;7914.722984695508;8080.797980050545;8173.713920012771;8286.337093032422;8293.046299675374;6994.405475534637;7015.088038555159;7181.964090179516;7248.057752492142;7292.270772922665;6915.654217289015;7016.859662806817;7021.754238601625;7105.715771369088;7147;6586.045023471665;6606.10817539626;6672.532922695559;6680.5323627345615;6692.899606506004;5008.874778130576;5060.114479966065;5069.493050694901;5123.180291153398;5211.5049070338255;3867.593902640295;4887.828925987574;4968.4286307075145;5061.620378471703;5099.439061703284 10:09:03 INFO - PROCESS | 1637 | |4;prototype.html;356.59170250063676;361.29907978521663;370.92952339055586;374.0032812554542;380.15226045917603;5131.3573509642565;5177.637565370421;5181.43004269531;5182.585393168547;5204.9219261711105;4468.597826195642;5115.232715092738;5120.564751996076;5125.66683165594;5131.615128865331;3288.523164141198;3666.3034023535442;3847.9038024049482;3920.3926390180104;4064.841520166753;3989.760614363133;3995.1011022519847;3996.980015099935;4001.779902105383;4029.4560234368423;3996.960030399702;4016.9397459038137;4018.8948039289285;4024.444477756631;4037.4953130858644;3793.9945914332725;4028.395740638898;4037.9596204037875;4041.6766658667384;4048.6761059115493;3120.60992375953;3410.0622328859513;3513.7540372173958;3543.112363423827;3598.676119149289;4891.437484689271;4962.858542535237;4972.403311602595;4990.82532111378;4997.603068072836;3822.26087130355;4225.408442818008;4617.30740388941;4625.537446255347;4634.86095417138;5121.897562048775;5194.6104042196985;5342.545883599899;5420.403755586883;5476.370217424967;3993.221321842242;3993.341098718708;3993.9416054745516;3999.6200360965663;4012.137390461065;5300.178472336794;5433.429489903543;5731.570132240057;5745.621050947784;5771.769129234825;3735.34631439497;4008.3987401889367;4047.8988025299604;4063.0858056936954;4069.6744260459686;3430.811305378228;4075.0219947212454;4082.8366865325056;4097.85657501986;4099.831548008863;3873.9806300968316;3905.7656540607086;4293.055527783882;4580.358749775034;4661.974365639554;4010.8997275067773;4516.209663308908;4618.815247390134;4706.882327941828;5156.407013193456;1216.6106845809256;1244.9728973596818;1304.8760367765046;1342.744878473087;1349.9730005399838;733.4132693844903;875.60160127142;938.1884669760744;943.2312665177858;956.7942892278194;4833.589144922651;4846.903061938741;4865.683730557574;5011.599072074226;5038.874028149252;5439.129739241703;5448.182772584144;5457.508824205841;5462.323461503914;5466;4901.975490122527;5077.517635824591;5116.827566908541;5118.334616499831;5133.101707201225;2650.8336332014237;2743.711910249435;2748.477789220082;2775.778657390782;2777.472280266743;4546.431266334511;4909.803607855646;5256.6320357574605;5259.790887827122;5389.595780316492;4646.395968524071;4859.878503037382;5151.8196863109615;5344.91982620261;5421.83734487966;4929.556339929423;5421.783128674809;5669.716514174274;5753.33836608787;5785.747475605511;4887.706737595756;4906.509349065065;5037.345145131109;5554.50009499147;5555.166724991283;4868.853934381974;5220.791168353375;5542.806001790079;5569.387367389665;5639.548836093185;4295.785210739388;4847.636427268039;5368.489993450616;5458.4541545845095;5831.7375718093635;3194.7923384979904;3816.732828701964;3835.8657446989223;3845.8269377877505;3857.958351245204;5422.48486393792;5426.972865135807;5494.752736126804;5653.40639232891;5692.633767895758;5462.289902312674;5469.714617065066;5473.753681084281;5491.172046396029;5520.723963801875;5468.179773034077;5479.643823151482;5482.671039737628;5505.779768809202;5519.9448005521035;4320.092780516001;4402.603765661106;4641.828375160453;5415.566754659539;5423.29497165366;4596.517365676689;5183.377994640668;5301.893962120659;5337.0393329201115;5381.2197231402015;4724.362211101457;4913.70517768935;5080.669756465818;5212.687238765535;5234.408967560929 10:09:03 INFO - PROCESS | 1637 | |5;yui.html;741.4513260187463;745.5079647432696;777.498513458819;791.2325044706636;875.3916028360288;15073.547793566197;15456.149911754863;16374.017558946442;16406.67186656266;16408.343666253364;14776.261186940663;15204.315805788738;16771.580710482245;17478.563035924108;17518.386856460027;900.5407242306421;924.4314746430964;926.9258459323272;928.0997432490507;928.9024652411501;706.6961206681125;728.1662496441571;887.9112088791102;906.9682561110362;917.7567944494714;893.1559676106083;893.6148969097873;961.9134277914986;964.5177411294353;968.6851773173712;961.4711908450324;961.5624890674796;961.7307153996892;962.8507581324906;963.9614415423374;715.5349023134952;716.6273537760335;716.9426445884317;717.243308309733;718.0019772516207;15816.446424375206;16179.83820161807;16202.675946481122;16229.594260143473;16448.588785280343;14577.635559111;14794.260286985607;14798.926005370013;14805.555833325017;14813.629659258497;11658.242214256046;11809;11847.585334513336;12084.939575302154;12601.432935517923;3828.9042773930596;3845.596212397686;3866.1881004988986;3915.686745060388;3926.921461570781;96836;111783.99999999919;112656;113135;114272;11040.171987101;11204.775904481865;11234.887651123385;11257.324560526395;11302.4913878874;22780.658290125662;23152.884235578713;23287.53424931492;23288.301350959497;23314;7844.529328240324;7923.564203968722;7933.523988560705;7994.480358776661;8000.35997120229;4369.60673539383;4412.051408947092;4461.709988850715;4500.527444618333;4648.5119062498625;3109.9067027989195;3777.4522694209186;3809.9809500952874;3812.866549670748;3814.5803961564206;681.9556728812611;683.4498228925762;687.5599616245606;696.6934548798513;704.5631708340759;685.4242436353487;686.5811854768588;728.2135293882594;770.9884351734728;774.8527779721835;8848.778780530538;9401.777768890137;10184.490775461198;10363.63727269557;10452.32059916103;687.9071325371111;706.7702996526046;727.5489196697976;730.4193166432699;734.4234775701049;4217.831286748557;4979.30289759434;4988.081048867685;5120.769565369567;5163.819266325736;94808.52595736977;94968.52515737378;97136.05727885544;97583.53624695636;97892;84146.57926710449;84501.57749211337;85389.57305213559;85662;86136;68238.31761682419;68530.31469685338;69486;74356;75810.62094689491;10810.243282970117;10908.836367454653;11007.889921101007;11213.60752373663;11253;43445;44388;44986.87532811706;47167;48917.755411222715;68262;69657.30342696508;71814;72491;73491;13011.609651710463;13184.60446186616;13198;13488;13768.724625507633;14103.2948352584;14509.419623214953;14625.780613291023;15001.699966000837;15245.847541524443;12377.85991111646;12423.37883105823;12437.875621244033;12860.356982150668;12979.41592628315;13138.080334376502;13867.930660346634;14016.29918504091;14362.373423696508;14586.270686465423;13012.869871301165;13643.86356136426;13685.247311397969;13691.726165476435;13692.657683557592;9487.33588648788;9777.902220977983;10271.178305735673;10302.62473046335;10580.15358771312;8926.285897128344;10440.269181157246;11241.494132764208;11263.211575189658;11300.604478843201 10:09:03 INFO - PROCESS | 1637 | __end_tp_report 10:09:03 INFO - PROCESS | 1637 | __start_cc_report 10:09:03 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1346 10:09:03 INFO - PROCESS | 1637 | __end_cc_report 10:09:03 INFO - PROCESS | 1637 | __startTimestamp1490634543634__endTimestamp 10:09:03 INFO - PROCESS | 1637 | 10:09:03 INFO - PROCESS | 1637 | ------- Summary: start ------- 10:09:03 INFO - PROCESS | 1637 | Number of tests: 6 10:09:03 INFO - PROCESS | 1637 | 10:09:03 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5705.32 Median:5868.77 stddev:656.59 (11.2%) stddev-sans-first:633.58 10:09:03 INFO - PROCESS | 1637 | Values: 3416.9 3432.1 3441.3 3454.8 3491.4 5585.4 5631.7 5649.9 5656.9 5661.2 5621.2 5697.0 5699.9 5710.2 5716.6 3778.5 5143.8 5169.4 5185.1 5188.3 3998.7 4735.1 5136.6 5267.4 5301.1 5131.5 5192.8 5202.0 5207.2 5208.6 5218.3 5219.7 5245.7 5252.6 5252.7 5107.1 5172.8 5199.6 5212.7 5228.3 5548.9 5588.3 5609.1 5650.8 5671.1 6108.5 6140.1 6165.6 6234.6 6247.6 6227.4 6294.9 6312.7 6316.2 6316.8 5759.7 5779.8 5789.5 5796.2 5799.0 6212.0 6278.0 6301.8 6338.1 6344.2 5562.2 5804.2 6152.3 6154.9 6169.0 5267.4 6222.8 6285.9 6290.2 6295.2 5981.9 6015.5 6031.1 6137.3 6197.5 6179.8 6240.0 6250.5 6258.3 6288.8 4966.9 4986.2 4992.5 4998.8 5028.8 4383.1 4384.8 4397.2 4448.1 4487.6 5766.7 5770.9 5823.5 5855.2 5873.7 6100.7 6235.8 6258.2 6284.1 6295.9 5684.9 5719.8 5724.8 5828.1 5831.2 5382.5 5384.1 5396.7 5398.2 5401.1 5182.6 6304.4 6348.0 6349.3 6362.3 6234.4 6272.5 6302.4 6318.1 6321.4 6282.2 6289.5 6291.2 6295.1 6295.2 6041.1 6067.9 6091.9 6128.3 6210.9 6198.5 6262.0 6279.2 6294.1 6294.2 6029.6 6092.0 6094.8 6100.3 6115.4 5471.0 5834.8 5847.4 6076.0 6089.8 5868.8 5884.9 5937.4 5966.9 6017.7 6103.1 6105.8 6112.5 6118.9 6120.8 5781.7 5926.4 5940.9 5941.1 5955.2 10:09:03 INFO - PROCESS | 1637 | 10:09:03 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:65411.71 Median:3358.85 stddev:135254.26 (4026.8%) stddev-sans-first:135545.77 10:09:03 INFO - PROCESS | 1637 | Values: 459.9 503.0 510.5 521.2 541.8 32559.3 42650.4 43089.4 43207.6 44829.1 45720.8 46043.1 46109.8 46180.3 46208.0 8969.5 9588.6 9805.2 9815.9 9817.1 8893.6 11759.7 11978.0 12053.5 12214.8 10021.0 11958.3 11967.3 11981.5 11984.9 11970.5 12039.8 12051.8 12052.8 12063.8 11737.2 11823.9 11831.1 11833.6 11839.4 42443.8 42813.6 42827.0 42957.0 43004.6 4079.8 4082.8 4105.4 4118.2 4121.5 31177.1 31802.2 32832.8 33244.5 33447.5 3309.0 3358.6 3359.1 3489.6 3495.0 483086.0 489508.0 490598.0 491527.0 491843.0 63778.7 64002.4 64222.0 64410.7 64435.7 66791.0 66846.7 66884.7 66907.3 66915.3 17284.4 17813.6 17816.7 17860.7 17873.1 12570.2 13229.7 13736.7 13737.4 13804.3 14500.1 14855.6 14861.9 14872.3 16046.4 6929.3 7045.0 7112.5 7172.2 7218.2 886.9 888.6 891.1 911.1 921.4 30634.7 30670.7 30851.1 31340.4 31426.7 1001.2 1077.6 1108.5 1120.3 1157.6 14239.7 14770.7 15725.5 15822.0 16196.3 535207.0 538265.0 539067.0 539624.0 540875.0 61217.0 61249.8 61378.1 61438.0 61469.0 1273.8 1458.5 1471.1 1490.9 1491.2 27626.7 29977.0 30056.1 30687.5 30926.0 50705.0 51004.0 51017.5 51033.0 51140.5 492972.0 496149.0 497751.0 497812.0 498213.0 25704.7 26323.3 26391.3 40146.0 40495.6 33376.3 37717.2 40751.6 44563.6 45438.8 30335.8 31209.0 31515.7 31806.8 32286.8 27119.7 31289.0 32079.5 32193.2 32388.9 36352.1 37010.8 37081.0 37092.6 37143.8 30356.0 30681.8 31536.4 31682.0 32228.7 21566.0 23655.3 24910.9 25304.7 25332.7 10:09:03 INFO - PROCESS | 1637 | 10:09:03 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:40506.38 Median:22665.43 stddev:124897.65 (551.0%) stddev-sans-first:125211.67 10:09:03 INFO - PROCESS | 1637 | Values: 375.3 403.5 412.2 412.7 436.5 12074.1 18014.4 18974.8 19017.5 20734.1 21734.6 22361.0 22404.9 22408.4 22645.3 5719.7 6036.3 6037.6 6042.0 6043.8 4878.6 5902.1 6025.4 6625.2 6713.6 6683.4 6700.0 6701.5 6706.1 6719.9 6410.5 6563.4 6639.4 6641.0 6643.1 5163.9 5532.0 5832.4 5838.6 5840.5 13287.0 13290.8 13487.4 13639.7 22685.5 2559.3 2604.7 2635.6 2667.9 2737.8 9620.7 10053.6 10148.3 10531.0 10606.5 1836.5 1847.6 1858.8 1873.9 1891.4 132232.0 132741.0 134268.7 134692.9 143538.3 10055.6 10506.7 10611.6 10656.3 11912.3 11076.5 13040.7 13182.0 14765.8 15390.7 8418.4 8676.9 9049.4 9057.1 9066.0 8867.8 8922.7 8964.0 9101.8 9148.0 4796.7 4850.6 4910.9 4949.9 5027.0 1790.1 1965.9 2081.0 2103.5 2103.8 877.2 899.7 906.1 934.2 935.4 21918.3 22490.6 22500.5 22524.9 22580.7 906.4 906.8 911.2 938.7 941.5 9792.0 11520.7 11672.7 11702.4 11739.5 666889.0 757870.0 772200.0 772556.0 775778.0 110540.9 128379.1 153634.5 157316.0 159662.0 1072.5 1073.3 1092.4 1092.7 1096.9 17972.4 18007.8 18204.9 19516.0 19718.7 61201.0 62757.7 62788.7 63130.7 63288.0 88664.0 88918.0 91484.5 93018.5 93037.0 6642.9 8218.4 8314.8 8508.9 8538.3 12155.9 12667.4 12958.5 12974.9 12994.5 10466.7 10953.7 11101.6 11218.3 11308.2 10301.2 10313.9 10341.9 10502.7 10582.6 11045.9 11261.3 11284.9 11287.3 11329.7 8206.8 8231.2 8293.2 8462.0 8678.7 8261.3 11017.0 11077.1 11299.4 11350.5 10:09:03 INFO - PROCESS | 1637 | 10:09:03 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5505.43 Median:5442.36 stddev:2958.51 (54.4%) stddev-sans-first:2951.24 10:09:03 INFO - PROCESS | 1637 | Values: 1467.4 1473.1 1495.5 1500.2 1502.8 8274.5 8630.4 8665.5 8668.0 8681.0 7764.9 7936.6 7955.6 8321.8 8539.9 2371.0 2420.9 2422.2 2422.4 2429.2 2417.5 2424.1 2437.3 2456.8 2464.0 2411.7 2412.9 2438.7 2439.8 2445.1 2379.4 2384.8 2407.7 2407.9 2411.0 2407.9 2408.2 2431.7 2433.9 2434.4 8611.2 8639.5 8692.7 8695.8 8702.7 5187.7 5364.0 5367.8 5370.8 5371.3 3544.5 3615.7 3620.6 3647.0 3696.0 1101.9 1247.3 1271.0 1278.2 1291.1 10869.5 11095.6 11103.2 11190.0 11211.2 4627.9 4738.5 4783.4 4854.8 4875.2 9748.5 9748.8 9754.1 9762.1 9794.9 4642.5 5429.5 5434.0 5440.0 5442.8 4453.6 4486.4 4923.3 4997.6 4998.5 3895.3 3976.4 4015.6 4044.6 4045.3 1305.5 1308.5 1309.5 1318.8 1320.7 914.7 915.7 935.7 936.4 986.5 5673.0 5717.5 5906.6 6078.2 6083.6 557.2 559.9 567.5 570.6 574.6 3796.2 3809.3 3813.9 3917.7 3920.0 9307.3 9752.8 9754.0 9759.2 9768.8 9496.9 9737.5 9751.5 9753.8 9756.0 7713.3 7757.0 7782.6 7806.3 7811.2 5325.0 5441.9 5526.1 5657.0 5657.7 8895.3 9021.8 9027.5 9045.9 9079.0 8004.0 9067.2 9074.5 9607.5 9640.5 6891.6 7093.0 7099.5 7392.7 7542.9 7914.7 8080.8 8173.7 8286.3 8293.0 6994.4 7015.1 7182.0 7248.1 7292.3 6915.7 7016.9 7021.8 7105.7 7147.0 6586.0 6606.1 6672.5 6680.5 6692.9 5008.9 5060.1 5069.5 5123.2 5211.5 3867.6 4887.8 4968.4 5061.6 5099.4 10:09:03 INFO - PROCESS | 1637 | 10:09:03 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4383.66 Median:4896.71 stddev:1297.00 (26.5%) stddev-sans-first:1264.93 10:09:03 INFO - PROCESS | 1637 | Values: 356.6 361.3 370.9 374.0 380.2 5131.4 5177.6 5181.4 5182.6 5204.9 4468.6 5115.2 5120.6 5125.7 5131.6 3288.5 3666.3 3847.9 3920.4 4064.8 3989.8 3995.1 3997.0 4001.8 4029.5 3997.0 4016.9 4018.9 4024.4 4037.5 3794.0 4028.4 4038.0 4041.7 4048.7 3120.6 3410.1 3513.8 3543.1 3598.7 4891.4 4962.9 4972.4 4990.8 4997.6 3822.3 4225.4 4617.3 4625.5 4634.9 5121.9 5194.6 5342.5 5420.4 5476.4 3993.2 3993.3 3993.9 3999.6 4012.1 5300.2 5433.4 5731.6 5745.6 5771.8 3735.3 4008.4 4047.9 4063.1 4069.7 3430.8 4075.0 4082.8 4097.9 4099.8 3874.0 3905.8 4293.1 4580.4 4662.0 4010.9 4516.2 4618.8 4706.9 5156.4 1216.6 1245.0 1304.9 1342.7 1350.0 733.4 875.6 938.2 943.2 956.8 4833.6 4846.9 4865.7 5011.6 5038.9 5439.1 5448.2 5457.5 5462.3 5466.0 4902.0 5077.5 5116.8 5118.3 5133.1 2650.8 2743.7 2748.5 2775.8 2777.5 4546.4 4909.8 5256.6 5259.8 5389.6 4646.4 4859.9 5151.8 5344.9 5421.8 4929.6 5421.8 5669.7 5753.3 5785.7 4887.7 4906.5 5037.3 5554.5 5555.2 4868.9 5220.8 5542.8 5569.4 5639.5 4295.8 4847.6 5368.5 5458.5 5831.7 3194.8 3816.7 3835.9 3845.8 3858.0 5422.5 5427.0 5494.8 5653.4 5692.6 5462.3 5469.7 5473.8 5491.2 5520.7 5468.2 5479.6 5482.7 5505.8 5519.9 4320.1 4402.6 4641.8 5415.6 5423.3 4596.5 5183.4 5301.9 5337.0 5381.2 4724.4 4913.7 5080.7 5212.7 5234.4 10:09:03 INFO - PROCESS | 1637 | 10:09:03 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20308.98 Median:23907.30 stddev:28644.70 (119.8%) stddev-sans-first:28687.38 10:09:03 INFO - PROCESS | 1637 | Values: 741.5 745.5 777.5 791.2 875.4 15073.5 15456.1 16374.0 16406.7 16408.3 14776.3 15204.3 16771.6 17478.6 17518.4 900.5 924.4 926.9 928.1 928.9 706.7 728.2 887.9 907.0 917.8 893.2 893.6 961.9 964.5 968.7 961.5 961.6 961.7 962.9 964.0 715.5 716.6 716.9 717.2 718.0 15816.4 16179.8 16202.7 16229.6 16448.6 14577.6 14794.3 14798.9 14805.6 14813.6 11658.2 11809.0 11847.6 12084.9 12601.4 3828.9 3845.6 3866.2 3915.7 3926.9 96836.0 111784.0 112656.0 113135.0 114272.0 11040.2 11204.8 11234.9 11257.3 11302.5 22780.7 23152.9 23287.5 23288.3 23314.0 7844.5 7923.6 7933.5 7994.5 8000.4 4369.6 4412.1 4461.7 4500.5 4648.5 3109.9 3777.5 3810.0 3812.9 3814.6 682.0 683.4 687.6 696.7 704.6 685.4 686.6 728.2 771.0 774.9 8848.8 9401.8 10184.5 10363.6 10452.3 687.9 706.8 727.5 730.4 734.4 4217.8 4979.3 4988.1 5120.8 5163.8 94808.5 94968.5 97136.1 97583.5 97892.0 84146.6 84501.6 85389.6 85662.0 86136.0 68238.3 68530.3 69486.0 74356.0 75810.6 10810.2 10908.8 11007.9 11213.6 11253.0 43445.0 44388.0 44986.9 47167.0 48917.8 68262.0 69657.3 71814.0 72491.0 73491.0 13011.6 13184.6 13198.0 13488.0 13768.7 14103.3 14509.4 14625.8 15001.7 15245.8 12377.9 12423.4 12437.9 12860.4 12979.4 13138.1 13867.9 14016.3 14362.4 14586.3 13012.9 13643.9 13685.2 13691.7 13692.7 9487.3 9777.9 10271.2 10302.6 10580.2 8926.3 10440.3 11241.5 11263.2 11300.6 10:09:03 INFO - PROCESS | 1637 | -------- Summary: end -------- 10:09:03 INFO - PROCESS | 1637 | 10:09:04 INFO - TEST-INFO | 1637: exit 0 10:09:04 INFO - TEST-OK | dromaeo_css | took 1116977ms 10:09:04 INFO - TEST-START | kraken 10:09:04 INFO - operating with platform_type : mac_ 10:09:04 INFO - Initialising browser for kraken test... 10:09:04 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmp2eQ67Q/profile http://localhost:49241/getInfo.html) 10:09:06 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 10:09:06 INFO - PROCESS | 1646 | colorDepth:24 10:09:06 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 10:09:06 INFO - PROCESS | 1646 | __metrics 10:09:06 INFO - PROCESS | 1646 | 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" 10:09:06 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:09:07 INFO - TEST-INFO | 1646: exit 0 10:09:07 INFO - Browser initialized. 10:09:07 INFO - Running cycle 1/1 for kraken test... 10:09:07 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmp2eQ67Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:19 INFO - PROCESS | 1648 | RSS: Main: 163676160 10:09:19 INFO - PROCESS | 1648 | 10:09:21 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 10:09:22 INFO - PROCESS | 1648 | RSS: Main: 214310912 10:09:22 INFO - PROCESS | 1648 | 10:09:25 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 10:09:25 INFO - PROCESS | 1648 | RSS: Main: 228519936 10:09:25 INFO - PROCESS | 1648 | 10:09:28 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 10:09:29 INFO - PROCESS | 1648 | RSS: Main: 326152192 10:09:29 INFO - PROCESS | 1648 | 10:09:31 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 10:09:32 INFO - PROCESS | 1648 | RSS: Main: 228474880 10:09:32 INFO - PROCESS | 1648 | 10:09:34 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:09:34 INFO - PROCESS | 1648 | RSS: Main: 229769216 10:09:34 INFO - PROCESS | 1648 | 10:09:37 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 10:09:38 INFO - PROCESS | 1648 | RSS: Main: 271241216 10:09:38 INFO - PROCESS | 1648 | 10:09:41 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 10:09:41 INFO - PROCESS | 1648 | RSS: Main: 272601088 10:09:41 INFO - PROCESS | 1648 | 10:09:44 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 10:09:45 INFO - PROCESS | 1648 | RSS: Main: 267632640 10:09:45 INFO - PROCESS | 1648 | 10:09:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:09:47 INFO - PROCESS | 1648 | RSS: Main: 244785152 10:09:47 INFO - PROCESS | 1648 | 10:09:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:09:50 INFO - PROCESS | 1648 | RSS: Main: 250703872 10:09:50 INFO - PROCESS | 1648 | 10:09:52 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:09:52 INFO - PROCESS | 1648 | RSS: Main: 256081920 10:09:52 INFO - PROCESS | 1648 | 10:09:55 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:09:56 INFO - PROCESS | 1648 | RSS: Main: 268771328 10:09:56 INFO - PROCESS | 1648 | 10:09:59 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:09:59 INFO - PROCESS | 1648 | RSS: Main: 263241728 10:09:59 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 10:10:01 INFO - PROCESS | 1648 | RSS: Main: 307724288 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | __start_tp_report 10:10:01 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 10:10:01 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 10:10:01 INFO - PROCESS | 1648 | |i|pagename|runs| 10:10:01 INFO - PROCESS | 1648 | |0;ai-astar;103;113;113;113;114;114;112;113;113;114 10:10:01 INFO - PROCESS | 1648 | |1;audio-beat-detection;141;105;106;142;113;137;105;107;127;106 10:10:01 INFO - PROCESS | 1648 | |2;audio-dft;182;183;183;181;183;184;182;183;182;183 10:10:01 INFO - PROCESS | 1648 | |3;audio-fft;79;58;57;89;60;58;58;59;73;57 10:10:01 INFO - PROCESS | 1648 | |4;audio-oscillator;85;70;84;70;68;68;81;66;69;81 10:10:01 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;89;86;89;87;89;86;91;86;89;86 10:10:01 INFO - PROCESS | 1648 | |6;imaging-darkroom;96;95;95;110;151;152;95;96;96;96 10:10:01 INFO - PROCESS | 1648 | |7;imaging-desaturate;88;93;130;88;89;85;68;84;93;133 10:10:01 INFO - PROCESS | 1648 | |8;json-parse-financial;53;51;53;52;54;55;78;86;85;82 10:10:01 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;65;73;67;74;69;65;67;68;68;67 10:10:01 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;82;81;82;80;80;82;83;84;87;82 10:10:01 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;132;135;142;146;131;128;133;132;169;142 10:10:01 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;162;191;162;162;163;163;161;160;161;217 10:10:01 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;61;63;66;64;65;62;62;65;62;63 10:10:01 INFO - PROCESS | 1648 | __end_tp_report 10:10:01 INFO - PROCESS | 1648 | __start_cc_report 10:10:01 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1991 10:10:01 INFO - PROCESS | 1648 | __end_cc_report 10:10:01 INFO - PROCESS | 1648 | __startTimestamp1490634601719__endTimestamp 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | ------- Summary: start ------- 10:10:01 INFO - PROCESS | 1648 | Number of tests: 14 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:3.29 (2.9%) stddev-sans-first:0.67 10:10:01 INFO - PROCESS | 1648 | Values: 103.0 113.0 113.0 113.0 114.0 114.0 112.0 113.0 113.0 114.0 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:118.90 Median:120.00 stddev:16.02 (13.4%) stddev-sans-first:14.87 10:10:01 INFO - PROCESS | 1648 | Values: 141.0 105.0 106.0 142.0 113.0 137.0 105.0 107.0 127.0 106.0 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 10:10:01 INFO - PROCESS | 1648 | Values: 182.0 183.0 183.0 181.0 183.0 184.0 182.0 183.0 182.0 183.0 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:64.80 Median:59.50 stddev:11.41 (19.2%) stddev-sans-first:10.88 10:10:01 INFO - PROCESS | 1648 | Values: 79.0 58.0 57.0 89.0 60.0 58.0 58.0 59.0 73.0 57.0 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:74.20 Median:75.50 stddev:7.54 (10.0%) stddev-sans-first:6.91 10:10:01 INFO - PROCESS | 1648 | Values: 85.0 70.0 84.0 70.0 68.0 68.0 81.0 66.0 69.0 81.0 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:89.00 stddev:1.81 (2.0%) stddev-sans-first:1.87 10:10:01 INFO - PROCESS | 1648 | Values: 89.0 86.0 89.0 87.0 89.0 86.0 91.0 86.0 89.0 86.0 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:108.20 Median:95.50 stddev:23.27 (24.4%) stddev-sans-first:24.25 10:10:01 INFO - PROCESS | 1648 | Values: 96.0 95.0 95.0 110.0 151.0 152.0 95.0 96.0 96.0 96.0 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:88.00 stddev:20.44 (23.2%) stddev-sans-first:21.52 10:10:01 INFO - PROCESS | 1648 | Values: 88.0 93.0 130.0 88.0 89.0 85.0 68.0 84.0 93.0 133.0 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:66.50 stddev:15.54 (23.4%) stddev-sans-first:15.87 10:10:01 INFO - PROCESS | 1648 | Values: 53.0 51.0 53.0 52.0 54.0 55.0 78.0 86.0 85.0 82.0 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:3.02 (4.4%) stddev-sans-first:2.96 10:10:01 INFO - PROCESS | 1648 | Values: 65.0 73.0 67.0 74.0 69.0 65.0 67.0 68.0 68.0 67.0 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:2.06 (2.5%) stddev-sans-first:2.18 10:10:01 INFO - PROCESS | 1648 | Values: 82.0 81.0 82.0 80.0 80.0 82.0 83.0 84.0 87.0 82.0 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:138.50 stddev:12.03 (8.7%) stddev-sans-first:12.49 10:10:01 INFO - PROCESS | 1648 | Values: 132.0 135.0 142.0 146.0 131.0 128.0 133.0 132.0 169.0 142.0 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:162.50 stddev:18.86 (11.6%) stddev-sans-first:19.77 10:10:01 INFO - PROCESS | 1648 | Values: 162.0 191.0 162.0 162.0 163.0 163.0 161.0 160.0 161.0 217.0 10:10:01 INFO - PROCESS | 1648 | 10:10:01 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:1.64 (2.6%) stddev-sans-first:1.51 10:10:01 INFO - PROCESS | 1648 | Values: 61.0 63.0 66.0 64.0 65.0 62.0 62.0 65.0 62.0 63.0 10:10:01 INFO - PROCESS | 1648 | -------- Summary: end -------- 10:10:01 INFO - PROCESS | 1648 | 10:10:02 INFO - TEST-INFO | 1648: exit 0 10:10:02 INFO - TEST-OK | kraken | took 58327ms 10:10:02 INFO - SUITE-END | took 1175s 10:10:02 INFO - Completed test suite (00:19:35) 10:10:02 INFO - javascript benchmark 10:10:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3416.914577135571, 3432.0904960185553, 3441.3461442325956, 3454.84453199606, 3491.3715531204375, 5585.441455854412, 5631.746571404286, 5649.943500564993, 5656.886862262752, 5661.179129026289, 5621.213030175769, 5696.971515142429, 5699.857503562413, 5710.200571919934, 5716.628419152752, 3778.4899038629846, 5143.768530416121, 5169.431362550116, 5185.144451165553, 5188.2995795567585, 3998.6601138903084, 4735.147673418784, 5136.58907287418, 5267.420583735805, 5301.125314323132, 5131.486851314858, 5192.844214673547, 5201.973990130044, 5207.218917162437, 5208.635395522315, 5218.269442278084, 5219.660722053054, 5245.659032162936, 5252.606054545924, 5252.737363131847, 5107.106256405114, 5172.818951336722, 5199.558037566811, 5212.713300768456, 5228.346456692913, 5548.91676624851, 5588.329400471929, 5609.102543593046, 5650.773969041234, 5671.149327600851, 6108.471341378537, 6140.057253910601, 6165.568410211287, 6234.594751341194, 6247.5939063960695, 6227.408396202353, 6294.87410251797, 6312.684365781738, 6316.210473690789, 6316.842078948063, 5759.740811663527, 5779.826605201809, 5789.536837053026, 5796.217510636095, 5798.985177593904, 6212.006079027425, 6277.96861015692, 6301.842453938688, 6338.144350512714, 6344.238691356974, 5562.193481945095, 5804.216430781875, 6152.2924863640355, 6154.892119418548, 6168.9691551542855, 5267.446918073547, 6222.844428889223, 6285.9057114143325, 6290.21372328459, 6295.213098362705, 5981.910271345933, 6015.518758499309, 6031.095335699592, 6137.263528376623, 6197.504199664016, 6179.84550386235, 6239.968800156061, 6250.468710159596, 6258.311585725566, 6288.779892703825, 4966.90066198674, 4986.227134794112, 4992.450830408652, 4998.800047998112, 5028.798848046037, 4383.145286669069, 4384.802683879233, 4397.164538737629, 4448.065906159678, 4487.640988720895, 5766.682832444172, 5770.913436298459, 5823.5341172706085, 5855.238818953509, 5873.676947767828, 6100.664463454464, 6235.844103897348, 6258.15514905491, 6284.12022316876, 6295.905561416583, 5684.8863022739315, 5719.828405147852, 5724.77100915967, 5828.067509198592, 5831.154482599999, 5382.515573598395, 5384.057789886754, 5396.730163491889, 5398.217258497496, 5401.081816091274, 5182.585393168538, 6304.432601065926, 6348.047792831112, 6349.301576826545, 6362.2683391409655, 6234.407731265523, 6272.498200143887, 6302.369763023661, 6318.115463834974, 6321.431071203614, 6282.2147231596055, 6289.528285378524, 6291.213598300213, 6295.055741638791, 6295.213098362705, 6041.093835924647, 6067.939320606914, 6091.8781624366375, 6128.32588415265, 6210.937890621036, 6198.504119670325, 6262.029385445263, 6279.152314437675, 6294.087357333253, 6294.244690637152, 6029.60807547508, 6091.969540152271, 6094.7562097517375, 6100.2984656763265, 6115.388461153849, 5471.015217260772, 5834.824955251349, 5847.415258474119, 6076.0278355462915, 6089.786857459968, 5868.765249389977, 5884.882302354014, 5937.435943585352, 5966.850828729316, 6017.729202185999, 6103.084537319438, 6105.84735381619, 6112.480439162543, 6118.908216376669, 6120.846978825565, 5781.68200748946, 5926.407359264212, 5940.940590594038, 5941.079132734433, 5955.196048533393], "value": 5664.760284935769, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.9260726204313, 502.9949700502994, 510.52011109557014, 521.1583292981835, 541.7914103070317, 32559.348813023757, 42650.36024459632, 43089.35365969509, 43207.56792432075, 44829.10341793162, 45720.771396143056, 46043.07913841721, 46109.76945115278, 46180.307295390514, 46208.0, 8969.461832290084, 9588.616455341795, 9805.215582753362, 9815.852762208573, 9817.116459518642, 8893.644254229823, 11759.7060073498, 11978.0, 12053.457594408274, 12214.755704885896, 10021.0, 11958.282503049844, 11967.2819630822, 11981.520739170423, 11984.880151198508, 11970.461329240205, 12039.819402708967, 12051.819222711667, 12052.819207711891, 12063.819042714365, 11737.178397512178, 11823.94088029563, 11831.112666550043, 11833.644990650295, 11839.408029598486, 42443.787781061204, 42813.57186428127, 42827.0, 42957.0, 43004.56995430037, 4079.796010199478, 4082.81627326771, 4105.363668631367, 4118.176364727036, 4121.4848143982, 31177.064688059396, 31802.204944876332, 32832.83583582091, 33244.50133248003, 33447.498287525705, 3308.983455082709, 3358.613759417674, 3359.0762540301366, 3489.6335884731993, 3494.9650503494895, 483086.0, 489508.0, 490598.0, 491527.0, 491843.0, 63778.6811065951, 64002.35997640057, 64222.0, 64410.67794660997, 64435.67782161059, 66791.0, 66846.66576667085, 66884.6623067536, 66907.33092669108, 66915.32711682247, 17284.395046173322, 17813.554661133316, 17816.732749008515, 17860.732089018675, 17873.106344682714, 12570.245785252913, 13229.735405292033, 13736.725265494833, 13737.381817818223, 13804.309784510735, 14500.129992200502, 14855.628609284639, 14861.851381486047, 14872.33074511628, 16046.358145674276, 6929.336959129873, 7044.964775176091, 7112.537685050559, 7172.175199852084, 7218.242084581148, 886.8758373827669, 888.6401007591936, 891.140049851896, 911.0889110889111, 921.4056933278132, 30634.69365306363, 30670.693293066783, 30851.074467766004, 31340.373192536023, 31426.685733142833, 1001.1890368801294, 1077.6066735641434, 1108.451316598289, 1120.2718233148519, 1157.5993048411349, 14239.715205695828, 14770.70458590822, 15725.483922572563, 15822.0, 16196.271167797477, 535207.0, 538265.0, 539067.0, 539624.0, 540875.0, 61217.0, 61249.77500449966, 61378.079328810105, 61438.0, 61469.0, 1273.8471383433862, 1458.50410860308, 1471.0805746408494, 1490.903091299062, 1491.1873029198896, 27626.723732762413, 29977.0, 30056.098317050524, 30687.539686905162, 30926.0, 50705.0, 51004.0, 51017.48982510127, 51033.0, 51140.48859511357, 492972.0, 496149.0, 497751.0, 497812.0, 498213.0, 25704.742952570236, 26323.341916452242, 26391.34021649474, 40145.99635009148, 40495.59504405036, 33376.33247334991, 37717.245655087296, 40751.59248407478, 44563.554364455944, 45438.772806135756, 30335.848320758254, 31209.0, 31515.684843152194, 31806.84096579502, 32286.838565807022, 27119.72880271251, 31289.0, 32079.518807218377, 32193.195170120933, 32388.86638967625, 36352.09119771921, 37010.8149459251, 37081.0, 37092.629073708915, 37143.814280928425, 30356.0, 30681.8465907669, 31536.36927261396, 31682.0, 32228.71085156661, 21566.029528671563, 23655.29034128979, 24910.875445622656, 25304.746952530975, 25332.746672533776], "value": 20240.801847546398, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.29070057591156, 403.52182663543687, 412.19827435637694, 412.7193508414277, 436.4675096382412, 12074.072266816316, 18014.369497067604, 18974.810251897477, 19017.52456188596, 20734.066966986484, 21734.56530869382, 22361.0, 22404.8879755601, 22408.439789005242, 22645.320640380774, 5719.714014299289, 6036.305824830157, 6037.577369584131, 6042.033274676052, 6043.788467403641, 4878.634102442314, 5902.085176797603, 6025.397460253984, 6625.17185351831, 6713.630750308731, 6683.398494135527, 6700.028495868096, 6701.530892837503, 6706.12820333356, 6719.8656026879435, 6410.487161027107, 6563.409293163614, 6639.3692599203, 6640.966795165993, 6643.136392268998, 5163.948360516384, 5532.0, 5832.416758324176, 5838.562107841886, 5840.474357307863, 13287.006948957636, 13290.800637990438, 13487.393067311896, 13639.727205455934, 22685.546289074293, 2559.270607876746, 2604.6613940187844, 2635.604659301101, 2667.8666066696783, 2737.794665400103, 9620.663276785279, 10053.597856085747, 10148.340357876714, 10530.999555042259, 10606.522706478227, 1836.494963884929, 1847.5842935339576, 1858.8048254933171, 1873.9156737946826, 1891.4042076745782, 132232.0, 132741.0, 134268.65731342658, 134692.87764101278, 143538.28230858882, 10055.59777608902, 10506.684799456028, 10611.628592999208, 10656.307340022873, 11912.344821034927, 11076.501557429934, 13040.673983150496, 13182.0, 14765.77851332231, 15390.692186156215, 8418.368622353348, 8676.8698469523, 9049.411788233876, 9057.09429057089, 9066.048064953216, 8867.778305542413, 8922.73231803047, 8964.0, 9101.81796364069, 9148.0, 4796.736179510091, 4850.6362022848425, 4910.90178196434, 4949.925751113737, 5027.0, 1790.0961617889382, 1965.8525610578977, 2080.979190208109, 2103.5477372364708, 2103.842211834088, 877.1842186766369, 899.67161985876, 906.0758026812746, 934.1592566690033, 935.4153653966271, 21918.342449726533, 22490.550188996454, 22500.549989000127, 22524.887375563347, 22580.66129008066, 906.4334790755778, 906.845836207833, 911.1617312072909, 938.7090002099371, 941.5198248892976, 9792.0, 11520.73271940086, 11672.70818229551, 11702.356370399539, 11739.47172377228, 666889.0, 757870.0, 772200.0, 772556.0, 775778.0, 110540.89459105468, 128379.07431388537, 153634.46365536202, 157316.0, 159662.0, 1072.5495291977388, 1073.2648136026846, 1092.3664274720643, 1092.6831218946415, 1096.8848270931596, 17972.370967016093, 18007.819921800616, 18204.90770553771, 19516.0, 19718.704219436433, 61201.0, 62757.68621156865, 62788.68605656942, 63130.684346577975, 63288.0, 88664.0, 88918.0, 91484.54257728669, 93018.53490732503, 93037.0, 6642.900356494753, 8218.424710270223, 8314.750557483285, 8508.872366914378, 8538.274246689101, 12155.878441215475, 12667.366631668565, 12958.481660733465, 12974.870251297367, 12994.480220791062, 10466.738331541772, 10953.671389858317, 11101.555937762721, 11218.326900386002, 11308.208425410143, 10301.175905927657, 10313.896861031293, 10341.896581034094, 10502.737431563966, 10582.576696932036, 11045.944770276097, 11261.324320540794, 11284.887151128383, 11287.266327688674, 11329.71675708114, 8206.794830129294, 8231.218034286732, 8293.21214484623, 8461.957690211755, 8678.696245631372, 8261.256486916207, 11017.0, 11077.113830893348, 11299.3785341807, 11350.489227984595], "value": 9823.44000302278, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.3690313165334, 1473.1455755661718, 1495.4541592318794, 1500.1749038029084, 1502.7971223884779, 8274.462159959607, 8630.352723545735, 8665.523396213206, 8667.959844818615, 8681.00168480625, 7764.922350776491, 7936.563489008102, 7955.641996110175, 8321.791955201108, 8539.87190192146, 2370.9644355334685, 2420.878956052199, 2422.2369953464604, 2422.382292515415, 2429.2469334506272, 2417.516496700658, 2424.1273141668985, 2437.31755108569, 2456.828022038458, 2464.0143942422997, 2411.6503107049466, 2412.8552286862755, 2438.7317395086616, 2439.780419762221, 2445.08309383981, 2379.3575734551573, 2384.7734465225776, 2407.747186545405, 2407.855528668268, 2410.9517809643885, 2407.879606019692, 2408.1691816323514, 2431.7446668099947, 2433.8783060846886, 2434.3914021494625, 8611.22498975089, 8639.52482613456, 8692.652293908237, 8695.826083478358, 8702.738917832476, 5187.740612969336, 5364.034473794715, 5367.81212657559, 5370.785168593252, 5371.274877891474, 3544.468329750558, 3615.7468977171607, 3620.583632882226, 3647.0, 3695.9630403695887, 1101.9008289253925, 1247.3202104852876, 1270.9618711438673, 1278.1755767529985, 1291.1155858237044, 10869.456527173688, 11095.55617775288, 11103.222774405795, 11190.048845848112, 11211.215214934959, 4627.892432770455, 4738.526147385234, 4783.449903261169, 4854.805807767721, 4875.219964805614, 9748.512574371252, 9748.756281092888, 9754.0733630305, 9762.072603102693, 9794.902050979541, 4642.51253618372, 5429.484199001088, 5433.972830135903, 5440.0, 5442.782288708408, 4453.643708503312, 4486.371907932892, 4923.335349727812, 4997.550220480174, 4998.450170481244, 3895.3183192941124, 3976.403539469045, 4015.558288588253, 4044.595540445932, 4045.271851066836, 1305.5169587252587, 1308.4896890212635, 1309.463120120746, 1318.815365848782, 1320.683036071336, 914.7285273469749, 915.7298596913927, 935.6678379175431, 936.3585943628636, 986.452518852044, 5672.986634167795, 5717.514011309086, 5906.586538942232, 6078.209832721718, 6083.6349819011, 557.2198921509838, 559.8684309187338, 567.5119397318302, 570.5948776368741, 574.6092656993285, 3796.202797412519, 3809.314323421755, 3813.8855834325013, 3917.666998305176, 3919.980804990666, 9307.255419566418, 9752.756181095387, 9754.02459754033, 9759.170470509944, 9768.755781105387, 9496.857547136799, 9737.464439455898, 9751.512424378752, 9753.804923901482, 9756.0, 7713.3443657288635, 7757.030371203599, 7782.599132156153, 7806.258405451473, 7811.179826118289, 5324.9733751331, 5441.945580544302, 5526.143447765603, 5657.010023245998, 5657.688827114548, 8895.2883769297, 9021.774455638662, 9027.548622568976, 9045.909540904508, 9078.954605226932, 8004.0, 9067.183953444222, 9074.546272686472, 9607.51962401891, 9640.517974101127, 6891.586504809527, 7092.9645351772915, 7099.467539934422, 7392.704291828267, 7542.886856697044, 7914.722984695508, 8080.797980050545, 8173.713920012771, 8286.337093032422, 8293.046299675374, 6994.405475534637, 7015.088038555159, 7181.964090179516, 7248.057752492142, 7292.270772922665, 6915.654217289015, 7016.859662806817, 7021.754238601625, 7105.715771369088, 7147.0, 6586.045023471665, 6606.10817539626, 6672.532922695559, 6680.5323627345615, 6692.899606506004, 5008.874778130576, 5060.114479966065, 5069.493050694901, 5123.180291153398, 5211.5049070338255, 3867.593902640295, 4887.828925987574, 4968.4286307075145, 5061.620378471703, 5099.439061703284], "value": 4456.92435890672, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.59170250063676, 361.29907978521663, 370.92952339055586, 374.0032812554542, 380.15226045917603, 5131.3573509642565, 5177.637565370421, 5181.43004269531, 5182.585393168547, 5204.9219261711105, 4468.597826195642, 5115.232715092738, 5120.564751996076, 5125.66683165594, 5131.615128865331, 3288.523164141198, 3666.3034023535442, 3847.9038024049482, 3920.3926390180104, 4064.841520166753, 3989.760614363133, 3995.1011022519847, 3996.980015099935, 4001.779902105383, 4029.4560234368423, 3996.960030399702, 4016.9397459038137, 4018.8948039289285, 4024.444477756631, 4037.4953130858644, 3793.9945914332725, 4028.395740638898, 4037.9596204037875, 4041.6766658667384, 4048.6761059115493, 3120.60992375953, 3410.0622328859513, 3513.7540372173958, 3543.112363423827, 3598.676119149289, 4891.437484689271, 4962.858542535237, 4972.403311602595, 4990.82532111378, 4997.603068072836, 3822.26087130355, 4225.408442818008, 4617.30740388941, 4625.537446255347, 4634.86095417138, 5121.897562048775, 5194.6104042196985, 5342.545883599899, 5420.403755586883, 5476.370217424967, 3993.221321842242, 3993.341098718708, 3993.9416054745516, 3999.6200360965663, 4012.137390461065, 5300.178472336794, 5433.429489903543, 5731.570132240057, 5745.621050947784, 5771.769129234825, 3735.34631439497, 4008.3987401889367, 4047.8988025299604, 4063.0858056936954, 4069.6744260459686, 3430.811305378228, 4075.0219947212454, 4082.8366865325056, 4097.85657501986, 4099.831548008863, 3873.9806300968316, 3905.7656540607086, 4293.055527783882, 4580.358749775034, 4661.974365639554, 4010.8997275067773, 4516.209663308908, 4618.815247390134, 4706.882327941828, 5156.407013193456, 1216.6106845809256, 1244.9728973596818, 1304.8760367765046, 1342.744878473087, 1349.9730005399838, 733.4132693844903, 875.60160127142, 938.1884669760744, 943.2312665177858, 956.7942892278194, 4833.589144922651, 4846.903061938741, 4865.683730557574, 5011.599072074226, 5038.874028149252, 5439.129739241703, 5448.182772584144, 5457.508824205841, 5462.323461503914, 5466.0, 4901.975490122527, 5077.517635824591, 5116.827566908541, 5118.334616499831, 5133.101707201225, 2650.8336332014237, 2743.711910249435, 2748.477789220082, 2775.778657390782, 2777.472280266743, 4546.431266334511, 4909.803607855646, 5256.6320357574605, 5259.790887827122, 5389.595780316492, 4646.395968524071, 4859.878503037382, 5151.8196863109615, 5344.91982620261, 5421.83734487966, 4929.556339929423, 5421.783128674809, 5669.716514174274, 5753.33836608787, 5785.747475605511, 4887.706737595756, 4906.509349065065, 5037.345145131109, 5554.50009499147, 5555.166724991283, 4868.853934381974, 5220.791168353375, 5542.806001790079, 5569.387367389665, 5639.548836093185, 4295.785210739388, 4847.636427268039, 5368.489993450616, 5458.4541545845095, 5831.7375718093635, 3194.7923384979904, 3816.732828701964, 3835.8657446989223, 3845.8269377877505, 3857.958351245204, 5422.48486393792, 5426.972865135807, 5494.752736126804, 5653.40639232891, 5692.633767895758, 5462.289902312674, 5469.714617065066, 5473.753681084281, 5491.172046396029, 5520.723963801875, 5468.179773034077, 5479.643823151482, 5482.671039737628, 5505.779768809202, 5519.9448005521035, 4320.092780516001, 4402.603765661106, 4641.828375160453, 5415.566754659539, 5423.29497165366, 4596.517365676689, 5183.377994640668, 5301.893962120659, 5337.0393329201115, 5381.2197231402015, 4724.362211101457, 4913.70517768935, 5080.669756465818, 5212.687238765535, 5234.408967560929], "value": 3989.897159093255, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.4513260187463, 745.5079647432696, 777.498513458819, 791.2325044706636, 875.3916028360288, 15073.547793566197, 15456.149911754863, 16374.017558946442, 16406.67186656266, 16408.343666253364, 14776.261186940663, 15204.315805788738, 16771.580710482245, 17478.563035924108, 17518.386856460027, 900.5407242306421, 924.4314746430964, 926.9258459323272, 928.0997432490507, 928.9024652411501, 706.6961206681125, 728.1662496441571, 887.9112088791102, 906.9682561110362, 917.7567944494714, 893.1559676106083, 893.6148969097873, 961.9134277914986, 964.5177411294353, 968.6851773173712, 961.4711908450324, 961.5624890674796, 961.7307153996892, 962.8507581324906, 963.9614415423374, 715.5349023134952, 716.6273537760335, 716.9426445884317, 717.243308309733, 718.0019772516207, 15816.446424375206, 16179.83820161807, 16202.675946481122, 16229.594260143473, 16448.588785280343, 14577.635559111, 14794.260286985607, 14798.926005370013, 14805.555833325017, 14813.629659258497, 11658.242214256046, 11809.0, 11847.585334513336, 12084.939575302154, 12601.432935517923, 3828.9042773930596, 3845.596212397686, 3866.1881004988986, 3915.686745060388, 3926.921461570781, 96836.0, 111783.99999999919, 112656.0, 113135.0, 114272.0, 11040.171987101, 11204.775904481865, 11234.887651123385, 11257.324560526395, 11302.4913878874, 22780.658290125662, 23152.884235578713, 23287.53424931492, 23288.301350959497, 23314.0, 7844.529328240324, 7923.564203968722, 7933.523988560705, 7994.480358776661, 8000.35997120229, 4369.60673539383, 4412.051408947092, 4461.709988850715, 4500.527444618333, 4648.5119062498625, 3109.9067027989195, 3777.4522694209186, 3809.9809500952874, 3812.866549670748, 3814.5803961564206, 681.9556728812611, 683.4498228925762, 687.5599616245606, 696.6934548798513, 704.5631708340759, 685.4242436353487, 686.5811854768588, 728.2135293882594, 770.9884351734728, 774.8527779721835, 8848.778780530538, 9401.777768890137, 10184.490775461198, 10363.63727269557, 10452.32059916103, 687.9071325371111, 706.7702996526046, 727.5489196697976, 730.4193166432699, 734.4234775701049, 4217.831286748557, 4979.30289759434, 4988.081048867685, 5120.769565369567, 5163.819266325736, 94808.52595736977, 94968.52515737378, 97136.05727885544, 97583.53624695636, 97892.0, 84146.57926710449, 84501.57749211337, 85389.57305213559, 85662.0, 86136.0, 68238.31761682419, 68530.31469685338, 69486.0, 74356.0, 75810.62094689491, 10810.243282970117, 10908.836367454653, 11007.889921101007, 11213.60752373663, 11253.0, 43445.0, 44388.0, 44986.87532811706, 47167.0, 48917.755411222715, 68262.0, 69657.30342696508, 71814.0, 72491.0, 73491.0, 13011.609651710463, 13184.60446186616, 13198.0, 13488.0, 13768.724625507633, 14103.2948352584, 14509.419623214953, 14625.780613291023, 15001.699966000837, 15245.847541524443, 12377.85991111646, 12423.37883105823, 12437.875621244033, 12860.356982150668, 12979.41592628315, 13138.080334376502, 13867.930660346634, 14016.29918504091, 14362.373423696508, 14586.270686465423, 13012.869871301165, 13643.86356136426, 13685.247311397969, 13691.726165476435, 13692.657683557592, 9487.33588648788, 9777.902220977983, 10271.178305735673, 10302.62473046335, 10580.15358771312, 8926.285897128344, 10440.269181157246, 11241.494132764208, 11263.211575189658, 11300.604478843201], "value": 7688.357044421517, "unit": "score"}], "name": "dromaeo_css", "value": 7321.365527983405, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 113.0, 114.0, 114.0, 112.0, 113.0, 113.0, 114.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 105.0, 106.0, 142.0, 113.0, 137.0, 105.0, 107.0, 127.0, 106.0], "value": 118.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 183.0, 181.0, 183.0, 184.0, 182.0, 183.0, 182.0, 183.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 57.0, 89.0, 60.0, 58.0, 58.0, 59.0, 73.0, 57.0], "value": 64.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 84.0, 70.0, 68.0, 68.0, 81.0, 66.0, 69.0, 81.0], "value": 74.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 89.0, 86.0, 91.0, 86.0, 89.0, 86.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 110.0, 151.0, 152.0, 95.0, 96.0, 96.0, 96.0], "value": 108.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 93.0, 130.0, 88.0, 89.0, 85.0, 68.0, 84.0, 93.0, 133.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 53.0, 52.0, 54.0, 55.0, 78.0, 86.0, 85.0, 82.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 67.0, 74.0, 69.0, 65.0, 67.0, 68.0, 68.0, 67.0], "value": 68.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 82.0, 80.0, 80.0, 82.0, 83.0, 84.0, 87.0, 82.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 135.0, 142.0, 146.0, 131.0, 128.0, 133.0, 132.0, 169.0, 142.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 191.0, 162.0, 162.0, 163.0, 163.0, 161.0, 160.0, 161.0, 217.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 66.0, 64.0, 65.0, 62.0, 62.0, 65.0, 62.0, 63.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1431.8, "alertThreshold": 2.0}]} 10:10:02 INFO - Return code: 0 10:10:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:10:03 INFO - # TBPL SUCCESS # 10:10:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:10:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:10:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:10:03 INFO - 2017-03-27 10:10:03.052 screenresolution[1652:9770] starting screenresolution argv=screenresolution get 10:10:03 INFO - 2017-03-27 10:10:03.055 screenresolution[1652:9770] Display 0: 1600x1200x32@60 10:10:03 INFO - 2017-03-27 10:10:03.061 screenresolution[1653:9773] starting screenresolution argv=screenresolution list 10:10:03 INFO - Available Modes on Display 0 10:10:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:10:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:10:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:10:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:10:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:10:03 INFO - Intel Iris: 10:10:03 INFO - Chipset Model: Intel Iris 10:10:03 INFO - Type: GPU 10:10:03 INFO - Bus: Built-In 10:10:03 INFO - VRAM (Dynamic, Max): 1536 MB 10:10:03 INFO - Vendor: Intel (0x8086) 10:10:03 INFO - Device ID: 0x0a2e 10:10:03 INFO - Revision ID: 0x0009 10:10:03 INFO - Displays: 10:10:03 INFO - Display: 10:10:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:10:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:10:03 INFO - Display Serial Number: 1600x1200 60 10:10:03 INFO - Main Display: Yes 10:10:03 INFO - Mirror: Off 10:10:03 INFO - Online: Yes 10:10:03 INFO - Rotation: Supported 10:10:03 INFO - Return code: 0 10:10:03 INFO - Running post-action listener: _resource_record_post_action 10:10:03 INFO - [mozharness: 2017-03-27 17:10:03.294426Z] Finished run-tests step (success) 10:10:03 INFO - Running post-run listener: _resource_record_post_run 10:10:03 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 38212608; Write bytes: 420239360; Read time: 241; Write time: 1408 10:10:03 INFO - TinderboxPrint: CPU usage
53.5% 10:10:03 INFO - TinderboxPrint: I/O read bytes / time
38,212,608 / 241 10:10:03 INFO - TinderboxPrint: I/O write bytes / time
420,239,360 / 1,408 10:10:03 INFO - TinderboxPrint: CPU idle
2,218.0 (46.5%) 10:10:03 INFO - TinderboxPrint: CPU system
952.0 (20.0%) 10:10:03 INFO - TinderboxPrint: CPU user
1,595.7 (33.5%) 10:10:03 INFO - TinderboxPrint: Swap in / out
159,891,456 / 0 10:10:03 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 122706432; Write bytes: 113778688; Read time: 11219; Write time: 252 10:10:03 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 34399232; Write bytes: 296327168; Read time: 216; Write time: 1120 10:10:03 INFO - Running post-run listener: _upload_blobber_files 10:10:03 INFO - Blob upload gear active. 10:10:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:10: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 10:10: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'] 10:10: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 10:10:04 INFO - (blobuploader) - INFO - Open directory for files ... 10:10:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:10:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:10:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:05 INFO - (blobuploader) - INFO - Done attempting. 10:10:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:10:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:10:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:06 INFO - (blobuploader) - INFO - Done attempting. 10:10:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:10:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:10:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:07 INFO - (blobuploader) - INFO - Done attempting. 10:10:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:10:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:10:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:10:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:10:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:10:09 INFO - (blobuploader) - INFO - Done attempting. 10:10:09 INFO - (blobuploader) - INFO - Iteration through files over. 10:10:09 INFO - Return code: 0 10:10:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:10:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:10:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1493628b27120d6605fb3715fac664495baa4e675ee154eef5796d82eb4b3ec7c7456285e90d391c30098afe478726e6e90b082cda8f3a31e1fe5f3a58e17c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb5cac281fefa1062edf92ee804515a4240d39c8bb90250bfc1bce68e7f193dcde5e03220f623ab690ffe373674ed25c689afc3cab85c2889bf98c10d4e2c360", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14946663242fe7d638f5f69bec9cb07caf3faedc9e1f07ed5b90aa76a59a134a6540c2090c78d366fc4613b74934f2fc1b1e60a33fd95fdf4327f95921a324de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f683ab49e566c3eaebbed2e3a436e25f959d78a543302f4280cf35d279e3238670d1e8e544e42f7b89f4610076ea480b52e2642ecfd400baca4d6fb83ce4069a"} 10:10:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:10:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:10:09 INFO - Contents: 10:10:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1493628b27120d6605fb3715fac664495baa4e675ee154eef5796d82eb4b3ec7c7456285e90d391c30098afe478726e6e90b082cda8f3a31e1fe5f3a58e17c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb5cac281fefa1062edf92ee804515a4240d39c8bb90250bfc1bce68e7f193dcde5e03220f623ab690ffe373674ed25c689afc3cab85c2889bf98c10d4e2c360", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14946663242fe7d638f5f69bec9cb07caf3faedc9e1f07ed5b90aa76a59a134a6540c2090c78d366fc4613b74934f2fc1b1e60a33fd95fdf4327f95921a324de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f683ab49e566c3eaebbed2e3a436e25f959d78a543302f4280cf35d279e3238670d1e8e544e42f7b89f4610076ea480b52e2642ecfd400baca4d6fb83ce4069a"} 10:10:09 INFO - Running post-run listener: copy_logs_to_upload_dir 10:10:09 INFO - Copying logs to upload dir... 10:10:09 INFO - mkdir: /builds/slave/test/build/upload/logs 10:10:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.682146 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-27 10:10:09.479463) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 10:10:09.482650) ========= 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.jVimvm6Kkp/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.eRu5MKEdfs/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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/b1493628b27120d6605fb3715fac664495baa4e675ee154eef5796d82eb4b3ec7c7456285e90d391c30098afe478726e6e90b082cda8f3a31e1fe5f3a58e17c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb5cac281fefa1062edf92ee804515a4240d39c8bb90250bfc1bce68e7f193dcde5e03220f623ab690ffe373674ed25c689afc3cab85c2889bf98c10d4e2c360", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14946663242fe7d638f5f69bec9cb07caf3faedc9e1f07ed5b90aa76a59a134a6540c2090c78d366fc4613b74934f2fc1b1e60a33fd95fdf4327f95921a324de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f683ab49e566c3eaebbed2e3a436e25f959d78a543302f4280cf35d279e3238670d1e8e544e42f7b89f4610076ea480b52e2642ecfd400baca4d6fb83ce4069a"} build_url:https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009673 build_url: 'https://queue.taskcluster.net/v1/task/Kuj3CHSmTx6OKf9SbjY-VQ/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/b1493628b27120d6605fb3715fac664495baa4e675ee154eef5796d82eb4b3ec7c7456285e90d391c30098afe478726e6e90b082cda8f3a31e1fe5f3a58e17c3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bb5cac281fefa1062edf92ee804515a4240d39c8bb90250bfc1bce68e7f193dcde5e03220f623ab690ffe373674ed25c689afc3cab85c2889bf98c10d4e2c360", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14946663242fe7d638f5f69bec9cb07caf3faedc9e1f07ed5b90aa76a59a134a6540c2090c78d366fc4613b74934f2fc1b1e60a33fd95fdf4327f95921a324de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f683ab49e566c3eaebbed2e3a436e25f959d78a543302f4280cf35d279e3238670d1e8e544e42f7b89f4610076ea480b52e2642ecfd400baca4d6fb83ce4069a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-27 10:10:09.516758) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 10:10:09.517445) ========= 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.jVimvm6Kkp/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.eRu5MKEdfs/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.004836 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-27 10:10:09.568201) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 10:10:09.568543) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-27 10:10:09.568907) ========= ========= Total master_lag: 0.19 =========