builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0286 starttime: 1476179278.3 results: success (0) buildid: 20161011004015 builduid: 493ec98de2734c049c659a825a86cd7f revision: 9a452e8fde0ffd76d25179f5d6165265444a2247 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:58.302572) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:58.308757) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:58.309111) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:58.334563) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:58.335033) ========= 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.QnxLa1W7J5/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.8qN1CbKdLb/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 --2016-10-11 02:47:58-- 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% 15.6M=0.001s 2016-10-11 02:47:58 (15.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.620467 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:58.999181) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:58.999486) ========= 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.QnxLa1W7J5/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.8qN1CbKdLb/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.030446 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 02:47:59.053168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 02:47:59.053508) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a452e8fde0ffd76d25179f5d6165265444a2247 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a452e8fde0ffd76d25179f5d6165265444a2247 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QnxLa1W7J5/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.8qN1CbKdLb/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 2016-10-11 02:47:59,134 truncating revision to first 12 chars 2016-10-11 02:47:59,134 Setting DEBUG logging. 2016-10-11 02:47:59,134 attempt 1/10 2016-10-11 02:47:59,134 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a452e8fde0f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 02:48:00,485 unpacking tar archive at: mozilla-aurora-9a452e8fde0f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.728292 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 02:48:00.805104) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 02:48:00.805404) ========= script_repo_revision: 9a452e8fde0ffd76d25179f5d6165265444a2247 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 02:48:00.805805) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 02:48:00.806201) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 02:48:00.824029) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-10-11 02:48:00.824362) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QnxLa1W7J5/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.8qN1CbKdLb/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 02:48:01 INFO - MultiFileLogger online at 20161011 02:48:01 in /builds/slave/test 02:48:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:48:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:48:01 INFO - {'append_to_log': False, 02:48:01 INFO - 'base_work_dir': '/builds/slave/test', 02:48:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:48:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:48:01 INFO - 'branch': 'Mozilla-Aurora', 02:48:01 INFO - 'buildbot_json_path': 'buildprops.json', 02:48:01 INFO - 'config_files': ('talos/mac_config.py',), 02:48:01 INFO - 'default_actions': ('clobber', 02:48:01 INFO - 'read-buildbot-config', 02:48:01 INFO - 'download-and-extract', 02:48:01 INFO - 'populate-webroot', 02:48:01 INFO - 'create-virtualenv', 02:48:01 INFO - 'install', 02:48:01 INFO - 'run-tests'), 02:48:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:48:01 INFO - 'download_minidump_stackwalk': True, 02:48:01 INFO - 'download_symbols': 'ondemand', 02:48:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:48:01 INFO - 'tooltool.py': '/tools/tooltool.py', 02:48:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:48:01 INFO - '/tools/misc-python/virtualenv.py')}, 02:48:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:48:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:48:01 INFO - 'installer_path': 'installer.exe', 02:48:01 INFO - 'log_level': 'info', 02:48:01 INFO - 'log_name': 'talos', 02:48:01 INFO - 'log_to_console': True, 02:48:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:48:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:48:01 INFO - 'opt_config_files': (), 02:48:01 INFO - 'pip_index': False, 02:48:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:01 INFO - 'cmd': ('bash', 02:48:01 INFO - '-c', 02:48:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:01 INFO - 'enabled': True, 02:48:01 INFO - 'halt_on_failure': False, 02:48:01 INFO - 'name': 'check_screen_resolution'},), 02:48:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:48:01 INFO - 'cmd': ('bash', 02:48:01 INFO - '-c', 02:48:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:48:01 INFO - 'enabled': True, 02:48:01 INFO - 'halt_on_failure': False, 02:48:01 INFO - 'name': 'check_screen_resolution'},), 02:48:01 INFO - 'run_cmd_checks_enabled': True, 02:48:01 INFO - 'sps_profile': False, 02:48:01 INFO - 'sps_profile_interval': 0, 02:48:01 INFO - 'suite': 'dromaeojs-e10s', 02:48:01 INFO - 'system_bits': '32', 02:48:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:48:01 INFO - 'title': 't-yosemite-r7-0286', 02:48:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:48:01 INFO - 'use_talos_json': True, 02:48:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:48:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:48:01 INFO - 'work_dir': 'build'} 02:48:01 INFO - [mozharness: 2016-10-11 09:48:01.027541Z] Running clobber step. 02:48:01 INFO - Running pre-action listener: _resource_record_pre_action 02:48:01 INFO - Running main action method: clobber 02:48:01 INFO - rmtree: /builds/slave/test/build 02:48:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:48:03 INFO - Running post-action listener: _resource_record_post_action 02:48:03 INFO - [mozharness: 2016-10-11 09:48:03.137100Z] Finished clobber step (success) 02:48:03 INFO - [mozharness: 2016-10-11 09:48:03.137221Z] Running read-buildbot-config step. 02:48:03 INFO - Running pre-action listener: _resource_record_pre_action 02:48:03 INFO - Running main action method: read_buildbot_config 02:48:03 INFO - Using buildbot properties: 02:48:03 INFO - { 02:48:03 INFO - "project": "", 02:48:03 INFO - "product": "firefox", 02:48:03 INFO - "script_repo_revision": "production", 02:48:03 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:48:03 INFO - "repository": "", 02:48:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:48:03 INFO - "buildid": "20161011004015", 02:48:03 INFO - "stage_platform": "macosx64", 02:48:03 INFO - "basedir": "/builds/slave/test", 02:48:03 INFO - "nightly_build": "True", 02:48:03 INFO - "buildnumber": 0, 02:48:03 INFO - "slavename": "t-yosemite-r7-0286", 02:48:03 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 02:48:03 INFO - "platform": "yosemite_r7", 02:48:03 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:48:03 INFO - "branch": "mozilla-aurora", 02:48:03 INFO - "repo_path": "releases/mozilla-aurora", 02:48:03 INFO - "revision": "9a452e8fde0ffd76d25179f5d6165265444a2247", 02:48:03 INFO - "pgo_build": "False", 02:48:03 INFO - "builduid": "493ec98de2734c049c659a825a86cd7f", 02:48:03 INFO - "slavebuilddir": "test" 02:48:03 INFO - } 02:48:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 02:48:03 INFO - Running post-action listener: _resource_record_post_action 02:48:03 INFO - [mozharness: 2016-10-11 09:48:03.140721Z] Finished read-buildbot-config step (success) 02:48:03 INFO - [mozharness: 2016-10-11 09:48:03.140814Z] Running download-and-extract step. 02:48:03 INFO - Running pre-action listener: _resource_record_pre_action 02:48:03 INFO - Running main action method: download_and_extract 02:48:03 INFO - mkdir: /builds/slave/test/build/tests 02:48:03 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')]} 02:48:03 INFO - trying https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 02:48:03 INFO - Downloading https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:48:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 02:48:04 INFO - Downloaded 1199 bytes. 02:48:04 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:48:04 INFO - Using the following test package requirements: 02:48:04 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:48:04 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:04 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 02:48:04 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:04 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 02:48:04 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:04 INFO - u'jsshell-mac.zip'], 02:48:04 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:04 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 02:48:04 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:48:04 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:04 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 02:48:04 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:04 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 02:48:04 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:04 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 02:48:04 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:48:04 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 02:48:04 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:48:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:48:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:48:04 INFO - Fetch https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:48:04 INFO - Expected file size: 16434994 02:48:12 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:48:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:48:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:48:12 INFO - Fetch https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:48:13 INFO - Expected file size: 16434994 02:48:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 02:48:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:48:19 INFO - Fetch https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 02:48:20 INFO - Expected file size: 14414059 02:48:20 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')]} 02:48:20 INFO - trying https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:48:20 INFO - Downloading https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 02:48:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 02:48:23 INFO - Downloaded 115437539 bytes. 02:48:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:48:23 INFO - mkdir: /builds/slave/test/properties 02:48:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:48:23 INFO - Writing to file /builds/slave/test/properties/build_url 02:48:23 INFO - Contents: 02:48:23 INFO - build_url:https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:48:24 INFO - Running post-action listener: _resource_record_post_action 02:48:24 INFO - Running post-action listener: set_extra_try_arguments 02:48:24 INFO - [mozharness: 2016-10-11 09:48:24.464682Z] Finished download-and-extract step (success) 02:48:24 INFO - [mozharness: 2016-10-11 09:48:24.464832Z] Running populate-webroot step. 02:48:24 INFO - Running pre-action listener: _resource_record_pre_action 02:48:24 INFO - Running main action method: populate_webroot 02:48:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:48:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:48:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:48:24 INFO - '--tppagecycles', 02:48:24 INFO - '7'], 02:48:24 INFO - 'tests': ['tsvgm']}}, 02:48:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:48:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:48:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:48:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:48:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:48:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:48:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:24 INFO - 'talos_options': ['--disable-e10s'], 02:48:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:48:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:24 INFO - 'talos_options': ['--disable-e10s'], 02:48:24 INFO - 'tests': ['damp', 'tps']}, 02:48:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:24 INFO - 'tests': ['damp', 'tps']}, 02:48:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:48:24 INFO - 'tests': ['dromaeo_dom']}, 02:48:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:48:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:48:24 INFO - 'tests': ['basic_compositor_video']}, 02:48:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:48:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:48:24 INFO - 'tests': ['a11yr', 02:48:24 INFO - 'ts_paint', 02:48:24 INFO - 'tpaint', 02:48:24 INFO - 'sessionrestore', 02:48:24 INFO - 'sessionrestore_no_auto_restore', 02:48:24 INFO - 'tabpaint']}, 02:48:24 INFO - 'other-e10s': {'tests': ['a11yr', 02:48:24 INFO - 'ts_paint', 02:48:24 INFO - 'tpaint', 02:48:24 INFO - 'sessionrestore', 02:48:24 INFO - 'sessionrestore_no_auto_restore', 02:48:24 INFO - 'tabpaint']}, 02:48:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:48:24 INFO - 'ts_paint', 02:48:24 INFO - 'tpaint', 02:48:24 INFO - 'sessionrestore', 02:48:24 INFO - 'sessionrestore_no_auto_restore', 02:48:24 INFO - 'tabpaint']}, 02:48:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:48:24 INFO - 'ts_paint', 02:48:24 INFO - 'tpaint', 02:48:24 INFO - 'sessionrestore', 02:48:24 INFO - 'sessionrestore_no_auto_restore', 02:48:24 INFO - 'tabpaint']}, 02:48:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:48:24 INFO - 'tests': ['a11yr', 02:48:24 INFO - 'ts_paint', 02:48:24 INFO - 'tpaint', 02:48:24 INFO - 'sessionrestore', 02:48:24 INFO - 'sessionrestore_no_auto_restore', 02:48:24 INFO - 'tabpaint']}, 02:48:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:48:24 INFO - 'tests': ['a11yr', 02:48:24 INFO - 'ts_paint', 02:48:24 INFO - 'tpaint', 02:48:24 INFO - 'sessionrestore', 02:48:24 INFO - 'sessionrestore_no_auto_restore', 02:48:24 INFO - 'tabpaint']}, 02:48:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:48:24 INFO - 'tests': ['tsvgx', 02:48:24 INFO - 'tsvgr_opacity', 02:48:24 INFO - 'tart', 02:48:24 INFO - 'tscrollx', 02:48:24 INFO - 'cart']}, 02:48:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:48:24 INFO - 'tsvgr_opacity', 02:48:24 INFO - 'tart', 02:48:24 INFO - 'tscrollx', 02:48:24 INFO - 'cart']}, 02:48:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:24 INFO - 'talos_options': ['--disable-e10s'], 02:48:24 INFO - 'tests': ['tp5o']}, 02:48:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:24 INFO - 'tests': ['tp5o']}, 02:48:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:24 INFO - 'talos_options': ['--disable-e10s', 02:48:24 INFO - '--xperf_path', 02:48:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:24 INFO - 'tests': ['tp5n']}, 02:48:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:48:24 INFO - 'talos_options': ['--xperf_path', 02:48:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:48:24 INFO - 'tests': ['tp5n']}}, 02:48:24 INFO - 'talos.zip': {'path': '', 02:48:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:48:24 INFO - Running post-action listener: _resource_record_post_action 02:48:24 INFO - [mozharness: 2016-10-11 09:48:24.483757Z] Finished populate-webroot step (success) 02:48:24 INFO - [mozharness: 2016-10-11 09:48:24.483888Z] Running create-virtualenv step. 02:48:24 INFO - Running pre-action listener: _resource_record_pre_action 02:48:24 INFO - Running main action method: create_virtualenv 02:48:24 INFO - Creating virtualenv /builds/slave/test/build/venv 02:48:24 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 02:48:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:48:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:48:24 INFO - Using real prefix '/tools/python27' 02:48:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:48:25 INFO - Installing distribute.............................................................................................................................................................................................done. 02:48:28 INFO - Installing pip.................done. 02:48:28 INFO - Return code: 0 02:48:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:48:28 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')]} 02:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:28 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')]} 02:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:28 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 0x101416490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10138c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8bd9f2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10122ad30>, '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 0x101090db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101222b20>, '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.QnxLa1W7J5/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.8qN1CbKdLb/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 02:48:28 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 02:48:28 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 02:48:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QnxLa1W7J5/Render', 02:48:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:28 INFO - 'HOME': '/Users/cltbld', 02:48:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:28 INFO - 'LOGNAME': 'cltbld', 02:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:28 INFO - 'MOZ_NO_REMOTE': '1', 02:48:28 INFO - 'NO_EM_RESTART': '1', 02:48:28 INFO - 'PAGER': '/bin/cat', 02:48:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:28 INFO - 'PWD': '/builds/slave/test', 02:48:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:28 INFO - 'SHELL': '/bin/bash', 02:48:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qN1CbKdLb/Listeners', 02:48:28 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:48:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:28 INFO - 'USER': 'cltbld', 02:48:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:28 INFO - 'XPC_FLAGS': '0x0', 02:48:28 INFO - 'XPC_SERVICE_NAME': '0', 02:48:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:28 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 02:48:28 INFO - Cleaning up... 02:48:28 INFO - Return code: 0 02:48:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:48:28 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')]} 02:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:28 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')]} 02:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:28 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 0x101416490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10138c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8bd9f2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10122ad30>, '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 0x101090db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101222b20>, '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.QnxLa1W7J5/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.8qN1CbKdLb/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 02:48:28 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 02:48:28 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 02:48:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QnxLa1W7J5/Render', 02:48:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:28 INFO - 'HOME': '/Users/cltbld', 02:48:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:28 INFO - 'LOGNAME': 'cltbld', 02:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:28 INFO - 'MOZ_NO_REMOTE': '1', 02:48:28 INFO - 'NO_EM_RESTART': '1', 02:48:28 INFO - 'PAGER': '/bin/cat', 02:48:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:28 INFO - 'PWD': '/builds/slave/test', 02:48:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:28 INFO - 'SHELL': '/bin/bash', 02:48:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qN1CbKdLb/Listeners', 02:48:28 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:48:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:28 INFO - 'USER': 'cltbld', 02:48:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:28 INFO - 'XPC_FLAGS': '0x0', 02:48:28 INFO - 'XPC_SERVICE_NAME': '0', 02:48:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:28 INFO - Downloading/unpacking psutil>=3.1.1 02:48:28 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 02:48:28 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 02:48:28 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 02:48:28 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 02:48:28 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 02:48:28 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 02:48:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:48:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:31 INFO - Installing collected packages: psutil 02:48:31 INFO - Running setup.py install for psutil 02:48:31 INFO - building 'psutil._psutil_osx' extension 02:48:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:48:32 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 02:48:32 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 02:48:32 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 02:48:32 INFO - building 'psutil._psutil_posix' extension 02:48:32 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 02:48:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:48:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:48:32 INFO - ^ 02:48:32 INFO - 1 warning generated. 02:48:32 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 02:48:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:48:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:48:32 INFO - Successfully installed psutil 02:48:32 INFO - Cleaning up... 02:48:32 INFO - Return code: 0 02:48:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:48:32 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')]} 02:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:32 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')]} 02:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:32 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 0x101416490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10138c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8bd9f2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10122ad30>, '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 0x101090db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101222b20>, '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.QnxLa1W7J5/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.8qN1CbKdLb/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 02:48:32 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 02:48:32 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 02:48:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QnxLa1W7J5/Render', 02:48:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:32 INFO - 'HOME': '/Users/cltbld', 02:48:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:32 INFO - 'LOGNAME': 'cltbld', 02:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:32 INFO - 'MOZ_NO_REMOTE': '1', 02:48:32 INFO - 'NO_EM_RESTART': '1', 02:48:32 INFO - 'PAGER': '/bin/cat', 02:48:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:32 INFO - 'PWD': '/builds/slave/test', 02:48:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:32 INFO - 'SHELL': '/bin/bash', 02:48:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qN1CbKdLb/Listeners', 02:48:32 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:48:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:32 INFO - 'USER': 'cltbld', 02:48:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:32 INFO - 'XPC_FLAGS': '0x0', 02:48:32 INFO - 'XPC_SERVICE_NAME': '0', 02:48:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:48:32 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 02:48:32 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 02:48:32 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 02:48:32 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 02:48:32 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 02:48:32 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 02:48:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:48:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:48:35 INFO - Installing collected packages: mozsystemmonitor 02:48:35 INFO - Running setup.py install for mozsystemmonitor 02:48:35 INFO - Successfully installed mozsystemmonitor 02:48:35 INFO - Cleaning up... 02:48:35 INFO - Return code: 0 02:48:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101416490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10138c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8bd9f2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10122ad30>, '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 0x101090db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101222b20>, '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.QnxLa1W7J5/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.8qN1CbKdLb/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 02:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QnxLa1W7J5/Render', 02:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:35 INFO - 'HOME': '/Users/cltbld', 02:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:35 INFO - 'LOGNAME': 'cltbld', 02:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:35 INFO - 'MOZ_NO_REMOTE': '1', 02:48:35 INFO - 'NO_EM_RESTART': '1', 02:48:35 INFO - 'PAGER': '/bin/cat', 02:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:35 INFO - 'PWD': '/builds/slave/test', 02:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:35 INFO - 'SHELL': '/bin/bash', 02:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qN1CbKdLb/Listeners', 02:48:35 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:35 INFO - 'USER': 'cltbld', 02:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:35 INFO - 'XPC_FLAGS': '0x0', 02:48:35 INFO - 'XPC_SERVICE_NAME': '0', 02:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:36 INFO - Downloading/unpacking jsonschema==2.5.1 02:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:48:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:48:38 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 02:48:38 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 02:48:38 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 02:48:38 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 02:48:38 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 02:48:38 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 02:48:38 INFO - Downloading functools32-3.2.3-2.tar.gz 02:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:48:39 INFO - warning: no files found matching '*.txt' 02:48:39 INFO - no previously-included directories found matching 'build' 02:48:39 INFO - no previously-included directories found matching 'dist' 02:48:39 INFO - no previously-included directories found matching '.git*' 02:48:39 INFO - Installing collected packages: jsonschema, functools32 02:48:39 INFO - Running setup.py install for functools32 02:48:39 INFO - warning: no files found matching '*.txt' 02:48:39 INFO - no previously-included directories found matching 'build' 02:48:39 INFO - no previously-included directories found matching 'dist' 02:48:39 INFO - no previously-included directories found matching '.git*' 02:48:39 INFO - Successfully installed jsonschema functools32 02:48:39 INFO - Cleaning up... 02:48:39 INFO - Return code: 0 02:48:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101416490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10138c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8bd9f2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10122ad30>, '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 0x101090db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101222b20>, '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.QnxLa1W7J5/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.8qN1CbKdLb/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 02:48:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:48:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QnxLa1W7J5/Render', 02:48:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:39 INFO - 'HOME': '/Users/cltbld', 02:48:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:39 INFO - 'LOGNAME': 'cltbld', 02:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:39 INFO - 'MOZ_NO_REMOTE': '1', 02:48:39 INFO - 'NO_EM_RESTART': '1', 02:48:39 INFO - 'PAGER': '/bin/cat', 02:48:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:39 INFO - 'PWD': '/builds/slave/test', 02:48:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:39 INFO - 'SHELL': '/bin/bash', 02:48:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qN1CbKdLb/Listeners', 02:48:39 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:48:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:39 INFO - 'USER': 'cltbld', 02:48:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:39 INFO - 'XPC_FLAGS': '0x0', 02:48:39 INFO - 'XPC_SERVICE_NAME': '0', 02:48:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:48:39 INFO - Cleaning up... 02:48:39 INFO - Return code: 0 02:48:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101416490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10138c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8bd9f2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10122ad30>, '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 0x101090db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101222b20>, '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.QnxLa1W7J5/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.8qN1CbKdLb/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 02:48:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:48:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QnxLa1W7J5/Render', 02:48:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:39 INFO - 'HOME': '/Users/cltbld', 02:48:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:39 INFO - 'LOGNAME': 'cltbld', 02:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:39 INFO - 'MOZ_NO_REMOTE': '1', 02:48:39 INFO - 'NO_EM_RESTART': '1', 02:48:39 INFO - 'PAGER': '/bin/cat', 02:48:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:39 INFO - 'PWD': '/builds/slave/test', 02:48:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:39 INFO - 'SHELL': '/bin/bash', 02:48:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qN1CbKdLb/Listeners', 02:48:39 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:48:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:39 INFO - 'USER': 'cltbld', 02:48:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:39 INFO - 'XPC_FLAGS': '0x0', 02:48:39 INFO - 'XPC_SERVICE_NAME': '0', 02:48:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:39 INFO - Downloading/unpacking blobuploader==1.2.4 02:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:42 INFO - Downloading blobuploader-1.2.4.tar.gz 02:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:48:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48: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 02:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:48:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:43 INFO - Downloading docopt-0.6.1.tar.gz 02:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:48:43 INFO - Installing collected packages: blobuploader, requests, docopt 02:48:43 INFO - Running setup.py install for blobuploader 02:48:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:48:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:48:43 INFO - Running setup.py install for requests 02:48:44 INFO - Running setup.py install for docopt 02:48:44 INFO - Successfully installed blobuploader requests docopt 02:48:44 INFO - Cleaning up... 02:48:44 INFO - Return code: 0 02:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:44 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')]} 02:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:44 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')]} 02:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:44 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 0x101416490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10138c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8bd9f2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10122ad30>, '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 0x101090db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101222b20>, '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.QnxLa1W7J5/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.8qN1CbKdLb/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 02:48:44 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 02:48:44 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 02:48:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QnxLa1W7J5/Render', 02:48:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:44 INFO - 'HOME': '/Users/cltbld', 02:48:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:44 INFO - 'LOGNAME': 'cltbld', 02:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:44 INFO - 'MOZ_NO_REMOTE': '1', 02:48:44 INFO - 'NO_EM_RESTART': '1', 02:48:44 INFO - 'PAGER': '/bin/cat', 02:48:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:44 INFO - 'PWD': '/builds/slave/test', 02:48:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:44 INFO - 'SHELL': '/bin/bash', 02:48:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qN1CbKdLb/Listeners', 02:48:44 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:48:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:44 INFO - 'USER': 'cltbld', 02:48:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:44 INFO - 'XPC_FLAGS': '0x0', 02:48:44 INFO - 'XPC_SERVICE_NAME': '0', 02:48:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:44 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-bl0Q2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:44 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-16sUNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:44 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-kXqyvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-JGyGFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-OQqt6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-Ice0lM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-DCUkLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-UQzgLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-LnYDGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-tUzsss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-h5EdNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-WV9KZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:45 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-WOxz3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:46 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-NPBDRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:46 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-fJauKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:46 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ZRyZeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:46 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-LXj9vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:48:46 INFO - Running setup.py install for manifestparser 02:48:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:48:46 INFO - Running setup.py install for mozcrash 02:48:46 INFO - Running setup.py install for mozdebug 02:48:46 INFO - Running setup.py install for mozdevice 02:48:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Running setup.py install for mozfile 02:48:47 INFO - Running setup.py install for mozhttpd 02:48:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Running setup.py install for mozinfo 02:48:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Running setup.py install for mozInstall 02:48:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Running setup.py install for mozleak 02:48:47 INFO - Running setup.py install for mozlog 02:48:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:48:47 INFO - Running setup.py install for moznetwork 02:48:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Running setup.py install for mozprocess 02:48:48 INFO - Running setup.py install for mozprofile 02:48:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Running setup.py install for mozrunner 02:48:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:48:48 INFO - Running setup.py install for mozscreenshot 02:48:48 INFO - Running setup.py install for moztest 02:48:48 INFO - Running setup.py install for mozversion 02:48:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:48:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:48:49 INFO - Cleaning up... 02:48:49 INFO - Return code: 0 02:48:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48:49 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')]} 02:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:49 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')]} 02:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:49 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 0x101416490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10138c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8bd9f2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10122ad30>, '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 0x101090db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101222b20>, '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.QnxLa1W7J5/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.8qN1CbKdLb/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 02:48:49 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 02:48:49 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 02:48:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QnxLa1W7J5/Render', 02:48:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:49 INFO - 'HOME': '/Users/cltbld', 02:48:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:49 INFO - 'LOGNAME': 'cltbld', 02:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:49 INFO - 'MOZ_NO_REMOTE': '1', 02:48:49 INFO - 'NO_EM_RESTART': '1', 02:48:49 INFO - 'PAGER': '/bin/cat', 02:48:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:49 INFO - 'PWD': '/builds/slave/test', 02:48:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:49 INFO - 'SHELL': '/bin/bash', 02:48:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qN1CbKdLb/Listeners', 02:48:49 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:48:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:49 INFO - 'USER': 'cltbld', 02:48:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:49 INFO - 'XPC_FLAGS': '0x0', 02:48:49 INFO - 'XPC_SERVICE_NAME': '0', 02:48:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:48:49 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-oXby5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:48:49 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)) 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:48:49 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-yj374n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:48:49 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-2CidJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:48:49 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-sj6i2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:48:49 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-xueoX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:48:49 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-4UDLqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:48:49 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-WHAoTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:48:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-YGKzGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:48:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-mK_k7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:48:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-M0y5dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:48:50 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:48:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-zetCvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:48:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ttblN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:48:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-eofhdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:48:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-mSi2Y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-AzUfNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:48:50 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-A0cuu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 02:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:48:51 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-EdyDsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:48:51 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)) 02:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:48:51 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)) 02:48:51 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:48:51 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:48:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:48:53 INFO - Downloading blessings-1.6.tar.gz 02:48:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:48:53 INFO - Installing collected packages: blessings 02:48:53 INFO - Running setup.py install for blessings 02:48:53 INFO - Successfully installed blessings 02:48:53 INFO - Cleaning up... 02:48:53 INFO - Return code: 0 02:48:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:54 INFO - Reading from file tmpfile_stdout 02:48:54 INFO - Current package versions: 02:48:54 INFO - blessings == 1.6 02:48:54 INFO - blobuploader == 1.2.4 02:48:54 INFO - docopt == 0.6.1 02:48:54 INFO - functools32 == 3.2.3-2 02:48:54 INFO - jsonschema == 2.5.1 02:48:54 INFO - manifestparser == 1.1 02:48:54 INFO - mozInstall == 1.12 02:48:54 INFO - mozcrash == 0.17 02:48:54 INFO - mozdebug == 0.1 02:48:54 INFO - mozdevice == 0.48 02:48:54 INFO - mozfile == 1.2 02:48:54 INFO - mozhttpd == 0.7 02:48:54 INFO - mozinfo == 0.9 02:48:54 INFO - mozleak == 0.1 02:48:54 INFO - mozlog == 3.4 02:48:54 INFO - moznetwork == 0.27 02:48:54 INFO - mozprocess == 0.23 02:48:54 INFO - mozprofile == 0.28 02:48:54 INFO - mozrunner == 6.12 02:48:54 INFO - mozscreenshot == 0.1 02:48:54 INFO - mozsystemmonitor == 0.3 02:48:54 INFO - moztest == 0.7 02:48:54 INFO - mozversion == 1.4 02:48:54 INFO - psutil == 3.1.1 02:48:54 INFO - requests == 1.2.3 02:48:54 INFO - wsgiref == 0.1.2 02:48:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101416490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10138c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8bd9f2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10122ad30>, '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 0x101090db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101222b20>, '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.QnxLa1W7J5/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.8qN1CbKdLb/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 02:48:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:48:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QnxLa1W7J5/Render', 02:48:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:54 INFO - 'HOME': '/Users/cltbld', 02:48:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:54 INFO - 'LOGNAME': 'cltbld', 02:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:54 INFO - 'MOZ_NO_REMOTE': '1', 02:48:54 INFO - 'NO_EM_RESTART': '1', 02:48:54 INFO - 'PAGER': '/bin/cat', 02:48:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:54 INFO - 'PWD': '/builds/slave/test', 02:48:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:54 INFO - 'SHELL': '/bin/bash', 02:48:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qN1CbKdLb/Listeners', 02:48:54 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:48:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:54 INFO - 'USER': 'cltbld', 02:48:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:54 INFO - 'XPC_FLAGS': '0x0', 02:48:54 INFO - 'XPC_SERVICE_NAME': '0', 02:48:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:48:54 INFO - Cleaning up... 02:48:54 INFO - Return code: 0 02:48:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:48: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')]} 02:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48: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')]} 02:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:48:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101416490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10138c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc8bd9f2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10122ad30>, '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 0x101090db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101222b20>, '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.QnxLa1W7J5/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.8qN1CbKdLb/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 02:48:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:48:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QnxLa1W7J5/Render', 02:48:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:48:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:48:54 INFO - 'HOME': '/Users/cltbld', 02:48:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:48:54 INFO - 'LOGNAME': 'cltbld', 02:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:48:54 INFO - 'MOZ_NO_REMOTE': '1', 02:48:54 INFO - 'NO_EM_RESTART': '1', 02:48:54 INFO - 'PAGER': '/bin/cat', 02:48:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:48:54 INFO - 'PWD': '/builds/slave/test', 02:48:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:48:54 INFO - 'SHELL': '/bin/bash', 02:48:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qN1CbKdLb/Listeners', 02:48:54 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:48:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:48:54 INFO - 'USER': 'cltbld', 02:48:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:48:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:48:54 INFO - 'XPC_FLAGS': '0x0', 02:48:54 INFO - 'XPC_SERVICE_NAME': '0', 02:48:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:48:54 INFO - Cleaning up... 02:48:54 INFO - Return code: 0 02:48:54 INFO - Running post-action listener: _resource_record_post_action 02:48:54 INFO - Running post-action listener: _start_resource_monitoring 02:48:54 INFO - Starting resource monitoring. 02:48:54 INFO - [mozharness: 2016-10-11 09:48:54.788358Z] Finished create-virtualenv step (success) 02:48:54 INFO - [mozharness: 2016-10-11 09:48:54.789315Z] Running install step. 02:48:54 INFO - Running pre-action listener: _resource_record_pre_action 02:48:54 INFO - Running main action method: install 02:48:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:48:55 INFO - Reading from file tmpfile_stdout 02:48:55 INFO - Detecting whether we're running mozinstall >=1.0... 02:48:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:48:55 INFO - Reading from file tmpfile_stdout 02:48:55 INFO - Output received: 02:48:55 INFO - Usage: mozinstall [options] installer 02:48:55 INFO - Options: 02:48:55 INFO - -h, --help show this help message and exit 02:48:55 INFO - -d DEST, --destination=DEST 02:48:55 INFO - Directory to install application into. [default: 02:48:55 INFO - "/builds/slave/test"] 02:48:55 INFO - --app=APP Application being installed. [default: firefox] 02:48:55 INFO - mkdir: /builds/slave/test/build/application 02:48:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:49:27 INFO - Reading from file tmpfile_stdout 02:49:27 INFO - Output received: 02:49:27 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:49:27 INFO - Running post-action listener: _resource_record_post_action 02:49:27 INFO - [mozharness: 2016-10-11 09:49:27.459079Z] Finished install step (success) 02:49:27 INFO - [mozharness: 2016-10-11 09:49:27.459225Z] Running run-tests step. 02:49:27 INFO - Running pre-action listener: _resource_record_pre_action 02:49:27 INFO - Running main action method: run_tests 02:49:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:49:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:49:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:49:27 INFO - 2016-10-11 02:49:27.473 screenresolution[1642:8342] starting screenresolution argv=screenresolution get 02:49:27 INFO - 2016-10-11 02:49:27.476 screenresolution[1642:8342] Display 0: 1600x1200x32@60 02:49:27 INFO - 2016-10-11 02:49:27.482 screenresolution[1643:8345] starting screenresolution argv=screenresolution list 02:49:27 INFO - Available Modes on Display 0 02:49:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:49:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:49:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:49:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:49:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:49:27 INFO - Intel Iris: 02:49:27 INFO - Chipset Model: Intel Iris 02:49:27 INFO - Type: GPU 02:49:27 INFO - Bus: Built-In 02:49:27 INFO - VRAM (Dynamic, Max): 1536 MB 02:49:27 INFO - Vendor: Intel (0x8086) 02:49:27 INFO - Device ID: 0x0a2e 02:49:27 INFO - Revision ID: 0x0009 02:49:27 INFO - Displays: 02:49:27 INFO - Display: 02:49:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:49:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:49:27 INFO - Display Serial Number: 1600x1200 60 02:49:27 INFO - Main Display: Yes 02:49:27 INFO - Mirror: Off 02:49:27 INFO - Online: Yes 02:49:27 INFO - Rotation: Supported 02:49:27 INFO - Return code: 0 02:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:49:27 INFO - Python 2.7.3 02:49:27 INFO - Return code: 0 02:49:27 INFO - grabbing minidump binary from tooltool 02:49:27 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')]} 02:49:27 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 0x10122ad30>, '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 0x101090db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101222b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:49:27 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 02:49:27 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 02:49:27 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 02:49:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:49:27 INFO - Return code: 0 02:49:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:49:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:49:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:49:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:49:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:49:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QnxLa1W7J5/Render', 02:49:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:49:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:49:27 INFO - 'HOME': '/Users/cltbld', 02:49:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:49:27 INFO - 'LOGNAME': 'cltbld', 02:49:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:49:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:27 INFO - 'MOZ_NO_REMOTE': '1', 02:49:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:49:27 INFO - 'NO_EM_RESTART': '1', 02:49:27 INFO - 'PAGER': '/bin/cat', 02:49:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:27 INFO - 'PWD': '/builds/slave/test', 02:49:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:49:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:49:27 INFO - 'SHELL': '/bin/bash', 02:49:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qN1CbKdLb/Listeners', 02:49:27 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 02:49:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:49:27 INFO - 'USER': 'cltbld', 02:49:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:49:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:27 INFO - 'XPC_FLAGS': '0x0', 02:49:27 INFO - 'XPC_SERVICE_NAME': '0', 02:49:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:49:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:49:28 INFO - mozversion application_buildid: 20161011004015 02:49:28 INFO - mozversion application_changeset: 9a452e8fde0ffd76d25179f5d6165265444a2247 02:49:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:49:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:49:28 INFO - mozversion application_name: Firefox 02:49:28 INFO - mozversion application_remotingname: firefox-dev 02:49:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:49:28 INFO - mozversion application_vendor: Mozilla 02:49:28 INFO - mozversion application_version: 51.0a2 02:49:28 INFO - mozversion platform_buildid: 20161011004015 02:49:28 INFO - mozversion platform_changeset: 9a452e8fde0ffd76d25179f5d6165265444a2247 02:49:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:49:28 INFO - mozversion platform_version: 51.0a2 02:49:28 INFO - using testdate: 1476179368 02:49:28 INFO - actual date: 1476179368 02:49:28 INFO - starting webserver on 'localhost:49275' 02:49:28 INFO - SUITE-START | Running 2 tests 02:49:28 INFO - TEST-START | dromaeo_css 02:49:28 INFO - operating with platform_type : mac_ 02:49:28 INFO - Initialising browser for dromaeo_css test... 02:49:28 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpN0faVV/profile http://localhost:49275/getInfo.html) 02:49:30 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 02:49:30 INFO - PROCESS | 1653 | colorDepth:24 02:49:30 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 02:49:30 INFO - PROCESS | 1653 | __metrics 02:49:31 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 02:49:31 INFO - TEST-INFO | 1653: exit 0 02:49:31 INFO - Browser initialized. 02:49:31 INFO - Running cycle 1/1 for dromaeo_css test... 02:49:31 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpN0faVV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:43 INFO - PROCESS | 1658 | RSS: Main: 225173504 02:49:43 INFO - PROCESS | 1658 | 02:50:33 INFO - PROCESS | 1658 | 1476179433453 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:52:45 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 02:52:46 INFO - PROCESS | 1658 | RSS: Main: 236847104 02:52:46 INFO - PROCESS | 1658 | 02:55:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 02:55:49 INFO - PROCESS | 1658 | RSS: Main: 248000512 02:55:49 INFO - PROCESS | 1658 | 02:58:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 02:58:52 INFO - PROCESS | 1658 | RSS: Main: 251097088 02:58:52 INFO - PROCESS | 1658 | 03:01:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 03:01:54 INFO - PROCESS | 1658 | RSS: Main: 251482112 03:01:54 INFO - PROCESS | 1658 | 03:04:57 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 03:04:58 INFO - PROCESS | 1658 | RSS: Main: 255791104 03:04:58 INFO - PROCESS | 1658 | 03:08:00 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 03:08:00 INFO - PROCESS | 1658 | RSS: Main: 257736704 03:08:00 INFO - PROCESS | 1658 | 03:08:00 INFO - PROCESS | 1658 | __start_tp_report 03:08:00 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 03:08:00 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 03:08:00 INFO - PROCESS | 1658 | |i|pagename|runs| 03:08:00 INFO - PROCESS | 1658 | |0;dojo.html;3420.7263418926473;3422.589289285286;3452.94685121038;3453.309338132371;3461.7403694722893;4231.534531201573;5135.922961155581;5287.206918962158;5851.648901065933;5864.413558644133;5839.5620328475425;5840.53275737941;5909.497692696126;5925;5952.28572571291;4464.754438505881;5297.337832770903;5302.204669299597;5323.0152421802095;5353.973230133864;4586.564276393738;5360.758765855546;5376.677399356051;5393.514583687467;5398.676079435247;4585.220512512881;5244.344456942882;5348.625596208267;5389.43045671113;5397.8380648580405;3969.3450580654157;5263.157894736823;5282.339707536558;5295.338082739658;5328.333958255218;4433.578810013044;5285.210414100477;5290.788368465257;5314.574834013309;5338.813141540067;4919.950800491985;5682.687452190128;5913.408659134096;5927.911081333784;6007.699615019275;6212.254529456449;6233.158523599347;6266.467350275232;6309.085182648536;6310.810675679737;6283.560150789446;6325.778597749057;6346.11154438379;6349.809505714836;6358.078078678565;5895.4399332063385;5943.31651860033;5994.70026498682;6040.909386359208;6042.093685947099;6332.841678958063;6339.366063393716;6359;6363.236411630634;6428.389303016206;6250.968745156245;6269.310375858652;6270.028145637433;6274.937250627527;6306.022566502108;6207.534434917399;6221.4089661482085;6305.621662700252;6317.210348706411;6329.7468101275435;6226.283977342573;6250.124982502453;6262.937370626236;6269.46709529686;6332.778352757631;6308.621482711052;6315.305316415191;6316.968415157895;6330.525210609223;6336.429721325103;4838.709677419296;4995.275685025651;5009.12340340439;5011.974940125349;5051.924221136685;4434;4448.466184057869;4465.776711164429;4477.9328310074725;4556.453225612881;5882.794102206402;5981.342052374235;5986;5991.55063370249;5997.100434934795;6209.348018458088;6260.655663938527;6283.120363149163;6290.591111577733;6294.244690637152;5901.616394934315;5949.0481522956115;5982.790602328898;5988.730507127189;6017.638941663514;5423.240746295522;5457.317835270591;5464.972675136679;5469.972650136724;5488.341399032061;6204.317525072329;6376.171097757262;6412;6424.775132870327;6430.517711171681;6218.129461875251;6228.844278893064;6243.469305109116;6248.593841400295;6295.685215739103;6428.325025872403;6437.034444833313;6441.71012304438;6447.097406363019;6458.515611329075;6259.436650701458;6299.905501417574;6300.306966233802;6306.306306306211;6343.333949935375;5099.286099945936;6168.167297414791;6206.968965155145;6221.875562488634;6288.465480434214;6216.347283535164;6222.688865556614;6224;6240.251169859646;6258.7809426671665;6223;6224.875502489835;6240.812775616557;6257.624542527463;6258.624482531062;5838.095095260242;5964.493018093337;6051.636901785907;6086.482648974887;6092.756289748538;6204.286507051746;6235.501159907287;6274.874502509833;6287.371262873676;6289.96855015722;6119.694015299128;6121.051237058263;6138.693065346625;6147.200863887666;6155.261368635793 03:08:00 INFO - PROCESS | 1658 | |1;ext.html;461.84528183058654;507.7740405519543;514.4444000479483;524.2320001198244;532.0980937311258;34032.82983585082;42244.36633450497;42266.57733422665;44361.11277774443;44433.555664443345;43073;43369;43373.91565210871;43612;43693.563064369344;9690.370125941827;9831.164351030135;9879.209663226924;9918.851217231711;9923.305368624198;9689.370190937601;9758.609655613767;9810.852837207447;9813.264005199602;9829.55766990487;9770.413775173476;9823.263255255848;9833.65582204623;9839.803203935917;9848.950755246215;8151.144129866368;8694.65232888897;9138;9469.337146399756;9818.214542836557;9804.46075465849;9846.950765246127;9883.505824708807;9892.406455612687;9900.504974751233;38918.41622375666;41248;41268.79365603183;41642.58357416448;41755.7912210437;3263.4452143135723;3488.7383446241633;3642.289753498069;3968.7023473239624;4014.9397759033636;25627.231183064538;29655.55516667252;31085.689143108506;31142;32227.033189004367;2890.40746646939;3280.901572952815;3297.208669919226;3307.4873394623874;3388.491726241059;514739;518274;520737;520784;522949;33317.66682333194;35049.123771905906;59809;60213.69893150506;60341.69829150914;35463.4680479793;35717;36166.819165904;36171.819140904656;36203.81898090545;15382.769258461132;15472.226388680521;15505.302261398265;15529.301181446635;15542.9222853885;13133;13146.4084116215;13173.670658233621;13212.471501139848;13251.204927704175;7814.6092695365005;7827.5519028979825;7829.882551761728;7894.605269736605;7898.131205567383;2856.600075989363;3242.5460435539044;3258.9837050814594;3277.131560136566;3290.1116698491273;882.188386684252;929.972100836976;1041.286718597763;1057.751428414322;1135.6593022093339;27682.307942301602;29541.40917181644;29890.10329690113;30831.8458407711;31370.372592548476;962.9711108666751;970.4759429907912;1011.1708399112804;1069.5240617925103;1076.9138468922467;15448.304826282843;16009.919950400174;16058.678826423406;16118.50163224702;16327;687619;704477;705445;706236;710396;58337.8332433349;58699.70650146722;58700.7064964681;58716.70641646764;58814;1371.766799644043;1384.8822850057657;1402.6212922510865;1404.8384435790015;1410.9717805644034;27874.860625696743;29497.85251073731;30336.69663303339;30507.084787456413;30615.54076688807;50923.745381272856;51233.743831280604;51414.74292628513;51578.48421515737;51697.48302516927;597123;601500;604655;605670;610314;26499.470010600067;26835.060772872857;26852.59721104146;26994.595081074192;27282.72717272802;46644.53355466402;47624;48231;48540;48701.512984869696;38774.61225387823;39461.605383945796;39545.01137471586;39574;40144.99637509086;38672.30452428172;38771.22457550777;39321.80339098286;39844.203115936936;40112.39831402589;38401.6159838398;38418.0395490115;39203.607963919996;39305.803470982464;40582;32666;34344.65655343414;35052.29895402129;36078.8196059018;36337.454938176474;26160.215193544223;26378.208653740418;26379.868100659372;26454.86772566125;26862.59706104449 03:08:00 INFO - PROCESS | 1658 | |2;jquery.html;331.3158328052573;365.3551481634915;367.3993021409994;374.85755412943075;379.41948818308;19924.90037549814;20555.794442055576;20634.89682551589;20941.37175884724;21207.151713931424;20607.27874524392;20845.583088338262;20906.477338066557;20961.895190524025;21218.04518796654;5443.884003779235;5565;5841.094630332305;5951.464368206861;6056.51547876171;5169.224616307546;5926.703664816763;6019.367966363535;6048.485878700294;6070;5118.360204974379;5706.600537962344;5919;5949.196858424122;5971.313298970609;5785.913211301834;5851.795187168429;5888.411158884121;5943.762249510014;5944.346121926606;5078.390593128848;5121.487851214886;5124.5131712487255;5182.896342073175;5207.0366982108435;21656.35030949074;25537.744622553724;25622.615660765103;25940.481190376275;26139.477210455876;2447.3881529617597;2463.310273123528;2572.524083044624;3052.694730526952;3081.645610754747;10318.122959548447;12442.817932296417;14933.850661493354;15184.848151518565;16511.09188994605;1928.7974762650001;1937.951551211231;1944.2028768204968;1987.3243097346826;2002.4793553676004;86521.56739216263;106994;107476.4626176872;119596.20605690921;132007.01989470166;9130.497822619687;11640.825387619192;11763.000144987773;11778.94110529459;11795.410229488663;14603.707925841423;14625.85374146245;14630.63423414402;14656.267186640838;14659;8600.42417395105;8873.73378798637;8958.417702849425;8987.146221108984;9013.549322533847;7008.299170083053;7230.385417239593;8941.687040953535;8978.86531702025;9127.224185944136;3901;4554.72467709042;4559.224931761609;4567.748773817472;4635.930461043087;1499.9925000375147;1821.4990877508526;1900.277894400119;1937.7093435984434;1938.7770406403445;816.3102178659024;834.5618550261162;849.2314455417857;889.564113584339;926.7080869526078;20335.694964575545;21265;21665.063950852164;21989.23037693673;22530.372560083437;880.216607219575;921.9032001639731;924.9445033298024;961.3078583419926;962.3985009369144;8211.794705132419;11238.38188899602;11244.26912250701;11295.152863535268;11328.490217940212;553961;555489;565155;565246;566704;116965;117944.82055179338;118035;128417;131522.34238828745;958.9376690515094;985.8324084905584;996.1582462818907;1007.8840933292619;1013.7921726046143;16283.348666053225;18681.81318186801;19299.710504342165;19341;19360.4191874244;53544;54169.72915135399;56442.43557564536;57544.84910301854;58371.70814145902;81982;86363.56818215869;86723.56638216769;87504;89145.55427223082;6957.547759395826;7186.856262874818;7502.549847009197;7816.452848300564;8386.371022173484;12356.691082723004;13186.208827470382;13258.602241932758;13273.070885037954;13343;11436.828447573127;11488.540458381905;11548.884511154782;11595.89838965297;11712.297262164297;11133.554657813596;11248.21832607353;11379.487923043318;11431.942840285745;11467.827982580435;10181.185505159718;10594.947025264824;11643.825342619699;11751.294922304689;12046.75906481883;7008.053912721717;7046.753363632249;7411.370033546993;7460.142083660231;8102.918970810452;9313.88233411995;11292.209545332076;11478.483468243781;11745.001674857733;11811 03:08:00 INFO - PROCESS | 1658 | |3;mootools.html;1325.5493132335005;1453.7092581483703;1588.2376459299535;1689.6705142497203;1762.7355896615513;8090.312323452499;8369.539675317856;8616.741497755069;9200.861987070191;9216.17054465098;8657.437266577668;8981.056989016157;9005.144511271435;9069.90930090699;9154.908450915489;2392.28231530541;2437.9634305485433;2440.2313271319476;2440.255722004788;2447.437089469423;2397.676313697646;2425.8059355251626;2428.18655750323;2444.743301953296;2450.399652085233;2384.3681424422543;2410.5781488239577;2431.3070774829175;2441.438469152096;2451.8038556915403;2399.2322456813827;2409.734929157791;2416.2871952773885;2423.6364545318165;2424.612062070069;2381.7261014983324;2391.928242152738;2412.372783076395;2415.927522174338;2426.078090325665;8977.416467929628;9019.143181397756;9076.954615226947;9099.044600317004;9121.863172052424;5273.86815329616;5400.945990540123;5439.347278326587;5440.183972404131;5447.237386765816;3105.534169874514;3493.598236202844;3597.6042635310096;3631.8184090795353;3688.5389326334207;1076.101455284838;1094.1192340166162;1097.3086955218162;1123.955041798327;1130.6381957773515;11266.09871210293;11616.88383116175;11740.765184696344;11758.000569951564;11791.882081179165;4707.105649926503;4742.380225994141;4783.808647654055;4894.608431325485;4905.092557876804;9888.555015024342;9903.752406189902;10032.69901902944;10042.849357259647;10049.949750251202;4718.3158442025715;5355.705436201047;5393.487618676219;5399.082156033405;5407.702576358338;4194.748315101104;4550.795214215368;4794.352762377104;4931.18635425158;4939.53074457926;4012.197560487914;4022.27599032177;4105.384192371168;4140.503139623204;4152.522459917088;1133.880942501042;1296.4101333893057;1297.3383574377135;1305.6866352075433;1312.5406107862173;783.565121357652;890.1410139215687;912.4251721415466;918.2286879021653;934.9158575728217;6030.758769649253;6060.090986352083;6144.139820425144;6254.20074978714;6262.530310226751;903.218715810832;923.5936188077225;934.4813628436148;937.3204426790659;961.6922584772806;3955.0507878109047;3999.960000400017;4014.558398576154;4042.838286468508;4057.1885622875543;9896.307258491981;10580.57677692899;10847;10962.397068161168;10982.176336774774;10789.40658263803;10883.891161088288;10891.237613366988;10929.726756830984;10988.615398461016;7910.446268761247;8139.918600814034;8295.129011453831;8297.211764882326;8309.04445988719;5943.821685349447;6035;6055.5458340623745;6085;6095.116208149705;10111.292209545261;10115.39307641544;10153.746156345855;10293.588256469657;10297.53661085238;10094.343867648578;10187.490625468845;10310.793784124426;10323.174146068446;10492.947535262274;6204.968975155276;7057.082579264868;7466.962665186639;7585.544867307979;7670.578118203329;8498.235158835734;8504.489730616182;8519;8536.40245182856;8553.529555874238;7498.512596681198;7693.730719424793;7694.538327700356;7786.143524212445;7832.490888092256;7409.666565004695;7496.512726672749;7520.247975202436;7630.465867389229;7784.338331241682;7079.929200707927;7135.357817796424;7222.6388680566815;7230.74692385764;7245.456590755609;4943.406791184937;4953.876153096201;5014.147594908947;5144.897102058013;5144.9742751286;4937.259411088222;5091.13450713387;5142.460041695568;5209.973950130225;5212.192110222922 03:08:00 INFO - PROCESS | 1658 | |4;prototype.html;285.05504253399977;296.1338086098163;300.15506349625804;301.458881308052;303.1149044789215;4585.335126406669;4893.2170852663585;4932.580730637896;4964.5283698048715;5316.840494785153;4784.138855006097;5193.63644544882;5263.657862238952;5415.83752487426;5489.964875816272;4162.999999999993;4182.431588154442;4186.35111557709;4195.091233488755;4205.348171033479;3444.794321987297;3694.9445758313645;3914.138889444332;4187.28816101262;4198.580141985807;3505.4566542185876;4097.8770636880945;4098.590140985907;4130.938035929464;4150.501939767217;3667.853285868562;4136.627703506699;4152.480939882515;4180.68308482827;4193.391958166064;3047.817130972149;3176.5076413156;3553.2107295772694;3566.7681600696133;3597.388443964532;4472.300525800175;4937.950620493821;5116.00475814429;5256.764660304825;5442.673439593637;4369.4319738434115;4712.104700106968;4727.66906316558;4727.7163370197895;4736.8578942631775;5146.536811686966;5231.973840130813;5634.0703783875615;5810.21562089121;5833.445822646841;3718.442233664945;3720.720945929066;3885.417187421909;3889.202713443737;3933.5083114610675;5678.971605141948;6006.8498287542725;6030;6139.2632884053755;6150.200473938359;3537.257175993019;3790.33669107905;3967.26605577969;3969.7419667722083;3979.9204015919518;3136.6549679535233;3532.894013179609;3977.363621820553;3995.7402768819934;4028.5367182774357;3930.901727456779;4667.603253723403;4712.057588482317;4728.4798672146035;4744.857654270378;5125.820596279113;5729.4843464088435;5734.913976290359;5829.300483941869;5848.590598658053;1266.7973124300252;1277.3932382118605;1314.3756715560223;1352.506335187669;1360.6666366740212;791.4143533784958;832.3299743706375;895.7402353317595;910.1308250620641;913.4747520175926;5373.704446255415;5381.7578208980685;5407.648502847303;5419.403865574784;5451.591130665137;5046.369203849519;5904.557158213065;5933.495652869468;5935.139404786281;5941.673207973603;4464.330350447394;4772.0217355442055;5067.265246539231;5368.249099546851;5429.701366424805;2195.6706494026025;2351.7177938647474;2374.45387560862;2382.3448551648435;2686.1270087221733;4132.743274427345;4747.454042785124;4776.659436875975;4967.403911530567;5161.896762064813;4369.737815731066;4422.270325396274;4455.821767129279;4651.418572678415;5049.949500505021;4611.976940115278;5085.796568137233;5088.465711100355;5112.651213455267;5186.455422180692;4457.840961350137;4663.295288732459;4666.020135771526;4739.4075740532435;5022.472640372708;4455.75493347856;4478.723563784306;4547.04477074861;4986.451490335988;4987.902661414483;4482.910341793211;4495.325701144854;5156.7421628919155;5164.797825348308;5174.663646862942;2948.7493563047383;2958.8520573970786;3432.3821712092063;3447.2933048725454;3459.238967427162;4367.820688414174;4835;4928.950710492849;4972.428170760409;5764.452377024176;4385.912281754411;5858.414158584107;5884.47003779012;5923.318818335946;5956.642601443754;5875.735591898289;5903.144044113494;5909.113632955091;5927.2954403497815;5931.347551769388;4827.565519103297;5662.065759149694;5700.914486282792;5754.827355179351;5755.280589926259;5223.649357788934;5280.412597827114;5419.701916394636;5819.447152520504;5877.500412464818;5148.562372198405;5248.606354523502;5511.5969891814275;5559.833205003856;5764.962306784819 03:08:00 INFO - PROCESS | 1658 | |5;yui.html;676.3709749932563;700.0094865764943;766.2873527619315;801.5551368990208;820.4379999700205;15227.923860380697;15314.69370612587;15533.301001454933;15656.686866262668;15686.13726245056;12079.275243485397;14257.572272831805;14383.78424323636;15403.614909627266;15855.682886342294;814.3851392198882;844.8479273730726;848.2789628815519;851.6040041380757;851.82537579796;831.4678605692332;859.0936561927165;862.6118246788939;865.5109862927458;865.8138500222451;896.9641214351451;901.062894589626;902.6344330546107;903.4488961733338;904.0055938467699;895.7357579514058;896.4442045931531;897.9685711000117;898.9865152022725;902.9277657787361;658.3416583416583;660.1582981698325;662.493192707579;663.34329014276;664.5348256220665;14781.260936953217;15201.391944322324;15221.923890380587;15227.923860380628;15230.46693365727;14330.78503822433;14562.417503299856;14990.325435355326;15157.848421515864;15192.772108418383;11794.52821887132;11916.821247681291;11955.880441195564;12041.458134383975;12098.334591597459;3824.7131465140224;3832.329342365103;3843.385058390644;3857.7492462989817;3883.49514563105;112185.87814121836;116333;116828;117655.41172294169;119353;11086.501107450184;11504.482298296596;11505.906938840797;11555.942220289013;11640.53437862476;22034.228801991852;22716.886415568148;23251.418714531934;23317.183898563468;23599;7956.920430795733;8144.918550814535;8191.426600137933;8256.876146857801;8405;4478.395416618715;4478.776061196927;4593.402857628554;4594.540545945446;4595.1728688835665;3462.1344663834043;3568.3933731265747;3589.4077477215965;3596.1549035976523;3600.1899572595958;612.4824523277823;625.3808729357903;633.7813454358239;637.7640273098983;656.6979189572754;601.3205078261624;671.6403103236203;680.5406350713348;687.4809518813364;699.1575151941897;8402.831943361098;8699.695510657224;9355.719328420158;9677.177439917545;9870.60517579303;516.3261943164207;532.6032106080994;598.7425407075;635.1615867055442;649.2732904455477;4651.209294419889;4839.249916262985;4840.00779840132;4840.927386089212;4874.610031197496;95562.52218738862;96113.51943240239;138558.30720846532;162825.18587406987;164564;110520;116475.252871207;131746;146971;148043;124634;127940.72059279287;131653.025204622;133124;133386;9207.76980575491;9217.953910230406;9289.256859451363;9310.348275620641;9467.526623668928;58184.709076454346;69907;70173.94739078816;71689.64155179191;72627;105041.47479262555;106252.46873765581;106452.46773766082;109029;109224;11154.944225278821;12118.575849845565;12206.75586488283;12356.011519078633;12489;12812.487500499876;12976.870231297566;13007.609771706864;13098.148620339647;13197.274149921846;11725.648230553097;11860.644180674593;11932.16474846787;12149.1495595311;12339.50641974311;11950;12587.622371328875;12675.873241267838;12734.235945843278;12768.170068945488;11829.940850296038;11976.041916646473;12087.9725223357;12264;12298.20061695987;10247.014721580954;10360.844587331347;10514.316569422963;10874.075703565286;11063.668089957315;8889.622108573181;10658.413787241776;10691.57233710674;10775.29960552593;10831.945840270748 03:08:00 INFO - PROCESS | 1658 | __end_tp_report 03:08:00 INFO - PROCESS | 1658 | __start_cc_report 03:08:00 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,360 03:08:00 INFO - PROCESS | 1658 | __end_cc_report 03:08:00 INFO - PROCESS | 1658 | __startTimestamp1476180480650__endTimestamp 03:08:00 INFO - PROCESS | 1658 | 03:08:00 INFO - PROCESS | 1658 | ------- Summary: start ------- 03:08:00 INFO - PROCESS | 1658 | Number of tests: 6 03:08:00 INFO - PROCESS | 1658 | 03:08:00 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5802.03 Median:6121.05 stddev:700.40 (11.4%) stddev-sans-first:677.17 03:08:00 INFO - PROCESS | 1658 | Values: 3420.7 3422.6 3452.9 3453.3 3461.7 4231.5 5135.9 5287.2 5851.6 5864.4 5839.6 5840.5 5909.5 5925.0 5952.3 4464.8 5297.3 5302.2 5323.0 5354.0 4586.6 5360.8 5376.7 5393.5 5398.7 4585.2 5244.3 5348.6 5389.4 5397.8 3969.3 5263.2 5282.3 5295.3 5328.3 4433.6 5285.2 5290.8 5314.6 5338.8 4920.0 5682.7 5913.4 5927.9 6007.7 6212.3 6233.2 6266.5 6309.1 6310.8 6283.6 6325.8 6346.1 6349.8 6358.1 5895.4 5943.3 5994.7 6040.9 6042.1 6332.8 6339.4 6359.0 6363.2 6428.4 6251.0 6269.3 6270.0 6274.9 6306.0 6207.5 6221.4 6305.6 6317.2 6329.7 6226.3 6250.1 6262.9 6269.5 6332.8 6308.6 6315.3 6317.0 6330.5 6336.4 4838.7 4995.3 5009.1 5012.0 5051.9 4434.0 4448.5 4465.8 4477.9 4556.5 5882.8 5981.3 5986.0 5991.6 5997.1 6209.3 6260.7 6283.1 6290.6 6294.2 5901.6 5949.0 5982.8 5988.7 6017.6 5423.2 5457.3 5465.0 5470.0 5488.3 6204.3 6376.2 6412.0 6424.8 6430.5 6218.1 6228.8 6243.5 6248.6 6295.7 6428.3 6437.0 6441.7 6447.1 6458.5 6259.4 6299.9 6300.3 6306.3 6343.3 5099.3 6168.2 6207.0 6221.9 6288.5 6216.3 6222.7 6224.0 6240.3 6258.8 6223.0 6224.9 6240.8 6257.6 6258.6 5838.1 5964.5 6051.6 6086.5 6092.8 6204.3 6235.5 6274.9 6287.4 6290.0 6119.7 6121.1 6138.7 6147.2 6155.3 03:08:00 INFO - PROCESS | 1658 | 03:08:00 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:72401.55 Median:39978.30 stddev:164493.76 (411.5%) stddev-sans-first:164866.52 03:08:00 INFO - PROCESS | 1658 | Values: 461.8 507.8 514.4 524.2 532.1 34032.8 42244.4 42266.6 44361.1 44433.6 43073.0 43369.0 43373.9 43612.0 43693.6 9690.4 9831.2 9879.2 9918.9 9923.3 9689.4 9758.6 9810.9 9813.3 9829.6 9770.4 9823.3 9833.7 9839.8 9849.0 8151.1 8694.7 9138.0 9469.3 9818.2 9804.5 9847.0 9883.5 9892.4 9900.5 38918.4 41248.0 41268.8 41642.6 41755.8 3263.4 3488.7 3642.3 3968.7 4014.9 25627.2 29655.6 31085.7 31142.0 32227.0 2890.4 3280.9 3297.2 3307.5 3388.5 514739.0 518274.0 520737.0 520784.0 522949.0 33317.7 35049.1 59809.0 60213.7 60341.7 35463.5 35717.0 36166.8 36171.8 36203.8 15382.8 15472.2 15505.3 15529.3 15542.9 13133.0 13146.4 13173.7 13212.5 13251.2 7814.6 7827.6 7829.9 7894.6 7898.1 2856.6 3242.5 3259.0 3277.1 3290.1 882.2 930.0 1041.3 1057.8 1135.7 27682.3 29541.4 29890.1 30831.8 31370.4 963.0 970.5 1011.2 1069.5 1076.9 15448.3 16009.9 16058.7 16118.5 16327.0 687619.0 704477.0 705445.0 706236.0 710396.0 58337.8 58699.7 58700.7 58716.7 58814.0 1371.8 1384.9 1402.6 1404.8 1411.0 27874.9 29497.9 30336.7 30507.1 30615.5 50923.7 51233.7 51414.7 51578.5 51697.5 597123.0 601500.0 604655.0 605670.0 610314.0 26499.5 26835.1 26852.6 26994.6 27282.7 46644.5 47624.0 48231.0 48540.0 48701.5 38774.6 39461.6 39545.0 39574.0 40145.0 38672.3 38771.2 39321.8 39844.2 40112.4 38401.6 38418.0 39203.6 39305.8 40582.0 32666.0 34344.7 35052.3 36078.8 36337.5 26160.2 26378.2 26379.9 26454.9 26862.6 03:08:00 INFO - PROCESS | 1658 | 03:08:00 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:34077.54 Median:14596.09 stddev:93877.13 (643.2%) stddev-sans-first:94106.29 03:08:00 INFO - PROCESS | 1658 | Values: 331.3 365.4 367.4 374.9 379.4 19924.9 20555.8 20634.9 20941.4 21207.2 20607.3 20845.6 20906.5 20961.9 21218.0 5443.9 5565.0 5841.1 5951.5 6056.5 5169.2 5926.7 6019.4 6048.5 6070.0 5118.4 5706.6 5919.0 5949.2 5971.3 5785.9 5851.8 5888.4 5943.8 5944.3 5078.4 5121.5 5124.5 5182.9 5207.0 21656.4 25537.7 25622.6 25940.5 26139.5 2447.4 2463.3 2572.5 3052.7 3081.6 10318.1 12442.8 14933.9 15184.8 16511.1 1928.8 1938.0 1944.2 1987.3 2002.5 86521.6 106994.0 107476.5 119596.2 132007.0 9130.5 11640.8 11763.0 11778.9 11795.4 14603.7 14625.9 14630.6 14656.3 14659.0 8600.4 8873.7 8958.4 8987.1 9013.5 7008.3 7230.4 8941.7 8978.9 9127.2 3901.0 4554.7 4559.2 4567.7 4635.9 1500.0 1821.5 1900.3 1937.7 1938.8 816.3 834.6 849.2 889.6 926.7 20335.7 21265.0 21665.1 21989.2 22530.4 880.2 921.9 924.9 961.3 962.4 8211.8 11238.4 11244.3 11295.2 11328.5 553961.0 555489.0 565155.0 565246.0 566704.0 116965.0 117944.8 118035.0 128417.0 131522.3 958.9 985.8 996.2 1007.9 1013.8 16283.3 18681.8 19299.7 19341.0 19360.4 53544.0 54169.7 56442.4 57544.8 58371.7 81982.0 86363.6 86723.6 87504.0 89145.6 6957.5 7186.9 7502.5 7816.5 8386.4 12356.7 13186.2 13258.6 13273.1 13343.0 11436.8 11488.5 11548.9 11595.9 11712.3 11133.6 11248.2 11379.5 11431.9 11467.8 10181.2 10594.9 11643.8 11751.3 12046.8 7008.1 7046.8 7411.4 7460.1 8102.9 9313.9 11292.2 11478.5 11745.0 11811.0 03:08:00 INFO - PROCESS | 1658 | 03:08:00 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5797.23 Median:4918.14 stddev:3237.11 (65.8%) stddev-sans-first:3228.74 03:08:00 INFO - PROCESS | 1658 | Values: 1325.5 1453.7 1588.2 1689.7 1762.7 8090.3 8369.5 8616.7 9200.9 9216.2 8657.4 8981.1 9005.1 9069.9 9154.9 2392.3 2438.0 2440.2 2440.3 2447.4 2397.7 2425.8 2428.2 2444.7 2450.4 2384.4 2410.6 2431.3 2441.4 2451.8 2399.2 2409.7 2416.3 2423.6 2424.6 2381.7 2391.9 2412.4 2415.9 2426.1 8977.4 9019.1 9077.0 9099.0 9121.9 5273.9 5400.9 5439.3 5440.2 5447.2 3105.5 3493.6 3597.6 3631.8 3688.5 1076.1 1094.1 1097.3 1124.0 1130.6 11266.1 11616.9 11740.8 11758.0 11791.9 4707.1 4742.4 4783.8 4894.6 4905.1 9888.6 9903.8 10032.7 10042.8 10049.9 4718.3 5355.7 5393.5 5399.1 5407.7 4194.7 4550.8 4794.4 4931.2 4939.5 4012.2 4022.3 4105.4 4140.5 4152.5 1133.9 1296.4 1297.3 1305.7 1312.5 783.6 890.1 912.4 918.2 934.9 6030.8 6060.1 6144.1 6254.2 6262.5 903.2 923.6 934.5 937.3 961.7 3955.1 4000.0 4014.6 4042.8 4057.2 9896.3 10580.6 10847.0 10962.4 10982.2 10789.4 10883.9 10891.2 10929.7 10988.6 7910.4 8139.9 8295.1 8297.2 8309.0 5943.8 6035.0 6055.5 6085.0 6095.1 10111.3 10115.4 10153.7 10293.6 10297.5 10094.3 10187.5 10310.8 10323.2 10492.9 6205.0 7057.1 7467.0 7585.5 7670.6 8498.2 8504.5 8519.0 8536.4 8553.5 7498.5 7693.7 7694.5 7786.1 7832.5 7409.7 7496.5 7520.2 7630.5 7784.3 7079.9 7135.4 7222.6 7230.7 7245.5 4943.4 4953.9 5014.1 5144.9 5145.0 4937.3 5091.1 5142.5 5210.0 5212.2 03:08:00 INFO - PROCESS | 1658 | 03:08:00 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4403.10 Median:4759.74 stddev:1379.86 (29.0%) stddev-sans-first:1348.67 03:08:00 INFO - PROCESS | 1658 | Values: 285.1 296.1 300.2 301.5 303.1 4585.3 4893.2 4932.6 4964.5 5316.8 4784.1 5193.6 5263.7 5415.8 5490.0 4163.0 4182.4 4186.4 4195.1 4205.3 3444.8 3694.9 3914.1 4187.3 4198.6 3505.5 4097.9 4098.6 4130.9 4150.5 3667.9 4136.6 4152.5 4180.7 4193.4 3047.8 3176.5 3553.2 3566.8 3597.4 4472.3 4938.0 5116.0 5256.8 5442.7 4369.4 4712.1 4727.7 4727.7 4736.9 5146.5 5232.0 5634.1 5810.2 5833.4 3718.4 3720.7 3885.4 3889.2 3933.5 5679.0 6006.8 6030.0 6139.3 6150.2 3537.3 3790.3 3967.3 3969.7 3979.9 3136.7 3532.9 3977.4 3995.7 4028.5 3930.9 4667.6 4712.1 4728.5 4744.9 5125.8 5729.5 5734.9 5829.3 5848.6 1266.8 1277.4 1314.4 1352.5 1360.7 791.4 832.3 895.7 910.1 913.5 5373.7 5381.8 5407.6 5419.4 5451.6 5046.4 5904.6 5933.5 5935.1 5941.7 4464.3 4772.0 5067.3 5368.2 5429.7 2195.7 2351.7 2374.5 2382.3 2686.1 4132.7 4747.5 4776.7 4967.4 5161.9 4369.7 4422.3 4455.8 4651.4 5049.9 4612.0 5085.8 5088.5 5112.7 5186.5 4457.8 4663.3 4666.0 4739.4 5022.5 4455.8 4478.7 4547.0 4986.5 4987.9 4482.9 4495.3 5156.7 5164.8 5174.7 2948.7 2958.9 3432.4 3447.3 3459.2 4367.8 4835.0 4929.0 4972.4 5764.5 4385.9 5858.4 5884.5 5923.3 5956.6 5875.7 5903.1 5909.1 5927.3 5931.3 4827.6 5662.1 5700.9 5754.8 5755.3 5223.6 5280.4 5419.7 5819.4 5877.5 5148.6 5248.6 5511.6 5559.8 5765.0 03:08:00 INFO - PROCESS | 1658 | 03:08:00 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:25662.10 Median:23458.09 stddev:41478.86 (176.8%) stddev-sans-first:41552.79 03:08:00 INFO - PROCESS | 1658 | Values: 676.4 700.0 766.3 801.6 820.4 15227.9 15314.7 15533.3 15656.7 15686.1 12079.3 14257.6 14383.8 15403.6 15855.7 814.4 844.8 848.3 851.6 851.8 831.5 859.1 862.6 865.5 865.8 897.0 901.1 902.6 903.4 904.0 895.7 896.4 898.0 899.0 902.9 658.3 660.2 662.5 663.3 664.5 14781.3 15201.4 15221.9 15227.9 15230.5 14330.8 14562.4 14990.3 15157.8 15192.8 11794.5 11916.8 11955.9 12041.5 12098.3 3824.7 3832.3 3843.4 3857.7 3883.5 112185.9 116333.0 116828.0 117655.4 119353.0 11086.5 11504.5 11505.9 11555.9 11640.5 22034.2 22716.9 23251.4 23317.2 23599.0 7956.9 8144.9 8191.4 8256.9 8405.0 4478.4 4478.8 4593.4 4594.5 4595.2 3462.1 3568.4 3589.4 3596.2 3600.2 612.5 625.4 633.8 637.8 656.7 601.3 671.6 680.5 687.5 699.2 8402.8 8699.7 9355.7 9677.2 9870.6 516.3 532.6 598.7 635.2 649.3 4651.2 4839.2 4840.0 4840.9 4874.6 95562.5 96113.5 138558.3 162825.2 164564.0 110520.0 116475.3 131746.0 146971.0 148043.0 124634.0 127940.7 131653.0 133124.0 133386.0 9207.8 9218.0 9289.3 9310.3 9467.5 58184.7 69907.0 70173.9 71689.6 72627.0 105041.5 106252.5 106452.5 109029.0 109224.0 11154.9 12118.6 12206.8 12356.0 12489.0 12812.5 12976.9 13007.6 13098.1 13197.3 11725.6 11860.6 11932.2 12149.1 12339.5 11950.0 12587.6 12675.9 12734.2 12768.2 11829.9 11976.0 12088.0 12264.0 12298.2 10247.0 10360.8 10514.3 10874.1 11063.7 8889.6 10658.4 10691.6 10775.3 10831.9 03:08:00 INFO - PROCESS | 1658 | -------- Summary: end -------- 03:08:00 INFO - PROCESS | 1658 | 03:08:01 INFO - TEST-INFO | 1658: exit 0 03:08:01 INFO - TEST-OK | dromaeo_css | took 1113173ms 03:08:01 INFO - TEST-START | kraken 03:08:01 INFO - operating with platform_type : mac_ 03:08:01 INFO - Initialising browser for kraken test... 03:08:01 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpQ2TFEO/profile http://localhost:49275/getInfo.html) 03:08:04 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 03:08:04 INFO - PROCESS | 1667 | colorDepth:24 03:08:04 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 03:08:04 INFO - PROCESS | 1667 | __metrics 03:08:04 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:08:04 INFO - TEST-INFO | 1667: exit 0 03:08:04 INFO - Browser initialized. 03:08:04 INFO - Running cycle 1/1 for kraken test... 03:08:04 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpQ2TFEO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:16 INFO - PROCESS | 1670 | RSS: Main: 225361920 03:08:16 INFO - PROCESS | 1670 | 03:08:19 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 03:08:20 INFO - PROCESS | 1670 | RSS: Main: 237690880 03:08:20 INFO - PROCESS | 1670 | 03:08:22 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 03:08:23 INFO - PROCESS | 1670 | RSS: Main: 245202944 03:08:23 INFO - PROCESS | 1670 | 03:08:26 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 03:08:27 INFO - PROCESS | 1670 | RSS: Main: 249057280 03:08:27 INFO - PROCESS | 1670 | 03:08:29 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 03:08:29 INFO - PROCESS | 1670 | RSS: Main: 250277888 03:08:29 INFO - PROCESS | 1670 | 03:08:31 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:08:32 INFO - PROCESS | 1670 | RSS: Main: 250474496 03:08:32 INFO - PROCESS | 1670 | 03:08:35 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 03:08:35 INFO - PROCESS | 1670 | RSS: Main: 250679296 03:08:35 INFO - PROCESS | 1670 | 03:08:39 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 03:08:39 INFO - PROCESS | 1670 | RSS: Main: 250560512 03:08:39 INFO - PROCESS | 1670 | 03:08:43 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 03:08:43 INFO - PROCESS | 1670 | RSS: Main: 251117568 03:08:43 INFO - PROCESS | 1670 | 03:08:45 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:08:45 INFO - PROCESS | 1670 | RSS: Main: 250757120 03:08:45 INFO - PROCESS | 1670 | 03:08:47 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:08:48 INFO - PROCESS | 1670 | RSS: Main: 250785792 03:08:48 INFO - PROCESS | 1670 | 03:08:50 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:08:51 INFO - PROCESS | 1670 | RSS: Main: 250777600 03:08:51 INFO - PROCESS | 1670 | 03:08:54 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:08:55 INFO - PROCESS | 1670 | RSS: Main: 251109376 03:08:55 INFO - PROCESS | 1670 | 03:08:57 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:08:58 INFO - PROCESS | 1670 | RSS: Main: 251269120 03:08:58 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 03:09:00 INFO - PROCESS | 1670 | RSS: Main: 252956672 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | __start_tp_report 03:09:00 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 03:09:00 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 03:09:00 INFO - PROCESS | 1670 | |i|pagename|runs| 03:09:00 INFO - PROCESS | 1670 | |0;ai-astar;106;119;118;118;119;117;117;120;119;118 03:09:00 INFO - PROCESS | 1670 | |1;audio-beat-detection;139;111;112;145;110;114;112;113;137;111 03:09:00 INFO - PROCESS | 1670 | |2;audio-dft;196;197;201;197;240;271;202;197;196;194 03:09:00 INFO - PROCESS | 1670 | |3;audio-fft;82;58;58;86;64;60;59;58;78;58 03:09:00 INFO - PROCESS | 1670 | |4;audio-oscillator;88;71;87;74;68;69;89;69;72;87 03:09:00 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;90;102;91;112;109;86;112;87;90;86 03:09:00 INFO - PROCESS | 1670 | |6;imaging-darkroom;132;140;168;168;100;100;153;102;115;168 03:09:00 INFO - PROCESS | 1670 | |7;imaging-desaturate;141;106;143;149;89;83;94;112;143;146 03:09:00 INFO - PROCESS | 1670 | |8;json-parse-financial;56;56;55;56;58;59;59;60;60;59 03:09:00 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;67;67;83;75;72;68;67;70;69;70 03:09:00 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;83;87;83;87;101;107;104;83;86;94 03:09:00 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;136;143;154;128;157;157;166;162;200;163 03:09:00 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;173;166;163;170;168;167;169;169;228;180 03:09:00 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;69;66;67;66;70;66;69;68;76;87 03:09:00 INFO - PROCESS | 1670 | __end_tp_report 03:09:00 INFO - PROCESS | 1670 | __start_cc_report 03:09:00 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,954 03:09:00 INFO - PROCESS | 1670 | __end_cc_report 03:09:00 INFO - PROCESS | 1670 | __startTimestamp1476180540534__endTimestamp 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | ------- Summary: start ------- 03:09:00 INFO - PROCESS | 1670 | Number of tests: 14 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:117.10 Median:118.50 stddev:4.01 (3.4%) stddev-sans-first:1.00 03:09:00 INFO - PROCESS | 1670 | Values: 106.0 119.0 118.0 118.0 119.0 117.0 117.0 120.0 119.0 118.0 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:120.40 Median:113.50 stddev:13.94 (12.3%) stddev-sans-first:13.06 03:09:00 INFO - PROCESS | 1670 | Values: 139.0 111.0 112.0 145.0 110.0 114.0 112.0 113.0 137.0 111.0 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:209.10 Median:199.00 stddev:25.63 (12.9%) stddev-sans-first:26.74 03:09:00 INFO - PROCESS | 1670 | Values: 196.0 197.0 201.0 197.0 240.0 271.0 202.0 197.0 196.0 194.0 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:66.10 Median:62.00 stddev:11.28 (18.2%) stddev-sans-first:10.39 03:09:00 INFO - PROCESS | 1670 | Values: 82.0 58.0 58.0 86.0 64.0 60.0 59.0 58.0 78.0 58.0 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:80.50 stddev:9.08 (11.3%) stddev-sans-first:8.79 03:09:00 INFO - PROCESS | 1670 | Values: 88.0 71.0 87.0 74.0 68.0 69.0 89.0 69.0 72.0 87.0 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:96.50 Median:86.50 stddev:11.02 (12.7%) stddev-sans-first:11.43 03:09:00 INFO - PROCESS | 1670 | Values: 90.0 102.0 91.0 112.0 109.0 86.0 112.0 87.0 90.0 86.0 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:134.60 Median:146.50 stddev:28.99 (19.8%) stddev-sans-first:30.73 03:09:00 INFO - PROCESS | 1670 | Values: 132.0 140.0 168.0 168.0 100.0 100.0 153.0 102.0 115.0 168.0 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:120.60 Median:147.50 stddev:26.41 (17.9%) stddev-sans-first:26.96 03:09:00 INFO - PROCESS | 1670 | Values: 141.0 106.0 143.0 149.0 89.0 83.0 94.0 112.0 143.0 146.0 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:59.00 stddev:1.87 (3.2%) stddev-sans-first:1.87 03:09:00 INFO - PROCESS | 1670 | Values: 56.0 56.0 55.0 56.0 58.0 59.0 59.0 60.0 60.0 59.0 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:70.00 stddev:4.98 (7.1%) stddev-sans-first:5.09 03:09:00 INFO - PROCESS | 1670 | Values: 67.0 67.0 83.0 75.0 72.0 68.0 67.0 70.0 69.0 70.0 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:84.50 stddev:9.31 (11.0%) stddev-sans-first:9.36 03:09:00 INFO - PROCESS | 1670 | Values: 83.0 87.0 83.0 87.0 101.0 107.0 104.0 83.0 86.0 94.0 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:156.60 Median:159.50 stddev:19.65 (12.3%) stddev-sans-first:19.38 03:09:00 INFO - PROCESS | 1670 | Values: 136.0 143.0 154.0 128.0 157.0 157.0 166.0 162.0 200.0 163.0 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:169.50 stddev:19.07 (11.2%) stddev-sans-first:20.21 03:09:00 INFO - PROCESS | 1670 | Values: 173.0 166.0 163.0 170.0 168.0 167.0 169.0 169.0 228.0 180.0 03:09:00 INFO - PROCESS | 1670 | 03:09:00 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:69.00 stddev:6.55 (9.5%) stddev-sans-first:6.93 03:09:00 INFO - PROCESS | 1670 | Values: 69.0 66.0 67.0 66.0 70.0 66.0 69.0 68.0 76.0 87.0 03:09:00 INFO - PROCESS | 1670 | -------- Summary: end -------- 03:09:00 INFO - PROCESS | 1670 | 03:09:01 INFO - TEST-INFO | 1670: exit 0 03:09:01 INFO - TEST-OK | kraken | took 60164ms 03:09:01 INFO - SUITE-END | took 1173s 03:09:01 INFO - Completed test suite (00:19:33) 03:09:01 INFO - javascript benchmark 03:09:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7303.746558342426, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3420.7263418926473, 3422.589289285286, 3452.94685121038, 3453.309338132371, 3461.7403694722893, 4231.534531201573, 5135.922961155581, 5287.206918962158, 5851.648901065933, 5864.413558644133, 5839.5620328475425, 5840.53275737941, 5909.497692696126, 5925.0, 5952.28572571291, 4464.754438505881, 5297.337832770903, 5302.204669299597, 5323.0152421802095, 5353.973230133864, 4586.564276393738, 5360.758765855546, 5376.677399356051, 5393.514583687467, 5398.676079435247, 4585.220512512881, 5244.344456942882, 5348.625596208267, 5389.43045671113, 5397.8380648580405, 3969.3450580654157, 5263.157894736823, 5282.339707536558, 5295.338082739658, 5328.333958255218, 4433.578810013044, 5285.210414100477, 5290.788368465257, 5314.574834013309, 5338.813141540067, 4919.950800491985, 5682.687452190128, 5913.408659134096, 5927.911081333784, 6007.699615019275, 6212.254529456449, 6233.158523599347, 6266.467350275232, 6309.085182648536, 6310.810675679737, 6283.560150789446, 6325.778597749057, 6346.11154438379, 6349.809505714836, 6358.078078678565, 5895.4399332063385, 5943.31651860033, 5994.70026498682, 6040.909386359208, 6042.093685947099, 6332.841678958063, 6339.366063393716, 6359.0, 6363.236411630634, 6428.389303016206, 6250.968745156245, 6269.310375858652, 6270.028145637433, 6274.937250627527, 6306.022566502108, 6207.534434917399, 6221.4089661482085, 6305.621662700252, 6317.210348706411, 6329.7468101275435, 6226.283977342573, 6250.124982502453, 6262.937370626236, 6269.46709529686, 6332.778352757631, 6308.621482711052, 6315.305316415191, 6316.968415157895, 6330.525210609223, 6336.429721325103, 4838.709677419296, 4995.275685025651, 5009.12340340439, 5011.974940125349, 5051.924221136685, 4434.0, 4448.466184057869, 4465.776711164429, 4477.9328310074725, 4556.453225612881, 5882.794102206402, 5981.342052374235, 5986.0, 5991.55063370249, 5997.100434934795, 6209.348018458088, 6260.655663938527, 6283.120363149163, 6290.591111577733, 6294.244690637152, 5901.616394934315, 5949.0481522956115, 5982.790602328898, 5988.730507127189, 6017.638941663514, 5423.240746295522, 5457.317835270591, 5464.972675136679, 5469.972650136724, 5488.341399032061, 6204.317525072329, 6376.171097757262, 6412.0, 6424.775132870327, 6430.517711171681, 6218.129461875251, 6228.844278893064, 6243.469305109116, 6248.593841400295, 6295.685215739103, 6428.325025872403, 6437.034444833313, 6441.71012304438, 6447.097406363019, 6458.515611329075, 6259.436650701458, 6299.905501417574, 6300.306966233802, 6306.306306306211, 6343.333949935375, 5099.286099945936, 6168.167297414791, 6206.968965155145, 6221.875562488634, 6288.465480434214, 6216.347283535164, 6222.688865556614, 6224.0, 6240.251169859646, 6258.7809426671665, 6223.0, 6224.875502489835, 6240.812775616557, 6257.624542527463, 6258.624482531062, 5838.095095260242, 5964.493018093337, 6051.636901785907, 6086.482648974887, 6092.756289748538, 6204.286507051746, 6235.501159907287, 6274.874502509833, 6287.371262873676, 6289.96855015722, 6119.694015299128, 6121.051237058263, 6138.693065346625, 6147.200863887666, 6155.261368635793], "value": 5757.308842919854, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.84528183058654, 507.7740405519543, 514.4444000479483, 524.2320001198244, 532.0980937311258, 34032.82983585082, 42244.36633450497, 42266.57733422665, 44361.11277774443, 44433.555664443345, 43073.0, 43369.0, 43373.91565210871, 43612.0, 43693.563064369344, 9690.370125941827, 9831.164351030135, 9879.209663226924, 9918.851217231711, 9923.305368624198, 9689.370190937601, 9758.609655613767, 9810.852837207447, 9813.264005199602, 9829.55766990487, 9770.413775173476, 9823.263255255848, 9833.65582204623, 9839.803203935917, 9848.950755246215, 8151.144129866368, 8694.65232888897, 9138.0, 9469.337146399756, 9818.214542836557, 9804.46075465849, 9846.950765246127, 9883.505824708807, 9892.406455612687, 9900.504974751233, 38918.41622375666, 41248.0, 41268.79365603183, 41642.58357416448, 41755.7912210437, 3263.4452143135723, 3488.7383446241633, 3642.289753498069, 3968.7023473239624, 4014.9397759033636, 25627.231183064538, 29655.55516667252, 31085.689143108506, 31142.0, 32227.033189004367, 2890.40746646939, 3280.901572952815, 3297.208669919226, 3307.4873394623874, 3388.491726241059, 514739.0, 518274.0, 520737.0, 520784.0, 522949.0, 33317.66682333194, 35049.123771905906, 59809.0, 60213.69893150506, 60341.69829150914, 35463.4680479793, 35717.0, 36166.819165904, 36171.819140904656, 36203.81898090545, 15382.769258461132, 15472.226388680521, 15505.302261398265, 15529.301181446635, 15542.9222853885, 13133.0, 13146.4084116215, 13173.670658233621, 13212.471501139848, 13251.204927704175, 7814.6092695365005, 7827.5519028979825, 7829.882551761728, 7894.605269736605, 7898.131205567383, 2856.600075989363, 3242.5460435539044, 3258.9837050814594, 3277.131560136566, 3290.1116698491273, 882.188386684252, 929.972100836976, 1041.286718597763, 1057.751428414322, 1135.6593022093339, 27682.307942301602, 29541.40917181644, 29890.10329690113, 30831.8458407711, 31370.372592548476, 962.9711108666751, 970.4759429907912, 1011.1708399112804, 1069.5240617925103, 1076.9138468922467, 15448.304826282843, 16009.919950400174, 16058.678826423406, 16118.50163224702, 16327.0, 687619.0, 704477.0, 705445.0, 706236.0, 710396.0, 58337.8332433349, 58699.70650146722, 58700.7064964681, 58716.70641646764, 58814.0, 1371.766799644043, 1384.8822850057657, 1402.6212922510865, 1404.8384435790015, 1410.9717805644034, 27874.860625696743, 29497.85251073731, 30336.69663303339, 30507.084787456413, 30615.54076688807, 50923.745381272856, 51233.743831280604, 51414.74292628513, 51578.48421515737, 51697.48302516927, 597123.0, 601500.0, 604655.0, 605670.0, 610314.0, 26499.470010600067, 26835.060772872857, 26852.59721104146, 26994.595081074192, 27282.72717272802, 46644.53355466402, 47624.0, 48231.0, 48540.0, 48701.512984869696, 38774.61225387823, 39461.605383945796, 39545.01137471586, 39574.0, 40144.99637509086, 38672.30452428172, 38771.22457550777, 39321.80339098286, 39844.203115936936, 40112.39831402589, 38401.6159838398, 38418.0395490115, 39203.607963919996, 39305.803470982464, 40582.0, 32666.0, 34344.65655343414, 35052.29895402129, 36078.8196059018, 36337.454938176474, 26160.215193544223, 26378.208653740418, 26379.868100659372, 26454.86772566125, 26862.59706104449], "value": 18965.20728667459, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.3158328052573, 365.3551481634915, 367.3993021409994, 374.85755412943075, 379.41948818308, 19924.90037549814, 20555.794442055576, 20634.89682551589, 20941.37175884724, 21207.151713931424, 20607.27874524392, 20845.583088338262, 20906.477338066557, 20961.895190524025, 21218.04518796654, 5443.884003779235, 5565.0, 5841.094630332305, 5951.464368206861, 6056.51547876171, 5169.224616307546, 5926.703664816763, 6019.367966363535, 6048.485878700294, 6070.0, 5118.360204974379, 5706.600537962344, 5919.0, 5949.196858424122, 5971.313298970609, 5785.913211301834, 5851.795187168429, 5888.411158884121, 5943.762249510014, 5944.346121926606, 5078.390593128848, 5121.487851214886, 5124.5131712487255, 5182.896342073175, 5207.0366982108435, 21656.35030949074, 25537.744622553724, 25622.615660765103, 25940.481190376275, 26139.477210455876, 2447.3881529617597, 2463.310273123528, 2572.524083044624, 3052.694730526952, 3081.645610754747, 10318.122959548447, 12442.817932296417, 14933.850661493354, 15184.848151518565, 16511.09188994605, 1928.7974762650001, 1937.951551211231, 1944.2028768204968, 1987.3243097346826, 2002.4793553676004, 86521.56739216263, 106994.0, 107476.4626176872, 119596.20605690921, 132007.01989470166, 9130.497822619687, 11640.825387619192, 11763.000144987773, 11778.94110529459, 11795.410229488663, 14603.707925841423, 14625.85374146245, 14630.63423414402, 14656.267186640838, 14659.0, 8600.42417395105, 8873.73378798637, 8958.417702849425, 8987.146221108984, 9013.549322533847, 7008.299170083053, 7230.385417239593, 8941.687040953535, 8978.86531702025, 9127.224185944136, 3901.0, 4554.72467709042, 4559.224931761609, 4567.748773817472, 4635.930461043087, 1499.9925000375147, 1821.4990877508526, 1900.277894400119, 1937.7093435984434, 1938.7770406403445, 816.3102178659024, 834.5618550261162, 849.2314455417857, 889.564113584339, 926.7080869526078, 20335.694964575545, 21265.0, 21665.063950852164, 21989.23037693673, 22530.372560083437, 880.216607219575, 921.9032001639731, 924.9445033298024, 961.3078583419926, 962.3985009369144, 8211.794705132419, 11238.38188899602, 11244.26912250701, 11295.152863535268, 11328.490217940212, 553961.0, 555489.0, 565155.0, 565246.0, 566704.0, 116965.0, 117944.82055179338, 118035.0, 128417.0, 131522.34238828745, 958.9376690515094, 985.8324084905584, 996.1582462818907, 1007.8840933292619, 1013.7921726046143, 16283.348666053225, 18681.81318186801, 19299.710504342165, 19341.0, 19360.4191874244, 53544.0, 54169.72915135399, 56442.43557564536, 57544.84910301854, 58371.70814145902, 81982.0, 86363.56818215869, 86723.56638216769, 87504.0, 89145.55427223082, 6957.547759395826, 7186.856262874818, 7502.549847009197, 7816.452848300564, 8386.371022173484, 12356.691082723004, 13186.208827470382, 13258.602241932758, 13273.070885037954, 13343.0, 11436.828447573127, 11488.540458381905, 11548.884511154782, 11595.89838965297, 11712.297262164297, 11133.554657813596, 11248.21832607353, 11379.487923043318, 11431.942840285745, 11467.827982580435, 10181.185505159718, 10594.947025264824, 11643.825342619699, 11751.294922304689, 12046.75906481883, 7008.053912721717, 7046.753363632249, 7411.370033546993, 7460.142083660231, 8102.918970810452, 9313.88233411995, 11292.209545332076, 11478.483468243781, 11745.001674857733, 11811.0], "value": 9623.475045968173, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.5493132335005, 1453.7092581483703, 1588.2376459299535, 1689.6705142497203, 1762.7355896615513, 8090.312323452499, 8369.539675317856, 8616.741497755069, 9200.861987070191, 9216.17054465098, 8657.437266577668, 8981.056989016157, 9005.144511271435, 9069.90930090699, 9154.908450915489, 2392.28231530541, 2437.9634305485433, 2440.2313271319476, 2440.255722004788, 2447.437089469423, 2397.676313697646, 2425.8059355251626, 2428.18655750323, 2444.743301953296, 2450.399652085233, 2384.3681424422543, 2410.5781488239577, 2431.3070774829175, 2441.438469152096, 2451.8038556915403, 2399.2322456813827, 2409.734929157791, 2416.2871952773885, 2423.6364545318165, 2424.612062070069, 2381.7261014983324, 2391.928242152738, 2412.372783076395, 2415.927522174338, 2426.078090325665, 8977.416467929628, 9019.143181397756, 9076.954615226947, 9099.044600317004, 9121.863172052424, 5273.86815329616, 5400.945990540123, 5439.347278326587, 5440.183972404131, 5447.237386765816, 3105.534169874514, 3493.598236202844, 3597.6042635310096, 3631.8184090795353, 3688.5389326334207, 1076.101455284838, 1094.1192340166162, 1097.3086955218162, 1123.955041798327, 1130.6381957773515, 11266.09871210293, 11616.88383116175, 11740.765184696344, 11758.000569951564, 11791.882081179165, 4707.105649926503, 4742.380225994141, 4783.808647654055, 4894.608431325485, 4905.092557876804, 9888.555015024342, 9903.752406189902, 10032.69901902944, 10042.849357259647, 10049.949750251202, 4718.3158442025715, 5355.705436201047, 5393.487618676219, 5399.082156033405, 5407.702576358338, 4194.748315101104, 4550.795214215368, 4794.352762377104, 4931.18635425158, 4939.53074457926, 4012.197560487914, 4022.27599032177, 4105.384192371168, 4140.503139623204, 4152.522459917088, 1133.880942501042, 1296.4101333893057, 1297.3383574377135, 1305.6866352075433, 1312.5406107862173, 783.565121357652, 890.1410139215687, 912.4251721415466, 918.2286879021653, 934.9158575728217, 6030.758769649253, 6060.090986352083, 6144.139820425144, 6254.20074978714, 6262.530310226751, 903.218715810832, 923.5936188077225, 934.4813628436148, 937.3204426790659, 961.6922584772806, 3955.0507878109047, 3999.960000400017, 4014.558398576154, 4042.838286468508, 4057.1885622875543, 9896.307258491981, 10580.57677692899, 10847.0, 10962.397068161168, 10982.176336774774, 10789.40658263803, 10883.891161088288, 10891.237613366988, 10929.726756830984, 10988.615398461016, 7910.446268761247, 8139.918600814034, 8295.129011453831, 8297.211764882326, 8309.04445988719, 5943.821685349447, 6035.0, 6055.5458340623745, 6085.0, 6095.116208149705, 10111.292209545261, 10115.39307641544, 10153.746156345855, 10293.588256469657, 10297.53661085238, 10094.343867648578, 10187.490625468845, 10310.793784124426, 10323.174146068446, 10492.947535262274, 6204.968975155276, 7057.082579264868, 7466.962665186639, 7585.544867307979, 7670.578118203329, 8498.235158835734, 8504.489730616182, 8519.0, 8536.40245182856, 8553.529555874238, 7498.512596681198, 7693.730719424793, 7694.538327700356, 7786.143524212445, 7832.490888092256, 7409.666565004695, 7496.512726672749, 7520.247975202436, 7630.465867389229, 7784.338331241682, 7079.929200707927, 7135.357817796424, 7222.6388680566815, 7230.74692385764, 7245.456590755609, 4943.406791184937, 4953.876153096201, 5014.147594908947, 5144.897102058013, 5144.9742751286, 4937.259411088222, 5091.13450713387, 5142.460041695568, 5209.973950130225, 5212.192110222922], "value": 4656.143181924111, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.05504253399977, 296.1338086098163, 300.15506349625804, 301.458881308052, 303.1149044789215, 4585.335126406669, 4893.2170852663585, 4932.580730637896, 4964.5283698048715, 5316.840494785153, 4784.138855006097, 5193.63644544882, 5263.657862238952, 5415.83752487426, 5489.964875816272, 4162.999999999993, 4182.431588154442, 4186.35111557709, 4195.091233488755, 4205.348171033479, 3444.794321987297, 3694.9445758313645, 3914.138889444332, 4187.28816101262, 4198.580141985807, 3505.4566542185876, 4097.8770636880945, 4098.590140985907, 4130.938035929464, 4150.501939767217, 3667.853285868562, 4136.627703506699, 4152.480939882515, 4180.68308482827, 4193.391958166064, 3047.817130972149, 3176.5076413156, 3553.2107295772694, 3566.7681600696133, 3597.388443964532, 4472.300525800175, 4937.950620493821, 5116.00475814429, 5256.764660304825, 5442.673439593637, 4369.4319738434115, 4712.104700106968, 4727.66906316558, 4727.7163370197895, 4736.8578942631775, 5146.536811686966, 5231.973840130813, 5634.0703783875615, 5810.21562089121, 5833.445822646841, 3718.442233664945, 3720.720945929066, 3885.417187421909, 3889.202713443737, 3933.5083114610675, 5678.971605141948, 6006.8498287542725, 6030.0, 6139.2632884053755, 6150.200473938359, 3537.257175993019, 3790.33669107905, 3967.26605577969, 3969.7419667722083, 3979.9204015919518, 3136.6549679535233, 3532.894013179609, 3977.363621820553, 3995.7402768819934, 4028.5367182774357, 3930.901727456779, 4667.603253723403, 4712.057588482317, 4728.4798672146035, 4744.857654270378, 5125.820596279113, 5729.4843464088435, 5734.913976290359, 5829.300483941869, 5848.590598658053, 1266.7973124300252, 1277.3932382118605, 1314.3756715560223, 1352.506335187669, 1360.6666366740212, 791.4143533784958, 832.3299743706375, 895.7402353317595, 910.1308250620641, 913.4747520175926, 5373.704446255415, 5381.7578208980685, 5407.648502847303, 5419.403865574784, 5451.591130665137, 5046.369203849519, 5904.557158213065, 5933.495652869468, 5935.139404786281, 5941.673207973603, 4464.330350447394, 4772.0217355442055, 5067.265246539231, 5368.249099546851, 5429.701366424805, 2195.6706494026025, 2351.7177938647474, 2374.45387560862, 2382.3448551648435, 2686.1270087221733, 4132.743274427345, 4747.454042785124, 4776.659436875975, 4967.403911530567, 5161.896762064813, 4369.737815731066, 4422.270325396274, 4455.821767129279, 4651.418572678415, 5049.949500505021, 4611.976940115278, 5085.796568137233, 5088.465711100355, 5112.651213455267, 5186.455422180692, 4457.840961350137, 4663.295288732459, 4666.020135771526, 4739.4075740532435, 5022.472640372708, 4455.75493347856, 4478.723563784306, 4547.04477074861, 4986.451490335988, 4987.902661414483, 4482.910341793211, 4495.325701144854, 5156.7421628919155, 5164.797825348308, 5174.663646862942, 2948.7493563047383, 2958.8520573970786, 3432.3821712092063, 3447.2933048725454, 3459.238967427162, 4367.820688414174, 4835.0, 4928.950710492849, 4972.428170760409, 5764.452377024176, 4385.912281754411, 5858.414158584107, 5884.47003779012, 5923.318818335946, 5956.642601443754, 5875.735591898289, 5903.144044113494, 5909.113632955091, 5927.2954403497815, 5931.347551769388, 4827.565519103297, 5662.065759149694, 5700.914486282792, 5754.827355179351, 5755.280589926259, 5223.649357788934, 5280.412597827114, 5419.701916394636, 5819.447152520504, 5877.500412464818, 5148.562372198405, 5248.606354523502, 5511.5969891814275, 5559.833205003856, 5764.962306784819], "value": 3965.1359789434946, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.3709749932563, 700.0094865764943, 766.2873527619315, 801.5551368990208, 820.4379999700205, 15227.923860380697, 15314.69370612587, 15533.301001454933, 15656.686866262668, 15686.13726245056, 12079.275243485397, 14257.572272831805, 14383.78424323636, 15403.614909627266, 15855.682886342294, 814.3851392198882, 844.8479273730726, 848.2789628815519, 851.6040041380757, 851.82537579796, 831.4678605692332, 859.0936561927165, 862.6118246788939, 865.5109862927458, 865.8138500222451, 896.9641214351451, 901.062894589626, 902.6344330546107, 903.4488961733338, 904.0055938467699, 895.7357579514058, 896.4442045931531, 897.9685711000117, 898.9865152022725, 902.9277657787361, 658.3416583416583, 660.1582981698325, 662.493192707579, 663.34329014276, 664.5348256220665, 14781.260936953217, 15201.391944322324, 15221.923890380587, 15227.923860380628, 15230.46693365727, 14330.78503822433, 14562.417503299856, 14990.325435355326, 15157.848421515864, 15192.772108418383, 11794.52821887132, 11916.821247681291, 11955.880441195564, 12041.458134383975, 12098.334591597459, 3824.7131465140224, 3832.329342365103, 3843.385058390644, 3857.7492462989817, 3883.49514563105, 112185.87814121836, 116333.0, 116828.0, 117655.41172294169, 119353.0, 11086.501107450184, 11504.482298296596, 11505.906938840797, 11555.942220289013, 11640.53437862476, 22034.228801991852, 22716.886415568148, 23251.418714531934, 23317.183898563468, 23599.0, 7956.920430795733, 8144.918550814535, 8191.426600137933, 8256.876146857801, 8405.0, 4478.395416618715, 4478.776061196927, 4593.402857628554, 4594.540545945446, 4595.1728688835665, 3462.1344663834043, 3568.3933731265747, 3589.4077477215965, 3596.1549035976523, 3600.1899572595958, 612.4824523277823, 625.3808729357903, 633.7813454358239, 637.7640273098983, 656.6979189572754, 601.3205078261624, 671.6403103236203, 680.5406350713348, 687.4809518813364, 699.1575151941897, 8402.831943361098, 8699.695510657224, 9355.719328420158, 9677.177439917545, 9870.60517579303, 516.3261943164207, 532.6032106080994, 598.7425407075, 635.1615867055442, 649.2732904455477, 4651.209294419889, 4839.249916262985, 4840.00779840132, 4840.927386089212, 4874.610031197496, 95562.52218738862, 96113.51943240239, 138558.30720846532, 162825.18587406987, 164564.0, 110520.0, 116475.252871207, 131746.0, 146971.0, 148043.0, 124634.0, 127940.72059279287, 131653.025204622, 133124.0, 133386.0, 9207.76980575491, 9217.953910230406, 9289.256859451363, 9310.348275620641, 9467.526623668928, 58184.709076454346, 69907.0, 70173.94739078816, 71689.64155179191, 72627.0, 105041.47479262555, 106252.46873765581, 106452.46773766082, 109029.0, 109224.0, 11154.944225278821, 12118.575849845565, 12206.75586488283, 12356.011519078633, 12489.0, 12812.487500499876, 12976.870231297566, 13007.609771706864, 13098.148620339647, 13197.274149921846, 11725.648230553097, 11860.644180674593, 11932.16474846787, 12149.1495595311, 12339.50641974311, 11950.0, 12587.622371328875, 12675.873241267838, 12734.235945843278, 12768.170068945488, 11829.940850296038, 11976.041916646473, 12087.9725223357, 12264.0, 12298.20061695987, 10247.014721580954, 10360.844587331347, 10514.316569422963, 10874.075703565286, 11063.668089957315, 8889.622108573181, 10658.413787241776, 10691.57233710674, 10775.29960552593, 10831.945840270748], "value": 7824.123973097059, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1564.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 118.0, 118.0, 119.0, 117.0, 117.0, 120.0, 119.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 111.0, 112.0, 145.0, 110.0, 114.0, 112.0, 113.0, 137.0, 111.0], "value": 120.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 197.0, 201.0, 197.0, 240.0, 271.0, 202.0, 197.0, 196.0, 194.0], "value": 209.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 86.0, 64.0, 60.0, 59.0, 58.0, 78.0, 58.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 87.0, 74.0, 68.0, 69.0, 89.0, 69.0, 72.0, 87.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 102.0, 91.0, 112.0, 109.0, 86.0, 112.0, 87.0, 90.0, 86.0], "value": 96.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 140.0, 168.0, 168.0, 100.0, 100.0, 153.0, 102.0, 115.0, 168.0], "value": 134.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 106.0, 143.0, 149.0, 89.0, 83.0, 94.0, 112.0, 143.0, 146.0], "value": 120.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 58.0, 59.0, 59.0, 60.0, 60.0, 59.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 83.0, 75.0, 72.0, 68.0, 67.0, 70.0, 69.0, 70.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 83.0, 87.0, 101.0, 107.0, 104.0, 83.0, 86.0, 94.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 143.0, 154.0, 128.0, 157.0, 157.0, 166.0, 162.0, 200.0, 163.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 166.0, 163.0, 170.0, 168.0, 167.0, 169.0, 169.0, 228.0, 180.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 67.0, 66.0, 70.0, 66.0, 69.0, 68.0, 76.0, 87.0], "value": 70.4, "unit": "score"}]}]} 03:09:01 INFO - Return code: 0 03:09:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:09:01 ERROR - # TBPL SUCCESS # 03:09:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:09:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:09:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:09:01 INFO - 2016-10-11 03:09:01.833 screenresolution[1675:11434] starting screenresolution argv=screenresolution get 03:09:01 INFO - 2016-10-11 03:09:01.835 screenresolution[1675:11434] Display 0: 1600x1200x32@60 03:09:01 INFO - 2016-10-11 03:09:01.841 screenresolution[1676:11437] starting screenresolution argv=screenresolution list 03:09:01 INFO - Available Modes on Display 0 03:09:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:09:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:09:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:09:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:09:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:09:02 INFO - Intel Iris: 03:09:02 INFO - Chipset Model: Intel Iris 03:09:02 INFO - Type: GPU 03:09:02 INFO - Bus: Built-In 03:09:02 INFO - VRAM (Dynamic, Max): 1536 MB 03:09:02 INFO - Vendor: Intel (0x8086) 03:09:02 INFO - Device ID: 0x0a2e 03:09:02 INFO - Revision ID: 0x0009 03:09:02 INFO - Displays: 03:09:02 INFO - Display: 03:09:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:09:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:09:02 INFO - Display Serial Number: 1600x1200 60 03:09:02 INFO - Main Display: Yes 03:09:02 INFO - Mirror: Off 03:09:02 INFO - Online: Yes 03:09:02 INFO - Rotation: Supported 03:09:02 INFO - Return code: 0 03:09:02 INFO - Running post-action listener: _resource_record_post_action 03:09:02 INFO - [mozharness: 2016-10-11 10:09:02.075910Z] Finished run-tests step (success) 03:09:02 INFO - Running post-run listener: _resource_record_post_run 03:09:02 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 32091136; Write bytes: 666964992; Read time: 197; Write time: 1969 03:09:02 INFO - TinderboxPrint: CPU usage
54.5% 03:09:02 INFO - TinderboxPrint: I/O read bytes / time
32,091,136 / 197 03:09:02 INFO - TinderboxPrint: I/O write bytes / time
666,964,992 / 1,969 03:09:02 INFO - TinderboxPrint: CPU idle
2,195.9 (45.5%) 03:09:02 INFO - TinderboxPrint: CPU system
979.0 (20.3%) 03:09:02 INFO - TinderboxPrint: CPU user
1,650.8 (34.2%) 03:09:02 INFO - TinderboxPrint: Swap in / out
391,917,568 / 0 03:09:02 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356137472; Write bytes: 355505664; Read time: 27279; Write time: 765 03:09:02 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 30325760; Write bytes: 300436992; Read time: 182; Write time: 1168 03:09:02 INFO - Running post-run listener: _upload_blobber_files 03:09:02 INFO - Blob upload gear active. 03:09:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:09:02 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:09:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:09:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:09:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:09:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:09:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:04 INFO - (blobuploader) - INFO - Done attempting. 03:09:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:09:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:09:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:05 INFO - (blobuploader) - INFO - Done attempting. 03:09:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:09:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:09:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:07 INFO - (blobuploader) - INFO - Done attempting. 03:09:07 INFO - (blobuploader) - INFO - Iteration through files over. 03:09:07 INFO - Return code: 0 03:09:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:09:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:09:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3df1f9d44d6f5adccf78e4d626291cf0d6616a7690ad5ed35d21a07c410f31c5142cd0def9be09477c1980cc8f59015689455b3024daf450547bfee11a5e9cca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8e41d27d3317a94d651d99229d0161b6d07fd1ad2ce51a299831c7b1c9c2169c01c7aa973ed35e15e45880d2d3794b1f700ec6dd093cc832fe874832d4ae5b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e5bd05855f6efc756d4821a8f54169d4d81c37c6227645dd02ff424dedd60b13a943f555b6cab36d3c677fac84a375c7042d7658e5eef878d62ca452d92f87b"} 03:09:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:09:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:09:07 INFO - Contents: 03:09:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3df1f9d44d6f5adccf78e4d626291cf0d6616a7690ad5ed35d21a07c410f31c5142cd0def9be09477c1980cc8f59015689455b3024daf450547bfee11a5e9cca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8e41d27d3317a94d651d99229d0161b6d07fd1ad2ce51a299831c7b1c9c2169c01c7aa973ed35e15e45880d2d3794b1f700ec6dd093cc832fe874832d4ae5b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e5bd05855f6efc756d4821a8f54169d4d81c37c6227645dd02ff424dedd60b13a943f555b6cab36d3c677fac84a375c7042d7658e5eef878d62ca452d92f87b"} 03:09:07 INFO - Running post-run listener: copy_logs_to_upload_dir 03:09:07 INFO - Copying logs to upload dir... 03:09:07 INFO - mkdir: /builds/slave/test/build/upload/logs 03:09:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.704764 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-10-11 03:09:07.565628) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 03:09:07.569350) ========= 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.QnxLa1W7J5/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.8qN1CbKdLb/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3df1f9d44d6f5adccf78e4d626291cf0d6616a7690ad5ed35d21a07c410f31c5142cd0def9be09477c1980cc8f59015689455b3024daf450547bfee11a5e9cca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8e41d27d3317a94d651d99229d0161b6d07fd1ad2ce51a299831c7b1c9c2169c01c7aa973ed35e15e45880d2d3794b1f700ec6dd093cc832fe874832d4ae5b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e5bd05855f6efc756d4821a8f54169d4d81c37c6227645dd02ff424dedd60b13a943f555b6cab36d3c677fac84a375c7042d7658e5eef878d62ca452d92f87b"} build_url:https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010932 build_url: 'https://queue.taskcluster.net/v1/task/G3v9eu4xQzm55QL5wrwQ3Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3df1f9d44d6f5adccf78e4d626291cf0d6616a7690ad5ed35d21a07c410f31c5142cd0def9be09477c1980cc8f59015689455b3024daf450547bfee11a5e9cca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e8e41d27d3317a94d651d99229d0161b6d07fd1ad2ce51a299831c7b1c9c2169c01c7aa973ed35e15e45880d2d3794b1f700ec6dd093cc832fe874832d4ae5b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e5bd05855f6efc756d4821a8f54169d4d81c37c6227645dd02ff424dedd60b13a943f555b6cab36d3c677fac84a375c7042d7658e5eef878d62ca452d92f87b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 03:09:07.602131) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 03:09:07.602453) ========= 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.QnxLa1W7J5/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.8qN1CbKdLb/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.005084 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 03:09:07.650916) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 03:09:07.651247) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 03:09:07.651582) ========= ========= Total master_lag: 0.19 =========