builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0231 starttime: 1480716951.18 results: success (0) buildid: 20161202122743 builduid: b94c659ff18c40a387eb0ea8f0c166f5 revision: 919596f62a27dbc3275aea5e04572a9ab026c1da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 14:15:51.178522) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 14:15:51.178970) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 14:15:51.179274) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 14:15:51.245575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-02 14:15:51.245922) ========= 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.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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-12-02 14:15:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2016-12-02 14:15:51 (168 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.180463 ========= master_lag: 1.92 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-02 14:15:53.345587) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 14:15:53.345898) ========= 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.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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.024766 ========= master_lag: 0.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 14:15:53.555833) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-02 14:15:53.556246) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 919596f62a27dbc3275aea5e04572a9ab026c1da --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 919596f62a27dbc3275aea5e04572a9ab026c1da --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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-12-02 14:15:53,668 truncating revision to first 12 chars 2016-12-02 14:15:53,668 Setting DEBUG logging. 2016-12-02 14:15:53,668 attempt 1/10 2016-12-02 14:15:53,668 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/919596f62a27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-02 14:15:54,806 unpacking tar archive at: mozilla-central-919596f62a27/testing/mozharness/ program finished with exit code 0 elapsedTime=1.412318 ========= master_lag: 2.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-12-02 14:15:57.067993) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 14:15:57.072348) ========= script_repo_revision: 919596f62a27dbc3275aea5e04572a9ab026c1da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 14:15:57.072823) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 14:15:57.073087) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 14:15:57.563255) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-12-02 14:15:57.563631) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 14:15:57 INFO - MultiFileLogger online at 20161202 14:15:57 in /builds/slave/test 14:15:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:15:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:15:57 INFO - {'append_to_log': False, 14:15:57 INFO - 'base_work_dir': '/builds/slave/test', 14:15:57 INFO - 'blob_upload_branch': 'Firefox', 14:15:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:15:57 INFO - 'branch': 'Firefox', 14:15:57 INFO - 'buildbot_json_path': 'buildprops.json', 14:15:57 INFO - 'config_files': ('talos/mac_config.py',), 14:15:57 INFO - 'default_actions': ('clobber', 14:15:57 INFO - 'read-buildbot-config', 14:15:57 INFO - 'download-and-extract', 14:15:57 INFO - 'populate-webroot', 14:15:57 INFO - 'create-virtualenv', 14:15:57 INFO - 'install', 14:15:57 INFO - 'run-tests'), 14:15:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:15:57 INFO - 'download_minidump_stackwalk': True, 14:15:57 INFO - 'download_symbols': 'ondemand', 14:15:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:15:57 INFO - 'tooltool.py': '/tools/tooltool.py', 14:15:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:15:57 INFO - '/tools/misc-python/virtualenv.py')}, 14:15:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:15:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:15:57 INFO - 'installer_path': 'installer.exe', 14:15:57 INFO - 'log_level': 'info', 14:15:57 INFO - 'log_name': 'talos', 14:15:57 INFO - 'log_to_console': True, 14:15:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:15:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:15:57 INFO - 'opt_config_files': (), 14:15:57 INFO - 'pip_index': False, 14:15:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:15:57 INFO - 'cmd': ('bash', 14:15:57 INFO - '-c', 14:15:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:15:57 INFO - 'enabled': True, 14:15:57 INFO - 'halt_on_failure': False, 14:15:57 INFO - 'name': 'check_screen_resolution'},), 14:15:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:15:57 INFO - 'cmd': ('bash', 14:15:57 INFO - '-c', 14:15:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:15:57 INFO - 'enabled': True, 14:15:57 INFO - 'halt_on_failure': False, 14:15:57 INFO - 'name': 'check_screen_resolution'},), 14:15:57 INFO - 'run_cmd_checks_enabled': True, 14:15:57 INFO - 'sps_profile': False, 14:15:57 INFO - 'sps_profile_interval': 0, 14:15:57 INFO - 'suite': 'dromaeojs', 14:15:57 INFO - 'system_bits': '32', 14:15:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:15:57 INFO - 'title': 't-yosemite-r7-0231', 14:15:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:15:57 INFO - 'use_talos_json': True, 14:15:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:15:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:15:57 INFO - 'work_dir': 'build'} 14:15:57 INFO - [mozharness: 2016-12-02 22:15:57.777006Z] Running clobber step. 14:15:57 INFO - Running pre-action listener: _resource_record_pre_action 14:15:57 INFO - Running main action method: clobber 14:15:57 INFO - rmtree: /builds/slave/test/build 14:15:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:16:00 INFO - Running post-action listener: _resource_record_post_action 14:16:00 INFO - [mozharness: 2016-12-02 22:16:00.183585Z] Finished clobber step (success) 14:16:00 INFO - [mozharness: 2016-12-02 22:16:00.183847Z] Running read-buildbot-config step. 14:16:00 INFO - Running pre-action listener: _resource_record_pre_action 14:16:00 INFO - Running main action method: read_buildbot_config 14:16:00 INFO - Using buildbot properties: 14:16:00 INFO - { 14:16:00 INFO - "project": "", 14:16:00 INFO - "product": "firefox", 14:16:00 INFO - "script_repo_revision": "production", 14:16:00 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 14:16:00 INFO - "repository": "", 14:16:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 14:16:00 INFO - "buildid": "20161202122743", 14:16:00 INFO - "pgo_build": "False", 14:16:00 INFO - "basedir": "/builds/slave/test", 14:16:00 INFO - "buildnumber": 5, 14:16:00 INFO - "slavename": "t-yosemite-r7-0231", 14:16:00 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:16:00 INFO - "platform": "yosemite_r7", 14:16:00 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:16:00 INFO - "branch": "mozilla-central", 14:16:00 INFO - "repo_path": "mozilla-central", 14:16:00 INFO - "revision": "919596f62a27dbc3275aea5e04572a9ab026c1da", 14:16:00 INFO - "stage_platform": "macosx64", 14:16:00 INFO - "builduid": "b94c659ff18c40a387eb0ea8f0c166f5", 14:16:00 INFO - "slavebuilddir": "test" 14:16:00 INFO - } 14:16:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 14:16:00 INFO - Running post-action listener: _resource_record_post_action 14:16:00 INFO - [mozharness: 2016-12-02 22:16:00.189463Z] Finished read-buildbot-config step (success) 14:16:00 INFO - [mozharness: 2016-12-02 22:16:00.189673Z] Running download-and-extract step. 14:16:00 INFO - Running pre-action listener: _resource_record_pre_action 14:16:00 INFO - Running main action method: download_and_extract 14:16:00 INFO - mkdir: /builds/slave/test/build/tests 14:16:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:00 INFO - trying https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 14:16:00 INFO - Downloading https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:16:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 14:16:01 INFO - Downloaded 1199 bytes. 14:16:01 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 14:16:01 INFO - Using the following test package requirements: 14:16:01 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:16:01 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:16:01 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 14:16:01 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:16:01 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 14:16:01 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:16:01 INFO - u'jsshell-mac.zip'], 14:16:01 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:16:01 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 14:16:01 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 14:16:01 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:16:01 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 14:16:01 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:16:01 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 14:16:01 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:16:01 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 14:16:01 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 14:16:01 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 14:16:01 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:16:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:16:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:16:01 INFO - Fetch https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:16:02 INFO - Expected file size: 16274846 14:16:02 INFO - Obtained file size: 16274846 14:16:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:16:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 14:16:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:16:08 INFO - Fetch https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 14:16:10 INFO - Expected file size: 16274846 14:16:10 INFO - Obtained file size: 16274846 14:16:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 14:16:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:16:16 INFO - Fetch https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 14:16:17 INFO - Expected file size: 14409734 14:16:17 INFO - Obtained file size: 14409734 14:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:17 INFO - trying https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:16:17 INFO - Downloading https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 14:16:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 14:16:20 INFO - Downloaded 107634201 bytes. 14:16:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:16:20 INFO - mkdir: /builds/slave/test/properties 14:16:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:16:20 INFO - Writing to file /builds/slave/test/properties/build_url 14:16:20 INFO - Contents: 14:16:20 INFO - build_url:https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 14:16:21 INFO - Running post-action listener: _resource_record_post_action 14:16:21 INFO - Running post-action listener: set_extra_try_arguments 14:16:21 INFO - [mozharness: 2016-12-02 22:16:21.301576Z] Finished download-and-extract step (success) 14:16:21 INFO - [mozharness: 2016-12-02 22:16:21.301713Z] Running populate-webroot step. 14:16:21 INFO - Running pre-action listener: _resource_record_pre_action 14:16:21 INFO - Running main action method: populate_webroot 14:16:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:16:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:16:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:16:21 INFO - '--tppagecycles', 14:16:21 INFO - '7'], 14:16:21 INFO - 'tests': ['tsvgm']}}, 14:16:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:16:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:16:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:16:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:16:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:16:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:16:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:16:21 INFO - 'talos_options': ['--disable-e10s'], 14:16:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:16:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:16:21 INFO - 'talos_options': ['--disable-e10s'], 14:16:21 INFO - 'tests': ['damp', 'tps']}, 14:16:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:16:21 INFO - 'tests': ['damp', 'tps']}, 14:16:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:16:21 INFO - 'tests': ['dromaeo_dom']}, 14:16:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:16:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:16:21 INFO - 'tests': ['basic_compositor_video']}, 14:16:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:16:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:16:21 INFO - 'tests': ['a11yr', 14:16:21 INFO - 'ts_paint', 14:16:21 INFO - 'tpaint', 14:16:21 INFO - 'sessionrestore', 14:16:21 INFO - 'sessionrestore_no_auto_restore', 14:16:21 INFO - 'tabpaint']}, 14:16:21 INFO - 'other-e10s': {'tests': ['a11yr', 14:16:21 INFO - 'ts_paint', 14:16:21 INFO - 'tpaint', 14:16:21 INFO - 'sessionrestore', 14:16:21 INFO - 'sessionrestore_no_auto_restore', 14:16:21 INFO - 'tabpaint']}, 14:16:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:16:21 INFO - 'ts_paint', 14:16:21 INFO - 'tpaint', 14:16:21 INFO - 'sessionrestore', 14:16:21 INFO - 'sessionrestore_no_auto_restore', 14:16:21 INFO - 'tabpaint']}, 14:16:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:16:21 INFO - 'ts_paint', 14:16:21 INFO - 'tpaint', 14:16:21 INFO - 'sessionrestore', 14:16:21 INFO - 'sessionrestore_no_auto_restore', 14:16:21 INFO - 'tabpaint']}, 14:16:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:16:21 INFO - 'tests': ['a11yr', 14:16:21 INFO - 'ts_paint', 14:16:21 INFO - 'tpaint', 14:16:21 INFO - 'sessionrestore', 14:16:21 INFO - 'sessionrestore_no_auto_restore', 14:16:21 INFO - 'tabpaint']}, 14:16:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:16:21 INFO - 'tests': ['a11yr', 14:16:21 INFO - 'ts_paint', 14:16:21 INFO - 'tpaint', 14:16:21 INFO - 'sessionrestore', 14:16:21 INFO - 'sessionrestore_no_auto_restore', 14:16:21 INFO - 'tabpaint']}, 14:16:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:16:21 INFO - 'tests': ['tsvgx', 14:16:21 INFO - 'tsvgr_opacity', 14:16:21 INFO - 'tart', 14:16:21 INFO - 'tscrollx', 14:16:21 INFO - 'cart', 14:16:21 INFO - 'tsvg_static']}, 14:16:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:16:21 INFO - 'tsvgr_opacity', 14:16:21 INFO - 'tart', 14:16:21 INFO - 'tscrollx', 14:16:21 INFO - 'cart', 14:16:21 INFO - 'tsvg_static']}, 14:16:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:16:21 INFO - 'talos_options': ['--disable-e10s'], 14:16:21 INFO - 'tests': ['tp5o']}, 14:16:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:16:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:16:21 INFO - 'talos_options': ['--disable-e10s', 14:16:21 INFO - '--xperf_path', 14:16:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:21 INFO - 'tests': ['tp5n']}, 14:16:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:16:21 INFO - 'talos_options': ['--xperf_path', 14:16:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:21 INFO - 'tests': ['tp5n']}}, 14:16:21 INFO - 'talos.zip': {'path': '', 14:16:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:16:21 INFO - Running post-action listener: _resource_record_post_action 14:16:21 INFO - [mozharness: 2016-12-02 22:16:21.320559Z] Finished populate-webroot step (success) 14:16:21 INFO - [mozharness: 2016-12-02 22:16:21.320667Z] Running create-virtualenv step. 14:16:21 INFO - Running pre-action listener: _resource_record_pre_action 14:16:21 INFO - Running main action method: create_virtualenv 14:16:21 INFO - Creating virtualenv /builds/slave/test/build/venv 14:16:21 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 14:16:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:16:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:16:21 INFO - Using real prefix '/tools/python27' 14:16:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:16:22 INFO - Installing distribute.............................................................................................................................................................................................done. 14:16:25 INFO - Installing pip.................done. 14:16:25 INFO - Return code: 0 14:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:16:25 INFO - Reading from file tmpfile_stdout 14:16:25 INFO - Output received: 14:16:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:16:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:16:25 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')]} 14:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:25 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')]} 14:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:25 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 0x106c4c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f0c7b7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a61d30>, '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 0x1068c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a59b20>, '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.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 14:16:25 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 14:16:25 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 14:16:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k7B4zg8SrJ/Render', 14:16:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:25 INFO - 'HOME': '/Users/cltbld', 14:16:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:25 INFO - 'LOGNAME': 'cltbld', 14:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:25 INFO - 'MOZ_NO_REMOTE': '1', 14:16:25 INFO - 'NO_EM_RESTART': '1', 14:16:25 INFO - 'PAGER': '/bin/cat', 14:16:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:25 INFO - 'PWD': '/builds/slave/test', 14:16:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:25 INFO - 'SHELL': '/bin/bash', 14:16:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dzuqFBBKz7/Listeners', 14:16:25 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 14:16:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:25 INFO - 'USER': 'cltbld', 14:16:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:25 INFO - 'XPC_FLAGS': '0x0', 14:16:25 INFO - 'XPC_SERVICE_NAME': '0', 14:16:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:25 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 14:16:25 INFO - Cleaning up... 14:16:25 INFO - Return code: 0 14:16:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:16:25 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')]} 14:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:25 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')]} 14:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:25 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 0x106c4c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f0c7b7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a61d30>, '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 0x1068c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a59b20>, '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.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 14:16:25 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 14:16:25 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 14:16:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k7B4zg8SrJ/Render', 14:16:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:25 INFO - 'HOME': '/Users/cltbld', 14:16:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:25 INFO - 'LOGNAME': 'cltbld', 14:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:25 INFO - 'MOZ_NO_REMOTE': '1', 14:16:25 INFO - 'NO_EM_RESTART': '1', 14:16:25 INFO - 'PAGER': '/bin/cat', 14:16:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:25 INFO - 'PWD': '/builds/slave/test', 14:16:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:25 INFO - 'SHELL': '/bin/bash', 14:16:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dzuqFBBKz7/Listeners', 14:16:25 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 14:16:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:25 INFO - 'USER': 'cltbld', 14:16:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:25 INFO - 'XPC_FLAGS': '0x0', 14:16:25 INFO - 'XPC_SERVICE_NAME': '0', 14:16:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:25 INFO - Downloading/unpacking psutil>=3.1.1 14:16:25 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 14:16:25 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 14:16:25 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 14:16:25 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 14:16:25 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 14:16:25 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 14:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:16:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:16:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:16:29 INFO - Installing collected packages: psutil 14:16:29 INFO - Running setup.py install for psutil 14:16:29 INFO - building 'psutil._psutil_osx' extension 14:16:29 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 14:16:30 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 14:16:30 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 14:16:30 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 14:16:30 INFO - building 'psutil._psutil_posix' extension 14:16:30 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 14:16:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:16:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:16:30 INFO - ^ 14:16:30 INFO - 1 warning generated. 14:16:30 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 14:16:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:16:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:16:30 INFO - Successfully installed psutil 14:16:30 INFO - Cleaning up... 14:16:31 INFO - Return code: 0 14:16:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:16:31 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')]} 14:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:31 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')]} 14:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:31 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 0x106c4c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f0c7b7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a61d30>, '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 0x1068c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a59b20>, '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.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 14:16:31 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 14:16:31 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 14:16:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k7B4zg8SrJ/Render', 14:16:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:31 INFO - 'HOME': '/Users/cltbld', 14:16:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:31 INFO - 'LOGNAME': 'cltbld', 14:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:31 INFO - 'MOZ_NO_REMOTE': '1', 14:16:31 INFO - 'NO_EM_RESTART': '1', 14:16:31 INFO - 'PAGER': '/bin/cat', 14:16:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:31 INFO - 'PWD': '/builds/slave/test', 14:16:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:31 INFO - 'SHELL': '/bin/bash', 14:16:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dzuqFBBKz7/Listeners', 14:16:31 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 14:16:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:31 INFO - 'USER': 'cltbld', 14:16:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:31 INFO - 'XPC_FLAGS': '0x0', 14:16:31 INFO - 'XPC_SERVICE_NAME': '0', 14:16:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:16:31 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 14:16:31 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 14:16:31 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 14:16:31 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 14:16:31 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 14:16:31 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 14:16:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:16:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:16:33 INFO - Installing collected packages: mozsystemmonitor 14:16:33 INFO - Running setup.py install for mozsystemmonitor 14:16:33 INFO - Successfully installed mozsystemmonitor 14:16:33 INFO - Cleaning up... 14:16:34 INFO - Return code: 0 14:16:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:16:34 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')]} 14:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:34 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')]} 14:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:34 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 0x106c4c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f0c7b7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a61d30>, '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 0x1068c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a59b20>, '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.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 14:16:34 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 14:16:34 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 14:16:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k7B4zg8SrJ/Render', 14:16:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:34 INFO - 'HOME': '/Users/cltbld', 14:16:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:34 INFO - 'LOGNAME': 'cltbld', 14:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:34 INFO - 'MOZ_NO_REMOTE': '1', 14:16:34 INFO - 'NO_EM_RESTART': '1', 14:16:34 INFO - 'PAGER': '/bin/cat', 14:16:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:34 INFO - 'PWD': '/builds/slave/test', 14:16:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:34 INFO - 'SHELL': '/bin/bash', 14:16:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dzuqFBBKz7/Listeners', 14:16:34 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 14:16:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:34 INFO - 'USER': 'cltbld', 14:16:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:34 INFO - 'XPC_FLAGS': '0x0', 14:16:34 INFO - 'XPC_SERVICE_NAME': '0', 14:16:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:34 INFO - Downloading/unpacking jsonschema==2.5.1 14:16:34 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 14:16:34 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 14:16:34 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 14:16:34 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 14:16:34 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 14:16:34 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 14:16:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:16:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:16: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 14:16: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 14:16: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 14:16: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 14:16: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 14:16: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 14:16:37 INFO - Downloading functools32-3.2.3-2.tar.gz 14:16:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:16:37 INFO - warning: no files found matching '*.txt' 14:16:37 INFO - no previously-included directories found matching 'build' 14:16:37 INFO - no previously-included directories found matching 'dist' 14:16:37 INFO - no previously-included directories found matching '.git*' 14:16:37 INFO - Installing collected packages: jsonschema, functools32 14:16:37 INFO - Running setup.py install for functools32 14:16:37 INFO - warning: no files found matching '*.txt' 14:16:37 INFO - no previously-included directories found matching 'build' 14:16:37 INFO - no previously-included directories found matching 'dist' 14:16:37 INFO - no previously-included directories found matching '.git*' 14:16:37 INFO - Successfully installed jsonschema functools32 14:16:37 INFO - Cleaning up... 14:16:37 INFO - Return code: 0 14:16:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:16:37 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')]} 14:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:37 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')]} 14:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:37 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 0x106c4c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f0c7b7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a61d30>, '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 0x1068c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a59b20>, '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.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 14:16:37 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 14:16:37 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 14:16:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k7B4zg8SrJ/Render', 14:16:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:37 INFO - 'HOME': '/Users/cltbld', 14:16:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:37 INFO - 'LOGNAME': 'cltbld', 14:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:37 INFO - 'MOZ_NO_REMOTE': '1', 14:16:37 INFO - 'NO_EM_RESTART': '1', 14:16:37 INFO - 'PAGER': '/bin/cat', 14:16:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:37 INFO - 'PWD': '/builds/slave/test', 14:16:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:37 INFO - 'SHELL': '/bin/bash', 14:16:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dzuqFBBKz7/Listeners', 14:16:37 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 14:16:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:37 INFO - 'USER': 'cltbld', 14:16:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:37 INFO - 'XPC_FLAGS': '0x0', 14:16:37 INFO - 'XPC_SERVICE_NAME': '0', 14:16:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:16:38 INFO - Cleaning up... 14:16:38 INFO - Return code: 0 14:16:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:38 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 0x106c4c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f0c7b7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a61d30>, '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 0x1068c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a59b20>, '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.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 14:16:38 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 14:16:38 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 14:16:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k7B4zg8SrJ/Render', 14:16:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:38 INFO - 'HOME': '/Users/cltbld', 14:16:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:38 INFO - 'LOGNAME': 'cltbld', 14:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:38 INFO - 'MOZ_NO_REMOTE': '1', 14:16:38 INFO - 'NO_EM_RESTART': '1', 14:16:38 INFO - 'PAGER': '/bin/cat', 14:16:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:38 INFO - 'PWD': '/builds/slave/test', 14:16:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:38 INFO - 'SHELL': '/bin/bash', 14:16:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dzuqFBBKz7/Listeners', 14:16:38 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 14:16:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:38 INFO - 'USER': 'cltbld', 14:16:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:38 INFO - 'XPC_FLAGS': '0x0', 14:16:38 INFO - 'XPC_SERVICE_NAME': '0', 14:16:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:38 INFO - Downloading/unpacking blobuploader==1.2.4 14:16: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 14:16: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 14:16: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 14:16: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 14:16: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 14:16: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 14:16:40 INFO - Downloading blobuploader-1.2.4.tar.gz 14:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:16:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:16:40 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 14:16:40 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 14:16:40 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 14:16:40 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 14:16:40 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 14:16:40 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 14:16:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:16:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:16:41 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 14:16:41 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 14:16:41 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 14:16:41 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 14:16:41 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 14:16:41 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 14:16:42 INFO - Downloading docopt-0.6.1.tar.gz 14:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:16:42 INFO - Installing collected packages: blobuploader, requests, docopt 14:16:42 INFO - Running setup.py install for blobuploader 14:16:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:16:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:16:42 INFO - Running setup.py install for requests 14:16:42 INFO - Running setup.py install for docopt 14:16:43 INFO - Successfully installed blobuploader requests docopt 14:16:43 INFO - Cleaning up... 14:16:43 INFO - Return code: 0 14:16:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:43 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 0x106c4c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f0c7b7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a61d30>, '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 0x1068c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a59b20>, '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.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 14:16:43 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 14:16:43 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 14:16:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k7B4zg8SrJ/Render', 14:16:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:43 INFO - 'HOME': '/Users/cltbld', 14:16:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:43 INFO - 'LOGNAME': 'cltbld', 14:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:43 INFO - 'MOZ_NO_REMOTE': '1', 14:16:43 INFO - 'NO_EM_RESTART': '1', 14:16:43 INFO - 'PAGER': '/bin/cat', 14:16:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:43 INFO - 'PWD': '/builds/slave/test', 14:16:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:43 INFO - 'SHELL': '/bin/bash', 14:16:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dzuqFBBKz7/Listeners', 14:16:43 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 14:16:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:43 INFO - 'USER': 'cltbld', 14:16:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:43 INFO - 'XPC_FLAGS': '0x0', 14:16:43 INFO - 'XPC_SERVICE_NAME': '0', 14:16:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:16:43 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-F6prIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:16:43 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Uz7JrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:16:43 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-b3XlHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:16:43 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-DSke9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:16:43 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-9qvPYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:16:43 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-sRASmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:16:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-5vYC6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:16:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-9SnXPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:16:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Q54yBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:16:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-dgpWGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:16:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-61NDVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:16:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-K6ifDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:16:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-aVAENC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:16:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-c4jRtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:44 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Zkmvt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:16:45 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-vNt23N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:16:45 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-PW8a0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:16:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:16:45 INFO - Running setup.py install for manifestparser 14:16:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:16:45 INFO - Running setup.py install for mozcrash 14:16:45 INFO - Running setup.py install for mozdebug 14:16:45 INFO - Running setup.py install for mozdevice 14:16:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:16:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:16:45 INFO - Running setup.py install for mozfile 14:16:45 INFO - Running setup.py install for mozhttpd 14:16:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:16:46 INFO - Running setup.py install for mozinfo 14:16:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:16:46 INFO - Running setup.py install for mozInstall 14:16:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:16:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:16:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:16:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:16:46 INFO - Running setup.py install for mozleak 14:16:46 INFO - Running setup.py install for mozlog 14:16:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:16:46 INFO - Running setup.py install for moznetwork 14:16:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:16:46 INFO - Running setup.py install for mozprocess 14:16:47 INFO - Running setup.py install for mozprofile 14:16:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:16:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:16:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:16:47 INFO - Running setup.py install for mozrunner 14:16:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:16:47 INFO - Running setup.py install for mozscreenshot 14:16:47 INFO - Running setup.py install for moztest 14:16:47 INFO - Running setup.py install for mozversion 14:16:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:16:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:16:47 INFO - Cleaning up... 14:16:47 INFO - Return code: 0 14:16:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:47 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 0x106c4c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f0c7b7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a61d30>, '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 0x1068c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a59b20>, '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.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 14:16:47 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 14:16:47 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 14:16:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k7B4zg8SrJ/Render', 14:16:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:47 INFO - 'HOME': '/Users/cltbld', 14:16:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:47 INFO - 'LOGNAME': 'cltbld', 14:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:47 INFO - 'MOZ_NO_REMOTE': '1', 14:16:47 INFO - 'NO_EM_RESTART': '1', 14:16:47 INFO - 'PAGER': '/bin/cat', 14:16:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:47 INFO - 'PWD': '/builds/slave/test', 14:16:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:47 INFO - 'SHELL': '/bin/bash', 14:16:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dzuqFBBKz7/Listeners', 14:16:47 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 14:16:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:47 INFO - 'USER': 'cltbld', 14:16:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:47 INFO - 'XPC_FLAGS': '0x0', 14:16:47 INFO - 'XPC_SERVICE_NAME': '0', 14:16:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:16:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-oC8P85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:16:48 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)) 14:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:16:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-5Bc4qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:16:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Ij3Zvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:16:48 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)) 14:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:16:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-nB8aSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:16:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-LdGQ9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:16:48 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)) 14:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:16:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-nJTsjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:16:48 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)) 14:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:16:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-cVkZAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:16:48 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)) 14:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:16:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-xLGCCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:16:48 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)) 14:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:16:48 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-zc3fCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:16:49 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)) 14:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:16:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-snoFUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:16:49 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)) 14:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:16:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-xboD4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:16:49 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)) 14:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:16:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-Qe4AYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:16:49 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)) 14:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:16:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-xRBD8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:16:49 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)) 14:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:16:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-rzBYrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-bjpi5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:16:49 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)) 14:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:16:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-xxs9er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:16:49 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)) 14:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:16:49 INFO - Running setup.py (path:/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/pip-08xzkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:16:49 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)) 14:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:16:49 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)) 14:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:16:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:16:49 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 14:16:49 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 14:16:49 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 14:16:49 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 14:16:49 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 14:16:49 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 14:16:52 INFO - Downloading blessings-1.6.tar.gz 14:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:16:52 INFO - Installing collected packages: blessings 14:16:52 INFO - Running setup.py install for blessings 14:16:52 INFO - Successfully installed blessings 14:16:52 INFO - Cleaning up... 14:16:52 INFO - Return code: 0 14:16:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:16:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:16:53 INFO - Reading from file tmpfile_stdout 14:16:53 INFO - Current package versions: 14:16:53 INFO - blessings == 1.6 14:16:53 INFO - blobuploader == 1.2.4 14:16:53 INFO - docopt == 0.6.1 14:16:53 INFO - functools32 == 3.2.3-2 14:16:53 INFO - jsonschema == 2.5.1 14:16:53 INFO - manifestparser == 1.1 14:16:53 INFO - mozInstall == 1.12 14:16:53 INFO - mozcrash == 1.0 14:16:53 INFO - mozdebug == 0.1 14:16:53 INFO - mozdevice == 0.49 14:16:53 INFO - mozfile == 1.2 14:16:53 INFO - mozhttpd == 0.7 14:16:53 INFO - mozinfo == 0.9 14:16:53 INFO - mozleak == 0.1 14:16:53 INFO - mozlog == 3.4 14:16:53 INFO - moznetwork == 0.27 14:16:53 INFO - mozprocess == 0.23 14:16:53 INFO - mozprofile == 0.28 14:16:53 INFO - mozrunner == 6.13 14:16:53 INFO - mozscreenshot == 0.1 14:16:53 INFO - mozsystemmonitor == 0.3 14:16:53 INFO - moztest == 0.7 14:16:53 INFO - mozversion == 1.4 14:16:53 INFO - psutil == 3.1.1 14:16:53 INFO - requests == 1.2.3 14:16:53 INFO - wsgiref == 0.1.2 14:16:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:53 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 0x106c4c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f0c7b7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a61d30>, '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 0x1068c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a59b20>, '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.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 14:16:53 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 14:16:53 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 14:16:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k7B4zg8SrJ/Render', 14:16:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:53 INFO - 'HOME': '/Users/cltbld', 14:16:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:53 INFO - 'LOGNAME': 'cltbld', 14:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:53 INFO - 'MOZ_NO_REMOTE': '1', 14:16:53 INFO - 'NO_EM_RESTART': '1', 14:16:53 INFO - 'PAGER': '/bin/cat', 14:16:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:53 INFO - 'PWD': '/builds/slave/test', 14:16:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:53 INFO - 'SHELL': '/bin/bash', 14:16:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dzuqFBBKz7/Listeners', 14:16:53 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 14:16:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:53 INFO - 'USER': 'cltbld', 14:16:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:53 INFO - 'XPC_FLAGS': '0x0', 14:16:53 INFO - 'XPC_SERVICE_NAME': '0', 14:16:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:53 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)) 14:16:53 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)) 14:16:53 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)) 14:16:53 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)) 14:16:53 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)) 14:16:53 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)) 14:16:53 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)) 14:16:53 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)) 14:16:53 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)) 14:16:53 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)) 14:16:53 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)) 14:16:53 INFO - Cleaning up... 14:16:53 INFO - Return code: 0 14:16:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:16:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106c4c3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bc2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f0c7b7e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a61d30>, '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 0x1068c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a59b20>, '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.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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 14:16:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:16:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k7B4zg8SrJ/Render', 14:16:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:16:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:16:53 INFO - 'HOME': '/Users/cltbld', 14:16:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:16:53 INFO - 'LOGNAME': 'cltbld', 14:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:16:53 INFO - 'MOZ_NO_REMOTE': '1', 14:16:53 INFO - 'NO_EM_RESTART': '1', 14:16:53 INFO - 'PAGER': '/bin/cat', 14:16:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:16:53 INFO - 'PWD': '/builds/slave/test', 14:16:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:16:53 INFO - 'SHELL': '/bin/bash', 14:16:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dzuqFBBKz7/Listeners', 14:16:53 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 14:16:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:16:53 INFO - 'USER': 'cltbld', 14:16:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:16:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:16:53 INFO - 'XPC_FLAGS': '0x0', 14:16:53 INFO - 'XPC_SERVICE_NAME': '0', 14:16:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:16:53 INFO - Cleaning up... 14:16:53 INFO - Return code: 0 14:16:53 INFO - Running post-action listener: _resource_record_post_action 14:16:53 INFO - Running post-action listener: _start_resource_monitoring 14:16:53 INFO - Starting resource monitoring. 14:16:53 INFO - [mozharness: 2016-12-02 22:16:53.698784Z] Finished create-virtualenv step (success) 14:16:53 INFO - [mozharness: 2016-12-02 22:16:53.699688Z] Running install step. 14:16:53 INFO - Running pre-action listener: _resource_record_pre_action 14:16:53 INFO - Running main action method: install 14:16:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:16:53 INFO - Reading from file tmpfile_stdout 14:16:53 INFO - Detecting whether we're running mozinstall >=1.0... 14:16:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:16:54 INFO - Reading from file tmpfile_stdout 14:16:54 INFO - Output received: 14:16:54 INFO - Usage: mozinstall [options] installer 14:16:54 INFO - Options: 14:16:54 INFO - -h, --help show this help message and exit 14:16:54 INFO - -d DEST, --destination=DEST 14:16:54 INFO - Directory to install application into. [default: 14:16:54 INFO - "/builds/slave/test"] 14:16:54 INFO - --app=APP Application being installed. [default: firefox] 14:16:54 INFO - mkdir: /builds/slave/test/build/application 14:16:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:17:27 INFO - Reading from file tmpfile_stdout 14:17:27 INFO - Output received: 14:17:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:17:27 INFO - Running post-action listener: _resource_record_post_action 14:17:27 INFO - [mozharness: 2016-12-02 22:17:27.900899Z] Finished install step (success) 14:17:27 INFO - [mozharness: 2016-12-02 22:17:27.901054Z] Running run-tests step. 14:17:27 INFO - Running pre-action listener: _resource_record_pre_action 14:17:27 INFO - Running main action method: run_tests 14:17:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:17:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:17:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:17:27 INFO - 2016-12-02 14:17:27.915 screenresolution[1635:8308] starting screenresolution argv=screenresolution get 14:17:27 INFO - 2016-12-02 14:17:27.918 screenresolution[1635:8308] Display 0: 1600x1200x32@60 14:17:27 INFO - 2016-12-02 14:17:27.924 screenresolution[1636:8310] starting screenresolution argv=screenresolution list 14:17:27 INFO - Available Modes on Display 0 14:17:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:17:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:17:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:17:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:17:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:17:28 INFO - Intel Iris: 14:17:28 INFO - Chipset Model: Intel Iris 14:17:28 INFO - Type: GPU 14:17:28 INFO - Bus: Built-In 14:17:28 INFO - VRAM (Dynamic, Max): 1536 MB 14:17:28 INFO - Vendor: Intel (0x8086) 14:17:28 INFO - Device ID: 0x0a2e 14:17:28 INFO - Revision ID: 0x0009 14:17:28 INFO - Displays: 14:17:28 INFO - Display: 14:17:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:17:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:17:28 INFO - Display Serial Number: 1600x1200 60 14:17:28 INFO - Main Display: Yes 14:17:28 INFO - Mirror: Off 14:17:28 INFO - Online: Yes 14:17:28 INFO - Rotation: Supported 14:17:28 INFO - Return code: 0 14:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:17:28 INFO - Python 2.7.3 14:17:28 INFO - Return code: 0 14:17:28 INFO - grabbing minidump binary from tooltool 14:17: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')]} 14:17:28 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 0x106a61d30>, '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 0x1068c8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a59b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:17:28 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 14:17:28 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 14:17:28 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 14:17:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:17:28 INFO - Return code: 0 14:17:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:17:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:17:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:17:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:17:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0231', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0231 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k7B4zg8SrJ/Render', 14:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:17:28 INFO - 'HOME': '/Users/cltbld', 14:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:17:28 INFO - 'LOGNAME': 'cltbld', 14:17:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:17:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:28 INFO - 'MOZ_NO_REMOTE': '1', 14:17:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:17:28 INFO - 'NO_EM_RESTART': '1', 14:17:28 INFO - 'PAGER': '/bin/cat', 14:17:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:28 INFO - 'PWD': '/builds/slave/test', 14:17:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:17:28 INFO - 'SHELL': '/bin/bash', 14:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dzuqFBBKz7/Listeners', 14:17:28 INFO - 'TMPDIR': '/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/', 14:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:17:28 INFO - 'USER': 'cltbld', 14:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:28 INFO - 'XPC_FLAGS': '0x0', 14:17:28 INFO - 'XPC_SERVICE_NAME': '0', 14:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:17:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0231', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:17:28 INFO - mozversion application_buildid: 20161202122743 14:17:28 INFO - mozversion application_changeset: 919596f62a27dbc3275aea5e04572a9ab026c1da 14:17:28 INFO - mozversion application_display_name: Nightly 14:17:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:17:28 INFO - mozversion application_name: Firefox 14:17:28 INFO - mozversion application_remotingname: firefox 14:17:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:17:28 INFO - mozversion application_vendor: Mozilla 14:17:28 INFO - mozversion application_version: 53.0a1 14:17:28 INFO - mozversion platform_buildid: 20161202122743 14:17:28 INFO - mozversion platform_changeset: 919596f62a27dbc3275aea5e04572a9ab026c1da 14:17:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:17:28 INFO - mozversion platform_version: 53.0a1 14:17:28 INFO - using testdate: 1480717048 14:17:28 INFO - actual date: 1480717048 14:17:28 INFO - starting webserver on 'localhost:49244' 14:17:28 INFO - SUITE-START | Running 2 tests 14:17:28 INFO - TEST-START | dromaeo_css 14:17:28 INFO - operating with platform_type : mac_ 14:17:28 INFO - Initialising browser for dromaeo_css test... 14:17:28 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpdXhkC8/profile http://localhost:49244/getInfo.html) 14:17:31 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 14:17:31 INFO - PROCESS | 1646 | colorDepth:24 14:17:31 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 14:17:31 INFO - PROCESS | 1646 | __metrics 14:17:31 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:17:31 INFO - PROCESS | 1646 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:17:32 INFO - TEST-INFO | 1646: exit 0 14:17:32 INFO - Browser initialized. 14:17:32 INFO - Running cycle 1/1 for dromaeo_css test... 14:17:32 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmpdXhkC8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:17:44 INFO - PROCESS | 1649 | RSS: Main: 244543488 14:17:44 INFO - PROCESS | 1649 | 14:18:35 INFO - PROCESS | 1649 | 1480717115852 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] 14:20:47 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 14:20:50 INFO - PROCESS | 1649 | RSS: Main: 446484480 14:20:50 INFO - PROCESS | 1649 | 14:23:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 14:23:53 INFO - PROCESS | 1649 | RSS: Main: 374906880 14:23:53 INFO - PROCESS | 1649 | 14:26:56 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 14:26:56 INFO - PROCESS | 1649 | RSS: Main: 340262912 14:26:56 INFO - PROCESS | 1649 | 14:29:59 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 14:29:59 INFO - PROCESS | 1649 | RSS: Main: 336056320 14:29:59 INFO - PROCESS | 1649 | 14:33:03 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 14:33:04 INFO - PROCESS | 1649 | RSS: Main: 331087872 14:33:04 INFO - PROCESS | 1649 | 14:36:07 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 14:36:07 INFO - PROCESS | 1649 | RSS: Main: 468787200 14:36:07 INFO - PROCESS | 1649 | 14:36:07 INFO - PROCESS | 1649 | __start_tp_report 14:36:07 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 14:36:07 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 14:36:07 INFO - PROCESS | 1649 | |i|pagename|runs| 14:36:07 INFO - PROCESS | 1649 | |0;dojo.html;2890.407466469374;3183.9174680608603;3296;3320.817355045472;3341.3150304187643;5532.529734972532;5652.773889044439;5691.943080569204;5735.770569177228;5742.39704830993;5668.914966275499;5741.224934633823;5832.591718579701;5841.386654401291;5883.8529036774;5124.436312005695;5165.896682066356;5186.299849520305;5216.947830521684;5257.789688412478;5301;5319.148936170213;5321.148616221405;5329.493698098694;5337.866553336178;5161.148410512261;5316.282301889234;5317.441668624778;5334.946650533484;5391.379991300992;5254.684718916839;5261.710605916673;5263.394709608406;5270.183121616155;5277.6305658603915;5154;5173.870653233662;5196.974015129938;5198.16829307309;5237.266782650432;5715.199872017921;5724.5992780505385;5726.969145553799;5739;5741.856453588652;6154.599951003171;6162.014077747539;6176.660283684396;6198.2252218472695;6211.409916057967;6172.506199504029;6224.06639004153;6235.96882015587;6239.906401403982;6242.282137554149;5827.067669172912;5829.271341082364;5833.854153646151;5843.853903652443;5873.882522349529;6194.38056194386;6194.659293738888;6218.160548325918;6245;6249.34381889895;5039.193729003415;6026.879462410728;6040.909386359208;6041.365656606081;6084.4828189603495;6172.444479996732;6179.227596550431;6187.938120618826;6188.4739797116845;6192.969035154795;6062.393760623902;6077.1491991121275;6099.9085013724825;6102.307478454246;6134.294556126013;6138.202033735586;6140.302668458633;6188;6197.907031394533;6228.626282422979;4901.8970731585105;4906.435759887588;4914.975425122851;4916.385451818523;4939.827106051271;4365.257906155961;4383.539728328544;4418.447694038246;4434.224010798098;4460.107978404332;5731.312242530923;5748.511376533042;5827.7668893244645;5833.300003999547;5857.970710146507;6165.10605962133;6229;6238.906416403667;6241.032639940726;6242.09489624002;5839.532837373;5857.7656893724625;5879.265091863517;5883.911741323884;5902.911456328158;5292.417834038252;5329;5346.4386239445075;5388.0570900092325;5390.811321603804;6168.506519478341;6175.413335733098;6210.813675589739;6227.595206311576;6237.251529816451;5487.478689524489;6007.249093863267;6061.7575296987625;6219.875602487835;6227.9377206227355;5222.2688823565495;6181.412765787243;6193.535484838565;6228.719707613259;6254.937450625435;6100.633961962297;6109.799438327801;6121.755129794758;6132.569672417391;6145.678679084019;6229.719662615103;6243.875122497616;6256.124142619946;6260.342664020394;6270.843228919313;6152.046432802923;6162.537809664203;6173.012318029094;6179;6182.629042257479;6003.90994135097;6079.574429789872;6089.878202436015;6102.206713127265;6151.723172457339;4541.887237626671;5849.3858144894175;5918.911216331845;5955.255593050869;5971.850703732442;6109.572329936862;6111.663858487826;6111.99152139892;6112.877742445037;6117.96941015292;4950.851474455772;5922.585419020627;5971.522278217819;5980.252468441445;5986.700664966821 14:36:07 INFO - PROCESS | 1649 | |1;ext.html;445.5455435455835;475.3653872080772;488.76539261154625;525.4141632080232;558.9496945274927;37761;39025.21949561007;39278.643281403136;39314.2137157257;40873.79563102188;39443.40834887472;39967.600323996754;39998.60001399985;40019;40079.39880901782;8242.093369729355;8461.53461559614;9096.090390960917;9281.21109705676;9292.674756383529;10768.515416806262;11075.446227688582;11076.556937722482;11242.775144497105;11265.718357041058;11050.613228537002;11118.110551155889;11135.721606959809;11140.554377824878;11150.665480035572;11053.778924421507;11129.165312601506;11131.944340278327;11134.33194008362;11166;10907.509162087646;10992.120630349553;10997.34015959045;11010.834837477445;11026.614068507644;38066.619333806586;38321.467141314315;38361.04097397559;38479;38632.61367386347;2943.617329747119;3151.4012337656;3260.8043517389033;3273.8035717857006;3614.8192590370377;28969.130926072252;29418;29517.409651806844;29531.114066578037;29582.40835183306;3037.9696203037906;3139.7331226845745;3183.856726447292;3190.170555655523;3275;392912;461266;463236.68381658214;463475;464295;57875;58233.4176658228;58369.70815145897;58440.83118337695;58597.12104318439;61414.38585614086;61487;61527.38472615306;61597;61762;15141.621459463602;15636.92181539085;15653.139077350856;15660.216989150496;15685.215739212994;10923.126149907988;11170.609028683957;11173.776524469466;11369.488373023234;11975.700607484883;15731.011107889464;15849.207539622972;17471.126443677764;17769.46691599254;17977.19102640384;6622.635755033423;7388.298111679382;7461.813454663677;7594.5063570867715;7641.847163056819;813.3777660090036;928.1461055828654;939.6234516433458;1009.0414106598761;1015.8476228565775;25650.48699026009;28204.717952820618;28418.294902305926;29359.706402936125;29475.263118421783;930.3487558708931;966.5602151021268;993.7664648807524;1001.1240164855751;1121.3832392184265;14413.423463061361;14816.703665926621;14971.401143954337;15220.771688424682;15287.464938727091;658202;662859;664059;664239;664843;55086;55529.722351388795;55654.721726391916;55787.44212557904;55831.72084139553;1152.6138743521014;1197.7125489882364;1246.9314187719763;1336.0046765160018;1343.9193648381129;27943.58084628773;29309.560356595095;29322.041524394786;29910.70089299079;30090.69909300879;47393;47709.76145119252;47811.76094119507;47882;47981.76009119932;441449.7927510342;519510;520000;520772;521308;22434.5513089734;25460.236192914243;25786.8710656453;26170.476590467704;26304.079357222407;44159.77920110379;44455.777721112485;44690;44930.65208043633;44963.55036449594;36207;36523.452148217264;36632.26735465223;37270;37714;36050.819745902154;36236.63763362438;37235.627643723215;37275;37366;35928.64071359253;35950.640493595776;36295;36522.634773651924;36886.26227475489;31646.683533165295;33250.50124248186;33281;33318.666813331554;33423;22921.426964326027;23892;24213.394665133514;24604.876975615007;24943.12926530554 14:36:07 INFO - PROCESS | 1649 | |2;jquery.html;312.50312003913774;352.4114728403569;375.46683709133026;375.498709223187;405.05015738094176;14759.70480590389;15321.540353789376;15671.05973641581;19986.101320374542;20591.176352945866;19190.328338508156;19429.931353775537;20045.298414555495;20232.69650955237;20340;5681.403452637486;6052.092186172087;6055.545834062441;6055.606385584945;6057.51539876811;4556.498785133649;5939.524838012949;5984.970075149618;5995.970020149915;5998.4901283390745;5682.318121825387;5926.940730592703;5939.109133629969;5943.494802941756;5953.523718102541;5712.571557133231;5832.387599302076;5832.912506312387;5837.97835378807;5840.561957853136;4899.853004409873;5088.949110508885;5125.769340379692;5130.230070625628;5141.177411614161;25350.49299014028;25364.61953070687;25468.23595292144;25648.743512564823;25696.357591060187;2056.1775289884167;2081.198738485679;2095.905684244213;2274;2961.822290662567;14580.416783328654;15490.535283941499;15558.922205389013;15692.979956302917;16182.190890455548;1814.4738025972583;1844.9907750461296;1874.6157037807218;1917.0606402862497;1926.9903650481658;113142.43428782886;113183;117976.82023179744;118500;122082;10486.842697359545;10640.8500684733;10877.347359158475;11037.282576632493;11177.385243811668;11541.422928853524;13688.794668079987;13691.931540342433;13724.176549407068;13738.519151829638;7020.824479388056;7969.72105976288;8270.710525131592;8292.087870334379;8413.15868413166;8273.131321211185;8277.917220827836;8279.793005174919;8426.115257897833;8455.534945578052;6570.507211959027;6581.670916454158;6581.83545411359;6593;6599.007600401688;1507.6683129711446;1734.6790843693705;1812.2660322569118;1852.120242884646;1853.3883818339916;782.3193821375439;903.7108125399809;922.6032805893396;949.0177666115537;966.6326795817545;20889.686654700192;21577.892110539662;21770;21804.890975545022;21906.0142293594;944.1078181118777;947.5120313038791;950.078423928788;982.9017098290113;992.0525897767615;10984.176186785864;11107.55569777216;11561.364124973206;11609.477573509212;11727.237729547553;457707;557189;567727.3227267757;584175;585594;85123;117577;124770;131080.3445982764;137489.31255343658;906.4651855405342;953.9856902146473;1003.2024540490328;1004.829179039565;1011.4841430870162;18862.622747545247;19073.427797166107;19267.710984334964;19305.034748262813;19376.2249510018;53521;53917.460825392816;53922.19116713174;55244.72377638086;55289.44710552843;73494.66853963425;74501;78065.21934780579;81262;83995.28037757087;11408.201425900439;11490.208002073648;12160.574379896661;12225.144239903122;12300.138990270952;11179.72050698739;13560.932195339356;13709.383077761724;13814;14128.646783830487;10010.099091081547;10755.784884302426;11724.88275117238;11937.224080434744;11967.281963082243;11408;11467.31196128235;11681.182317237712;11960.043196544082;11979.580714674945;11504.137189710973;11605.187636865337;11806.82289765637;12058.638240852788;12097.274163550215;12024.939875300917;12033.939830300793;12059.432273804348;12296.81554776697;12358.382080896099;11523.308601483937;11733.413329333669;11775.352355620524;11854.051675865738;11950.760984780429 14:36:07 INFO - PROCESS | 1649 | |3;mootools.html;1306.8366454193226;1454.2001898955575;1579.6524764551796;1787.535240837382;1824.9178786954594;7904.5652489113145;8360.958195209016;8379.32965362771;8396.496210227382;8399.622017009235;6814.97775333699;6935.583864968093;7279.272072792718;7576.88634670479;8183.263506284433;2265.150568536799;2308.7114110736156;2311.05246848792;2314.467672435341;2317.1310758465575;2301.620232661609;2315.7452680205247;2336.19401306549;2341.7424083350816;2344.929652110431;2274.37454699958;2287.3938406322254;2307.8846057697133;2309.93070207894;2316.9420764480938;2200.2189222825987;2208.149862303009;2234;2239.85440946338;2240.753517113108;2285.8171346292256;2310.3761984264156;2311.5492478966607;2314.271004633552;2315.8263130265127;8113.675452981874;8164.387670924704;8310.085890552034;8325.333973282122;8376.748697539084;4257.8509752158525;5167.379914410295;5175.560077393426;5177.068127737006;5186.7147306898105;3135.8588863501195;3276.1318250663594;3528.6294939031545;3543.114221444639;3544.220271540257;1031.6647089695805;1032.7676272838626;1069.8930106989317;1077.299755159145;1088.455772113943;10598.311109777916;10619;10774.5690172393;10797.244192906499;10814.35113893169;4361.629261512807;4454;4578.336141259499;4578.748168850745;4623.69945953512;7950.324222441157;9334.439933604006;9342.859857102148;9349.298802589698;9368.110029547182;5125.33370661819;5129.666571672829;5133.8716532087;5140.203268493389;5144.151215049475;4125.23683118624;4204.810783514749;4372.322290045048;4683.15703173432;4712.670113092119;3674.6141655125825;3691.354013047706;3782.962170378316;3814.5613254475534;3853.190829925691;1243.720162963326;1249.4627310256676;1254.3101294288106;1267.1256832785348;1268.2580690296095;813.6948644258404;818.2267756969726;844.9070056872642;859.4542465534431;865.6148014133776;5143.3570803649545;5272.736363181825;5276.076686579833;5584.352615978296;5594.440555944454;424.5733038296554;436.9213541562486;442.7321470510295;444.26917720349843;448.28050978180204;3585.3904836177912;3625.4018087015347;3642.25333806569;3670.953778173208;3814.5422549294262;9573.234141268682;9956.900430995598;10019.098281154731;10094.091531762177;10112.089911907964;10031.197504199647;10047.598096076075;10078.344907580984;10083.394996300245;10088.69733907984;7542;7734.303912647776;7841;7841.902133701286;7845.646945887449;4835.540623640749;5054.064997975239;5601.411851755507;5683.261176047087;5793.102069179284;9095.454272743656;9279.118483744034;9375.765605859635;9376.249900008119;9406.212819564262;8908.287337013153;9288;9297.442153470813;9450.905490945002;9503.097205765442;6562.50781191403;6751.527393082437;6835.624040677611;7012.333828286304;7197.208307086321;7620.199879012624;7729.884051739341;7831.373490120663;7945.562994035384;7965.163657816078;6944.305569443015;7063.117110361205;7068.434525237866;7090.07828982229;7241.601711905896;6711.798646040626;6918.723251070102;6942.652867356713;6970.372666460043;7013.719451222098;5544.279243698294;6366;6565.934340656723;6612.140421745143;6717.462602991651;4667.649926255613;4747.620190384692;4778;4809.5430934061205;4879.194932836042;4078.388241763759;4456.17560751262;4552.9544704553855;4681.321208424692;4850.733209673502 14:36:07 INFO - PROCESS | 1649 | |4;prototype.html;296.74776440025977;305.5035567203294;305.87459141751873;312.84201478253476;314.3791012749821;4369.847055353063;4388.846390376338;4539.296409056593;5281.570477580313;5307.328191619642;4570;4992.700437973725;5181.4300426953005;5288.2596436498925;5303.045451818671;3510.964890351102;3601.2257364666593;3885.805709714517;3984.0836607580127;3988.78061706606;3569.7501174917766;3726.6087060858627;3949.407588861665;4015.638592526672;4019.7588144711262;3400.9829950850212;3583.0325812030865;3706.629337066299;3983.302921988655;4025.4565633639522;3320.9833950830093;3769.095417099876;3998.620475935812;4034.515858097018;4068.7558746475156;3141.7329526990234;3504.8422820972864;3513.508108864761;3515.806630635314;3525.7179425645886;4663.27719203524;5076.923846142311;5111.974440127813;5158.845234642967;5167.165656192073;4503.6580977891645;4596.609288210506;4634.328022436762;4648.488666246744;4665.440147182359;4851.951480485221;5461.918071228934;5508.724563771795;5517.779288828442;5548.722563871831;3872.7869967151796;3890.3580909149955;3893.27974324748;3900.0694656145106;3911.8044097794996;5315.654482458628;5836.941630583682;5841.948449279128;5854.912176317359;5856.795012174553;3545.3972824619877;3864.8260828262796;3947.703922205846;3959.040275063862;3970.134037002604;3989.9002524936527;4003;4017.1965606878157;4018.7186896916937;4051.2505186540584;4640.79116439761;4647.233206520954;4658.3711198988385;4680.555347242007;4681.9297710534365;5226.555742761831;5249.028929648028;5267.656747529356;5560.610757247035;5603.439656034364;1299.4282515693064;1309.3845892430543;1312.2323440787056;1315.7171208190284;1325.6884632111446;787.3701039168642;796.9203079692101;892.5358813416987;900.0954041188563;900.2707806676482;4879.634027447884;5039.672421292605;5224.582033437316;5253.921191182136;5254.054270231395;4762.428508578923;5614.192903548226;5635.21107045014;5642.153676948491;5643.250592316395;5099.745012749348;5281.524662780368;5288;5292.735363231823;5294.364676238876;2506.94986100277;2630.1057640401973;2752.582420053674;2837.8297302161936;2839.091490722949;5243.659162154448;5584.357798853102;5594.964931487688;5612.803551875665;5630.577706672016;5026.447090820006;5428.430014848463;5532.5573954083575;5555.527800120942;5680.7727690892725;5139.948600513947;5658.74535645897;5709.51469125129;5772.9711351442975;5797.565182611321;4807.010181549375;4825.662203645711;5100.6429549931145;5373.301470808769;5518.475744804237;4680.882977925579;4801.879953001203;5266.368035835724;5298.761555730079;5388.548210564106;4720.504347043511;5302.522772950453;5315;5589.245451864109;5667.943320566907;3709.7572313274277;3712.368897287414;3717.5910649827956;3727.9440808387353;3743.606921273336;4589.655775816894;4660.7669616519715;4939.481354457874;5069.476713683955;5389.245505629294;4869.732164730974;5198.194279886624;5235.136202526541;5239.633225674166;5250.868728281824;4316.827326906889;4619.907601847877;5111.897762044812;5191.896162076813;5282.917002014655;5048.3941926969;5070.41690205631;5075.543201111917;5514.724263786875;5599.776008959596;4245.49054113496;5027.59779217669;5042.949570504248;5545.944540554543;5609.21470994053;4846.345743324747;5487.832306238934;5493.253373313343;5509.449055094458;5514.546027017938 14:36:07 INFO - PROCESS | 1649 | |5;yui.html;636.729390009246;704.0776582676693;758.5676164586188;759.1990450075168;780.0483410239509;14918;15808.209589520508;15814.367425303002;15831.683366332667;15844.12857292847;14147.434102635882;14324.212168330738;14325.99718019739;14327.997040207163;14329.498467553638;642.1138828416779;663.6217356107021;664.1996394344827;813.544415127529;826.1985873702499;806.2985202873479;832.4422636833306;837.5058715357937;842.7429633961639;845.9619317130713;881.8104107616861;882.4925667741043;882.7307671160294;883.3021912688968;890.185480285538;574.7672192761938;698.930106989297;875.8729984152294;878.8901387326616;879.8504254276725;625.3715016408526;652.3997921911805;657.1522735670978;658.098405184895;659.0509666080828;14698.33857476416;14717.926410367987;14720.631984200374;14728.484503042342;14775.113493190443;13357.599272021855;13419.865801342057;13475.528356507475;13476.797848032287;13574.185548867099;12215.694607634792;12311.75376492474;12438.564650237198;12529.93735031319;12535.874641253562;3961.7424867383816;4261.552536983603;4339.218940590692;4364.585364390409;4379.343098535245;99112;102258.99999999926;120302;122480;122883;10351;10813;10815.242932994772;10822.837657435144;11214.887851121384;21053.684194737092;21151.04820283091;21181.258655946967;21506.247281345077;21544.353669389944;7794.727184548514;7851.685932562634;7861.685532578747;7923.960380198062;7991.960040199761;4313.935290970638;4349.782510874444;4353;4357.652834669616;4367.170237654836;3469.670381313771;3661.2860492203763;3669.798161101112;3670.7614005089586;3677.9816100919325;585.7861880413618;611.8990366589463;649.331188875459;661.0579923608839;674.4705406256065;539.463234082083;585.28887401807;655.1483072006373;674.0327629851179;695.7112798188695;9031.871016122985;9060.285283034056;9333;9351.532423378803;9502.667406640872;572.7565784541553;626.4330780643525;659.8779225843139;667.1027468055457;669.2069897171867;4344.522102568715;4499.88750281239;4558.931616025762;4666.183417901853;4685.508021657677;101161.49419252857;115121.54635360952;120421.39789300997;121237.39381303213;123522.76477235113;74045;92171.53914230385;92780;98241.50879245558;107715;82431;85854.57072714722;87074.1292587066;88041.55979220063;88094;9417.62329506812;9814.9018509814;9976.551055202388;9992.800143997225;10068.798624027624;57471;58664.413355865894;59872;59956.45051739961;60057;63326;67002;75556;84520.57739711262;84720.64595155265;11444.656660300205;13092.869071309546;13487.460501579826;13501.662458438617;14022.719545609234;13155;13375.665608359868;13423.26172060546;13674.247916364298;14076;12816.066899175665;13429.798553021517;13539.661508462368;13905.513307034205;14025;13187.80218296707;13477.595672129852;13707.794383084462;13731.656708582366;14404;13448.1258718183;13612.65968350799;13684.45262189541;13786.034977551475;14287.928560357132;10504.684859454228;11023.83464248053;11201.831972520256;11542.249753765978;11717.472713728073;10936.726581835517;11368.013491532694;11387.43062846871;11445.48495317696;11610.303381797119 14:36:07 INFO - PROCESS | 1649 | __end_tp_report 14:36:07 INFO - PROCESS | 1649 | __start_cc_report 14:36:07 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2652 14:36:07 INFO - PROCESS | 1649 | __end_cc_report 14:36:07 INFO - PROCESS | 1649 | __startTimestamp1480718167321__endTimestamp 14:36:07 INFO - PROCESS | 1649 | 14:36:07 INFO - PROCESS | 1649 | ------- Summary: start ------- 14:36:07 INFO - PROCESS | 1649 | Number of tests: 6 14:36:07 INFO - PROCESS | 1649 | 14:36:07 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5708.82 Median:5922.59 stddev:648.21 (10.9%) stddev-sans-first:611.33 14:36:07 INFO - PROCESS | 1649 | Values: 2890.4 3183.9 3296.0 3320.8 3341.3 5532.5 5652.8 5691.9 5735.8 5742.4 5668.9 5741.2 5832.6 5841.4 5883.9 5124.4 5165.9 5186.3 5216.9 5257.8 5301.0 5319.1 5321.1 5329.5 5337.9 5161.1 5316.3 5317.4 5334.9 5391.4 5254.7 5261.7 5263.4 5270.2 5277.6 5154.0 5173.9 5197.0 5198.2 5237.3 5715.2 5724.6 5727.0 5739.0 5741.9 6154.6 6162.0 6176.7 6198.2 6211.4 6172.5 6224.1 6236.0 6239.9 6242.3 5827.1 5829.3 5833.9 5843.9 5873.9 6194.4 6194.7 6218.2 6245.0 6249.3 5039.2 6026.9 6040.9 6041.4 6084.5 6172.4 6179.2 6187.9 6188.5 6193.0 6062.4 6077.1 6099.9 6102.3 6134.3 6138.2 6140.3 6188.0 6197.9 6228.6 4901.9 4906.4 4915.0 4916.4 4939.8 4365.3 4383.5 4418.4 4434.2 4460.1 5731.3 5748.5 5827.8 5833.3 5858.0 6165.1 6229.0 6238.9 6241.0 6242.1 5839.5 5857.8 5879.3 5883.9 5902.9 5292.4 5329.0 5346.4 5388.1 5390.8 6168.5 6175.4 6210.8 6227.6 6237.3 5487.5 6007.2 6061.8 6219.9 6227.9 5222.3 6181.4 6193.5 6228.7 6254.9 6100.6 6109.8 6121.8 6132.6 6145.7 6229.7 6243.9 6256.1 6260.3 6270.8 6152.0 6162.5 6173.0 6179.0 6182.6 6003.9 6079.6 6089.9 6102.2 6151.7 4541.9 5849.4 5918.9 5955.3 5971.9 6109.6 6111.7 6112.0 6112.9 6118.0 4950.9 5922.6 5971.5 5980.3 5986.7 14:36:07 INFO - PROCESS | 1649 | 14:36:07 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:66959.91 Median:19832.82 stddev:146233.69 (737.3%) stddev-sans-first:146558.64 14:36:07 INFO - PROCESS | 1649 | Values: 445.5 475.4 488.8 525.4 558.9 37761.0 39025.2 39278.6 39314.2 40873.8 39443.4 39967.6 39998.6 40019.0 40079.4 8242.1 8461.5 9096.1 9281.2 9292.7 10768.5 11075.4 11076.6 11242.8 11265.7 11050.6 11118.1 11135.7 11140.6 11150.7 11053.8 11129.2 11131.9 11134.3 11166.0 10907.5 10992.1 10997.3 11010.8 11026.6 38066.6 38321.5 38361.0 38479.0 38632.6 2943.6 3151.4 3260.8 3273.8 3614.8 28969.1 29418.0 29517.4 29531.1 29582.4 3038.0 3139.7 3183.9 3190.2 3275.0 392912.0 461266.0 463236.7 463475.0 464295.0 57875.0 58233.4 58369.7 58440.8 58597.1 61414.4 61487.0 61527.4 61597.0 61762.0 15141.6 15636.9 15653.1 15660.2 15685.2 10923.1 11170.6 11173.8 11369.5 11975.7 15731.0 15849.2 17471.1 17769.5 17977.2 6622.6 7388.3 7461.8 7594.5 7641.8 813.4 928.1 939.6 1009.0 1015.8 25650.5 28204.7 28418.3 29359.7 29475.3 930.3 966.6 993.8 1001.1 1121.4 14413.4 14816.7 14971.4 15220.8 15287.5 658202.0 662859.0 664059.0 664239.0 664843.0 55086.0 55529.7 55654.7 55787.4 55831.7 1152.6 1197.7 1246.9 1336.0 1343.9 27943.6 29309.6 29322.0 29910.7 30090.7 47393.0 47709.8 47811.8 47882.0 47981.8 441449.8 519510.0 520000.0 520772.0 521308.0 22434.6 25460.2 25786.9 26170.5 26304.1 44159.8 44455.8 44690.0 44930.7 44963.6 36207.0 36523.5 36632.3 37270.0 37714.0 36050.8 36236.6 37235.6 37275.0 37366.0 35928.6 35950.6 36295.0 36522.6 36886.3 31646.7 33250.5 33281.0 33318.7 33423.0 22921.4 23892.0 24213.4 24604.9 24943.1 14:36:07 INFO - PROCESS | 1649 | 14:36:07 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:33836.83 Median:11198.09 stddev:92395.85 (825.1%) stddev-sans-first:92620.75 14:36:07 INFO - PROCESS | 1649 | Values: 312.5 352.4 375.5 375.5 405.1 14759.7 15321.5 15671.1 19986.1 20591.2 19190.3 19429.9 20045.3 20232.7 20340.0 5681.4 6052.1 6055.5 6055.6 6057.5 4556.5 5939.5 5985.0 5996.0 5998.5 5682.3 5926.9 5939.1 5943.5 5953.5 5712.6 5832.4 5832.9 5838.0 5840.6 4899.9 5088.9 5125.8 5130.2 5141.2 25350.5 25364.6 25468.2 25648.7 25696.4 2056.2 2081.2 2095.9 2274.0 2961.8 14580.4 15490.5 15558.9 15693.0 16182.2 1814.5 1845.0 1874.6 1917.1 1927.0 113142.4 113183.0 117976.8 118500.0 122082.0 10486.8 10640.9 10877.3 11037.3 11177.4 11541.4 13688.8 13691.9 13724.2 13738.5 7020.8 7969.7 8270.7 8292.1 8413.2 8273.1 8277.9 8279.8 8426.1 8455.5 6570.5 6581.7 6581.8 6593.0 6599.0 1507.7 1734.7 1812.3 1852.1 1853.4 782.3 903.7 922.6 949.0 966.6 20889.7 21577.9 21770.0 21804.9 21906.0 944.1 947.5 950.1 982.9 992.1 10984.2 11107.6 11561.4 11609.5 11727.2 457707.0 557189.0 567727.3 584175.0 585594.0 85123.0 117577.0 124770.0 131080.3 137489.3 906.5 954.0 1003.2 1004.8 1011.5 18862.6 19073.4 19267.7 19305.0 19376.2 53521.0 53917.5 53922.2 55244.7 55289.4 73494.7 74501.0 78065.2 81262.0 83995.3 11408.2 11490.2 12160.6 12225.1 12300.1 11179.7 13560.9 13709.4 13814.0 14128.6 10010.1 10755.8 11724.9 11937.2 11967.3 11408.0 11467.3 11681.2 11960.0 11979.6 11504.1 11605.2 11806.8 12058.6 12097.3 12024.9 12033.9 12059.4 12296.8 12358.4 11523.3 11733.4 11775.4 11854.1 11950.8 14:36:07 INFO - PROCESS | 1649 | 14:36:07 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5325.92 Median:4793.77 stddev:2956.47 (61.7%) stddev-sans-first:2949.33 14:36:07 INFO - PROCESS | 1649 | Values: 1306.8 1454.2 1579.7 1787.5 1824.9 7904.6 8361.0 8379.3 8396.5 8399.6 6815.0 6935.6 7279.3 7576.9 8183.3 2265.2 2308.7 2311.1 2314.5 2317.1 2301.6 2315.7 2336.2 2341.7 2344.9 2274.4 2287.4 2307.9 2309.9 2316.9 2200.2 2208.1 2234.0 2239.9 2240.8 2285.8 2310.4 2311.5 2314.3 2315.8 8113.7 8164.4 8310.1 8325.3 8376.7 4257.9 5167.4 5175.6 5177.1 5186.7 3135.9 3276.1 3528.6 3543.1 3544.2 1031.7 1032.8 1069.9 1077.3 1088.5 10598.3 10619.0 10774.6 10797.2 10814.4 4361.6 4454.0 4578.3 4578.7 4623.7 7950.3 9334.4 9342.9 9349.3 9368.1 5125.3 5129.7 5133.9 5140.2 5144.2 4125.2 4204.8 4372.3 4683.2 4712.7 3674.6 3691.4 3783.0 3814.6 3853.2 1243.7 1249.5 1254.3 1267.1 1268.3 813.7 818.2 844.9 859.5 865.6 5143.4 5272.7 5276.1 5584.4 5594.4 424.6 436.9 442.7 444.3 448.3 3585.4 3625.4 3642.3 3671.0 3814.5 9573.2 9956.9 10019.1 10094.1 10112.1 10031.2 10047.6 10078.3 10083.4 10088.7 7542.0 7734.3 7841.0 7841.9 7845.6 4835.5 5054.1 5601.4 5683.3 5793.1 9095.5 9279.1 9375.8 9376.2 9406.2 8908.3 9288.0 9297.4 9450.9 9503.1 6562.5 6751.5 6835.6 7012.3 7197.2 7620.2 7729.9 7831.4 7945.6 7965.2 6944.3 7063.1 7068.4 7090.1 7241.6 6711.8 6918.7 6942.7 6970.4 7013.7 5544.3 6366.0 6565.9 6612.1 6717.5 4667.6 4747.6 4778.0 4809.5 4879.2 4078.4 4456.2 4553.0 4681.3 4850.7 14:36:07 INFO - PROCESS | 1649 | 14:36:07 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4407.90 Median:4966.09 stddev:1329.07 (26.8%) stddev-sans-first:1296.48 14:36:07 INFO - PROCESS | 1649 | Values: 296.7 305.5 305.9 312.8 314.4 4369.8 4388.8 4539.3 5281.6 5307.3 4570.0 4992.7 5181.4 5288.3 5303.0 3511.0 3601.2 3885.8 3984.1 3988.8 3569.8 3726.6 3949.4 4015.6 4019.8 3401.0 3583.0 3706.6 3983.3 4025.5 3321.0 3769.1 3998.6 4034.5 4068.8 3141.7 3504.8 3513.5 3515.8 3525.7 4663.3 5076.9 5112.0 5158.8 5167.2 4503.7 4596.6 4634.3 4648.5 4665.4 4852.0 5461.9 5508.7 5517.8 5548.7 3872.8 3890.4 3893.3 3900.1 3911.8 5315.7 5836.9 5841.9 5854.9 5856.8 3545.4 3864.8 3947.7 3959.0 3970.1 3989.9 4003.0 4017.2 4018.7 4051.3 4640.8 4647.2 4658.4 4680.6 4681.9 5226.6 5249.0 5267.7 5560.6 5603.4 1299.4 1309.4 1312.2 1315.7 1325.7 787.4 796.9 892.5 900.1 900.3 4879.6 5039.7 5224.6 5253.9 5254.1 4762.4 5614.2 5635.2 5642.2 5643.3 5099.7 5281.5 5288.0 5292.7 5294.4 2506.9 2630.1 2752.6 2837.8 2839.1 5243.7 5584.4 5595.0 5612.8 5630.6 5026.4 5428.4 5532.6 5555.5 5680.8 5139.9 5658.7 5709.5 5773.0 5797.6 4807.0 4825.7 5100.6 5373.3 5518.5 4680.9 4801.9 5266.4 5298.8 5388.5 4720.5 5302.5 5315.0 5589.2 5667.9 3709.8 3712.4 3717.6 3727.9 3743.6 4589.7 4660.8 4939.5 5069.5 5389.2 4869.7 5198.2 5235.1 5239.6 5250.9 4316.8 4619.9 5111.9 5191.9 5282.9 5048.4 5070.4 5075.5 5514.7 5599.8 4245.5 5027.6 5042.9 5545.9 5609.2 4846.3 5487.8 5493.3 5509.4 5514.5 14:36:07 INFO - PROCESS | 1649 | 14:36:07 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:21842.67 Median:4347.15 stddev:32528.27 (748.3%) stddev-sans-first:32580.55 14:36:07 INFO - PROCESS | 1649 | Values: 636.7 704.1 758.6 759.2 780.0 14918.0 15808.2 15814.4 15831.7 15844.1 14147.4 14324.2 14326.0 14328.0 14329.5 642.1 663.6 664.2 813.5 826.2 806.3 832.4 837.5 842.7 846.0 881.8 882.5 882.7 883.3 890.2 574.8 698.9 875.9 878.9 879.9 625.4 652.4 657.2 658.1 659.1 14698.3 14717.9 14720.6 14728.5 14775.1 13357.6 13419.9 13475.5 13476.8 13574.2 12215.7 12311.8 12438.6 12529.9 12535.9 3961.7 4261.6 4339.2 4364.6 4379.3 99112.0 102259.0 120302.0 122480.0 122883.0 10351.0 10813.0 10815.2 10822.8 11214.9 21053.7 21151.0 21181.3 21506.2 21544.4 7794.7 7851.7 7861.7 7924.0 7992.0 4313.9 4349.8 4353.0 4357.7 4367.2 3469.7 3661.3 3669.8 3670.8 3678.0 585.8 611.9 649.3 661.1 674.5 539.5 585.3 655.1 674.0 695.7 9031.9 9060.3 9333.0 9351.5 9502.7 572.8 626.4 659.9 667.1 669.2 4344.5 4499.9 4558.9 4666.2 4685.5 101161.5 115121.5 120421.4 121237.4 123522.8 74045.0 92171.5 92780.0 98241.5 107715.0 82431.0 85854.6 87074.1 88041.6 88094.0 9417.6 9814.9 9976.6 9992.8 10068.8 57471.0 58664.4 59872.0 59956.5 60057.0 63326.0 67002.0 75556.0 84520.6 84720.6 11444.7 13092.9 13487.5 13501.7 14022.7 13155.0 13375.7 13423.3 13674.2 14076.0 12816.1 13429.8 13539.7 13905.5 14025.0 13187.8 13477.6 13707.8 13731.7 14404.0 13448.1 13612.7 13684.5 13786.0 14287.9 10504.7 11023.8 11201.8 11542.2 11717.5 10936.7 11368.0 11387.4 11445.5 11610.3 14:36:07 INFO - PROCESS | 1649 | -------- Summary: end -------- 14:36:07 INFO - PROCESS | 1649 | 14:36:07 INFO - TEST-INFO | 1649: exit 0 14:36:07 INFO - TEST-OK | dromaeo_css | took 1119467ms 14:36:07 INFO - TEST-START | kraken 14:36:07 INFO - operating with platform_type : mac_ 14:36:07 INFO - Initialising browser for kraken test... 14:36:07 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmp4BehGT/profile http://localhost:49244/getInfo.html) 14:36:10 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 14:36:10 INFO - PROCESS | 1657 | colorDepth:24 14:36:10 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 14:36:10 INFO - PROCESS | 1657 | __metrics 14:36:10 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:36:10 INFO - PROCESS | 1657 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:36:11 INFO - TEST-INFO | 1657: exit 0 14:36:11 INFO - Browser initialized. 14:36:11 INFO - Running cycle 1/1 for kraken test... 14:36:11 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/tmp4BehGT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:36:23 INFO - PROCESS | 1658 | RSS: Main: 244277248 14:36:23 INFO - PROCESS | 1658 | 14:36:26 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 14:36:27 INFO - PROCESS | 1658 | RSS: Main: 295919616 14:36:27 INFO - PROCESS | 1658 | 14:36:30 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 14:36:30 INFO - PROCESS | 1658 | RSS: Main: 298942464 14:36:30 INFO - PROCESS | 1658 | 14:36:34 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 14:36:34 INFO - PROCESS | 1658 | RSS: Main: 390000640 14:36:34 INFO - PROCESS | 1658 | 14:36:36 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 14:36:37 INFO - PROCESS | 1658 | RSS: Main: 291020800 14:36:37 INFO - PROCESS | 1658 | 14:36:39 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:36:40 INFO - PROCESS | 1658 | RSS: Main: 293998592 14:36:40 INFO - PROCESS | 1658 | 14:36:42 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 14:36:43 INFO - PROCESS | 1658 | RSS: Main: 335855616 14:36:43 INFO - PROCESS | 1658 | 14:36:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 14:36:46 INFO - PROCESS | 1658 | RSS: Main: 337326080 14:36:46 INFO - PROCESS | 1658 | 14:36:49 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 14:36:50 INFO - PROCESS | 1658 | RSS: Main: 334688256 14:36:50 INFO - PROCESS | 1658 | 14:36:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:36:52 INFO - PROCESS | 1658 | RSS: Main: 310173696 14:36:52 INFO - PROCESS | 1658 | 14:36:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:36:55 INFO - PROCESS | 1658 | RSS: Main: 314515456 14:36:55 INFO - PROCESS | 1658 | 14:36:57 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:36:58 INFO - PROCESS | 1658 | RSS: Main: 317333504 14:36:58 INFO - PROCESS | 1658 | 14:37:01 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:37:02 INFO - PROCESS | 1658 | RSS: Main: 334688256 14:37:02 INFO - PROCESS | 1658 | 14:37:04 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:37:05 INFO - PROCESS | 1658 | RSS: Main: 328224768 14:37:05 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 14:37:07 INFO - PROCESS | 1658 | RSS: Main: 371802112 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | __start_tp_report 14:37:07 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 14:37:07 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 14:37:07 INFO - PROCESS | 1658 | |i|pagename|runs| 14:37:07 INFO - PROCESS | 1658 | |0;ai-astar;113;116;115;115;114;115;114;114;115;114 14:37:07 INFO - PROCESS | 1658 | |1;audio-beat-detection;152;115;116;151;113;114;116;115;134;113 14:37:07 INFO - PROCESS | 1658 | |2;audio-dft;187;182;192;185;185;182;209;262;184;183 14:37:07 INFO - PROCESS | 1658 | |3;audio-fft;82;58;59;89;61;58;58;73;64;58 14:37:07 INFO - PROCESS | 1658 | |4;audio-oscillator;86;70;84;70;69;91;105;94;73;83 14:37:07 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;89;86;88;85;87;85;89;85;89;86 14:37:07 INFO - PROCESS | 1658 | |6;imaging-darkroom;95;95;95;95;94;98;94;94;95;94 14:37:07 INFO - PROCESS | 1658 | |7;imaging-desaturate;88;87;84;105;141;100;87;88;87;85 14:37:07 INFO - PROCESS | 1658 | |8;json-parse-financial;58;53;57;55;56;56;56;57;55;57 14:37:07 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;71;68;64;79;72;69;69;72;69;71 14:37:07 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;88;88;87;87;97;104;104;80;89;89 14:37:07 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;156;169;157;166;154;158;158;164;216;180 14:37:07 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;177;177;172;173;177;179;169;175;174;175 14:37:07 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;72;80;88;67;64;88;84;86;84;67 14:37:07 INFO - PROCESS | 1658 | __end_tp_report 14:37:07 INFO - PROCESS | 1658 | __start_cc_report 14:37:07 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1979 14:37:07 INFO - PROCESS | 1658 | __end_cc_report 14:37:07 INFO - PROCESS | 1658 | __startTimestamp1480718227764__endTimestamp 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | ------- Summary: start ------- 14:37:07 INFO - PROCESS | 1658 | Number of tests: 14 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:0.85 (0.7%) stddev-sans-first:0.71 14:37:07 INFO - PROCESS | 1658 | Values: 113.0 116.0 115.0 115.0 114.0 115.0 114.0 114.0 115.0 114.0 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:116.00 stddev:15.79 (13.6%) stddev-sans-first:13.07 14:37:07 INFO - PROCESS | 1658 | Values: 152.0 115.0 116.0 151.0 113.0 114.0 116.0 115.0 134.0 113.0 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:195.10 Median:186.00 stddev:24.86 (13.4%) stddev-sans-first:26.19 14:37:07 INFO - PROCESS | 1658 | Values: 187.0 182.0 192.0 185.0 185.0 182.0 209.0 262.0 184.0 183.0 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:66.00 Median:62.50 stddev:11.39 (18.2%) stddev-sans-first:10.51 14:37:07 INFO - PROCESS | 1658 | Values: 82.0 58.0 59.0 89.0 61.0 58.0 58.0 73.0 64.0 58.0 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:82.50 Median:83.50 stddev:12.07 (14.5%) stddev-sans-first:12.73 14:37:07 INFO - PROCESS | 1658 | Values: 86.0 70.0 84.0 70.0 69.0 91.0 105.0 94.0 73.0 83.0 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:87.50 stddev:1.73 (2.0%) stddev-sans-first:1.66 14:37:07 INFO - PROCESS | 1658 | Values: 89.0 86.0 88.0 85.0 87.0 85.0 89.0 85.0 89.0 86.0 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:95.00 stddev:1.20 (1.3%) stddev-sans-first:1.27 14:37:07 INFO - PROCESS | 1658 | Values: 95.0 95.0 95.0 95.0 94.0 98.0 94.0 94.0 95.0 94.0 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:87.00 stddev:17.49 (20.1%) stddev-sans-first:18.35 14:37:07 INFO - PROCESS | 1658 | Values: 88.0 87.0 84.0 105.0 141.0 100.0 87.0 88.0 87.0 85.0 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.50 stddev:1.41 (2.5%) stddev-sans-first:1.30 14:37:07 INFO - PROCESS | 1658 | Values: 58.0 53.0 57.0 55.0 56.0 56.0 56.0 57.0 55.0 57.0 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:71.00 stddev:3.84 (5.4%) stddev-sans-first:4.06 14:37:07 INFO - PROCESS | 1658 | Values: 71.0 68.0 64.0 79.0 72.0 69.0 69.0 72.0 69.0 71.0 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:88.00 stddev:7.83 (8.9%) stddev-sans-first:8.22 14:37:07 INFO - PROCESS | 1658 | Values: 88.0 88.0 87.0 87.0 97.0 104.0 104.0 80.0 89.0 89.0 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:167.80 Median:165.00 stddev:18.65 (11.3%) stddev-sans-first:19.28 14:37:07 INFO - PROCESS | 1658 | Values: 156.0 169.0 157.0 166.0 154.0 158.0 158.0 164.0 216.0 180.0 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.80 Median:176.00 stddev:2.94 (1.7%) stddev-sans-first:3.00 14:37:07 INFO - PROCESS | 1658 | Values: 177.0 177.0 172.0 173.0 177.0 179.0 169.0 175.0 174.0 175.0 14:37:07 INFO - PROCESS | 1658 | 14:37:07 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.00 Median:84.00 stddev:9.51 (11.3%) stddev-sans-first:9.84 14:37:07 INFO - PROCESS | 1658 | Values: 72.0 80.0 88.0 67.0 64.0 88.0 84.0 86.0 84.0 67.0 14:37:07 INFO - PROCESS | 1658 | -------- Summary: end -------- 14:37:07 INFO - PROCESS | 1658 | 14:37:08 INFO - TEST-INFO | 1658: exit 0 14:37:08 INFO - TEST-OK | kraken | took 60870ms 14:37:08 INFO - SUITE-END | took 1180s 14:37:08 INFO - Completed test suite (00:19:40) 14:37:08 INFO - javascript benchmark 14:37:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2890.407466469374, 3183.9174680608603, 3296.0, 3320.817355045472, 3341.3150304187643, 5532.529734972532, 5652.773889044439, 5691.943080569204, 5735.770569177228, 5742.39704830993, 5668.914966275499, 5741.224934633823, 5832.591718579701, 5841.386654401291, 5883.8529036774, 5124.436312005695, 5165.896682066356, 5186.299849520305, 5216.947830521684, 5257.789688412478, 5301.0, 5319.148936170213, 5321.148616221405, 5329.493698098694, 5337.866553336178, 5161.148410512261, 5316.282301889234, 5317.441668624778, 5334.946650533484, 5391.379991300992, 5254.684718916839, 5261.710605916673, 5263.394709608406, 5270.183121616155, 5277.6305658603915, 5154.0, 5173.870653233662, 5196.974015129938, 5198.16829307309, 5237.266782650432, 5715.199872017921, 5724.5992780505385, 5726.969145553799, 5739.0, 5741.856453588652, 6154.599951003171, 6162.014077747539, 6176.660283684396, 6198.2252218472695, 6211.409916057967, 6172.506199504029, 6224.06639004153, 6235.96882015587, 6239.906401403982, 6242.282137554149, 5827.067669172912, 5829.271341082364, 5833.854153646151, 5843.853903652443, 5873.882522349529, 6194.38056194386, 6194.659293738888, 6218.160548325918, 6245.0, 6249.34381889895, 5039.193729003415, 6026.879462410728, 6040.909386359208, 6041.365656606081, 6084.4828189603495, 6172.444479996732, 6179.227596550431, 6187.938120618826, 6188.4739797116845, 6192.969035154795, 6062.393760623902, 6077.1491991121275, 6099.9085013724825, 6102.307478454246, 6134.294556126013, 6138.202033735586, 6140.302668458633, 6188.0, 6197.907031394533, 6228.626282422979, 4901.8970731585105, 4906.435759887588, 4914.975425122851, 4916.385451818523, 4939.827106051271, 4365.257906155961, 4383.539728328544, 4418.447694038246, 4434.224010798098, 4460.107978404332, 5731.312242530923, 5748.511376533042, 5827.7668893244645, 5833.300003999547, 5857.970710146507, 6165.10605962133, 6229.0, 6238.906416403667, 6241.032639940726, 6242.09489624002, 5839.532837373, 5857.7656893724625, 5879.265091863517, 5883.911741323884, 5902.911456328158, 5292.417834038252, 5329.0, 5346.4386239445075, 5388.0570900092325, 5390.811321603804, 6168.506519478341, 6175.413335733098, 6210.813675589739, 6227.595206311576, 6237.251529816451, 5487.478689524489, 6007.249093863267, 6061.7575296987625, 6219.875602487835, 6227.9377206227355, 5222.2688823565495, 6181.412765787243, 6193.535484838565, 6228.719707613259, 6254.937450625435, 6100.633961962297, 6109.799438327801, 6121.755129794758, 6132.569672417391, 6145.678679084019, 6229.719662615103, 6243.875122497616, 6256.124142619946, 6260.342664020394, 6270.843228919313, 6152.046432802923, 6162.537809664203, 6173.012318029094, 6179.0, 6182.629042257479, 6003.90994135097, 6079.574429789872, 6089.878202436015, 6102.206713127265, 6151.723172457339, 4541.887237626671, 5849.3858144894175, 5918.911216331845, 5955.255593050869, 5971.850703732442, 6109.572329936862, 6111.663858487826, 6111.99152139892, 6112.877742445037, 6117.96941015292, 4950.851474455772, 5922.585419020627, 5971.522278217819, 5980.252468441445, 5986.700664966821], "value": 5666.77797560121, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.5455435455835, 475.3653872080772, 488.76539261154625, 525.4141632080232, 558.9496945274927, 37761.0, 39025.21949561007, 39278.643281403136, 39314.2137157257, 40873.79563102188, 39443.40834887472, 39967.600323996754, 39998.60001399985, 40019.0, 40079.39880901782, 8242.093369729355, 8461.53461559614, 9096.090390960917, 9281.21109705676, 9292.674756383529, 10768.515416806262, 11075.446227688582, 11076.556937722482, 11242.775144497105, 11265.718357041058, 11050.613228537002, 11118.110551155889, 11135.721606959809, 11140.554377824878, 11150.665480035572, 11053.778924421507, 11129.165312601506, 11131.944340278327, 11134.33194008362, 11166.0, 10907.509162087646, 10992.120630349553, 10997.34015959045, 11010.834837477445, 11026.614068507644, 38066.619333806586, 38321.467141314315, 38361.04097397559, 38479.0, 38632.61367386347, 2943.617329747119, 3151.4012337656, 3260.8043517389033, 3273.8035717857006, 3614.8192590370377, 28969.130926072252, 29418.0, 29517.409651806844, 29531.114066578037, 29582.40835183306, 3037.9696203037906, 3139.7331226845745, 3183.856726447292, 3190.170555655523, 3275.0, 392912.0, 461266.0, 463236.68381658214, 463475.0, 464295.0, 57875.0, 58233.4176658228, 58369.70815145897, 58440.83118337695, 58597.12104318439, 61414.38585614086, 61487.0, 61527.38472615306, 61597.0, 61762.0, 15141.621459463602, 15636.92181539085, 15653.139077350856, 15660.216989150496, 15685.215739212994, 10923.126149907988, 11170.609028683957, 11173.776524469466, 11369.488373023234, 11975.700607484883, 15731.011107889464, 15849.207539622972, 17471.126443677764, 17769.46691599254, 17977.19102640384, 6622.635755033423, 7388.298111679382, 7461.813454663677, 7594.5063570867715, 7641.847163056819, 813.3777660090036, 928.1461055828654, 939.6234516433458, 1009.0414106598761, 1015.8476228565775, 25650.48699026009, 28204.717952820618, 28418.294902305926, 29359.706402936125, 29475.263118421783, 930.3487558708931, 966.5602151021268, 993.7664648807524, 1001.1240164855751, 1121.3832392184265, 14413.423463061361, 14816.703665926621, 14971.401143954337, 15220.771688424682, 15287.464938727091, 658202.0, 662859.0, 664059.0, 664239.0, 664843.0, 55086.0, 55529.722351388795, 55654.721726391916, 55787.44212557904, 55831.72084139553, 1152.6138743521014, 1197.7125489882364, 1246.9314187719763, 1336.0046765160018, 1343.9193648381129, 27943.58084628773, 29309.560356595095, 29322.041524394786, 29910.70089299079, 30090.69909300879, 47393.0, 47709.76145119252, 47811.76094119507, 47882.0, 47981.76009119932, 441449.7927510342, 519510.0, 520000.0, 520772.0, 521308.0, 22434.5513089734, 25460.236192914243, 25786.8710656453, 26170.476590467704, 26304.079357222407, 44159.77920110379, 44455.777721112485, 44690.0, 44930.65208043633, 44963.55036449594, 36207.0, 36523.452148217264, 36632.26735465223, 37270.0, 37714.0, 36050.819745902154, 36236.63763362438, 37235.627643723215, 37275.0, 37366.0, 35928.64071359253, 35950.640493595776, 36295.0, 36522.634773651924, 36886.26227475489, 31646.683533165295, 33250.50124248186, 33281.0, 33318.666813331554, 33423.0, 22921.426964326027, 23892.0, 24213.394665133514, 24604.876975615007, 24943.12926530554], "value": 19440.116594589108, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.50312003913774, 352.4114728403569, 375.46683709133026, 375.498709223187, 405.05015738094176, 14759.70480590389, 15321.540353789376, 15671.05973641581, 19986.101320374542, 20591.176352945866, 19190.328338508156, 19429.931353775537, 20045.298414555495, 20232.69650955237, 20340.0, 5681.403452637486, 6052.092186172087, 6055.545834062441, 6055.606385584945, 6057.51539876811, 4556.498785133649, 5939.524838012949, 5984.970075149618, 5995.970020149915, 5998.4901283390745, 5682.318121825387, 5926.940730592703, 5939.109133629969, 5943.494802941756, 5953.523718102541, 5712.571557133231, 5832.387599302076, 5832.912506312387, 5837.97835378807, 5840.561957853136, 4899.853004409873, 5088.949110508885, 5125.769340379692, 5130.230070625628, 5141.177411614161, 25350.49299014028, 25364.61953070687, 25468.23595292144, 25648.743512564823, 25696.357591060187, 2056.1775289884167, 2081.198738485679, 2095.905684244213, 2274.0, 2961.822290662567, 14580.416783328654, 15490.535283941499, 15558.922205389013, 15692.979956302917, 16182.190890455548, 1814.4738025972583, 1844.9907750461296, 1874.6157037807218, 1917.0606402862497, 1926.9903650481658, 113142.43428782886, 113183.0, 117976.82023179744, 118500.0, 122082.0, 10486.842697359545, 10640.8500684733, 10877.347359158475, 11037.282576632493, 11177.385243811668, 11541.422928853524, 13688.794668079987, 13691.931540342433, 13724.176549407068, 13738.519151829638, 7020.824479388056, 7969.72105976288, 8270.710525131592, 8292.087870334379, 8413.15868413166, 8273.131321211185, 8277.917220827836, 8279.793005174919, 8426.115257897833, 8455.534945578052, 6570.507211959027, 6581.670916454158, 6581.83545411359, 6593.0, 6599.007600401688, 1507.6683129711446, 1734.6790843693705, 1812.2660322569118, 1852.120242884646, 1853.3883818339916, 782.3193821375439, 903.7108125399809, 922.6032805893396, 949.0177666115537, 966.6326795817545, 20889.686654700192, 21577.892110539662, 21770.0, 21804.890975545022, 21906.0142293594, 944.1078181118777, 947.5120313038791, 950.078423928788, 982.9017098290113, 992.0525897767615, 10984.176186785864, 11107.55569777216, 11561.364124973206, 11609.477573509212, 11727.237729547553, 457707.0, 557189.0, 567727.3227267757, 584175.0, 585594.0, 85123.0, 117577.0, 124770.0, 131080.3445982764, 137489.31255343658, 906.4651855405342, 953.9856902146473, 1003.2024540490328, 1004.829179039565, 1011.4841430870162, 18862.622747545247, 19073.427797166107, 19267.710984334964, 19305.034748262813, 19376.2249510018, 53521.0, 53917.460825392816, 53922.19116713174, 55244.72377638086, 55289.44710552843, 73494.66853963425, 74501.0, 78065.21934780579, 81262.0, 83995.28037757087, 11408.201425900439, 11490.208002073648, 12160.574379896661, 12225.144239903122, 12300.138990270952, 11179.72050698739, 13560.932195339356, 13709.383077761724, 13814.0, 14128.646783830487, 10010.099091081547, 10755.784884302426, 11724.88275117238, 11937.224080434744, 11967.281963082243, 11408.0, 11467.31196128235, 11681.182317237712, 11960.043196544082, 11979.580714674945, 11504.137189710973, 11605.187636865337, 11806.82289765637, 12058.638240852788, 12097.274163550215, 12024.939875300917, 12033.939830300793, 12059.432273804348, 12296.81554776697, 12358.382080896099, 11523.308601483937, 11733.413329333669, 11775.352355620524, 11854.051675865738, 11950.760984780429], "value": 9880.232885651154, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.8366454193226, 1454.2001898955575, 1579.6524764551796, 1787.535240837382, 1824.9178786954594, 7904.5652489113145, 8360.958195209016, 8379.32965362771, 8396.496210227382, 8399.622017009235, 6814.97775333699, 6935.583864968093, 7279.272072792718, 7576.88634670479, 8183.263506284433, 2265.150568536799, 2308.7114110736156, 2311.05246848792, 2314.467672435341, 2317.1310758465575, 2301.620232661609, 2315.7452680205247, 2336.19401306549, 2341.7424083350816, 2344.929652110431, 2274.37454699958, 2287.3938406322254, 2307.8846057697133, 2309.93070207894, 2316.9420764480938, 2200.2189222825987, 2208.149862303009, 2234.0, 2239.85440946338, 2240.753517113108, 2285.8171346292256, 2310.3761984264156, 2311.5492478966607, 2314.271004633552, 2315.8263130265127, 8113.675452981874, 8164.387670924704, 8310.085890552034, 8325.333973282122, 8376.748697539084, 4257.8509752158525, 5167.379914410295, 5175.560077393426, 5177.068127737006, 5186.7147306898105, 3135.8588863501195, 3276.1318250663594, 3528.6294939031545, 3543.114221444639, 3544.220271540257, 1031.6647089695805, 1032.7676272838626, 1069.8930106989317, 1077.299755159145, 1088.455772113943, 10598.311109777916, 10619.0, 10774.5690172393, 10797.244192906499, 10814.35113893169, 4361.629261512807, 4454.0, 4578.336141259499, 4578.748168850745, 4623.69945953512, 7950.324222441157, 9334.439933604006, 9342.859857102148, 9349.298802589698, 9368.110029547182, 5125.33370661819, 5129.666571672829, 5133.8716532087, 5140.203268493389, 5144.151215049475, 4125.23683118624, 4204.810783514749, 4372.322290045048, 4683.15703173432, 4712.670113092119, 3674.6141655125825, 3691.354013047706, 3782.962170378316, 3814.5613254475534, 3853.190829925691, 1243.720162963326, 1249.4627310256676, 1254.3101294288106, 1267.1256832785348, 1268.2580690296095, 813.6948644258404, 818.2267756969726, 844.9070056872642, 859.4542465534431, 865.6148014133776, 5143.3570803649545, 5272.736363181825, 5276.076686579833, 5584.352615978296, 5594.440555944454, 424.5733038296554, 436.9213541562486, 442.7321470510295, 444.26917720349843, 448.28050978180204, 3585.3904836177912, 3625.4018087015347, 3642.25333806569, 3670.953778173208, 3814.5422549294262, 9573.234141268682, 9956.900430995598, 10019.098281154731, 10094.091531762177, 10112.089911907964, 10031.197504199647, 10047.598096076075, 10078.344907580984, 10083.394996300245, 10088.69733907984, 7542.0, 7734.303912647776, 7841.0, 7841.902133701286, 7845.646945887449, 4835.540623640749, 5054.064997975239, 5601.411851755507, 5683.261176047087, 5793.102069179284, 9095.454272743656, 9279.118483744034, 9375.765605859635, 9376.249900008119, 9406.212819564262, 8908.287337013153, 9288.0, 9297.442153470813, 9450.905490945002, 9503.097205765442, 6562.50781191403, 6751.527393082437, 6835.624040677611, 7012.333828286304, 7197.208307086321, 7620.199879012624, 7729.884051739341, 7831.373490120663, 7945.562994035384, 7965.163657816078, 6944.305569443015, 7063.117110361205, 7068.434525237866, 7090.07828982229, 7241.601711905896, 6711.798646040626, 6918.723251070102, 6942.652867356713, 6970.372666460043, 7013.719451222098, 5544.279243698294, 6366.0, 6565.934340656723, 6612.140421745143, 6717.462602991651, 4667.649926255613, 4747.620190384692, 4778.0, 4809.5430934061205, 4879.194932836042, 4078.388241763759, 4456.17560751262, 4552.9544704553855, 4681.321208424692, 4850.733209673502], "value": 4248.201288998449, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.74776440025977, 305.5035567203294, 305.87459141751873, 312.84201478253476, 314.3791012749821, 4369.847055353063, 4388.846390376338, 4539.296409056593, 5281.570477580313, 5307.328191619642, 4570.0, 4992.700437973725, 5181.4300426953005, 5288.2596436498925, 5303.045451818671, 3510.964890351102, 3601.2257364666593, 3885.805709714517, 3984.0836607580127, 3988.78061706606, 3569.7501174917766, 3726.6087060858627, 3949.407588861665, 4015.638592526672, 4019.7588144711262, 3400.9829950850212, 3583.0325812030865, 3706.629337066299, 3983.302921988655, 4025.4565633639522, 3320.9833950830093, 3769.095417099876, 3998.620475935812, 4034.515858097018, 4068.7558746475156, 3141.7329526990234, 3504.8422820972864, 3513.508108864761, 3515.806630635314, 3525.7179425645886, 4663.27719203524, 5076.923846142311, 5111.974440127813, 5158.845234642967, 5167.165656192073, 4503.6580977891645, 4596.609288210506, 4634.328022436762, 4648.488666246744, 4665.440147182359, 4851.951480485221, 5461.918071228934, 5508.724563771795, 5517.779288828442, 5548.722563871831, 3872.7869967151796, 3890.3580909149955, 3893.27974324748, 3900.0694656145106, 3911.8044097794996, 5315.654482458628, 5836.941630583682, 5841.948449279128, 5854.912176317359, 5856.795012174553, 3545.3972824619877, 3864.8260828262796, 3947.703922205846, 3959.040275063862, 3970.134037002604, 3989.9002524936527, 4003.0, 4017.1965606878157, 4018.7186896916937, 4051.2505186540584, 4640.79116439761, 4647.233206520954, 4658.3711198988385, 4680.555347242007, 4681.9297710534365, 5226.555742761831, 5249.028929648028, 5267.656747529356, 5560.610757247035, 5603.439656034364, 1299.4282515693064, 1309.3845892430543, 1312.2323440787056, 1315.7171208190284, 1325.6884632111446, 787.3701039168642, 796.9203079692101, 892.5358813416987, 900.0954041188563, 900.2707806676482, 4879.634027447884, 5039.672421292605, 5224.582033437316, 5253.921191182136, 5254.054270231395, 4762.428508578923, 5614.192903548226, 5635.21107045014, 5642.153676948491, 5643.250592316395, 5099.745012749348, 5281.524662780368, 5288.0, 5292.735363231823, 5294.364676238876, 2506.94986100277, 2630.1057640401973, 2752.582420053674, 2837.8297302161936, 2839.091490722949, 5243.659162154448, 5584.357798853102, 5594.964931487688, 5612.803551875665, 5630.577706672016, 5026.447090820006, 5428.430014848463, 5532.5573954083575, 5555.527800120942, 5680.7727690892725, 5139.948600513947, 5658.74535645897, 5709.51469125129, 5772.9711351442975, 5797.565182611321, 4807.010181549375, 4825.662203645711, 5100.6429549931145, 5373.301470808769, 5518.475744804237, 4680.882977925579, 4801.879953001203, 5266.368035835724, 5298.761555730079, 5388.548210564106, 4720.504347043511, 5302.522772950453, 5315.0, 5589.245451864109, 5667.943320566907, 3709.7572313274277, 3712.368897287414, 3717.5910649827956, 3727.9440808387353, 3743.606921273336, 4589.655775816894, 4660.7669616519715, 4939.481354457874, 5069.476713683955, 5389.245505629294, 4869.732164730974, 5198.194279886624, 5235.136202526541, 5239.633225674166, 5250.868728281824, 4316.827326906889, 4619.907601847877, 5111.897762044812, 5191.896162076813, 5282.917002014655, 5048.3941926969, 5070.41690205631, 5075.543201111917, 5514.724263786875, 5599.776008959596, 4245.49054113496, 5027.59779217669, 5042.949570504248, 5545.944540554543, 5609.21470994053, 4846.345743324747, 5487.832306238934, 5493.253373313343, 5509.449055094458, 5514.546027017938], "value": 3984.5060820682243, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.729390009246, 704.0776582676693, 758.5676164586188, 759.1990450075168, 780.0483410239509, 14918.0, 15808.209589520508, 15814.367425303002, 15831.683366332667, 15844.12857292847, 14147.434102635882, 14324.212168330738, 14325.99718019739, 14327.997040207163, 14329.498467553638, 642.1138828416779, 663.6217356107021, 664.1996394344827, 813.544415127529, 826.1985873702499, 806.2985202873479, 832.4422636833306, 837.5058715357937, 842.7429633961639, 845.9619317130713, 881.8104107616861, 882.4925667741043, 882.7307671160294, 883.3021912688968, 890.185480285538, 574.7672192761938, 698.930106989297, 875.8729984152294, 878.8901387326616, 879.8504254276725, 625.3715016408526, 652.3997921911805, 657.1522735670978, 658.098405184895, 659.0509666080828, 14698.33857476416, 14717.926410367987, 14720.631984200374, 14728.484503042342, 14775.113493190443, 13357.599272021855, 13419.865801342057, 13475.528356507475, 13476.797848032287, 13574.185548867099, 12215.694607634792, 12311.75376492474, 12438.564650237198, 12529.93735031319, 12535.874641253562, 3961.7424867383816, 4261.552536983603, 4339.218940590692, 4364.585364390409, 4379.343098535245, 99112.0, 102258.99999999926, 120302.0, 122480.0, 122883.0, 10351.0, 10813.0, 10815.242932994772, 10822.837657435144, 11214.887851121384, 21053.684194737092, 21151.04820283091, 21181.258655946967, 21506.247281345077, 21544.353669389944, 7794.727184548514, 7851.685932562634, 7861.685532578747, 7923.960380198062, 7991.960040199761, 4313.935290970638, 4349.782510874444, 4353.0, 4357.652834669616, 4367.170237654836, 3469.670381313771, 3661.2860492203763, 3669.798161101112, 3670.7614005089586, 3677.9816100919325, 585.7861880413618, 611.8990366589463, 649.331188875459, 661.0579923608839, 674.4705406256065, 539.463234082083, 585.28887401807, 655.1483072006373, 674.0327629851179, 695.7112798188695, 9031.871016122985, 9060.285283034056, 9333.0, 9351.532423378803, 9502.667406640872, 572.7565784541553, 626.4330780643525, 659.8779225843139, 667.1027468055457, 669.2069897171867, 4344.522102568715, 4499.88750281239, 4558.931616025762, 4666.183417901853, 4685.508021657677, 101161.49419252857, 115121.54635360952, 120421.39789300997, 121237.39381303213, 123522.76477235113, 74045.0, 92171.53914230385, 92780.0, 98241.50879245558, 107715.0, 82431.0, 85854.57072714722, 87074.1292587066, 88041.55979220063, 88094.0, 9417.62329506812, 9814.9018509814, 9976.551055202388, 9992.800143997225, 10068.798624027624, 57471.0, 58664.413355865894, 59872.0, 59956.45051739961, 60057.0, 63326.0, 67002.0, 75556.0, 84520.57739711262, 84720.64595155265, 11444.656660300205, 13092.869071309546, 13487.460501579826, 13501.662458438617, 14022.719545609234, 13155.0, 13375.665608359868, 13423.26172060546, 13674.247916364298, 14076.0, 12816.066899175665, 13429.798553021517, 13539.661508462368, 13905.513307034205, 14025.0, 13187.80218296707, 13477.595672129852, 13707.794383084462, 13731.656708582366, 14404.0, 13448.1258718183, 13612.65968350799, 13684.45262189541, 13786.034977551475, 14287.928560357132, 10504.684859454228, 11023.83464248053, 11201.831972520256, 11542.249753765978, 11717.472713728073, 10936.726581835517, 11368.013491532694, 11387.43062846871, 11445.48495317696, 11610.303381797119], "value": 7539.5069067099275, "unit": "score"}], "name": "dromaeo_css", "value": 7196.628304737453, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 115.0, 115.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 115.0, 116.0, 151.0, 113.0, 114.0, 116.0, 115.0, 134.0, 113.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 182.0, 192.0, 185.0, 185.0, 182.0, 209.0, 262.0, 184.0, 183.0], "value": 195.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 89.0, 61.0, 58.0, 58.0, 73.0, 64.0, 58.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 84.0, 70.0, 69.0, 91.0, 105.0, 94.0, 73.0, 83.0], "value": 82.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 85.0, 87.0, 85.0, 89.0, 85.0, 89.0, 86.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 98.0, 94.0, 94.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 84.0, 105.0, 141.0, 100.0, 87.0, 88.0, 87.0, 85.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 57.0, 55.0, 56.0, 56.0, 56.0, 57.0, 55.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 64.0, 79.0, 72.0, 69.0, 69.0, 72.0, 69.0, 71.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 87.0, 87.0, 97.0, 104.0, 104.0, 80.0, 89.0, 89.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 169.0, 157.0, 166.0, 154.0, 158.0, 158.0, 164.0, 216.0, 180.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 172.0, 173.0, 177.0, 179.0, 169.0, 175.0, 174.0, 175.0], "value": 174.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 80.0, 88.0, 67.0, 64.0, 88.0, 84.0, 86.0, 84.0, 67.0], "value": 78.0, "unit": "score"}], "name": "kraken", "value": 1497.3, "alertThreshold": 2.0}]} 14:37:09 INFO - Return code: 0 14:37:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:37:09 INFO - # TBPL SUCCESS # 14:37:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:37:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:37:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:37:09 INFO - 2016-12-02 14:37:09.104 screenresolution[1662:10638] starting screenresolution argv=screenresolution get 14:37:09 INFO - 2016-12-02 14:37:09.107 screenresolution[1662:10638] Display 0: 1600x1200x32@60 14:37:09 INFO - 2016-12-02 14:37:09.113 screenresolution[1663:10641] starting screenresolution argv=screenresolution list 14:37:09 INFO - Available Modes on Display 0 14:37:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:37:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:37:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:37:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:37:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:37:09 INFO - Intel Iris: 14:37:09 INFO - Chipset Model: Intel Iris 14:37:09 INFO - Type: GPU 14:37:09 INFO - Bus: Built-In 14:37:09 INFO - VRAM (Dynamic, Max): 1536 MB 14:37:09 INFO - Vendor: Intel (0x8086) 14:37:09 INFO - Device ID: 0x0a2e 14:37:09 INFO - Revision ID: 0x0009 14:37:09 INFO - Displays: 14:37:09 INFO - Display: 14:37:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:37:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:37:09 INFO - Display Serial Number: 1600x1200 60 14:37:09 INFO - Main Display: Yes 14:37:09 INFO - Mirror: Off 14:37:09 INFO - Online: Yes 14:37:09 INFO - Rotation: Supported 14:37:09 INFO - Return code: 0 14:37:09 INFO - Running post-action listener: _resource_record_post_action 14:37:09 INFO - [mozharness: 2016-12-02 22:37:09.355218Z] Finished run-tests step (success) 14:37:09 INFO - Running post-run listener: _resource_record_post_run 14:37:09 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 32361472; Write bytes: 698198016; Read time: 196; Write time: 2009 14:37:09 INFO - TinderboxPrint: CPU usage
53.8% 14:37:09 INFO - TinderboxPrint: I/O read bytes / time
32,361,472 / 196 14:37:09 INFO - TinderboxPrint: I/O write bytes / time
698,198,016 / 2,009 14:37:09 INFO - TinderboxPrint: CPU idle
2,248.1 (46.2%) 14:37:09 INFO - TinderboxPrint: CPU system
972.8 (20.0%) 14:37:09 INFO - TinderboxPrint: CPU user
1,640.8 (33.7%) 14:37:09 INFO - TinderboxPrint: Swap in / out
412,573,696 / 0 14:37:09 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 383230464; Write bytes: 377370112; Read time: 29496; Write time: 822 14:37:09 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 29207552; Write bytes: 310501888; Read time: 174; Write time: 1151 14:37:09 INFO - Running post-run listener: _upload_blobber_files 14:37:09 INFO - Blob upload gear active. 14:37:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:37:09 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 14:37:09 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:37:09 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:37:10 INFO - (blobuploader) - INFO - Open directory for files ... 14:37:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:37:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:37:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:11 INFO - (blobuploader) - INFO - Done attempting. 14:37:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:37:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:37:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:14 INFO - (blobuploader) - INFO - Done attempting. 14:37:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:37:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:37:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:16 INFO - (blobuploader) - INFO - Done attempting. 14:37:16 INFO - (blobuploader) - INFO - Iteration through files over. 14:37:16 INFO - Return code: 0 14:37:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:37:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:37:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f22d7744c4cdf94bb6ffe84f156202715736c4189b00480c20c24184716d4f3b4a5a942e2e6a8b916ae8ed3b893de605ffcdf7b98544fabf7e264e93a78434af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/939ca8283b75fba526054e44b490717d44eb25cdd636fb7e8d22bdeab0eadb8dfaaa43a01a204d9c1f537ab13d7119a312626f19e5ef5a5dc79be62c35ab26fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30b48d2cdde704618dd46771db04eff8afac499132f7da1d4f25d6bea9559c2f238cf45b31dc32a73c3bbc4a64b2b285b1250645641a908ad2ea46a61a6dffa9"} 14:37:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:37:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:37:16 INFO - Contents: 14:37:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f22d7744c4cdf94bb6ffe84f156202715736c4189b00480c20c24184716d4f3b4a5a942e2e6a8b916ae8ed3b893de605ffcdf7b98544fabf7e264e93a78434af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/939ca8283b75fba526054e44b490717d44eb25cdd636fb7e8d22bdeab0eadb8dfaaa43a01a204d9c1f537ab13d7119a312626f19e5ef5a5dc79be62c35ab26fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30b48d2cdde704618dd46771db04eff8afac499132f7da1d4f25d6bea9559c2f238cf45b31dc32a73c3bbc4a64b2b285b1250645641a908ad2ea46a61a6dffa9"} 14:37:16 INFO - Running post-run listener: copy_logs_to_upload_dir 14:37:16 INFO - Copying logs to upload dir... 14:37:16 INFO - mkdir: /builds/slave/test/build/upload/logs 14:37:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.853864 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-12-02 14:37:16.461340) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 14:37:16.464848) ========= 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.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f22d7744c4cdf94bb6ffe84f156202715736c4189b00480c20c24184716d4f3b4a5a942e2e6a8b916ae8ed3b893de605ffcdf7b98544fabf7e264e93a78434af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/939ca8283b75fba526054e44b490717d44eb25cdd636fb7e8d22bdeab0eadb8dfaaa43a01a204d9c1f537ab13d7119a312626f19e5ef5a5dc79be62c35ab26fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30b48d2cdde704618dd46771db04eff8afac499132f7da1d4f25d6bea9559c2f238cf45b31dc32a73c3bbc4a64b2b285b1250645641a908ad2ea46a61a6dffa9"} build_url:https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/IBrEQfzATOmdbaLRhSJYpQ/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f22d7744c4cdf94bb6ffe84f156202715736c4189b00480c20c24184716d4f3b4a5a942e2e6a8b916ae8ed3b893de605ffcdf7b98544fabf7e264e93a78434af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/939ca8283b75fba526054e44b490717d44eb25cdd636fb7e8d22bdeab0eadb8dfaaa43a01a204d9c1f537ab13d7119a312626f19e5ef5a5dc79be62c35ab26fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30b48d2cdde704618dd46771db04eff8afac499132f7da1d4f25d6bea9559c2f238cf45b31dc32a73c3bbc4a64b2b285b1250645641a908ad2ea46a61a6dffa9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 14:37:16.500739) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 14:37:16.501057) ========= 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.k7B4zg8SrJ/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.dzuqFBBKz7/Listeners TMPDIR=/var/folders/9_/bq7njmms6gbgk1ygh6pll6r400000w/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.005220 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 14:37:16.549901) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 14:37:16.550225) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 14:37:16.550559) ========= ========= Total master_lag: 4.32 =========