builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0247 starttime: 1479154463.46 results: success (0) buildid: 20161114091743 builduid: 42ed84f7fcb64e2fb957c8f0e52037f0 revision: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 12:14:23.456595) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 12:14:23.457073) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 12:14:23.457362) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 12:14:23.481853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:14:23.482139) ========= 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.cfXnUkqyeV/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.LVmo9vaeAS/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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-11-14 12:14:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 155M=0s 2016-11-14 12:14:23 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138865 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:14:23.643365) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:14:23.643711) ========= 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.cfXnUkqyeV/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.LVmo9vaeAS/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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.024919 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:14:23.694793) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 12:14:23.695381) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cfXnUkqyeV/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.LVmo9vaeAS/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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-11-14 12:14:23,797 truncating revision to first 12 chars 2016-11-14 12:14:23,797 Setting DEBUG logging. 2016-11-14 12:14:23,797 attempt 1/10 2016-11-14 12:14:23,797 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fd3c6c15ec64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 12:14:24,511 unpacking tar archive at: mozilla-beta-fd3c6c15ec64/testing/mozharness/ program finished with exit code 0 elapsedTime=1.004409 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 12:14:24.723421) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 12:14:24.723845) ========= script_repo_revision: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 12:14:24.724367) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 12:14:24.724790) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 12:14:24.743994) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-11-14 12:14:24.744400) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cfXnUkqyeV/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.LVmo9vaeAS/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 12:14:24 INFO - MultiFileLogger online at 20161114 12:14:24 in /builds/slave/test 12:14:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:14:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:14:24 INFO - {'append_to_log': False, 12:14:24 INFO - 'base_work_dir': '/builds/slave/test', 12:14:24 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:14:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:14:24 INFO - 'branch': 'Mozilla-Beta', 12:14:24 INFO - 'buildbot_json_path': 'buildprops.json', 12:14:24 INFO - 'config_files': ('talos/mac_config.py',), 12:14:24 INFO - 'default_actions': ('clobber', 12:14:24 INFO - 'read-buildbot-config', 12:14:24 INFO - 'download-and-extract', 12:14:24 INFO - 'populate-webroot', 12:14:24 INFO - 'create-virtualenv', 12:14:24 INFO - 'install', 12:14:24 INFO - 'run-tests'), 12:14:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:14:24 INFO - 'download_minidump_stackwalk': True, 12:14:24 INFO - 'download_symbols': 'ondemand', 12:14:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:14:24 INFO - 'tooltool.py': '/tools/tooltool.py', 12:14:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:14:24 INFO - '/tools/misc-python/virtualenv.py')}, 12:14:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:14:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:14:24 INFO - 'installer_path': 'installer.exe', 12:14:24 INFO - 'log_level': 'info', 12:14:24 INFO - 'log_name': 'talos', 12:14:24 INFO - 'log_to_console': True, 12:14:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:14:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:14:24 INFO - 'opt_config_files': (), 12:14:24 INFO - 'pip_index': False, 12:14:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:14:24 INFO - 'cmd': ('bash', 12:14:24 INFO - '-c', 12:14:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:14:24 INFO - 'enabled': True, 12:14:24 INFO - 'halt_on_failure': False, 12:14:24 INFO - 'name': 'check_screen_resolution'},), 12:14:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:14:24 INFO - 'cmd': ('bash', 12:14:24 INFO - '-c', 12:14:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:14:24 INFO - 'enabled': True, 12:14:24 INFO - 'halt_on_failure': False, 12:14:24 INFO - 'name': 'check_screen_resolution'},), 12:14:24 INFO - 'run_cmd_checks_enabled': True, 12:14:24 INFO - 'sps_profile': False, 12:14:24 INFO - 'sps_profile_interval': 0, 12:14:24 INFO - 'suite': 'dromaeojs', 12:14:24 INFO - 'system_bits': '32', 12:14:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:14:24 INFO - 'title': 't-yosemite-r7-0247', 12:14:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:14:24 INFO - 'use_talos_json': True, 12:14:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:14:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:14:24 INFO - 'work_dir': 'build'} 12:14:24 INFO - [mozharness: 2016-11-14 20:14:24.954967Z] Running clobber step. 12:14:24 INFO - Running pre-action listener: _resource_record_pre_action 12:14:24 INFO - Running main action method: clobber 12:14:24 INFO - rmtree: /builds/slave/test/build 12:14:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:14:27 INFO - Running post-action listener: _resource_record_post_action 12:14:27 INFO - [mozharness: 2016-11-14 20:14:27.205411Z] Finished clobber step (success) 12:14:27 INFO - [mozharness: 2016-11-14 20:14:27.205535Z] Running read-buildbot-config step. 12:14:27 INFO - Running pre-action listener: _resource_record_pre_action 12:14:27 INFO - Running main action method: read_buildbot_config 12:14:27 INFO - Using buildbot properties: 12:14:27 INFO - { 12:14:27 INFO - "project": "", 12:14:27 INFO - "product": "firefox", 12:14:27 INFO - "script_repo_revision": "production", 12:14:27 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 12:14:27 INFO - "repository": "", 12:14:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 12:14:27 INFO - "buildid": "20161114091743", 12:14:27 INFO - "pgo_build": "False", 12:14:27 INFO - "basedir": "/builds/slave/test", 12:14:27 INFO - "buildnumber": 23, 12:14:27 INFO - "slavename": "t-yosemite-r7-0247", 12:14:27 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:14:27 INFO - "platform": "yosemite_r7", 12:14:27 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:14:27 INFO - "branch": "mozilla-beta", 12:14:27 INFO - "repo_path": "releases/mozilla-beta", 12:14:27 INFO - "revision": "fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1", 12:14:27 INFO - "stage_platform": "macosx64", 12:14:27 INFO - "builduid": "42ed84f7fcb64e2fb957c8f0e52037f0", 12:14:27 INFO - "slavebuilddir": "test" 12:14:27 INFO - } 12:14:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 12:14:27 INFO - Running post-action listener: _resource_record_post_action 12:14:27 INFO - [mozharness: 2016-11-14 20:14:27.208964Z] Finished read-buildbot-config step (success) 12:14:27 INFO - [mozharness: 2016-11-14 20:14:27.209070Z] Running download-and-extract step. 12:14:27 INFO - Running pre-action listener: _resource_record_pre_action 12:14:27 INFO - Running main action method: download_and_extract 12:14:27 INFO - mkdir: /builds/slave/test/build/tests 12:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:27 INFO - trying https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 12:14:27 INFO - Downloading https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:14:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 12:14:28 INFO - Downloaded 1165 bytes. 12:14:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:14:28 INFO - Using the following test package requirements: 12:14:28 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:14:28 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:14:28 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 12:14:28 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:14:28 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 12:14:28 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:14:28 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:14:28 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 12:14:28 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:14:28 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:14:28 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 12:14:28 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:14:28 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 12:14:28 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:14:28 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 12:14:28 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:14:28 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 12:14:28 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 12:14:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:14:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:14:28 INFO - Fetch https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:14:29 INFO - Expected file size: 16231342 12:14:36 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 12:14:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:14:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:14:36 INFO - Fetch https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:14:36 INFO - Expected file size: 16231342 12:14:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 12:14:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 12:14:43 INFO - Fetch https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 12:14:44 INFO - Expected file size: 14414089 12:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:44 INFO - trying https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:14:44 INFO - Downloading https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 12:14:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 12:14:47 INFO - Downloaded 86010818 bytes. 12:14:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:14:47 INFO - mkdir: /builds/slave/test/properties 12:14:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:14:47 INFO - Writing to file /builds/slave/test/properties/build_url 12:14:47 INFO - Contents: 12:14:47 INFO - build_url:https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:14:47 INFO - Running post-action listener: _resource_record_post_action 12:14:47 INFO - Running post-action listener: set_extra_try_arguments 12:14:47 INFO - [mozharness: 2016-11-14 20:14:47.926964Z] Finished download-and-extract step (success) 12:14:47 INFO - [mozharness: 2016-11-14 20:14:47.927055Z] Running populate-webroot step. 12:14:47 INFO - Running pre-action listener: _resource_record_pre_action 12:14:47 INFO - Running main action method: populate_webroot 12:14:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:14:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:14:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:14:47 INFO - '--tppagecycles', 12:14:47 INFO - '7'], 12:14:47 INFO - 'tests': ['tsvgm']}}, 12:14:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:14:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:14:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:14:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:14:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:14:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:14:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:47 INFO - 'talos_options': ['--disable-e10s'], 12:14:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:47 INFO - 'talos_options': ['--disable-e10s'], 12:14:47 INFO - 'tests': ['damp', 'tps']}, 12:14:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:47 INFO - 'tests': ['damp', 'tps']}, 12:14:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:14:47 INFO - 'tests': ['dromaeo_dom']}, 12:14:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:14:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:14:47 INFO - 'tests': ['basic_compositor_video']}, 12:14:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:14:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:14:47 INFO - 'tests': ['a11yr', 12:14:47 INFO - 'ts_paint', 12:14:47 INFO - 'tpaint', 12:14:47 INFO - 'sessionrestore', 12:14:47 INFO - 'sessionrestore_no_auto_restore', 12:14:47 INFO - 'tabpaint']}, 12:14:47 INFO - 'other-e10s': {'tests': ['a11yr', 12:14:47 INFO - 'ts_paint', 12:14:47 INFO - 'tpaint', 12:14:47 INFO - 'sessionrestore', 12:14:47 INFO - 'sessionrestore_no_auto_restore', 12:14:47 INFO - 'tabpaint']}, 12:14:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:14:47 INFO - 'ts_paint', 12:14:47 INFO - 'tpaint', 12:14:47 INFO - 'sessionrestore', 12:14:47 INFO - 'sessionrestore_no_auto_restore', 12:14:47 INFO - 'tabpaint']}, 12:14:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:14:47 INFO - 'ts_paint', 12:14:47 INFO - 'tpaint', 12:14:47 INFO - 'sessionrestore', 12:14:47 INFO - 'sessionrestore_no_auto_restore', 12:14:47 INFO - 'tabpaint']}, 12:14:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:14:47 INFO - 'tests': ['a11yr', 12:14:47 INFO - 'ts_paint', 12:14:47 INFO - 'tpaint', 12:14:47 INFO - 'sessionrestore', 12:14:47 INFO - 'sessionrestore_no_auto_restore', 12:14:47 INFO - 'tabpaint']}, 12:14:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:14:47 INFO - 'tests': ['a11yr', 12:14:47 INFO - 'ts_paint', 12:14:47 INFO - 'tpaint', 12:14:47 INFO - 'sessionrestore', 12:14:47 INFO - 'sessionrestore_no_auto_restore', 12:14:47 INFO - 'tabpaint']}, 12:14:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:14:47 INFO - 'tests': ['tsvgx', 12:14:47 INFO - 'tsvgr_opacity', 12:14:47 INFO - 'tart', 12:14:47 INFO - 'tscrollx', 12:14:47 INFO - 'cart']}, 12:14:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:14:47 INFO - 'tsvgr_opacity', 12:14:47 INFO - 'tart', 12:14:47 INFO - 'tscrollx', 12:14:47 INFO - 'cart']}, 12:14:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:47 INFO - 'talos_options': ['--disable-e10s'], 12:14:47 INFO - 'tests': ['tp5o']}, 12:14:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:47 INFO - 'tests': ['tp5o']}, 12:14:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:47 INFO - 'talos_options': ['--disable-e10s', 12:14:47 INFO - '--xperf_path', 12:14:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:47 INFO - 'tests': ['tp5n']}, 12:14:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:14:47 INFO - 'talos_options': ['--xperf_path', 12:14:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:47 INFO - 'tests': ['tp5n']}}, 12:14:47 INFO - 'talos.zip': {'path': '', 12:14:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:14:47 INFO - Running post-action listener: _resource_record_post_action 12:14:47 INFO - [mozharness: 2016-11-14 20:14:47.945604Z] Finished populate-webroot step (success) 12:14:47 INFO - [mozharness: 2016-11-14 20:14:47.945749Z] Running create-virtualenv step. 12:14:47 INFO - Running pre-action listener: _resource_record_pre_action 12:14:47 INFO - Running main action method: create_virtualenv 12:14:47 INFO - Creating virtualenv /builds/slave/test/build/venv 12:14:47 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 12:14:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:14:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:14:48 INFO - Using real prefix '/tools/python27' 12:14:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:14:48 INFO - Installing distribute.............................................................................................................................................................................................done. 12:14:51 INFO - Installing pip.................done. 12:14:51 INFO - Return code: 0 12:14:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110616490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7bad5bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11042ad30>, '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 0x110290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110422b20>, '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.cfXnUkqyeV/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.LVmo9vaeAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 12:14:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:14:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfXnUkqyeV/Render', 12:14:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:51 INFO - 'HOME': '/Users/cltbld', 12:14:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:51 INFO - 'LOGNAME': 'cltbld', 12:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:51 INFO - 'MOZ_NO_REMOTE': '1', 12:14:51 INFO - 'NO_EM_RESTART': '1', 12:14:51 INFO - 'PAGER': '/bin/cat', 12:14:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:51 INFO - 'PWD': '/builds/slave/test', 12:14:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:51 INFO - 'SHELL': '/bin/bash', 12:14:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVmo9vaeAS/Listeners', 12:14:51 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 12:14:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:51 INFO - 'USER': 'cltbld', 12:14:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:51 INFO - 'XPC_FLAGS': '0x0', 12:14:51 INFO - 'XPC_SERVICE_NAME': '0', 12:14:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:51 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 12:14:51 INFO - Cleaning up... 12:14:51 INFO - Return code: 0 12:14:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110616490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7bad5bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11042ad30>, '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 0x110290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110422b20>, '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.cfXnUkqyeV/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.LVmo9vaeAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 12:14:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:14:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfXnUkqyeV/Render', 12:14:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:51 INFO - 'HOME': '/Users/cltbld', 12:14:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:51 INFO - 'LOGNAME': 'cltbld', 12:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:51 INFO - 'MOZ_NO_REMOTE': '1', 12:14:51 INFO - 'NO_EM_RESTART': '1', 12:14:51 INFO - 'PAGER': '/bin/cat', 12:14:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:51 INFO - 'PWD': '/builds/slave/test', 12:14:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:51 INFO - 'SHELL': '/bin/bash', 12:14:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVmo9vaeAS/Listeners', 12:14:51 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 12:14:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:51 INFO - 'USER': 'cltbld', 12:14:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:51 INFO - 'XPC_FLAGS': '0x0', 12:14:51 INFO - 'XPC_SERVICE_NAME': '0', 12:14:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:52 INFO - Downloading/unpacking psutil>=3.1.1 12:14:52 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 12:14:52 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 12:14:52 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 12:14:52 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 12:14:52 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 12:14:52 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 12:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:14:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:55 INFO - Installing collected packages: psutil 12:14:55 INFO - Running setup.py install for psutil 12:14:55 INFO - building 'psutil._psutil_osx' extension 12:14:55 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 12:14:56 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 12:14:56 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 12:14:56 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 12:14:56 INFO - building 'psutil._psutil_posix' extension 12:14:56 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 12:14:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:14:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:14:56 INFO - ^ 12:14:56 INFO - 1 warning generated. 12:14:56 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 12:14:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:56 INFO - Successfully installed psutil 12:14:56 INFO - Cleaning up... 12:14:56 INFO - Return code: 0 12:14:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:14:56 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')]} 12:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:56 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')]} 12:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:56 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 0x110616490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7bad5bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11042ad30>, '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 0x110290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110422b20>, '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.cfXnUkqyeV/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.LVmo9vaeAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 12:14:56 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 12:14:56 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 12:14:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfXnUkqyeV/Render', 12:14:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:56 INFO - 'HOME': '/Users/cltbld', 12:14:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:56 INFO - 'LOGNAME': 'cltbld', 12:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:56 INFO - 'MOZ_NO_REMOTE': '1', 12:14:56 INFO - 'NO_EM_RESTART': '1', 12:14:56 INFO - 'PAGER': '/bin/cat', 12:14:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:56 INFO - 'PWD': '/builds/slave/test', 12:14:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:56 INFO - 'SHELL': '/bin/bash', 12:14:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVmo9vaeAS/Listeners', 12:14:56 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 12:14:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:56 INFO - 'USER': 'cltbld', 12:14:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:56 INFO - 'XPC_FLAGS': '0x0', 12:14:56 INFO - 'XPC_SERVICE_NAME': '0', 12:14:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:14:56 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 12:14:56 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 12:14:56 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 12:14:56 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 12:14:56 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 12:14:56 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 12:14:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:14:59 INFO - Installing collected packages: mozsystemmonitor 12:14:59 INFO - Running setup.py install for mozsystemmonitor 12:14:59 INFO - Successfully installed mozsystemmonitor 12:14:59 INFO - Cleaning up... 12:14:59 INFO - Return code: 0 12:14:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:59 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 0x110616490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7bad5bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11042ad30>, '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 0x110290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110422b20>, '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.cfXnUkqyeV/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.LVmo9vaeAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 12:14:59 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 12:14:59 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 12:14:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfXnUkqyeV/Render', 12:14:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:59 INFO - 'HOME': '/Users/cltbld', 12:14:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:59 INFO - 'LOGNAME': 'cltbld', 12:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:59 INFO - 'MOZ_NO_REMOTE': '1', 12:14:59 INFO - 'NO_EM_RESTART': '1', 12:14:59 INFO - 'PAGER': '/bin/cat', 12:14:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:59 INFO - 'PWD': '/builds/slave/test', 12:14:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:59 INFO - 'SHELL': '/bin/bash', 12:14:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVmo9vaeAS/Listeners', 12:14:59 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 12:14:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:59 INFO - 'USER': 'cltbld', 12:14:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:59 INFO - 'XPC_FLAGS': '0x0', 12:14:59 INFO - 'XPC_SERVICE_NAME': '0', 12:14:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:00 INFO - Downloading/unpacking jsonschema==2.5.1 12:15:00 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 12:15:00 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 12:15:00 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 12:15:00 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 12:15:00 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 12:15:00 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 12:15:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:15:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:03 INFO - Downloading functools32-3.2.3-2.tar.gz 12:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:15:03 INFO - warning: no files found matching '*.txt' 12:15:03 INFO - no previously-included directories found matching 'build' 12:15:03 INFO - no previously-included directories found matching 'dist' 12:15:03 INFO - no previously-included directories found matching '.git*' 12:15:03 INFO - Installing collected packages: jsonschema, functools32 12:15:03 INFO - Running setup.py install for functools32 12:15:03 INFO - warning: no files found matching '*.txt' 12:15:03 INFO - no previously-included directories found matching 'build' 12:15:03 INFO - no previously-included directories found matching 'dist' 12:15:03 INFO - no previously-included directories found matching '.git*' 12:15:03 INFO - Successfully installed jsonschema functools32 12:15:03 INFO - Cleaning up... 12:15:03 INFO - Return code: 0 12:15:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:03 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 0x110616490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7bad5bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11042ad30>, '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 0x110290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110422b20>, '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.cfXnUkqyeV/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.LVmo9vaeAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 12:15:03 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 12:15:03 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 12:15:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfXnUkqyeV/Render', 12:15:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:03 INFO - 'HOME': '/Users/cltbld', 12:15:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:03 INFO - 'LOGNAME': 'cltbld', 12:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:03 INFO - 'MOZ_NO_REMOTE': '1', 12:15:03 INFO - 'NO_EM_RESTART': '1', 12:15:03 INFO - 'PAGER': '/bin/cat', 12:15:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:03 INFO - 'PWD': '/builds/slave/test', 12:15:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:03 INFO - 'SHELL': '/bin/bash', 12:15:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVmo9vaeAS/Listeners', 12:15:03 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 12:15:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:03 INFO - 'USER': 'cltbld', 12:15:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:03 INFO - 'XPC_FLAGS': '0x0', 12:15:03 INFO - 'XPC_SERVICE_NAME': '0', 12:15:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:15:03 INFO - Cleaning up... 12:15:03 INFO - Return code: 0 12:15:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:03 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 0x110616490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7bad5bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11042ad30>, '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 0x110290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110422b20>, '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.cfXnUkqyeV/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.LVmo9vaeAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 12:15:03 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 12:15:03 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 12:15:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfXnUkqyeV/Render', 12:15:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:03 INFO - 'HOME': '/Users/cltbld', 12:15:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:03 INFO - 'LOGNAME': 'cltbld', 12:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:03 INFO - 'MOZ_NO_REMOTE': '1', 12:15:03 INFO - 'NO_EM_RESTART': '1', 12:15:03 INFO - 'PAGER': '/bin/cat', 12:15:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:03 INFO - 'PWD': '/builds/slave/test', 12:15:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:03 INFO - 'SHELL': '/bin/bash', 12:15:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVmo9vaeAS/Listeners', 12:15:03 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 12:15:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:03 INFO - 'USER': 'cltbld', 12:15:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:03 INFO - 'XPC_FLAGS': '0x0', 12:15:03 INFO - 'XPC_SERVICE_NAME': '0', 12:15:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:03 INFO - Downloading/unpacking blobuploader==1.2.4 12:15:03 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 12:15:03 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 12:15:03 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 12:15:03 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 12:15:03 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 12:15:03 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 12:15:06 INFO - Downloading blobuploader-1.2.4.tar.gz 12:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:15:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:15:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:07 INFO - Downloading docopt-0.6.1.tar.gz 12:15:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:15:07 INFO - Installing collected packages: blobuploader, requests, docopt 12:15:07 INFO - Running setup.py install for blobuploader 12:15:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:15:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:15:08 INFO - Running setup.py install for requests 12:15:08 INFO - Running setup.py install for docopt 12:15:08 INFO - Successfully installed blobuploader requests docopt 12:15:08 INFO - Cleaning up... 12:15:08 INFO - Return code: 0 12:15:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:08 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')]} 12:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:08 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')]} 12:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:08 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 0x110616490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7bad5bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11042ad30>, '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 0x110290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110422b20>, '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.cfXnUkqyeV/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.LVmo9vaeAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 12:15:08 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 12:15:08 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 12:15:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfXnUkqyeV/Render', 12:15:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:08 INFO - 'HOME': '/Users/cltbld', 12:15:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:08 INFO - 'LOGNAME': 'cltbld', 12:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:08 INFO - 'MOZ_NO_REMOTE': '1', 12:15:08 INFO - 'NO_EM_RESTART': '1', 12:15:08 INFO - 'PAGER': '/bin/cat', 12:15:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:08 INFO - 'PWD': '/builds/slave/test', 12:15:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:08 INFO - 'SHELL': '/bin/bash', 12:15:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVmo9vaeAS/Listeners', 12:15:08 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 12:15:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:08 INFO - 'USER': 'cltbld', 12:15:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:08 INFO - 'XPC_FLAGS': '0x0', 12:15:08 INFO - 'XPC_SERVICE_NAME': '0', 12:15:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:09 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-qsbkdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:09 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-MPxeJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:09 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-2k9qEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:09 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-Vi2iAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:09 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-BR3IRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:09 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-rKjnA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:09 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-vzr9Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:09 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-jkA1lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:09 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-_mZBtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:10 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-P8Hi7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:10 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-vATlzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:10 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-oJpbKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:10 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-Cp0czb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:10 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-0o51Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:10 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-ZILs0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:10 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-bWdnBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:10 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-0qBBe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:15:10 INFO - Running setup.py install for manifestparser 12:15:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:15:11 INFO - Running setup.py install for mozcrash 12:15:11 INFO - Running setup.py install for mozdebug 12:15:11 INFO - Running setup.py install for mozdevice 12:15:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:15:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:15:11 INFO - Running setup.py install for mozfile 12:15:11 INFO - Running setup.py install for mozhttpd 12:15:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:15:11 INFO - Running setup.py install for mozinfo 12:15:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:15:11 INFO - Running setup.py install for mozInstall 12:15:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:15:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:15:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:15:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:15:12 INFO - Running setup.py install for mozleak 12:15:12 INFO - Running setup.py install for mozlog 12:15:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:15:12 INFO - Running setup.py install for moznetwork 12:15:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:15:12 INFO - Running setup.py install for mozprocess 12:15:12 INFO - Running setup.py install for mozprofile 12:15:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:15:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:15:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:15:12 INFO - Running setup.py install for mozrunner 12:15:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:15:13 INFO - Running setup.py install for mozscreenshot 12:15:13 INFO - Running setup.py install for moztest 12:15:13 INFO - Running setup.py install for mozversion 12:15:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:15:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:15:13 INFO - Cleaning up... 12:15:13 INFO - Return code: 0 12:15:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:13 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')]} 12:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:13 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')]} 12:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:13 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 0x110616490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7bad5bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11042ad30>, '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 0x110290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110422b20>, '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.cfXnUkqyeV/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.LVmo9vaeAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 12:15:13 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 12:15:13 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 12:15:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfXnUkqyeV/Render', 12:15:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:13 INFO - 'HOME': '/Users/cltbld', 12:15:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:13 INFO - 'LOGNAME': 'cltbld', 12:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:13 INFO - 'MOZ_NO_REMOTE': '1', 12:15:13 INFO - 'NO_EM_RESTART': '1', 12:15:13 INFO - 'PAGER': '/bin/cat', 12:15:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:13 INFO - 'PWD': '/builds/slave/test', 12:15:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:13 INFO - 'SHELL': '/bin/bash', 12:15:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVmo9vaeAS/Listeners', 12:15:13 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 12:15:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:13 INFO - 'USER': 'cltbld', 12:15:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:13 INFO - 'XPC_FLAGS': '0x0', 12:15:13 INFO - 'XPC_SERVICE_NAME': '0', 12:15:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:13 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-YCehjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:13 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)) 12:15:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:13 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-aJucOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:14 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-FyUDGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:14 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)) 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:14 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-AhYELO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:14 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-R0T_ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:14 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)) 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:14 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-p6ToDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:14 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)) 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:14 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-32QJfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:14 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)) 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:14 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-jxClnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:14 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)) 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:14 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-CxDSwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:14 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)) 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:14 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-sIpWfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:14 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)) 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:14 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-wBWpCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:14 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)) 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:14 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-cHYehX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:15 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)) 12:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:15 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-Su2fWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:15 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)) 12:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:15 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-oUktqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:15 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-ax64kw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:15 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)) 12:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:15 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-zoPXyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:15 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)) 12:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:15 INFO - Running setup.py (path:/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/pip-R62gfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:15 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)) 12:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:15:15 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)) 12:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:15:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:15:15 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 12:15:15 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 12:15:15 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 12:15:15 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 12:15:15 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 12:15:15 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 12:15:18 INFO - Downloading blessings-1.6.tar.gz 12:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:15:18 INFO - Installing collected packages: blessings 12:15:18 INFO - Running setup.py install for blessings 12:15:18 INFO - Successfully installed blessings 12:15:18 INFO - Cleaning up... 12:15:18 INFO - Return code: 0 12:15:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:15:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:18 INFO - Reading from file tmpfile_stdout 12:15:18 INFO - Current package versions: 12:15:18 INFO - blessings == 1.6 12:15:18 INFO - blobuploader == 1.2.4 12:15:18 INFO - docopt == 0.6.1 12:15:18 INFO - functools32 == 3.2.3-2 12:15:18 INFO - jsonschema == 2.5.1 12:15:18 INFO - manifestparser == 1.1 12:15:18 INFO - mozInstall == 1.12 12:15:18 INFO - mozcrash == 0.17 12:15:18 INFO - mozdebug == 0.1 12:15:18 INFO - mozdevice == 0.48 12:15:18 INFO - mozfile == 1.2 12:15:18 INFO - mozhttpd == 0.7 12:15:18 INFO - mozinfo == 0.9 12:15:18 INFO - mozleak == 0.1 12:15:18 INFO - mozlog == 3.4 12:15:18 INFO - moznetwork == 0.27 12:15:18 INFO - mozprocess == 0.23 12:15:18 INFO - mozprofile == 0.28 12:15:18 INFO - mozrunner == 6.12 12:15:18 INFO - mozscreenshot == 0.1 12:15:18 INFO - mozsystemmonitor == 0.3 12:15:18 INFO - moztest == 0.7 12:15:18 INFO - mozversion == 1.4 12:15:18 INFO - psutil == 3.1.1 12:15:18 INFO - requests == 1.2.3 12:15:18 INFO - wsgiref == 0.1.2 12:15:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:18 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 0x110616490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7bad5bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11042ad30>, '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 0x110290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110422b20>, '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.cfXnUkqyeV/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.LVmo9vaeAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 12:15:18 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 12:15:18 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 12:15:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfXnUkqyeV/Render', 12:15:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:18 INFO - 'HOME': '/Users/cltbld', 12:15:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:18 INFO - 'LOGNAME': 'cltbld', 12:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:18 INFO - 'MOZ_NO_REMOTE': '1', 12:15:18 INFO - 'NO_EM_RESTART': '1', 12:15:18 INFO - 'PAGER': '/bin/cat', 12:15:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:18 INFO - 'PWD': '/builds/slave/test', 12:15:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:18 INFO - 'SHELL': '/bin/bash', 12:15:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVmo9vaeAS/Listeners', 12:15:18 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 12:15:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:18 INFO - 'USER': 'cltbld', 12:15:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:18 INFO - 'XPC_FLAGS': '0x0', 12:15:18 INFO - 'XPC_SERVICE_NAME': '0', 12:15:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:19 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)) 12:15:19 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)) 12:15:19 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)) 12:15:19 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)) 12:15:19 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)) 12:15:19 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)) 12:15:19 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)) 12:15:19 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)) 12:15:19 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)) 12:15:19 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)) 12:15:19 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)) 12:15:19 INFO - Cleaning up... 12:15:19 INFO - Return code: 0 12:15:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:15:19 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')]} 12:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:19 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')]} 12:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:19 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 0x110616490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11058c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7bad5bd40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11042ad30>, '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 0x110290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110422b20>, '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.cfXnUkqyeV/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.LVmo9vaeAS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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 12:15:19 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 12:15:19 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 12:15:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfXnUkqyeV/Render', 12:15:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:19 INFO - 'HOME': '/Users/cltbld', 12:15:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:19 INFO - 'LOGNAME': 'cltbld', 12:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:19 INFO - 'MOZ_NO_REMOTE': '1', 12:15:19 INFO - 'NO_EM_RESTART': '1', 12:15:19 INFO - 'PAGER': '/bin/cat', 12:15:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:19 INFO - 'PWD': '/builds/slave/test', 12:15:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:19 INFO - 'SHELL': '/bin/bash', 12:15:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVmo9vaeAS/Listeners', 12:15:19 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 12:15:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:19 INFO - 'USER': 'cltbld', 12:15:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:19 INFO - 'XPC_FLAGS': '0x0', 12:15:19 INFO - 'XPC_SERVICE_NAME': '0', 12:15:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:15:19 INFO - Cleaning up... 12:15:19 INFO - Return code: 0 12:15:19 INFO - Running post-action listener: _resource_record_post_action 12:15:19 INFO - Running post-action listener: _start_resource_monitoring 12:15:19 INFO - Starting resource monitoring. 12:15:19 INFO - [mozharness: 2016-11-14 20:15:19.402478Z] Finished create-virtualenv step (success) 12:15:19 INFO - [mozharness: 2016-11-14 20:15:19.403430Z] Running install step. 12:15:19 INFO - Running pre-action listener: _resource_record_pre_action 12:15:19 INFO - Running main action method: install 12:15:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:19 INFO - Reading from file tmpfile_stdout 12:15:19 INFO - Detecting whether we're running mozinstall >=1.0... 12:15:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:15:19 INFO - Reading from file tmpfile_stdout 12:15:19 INFO - Output received: 12:15:19 INFO - Usage: mozinstall [options] installer 12:15:19 INFO - Options: 12:15:19 INFO - -h, --help show this help message and exit 12:15:19 INFO - -d DEST, --destination=DEST 12:15:19 INFO - Directory to install application into. [default: 12:15:19 INFO - "/builds/slave/test"] 12:15:19 INFO - --app=APP Application being installed. [default: firefox] 12:15:19 INFO - mkdir: /builds/slave/test/build/application 12:15:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:15:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 12:15:41 INFO - Reading from file tmpfile_stdout 12:15:41 INFO - Output received: 12:15:41 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:15:41 INFO - Running post-action listener: _resource_record_post_action 12:15:41 INFO - [mozharness: 2016-11-14 20:15:41.659016Z] Finished install step (success) 12:15:41 INFO - [mozharness: 2016-11-14 20:15:41.659171Z] Running run-tests step. 12:15:41 INFO - Running pre-action listener: _resource_record_pre_action 12:15:41 INFO - Running main action method: run_tests 12:15:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:15:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:15:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:15:41 INFO - 2016-11-14 12:15:41.673 screenresolution[1637:7599] starting screenresolution argv=screenresolution get 12:15:41 INFO - 2016-11-14 12:15:41.676 screenresolution[1637:7599] Display 0: 1600x1200x32@60 12:15:41 INFO - 2016-11-14 12:15:41.682 screenresolution[1638:7601] starting screenresolution argv=screenresolution list 12:15:41 INFO - Available Modes on Display 0 12:15:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:15:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:15:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:15:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:15:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:15:41 INFO - Intel Iris: 12:15:41 INFO - Chipset Model: Intel Iris 12:15:41 INFO - Type: GPU 12:15:41 INFO - Bus: Built-In 12:15:41 INFO - VRAM (Dynamic, Max): 1536 MB 12:15:41 INFO - Vendor: Intel (0x8086) 12:15:41 INFO - Device ID: 0x0a2e 12:15:41 INFO - Revision ID: 0x0009 12:15:41 INFO - Displays: 12:15:41 INFO - Display: 12:15:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:15:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:15:41 INFO - Display Serial Number: 1600x1200 60 12:15:41 INFO - Main Display: Yes 12:15:41 INFO - Mirror: Off 12:15:41 INFO - Online: Yes 12:15:41 INFO - Rotation: Supported 12:15:41 INFO - Return code: 0 12:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:15:41 INFO - Python 2.7.3 12:15:41 INFO - Return code: 0 12:15:41 INFO - grabbing minidump binary from tooltool 12:15:41 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')]} 12:15:41 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 0x11042ad30>, '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 0x110290db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110422b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:15:41 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 12:15:41 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 12:15:41 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 12:15:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:15:42 INFO - Return code: 0 12:15:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:15:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:15:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:15:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:15:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--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 12:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0247 --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 12:15:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cfXnUkqyeV/Render', 12:15:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:42 INFO - 'HOME': '/Users/cltbld', 12:15:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:42 INFO - 'LOGNAME': 'cltbld', 12:15:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:15:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:42 INFO - 'MOZ_NO_REMOTE': '1', 12:15:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:15:42 INFO - 'NO_EM_RESTART': '1', 12:15:42 INFO - 'PAGER': '/bin/cat', 12:15:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:42 INFO - 'PWD': '/builds/slave/test', 12:15:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:15:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:42 INFO - 'SHELL': '/bin/bash', 12:15:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVmo9vaeAS/Listeners', 12:15:42 INFO - 'TMPDIR': '/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/', 12:15:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:42 INFO - 'USER': 'cltbld', 12:15:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:42 INFO - 'XPC_FLAGS': '0x0', 12:15:42 INFO - 'XPC_SERVICE_NAME': '0', 12:15:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--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 12:15:42 INFO - mozversion application_buildid: 20161114091743 12:15:42 INFO - mozversion application_changeset: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 12:15:42 INFO - mozversion application_display_name: Firefox 12:15:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:15:42 INFO - mozversion application_name: Firefox 12:15:42 INFO - mozversion application_remotingname: firefox 12:15:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:15:42 INFO - mozversion application_vendor: Mozilla 12:15:42 INFO - mozversion application_version: 51.0 12:15:42 INFO - mozversion platform_buildid: 20161114091743 12:15:42 INFO - mozversion platform_changeset: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 12:15:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:15:42 INFO - mozversion platform_version: 51.0 12:15:42 INFO - using testdate: 1479154542 12:15:42 INFO - actual date: 1479154542 12:15:42 INFO - starting webserver on 'localhost:49271' 12:15:42 INFO - SUITE-START | Running 2 tests 12:15:42 INFO - TEST-START | dromaeo_css 12:15:42 INFO - operating with platform_type : mac_ 12:15:42 INFO - Initialising browser for dromaeo_css test... 12:15:42 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpXxvVwd/profile http://localhost:49271/getInfo.html) 12:15:44 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 12:15:44 INFO - PROCESS | 1648 | colorDepth:24 12:15:44 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 12:15:44 INFO - PROCESS | 1648 | __metrics 12:15:44 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:15:44 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:15:45 INFO - TEST-INFO | 1648: exit 0 12:15:45 INFO - Browser initialized. 12:15:45 INFO - Running cycle 1/1 for dromaeo_css test... 12:15:45 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpXxvVwd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:57 INFO - PROCESS | 1651 | RSS: Main: 168271872 12:15:57 INFO - PROCESS | 1651 | 12:16:49 INFO - PROCESS | 1651 | 1479154609196 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] 12:18:59 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 12:19:01 INFO - PROCESS | 1651 | RSS: Main: 296386560 12:19:01 INFO - PROCESS | 1651 | 12:22:03 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 12:22:04 INFO - PROCESS | 1651 | RSS: Main: 301494272 12:22:04 INFO - PROCESS | 1651 | 12:25:06 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 12:25:07 INFO - PROCESS | 1651 | RSS: Main: 278089728 12:25:07 INFO - PROCESS | 1651 | 12:28:09 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 12:28:09 INFO - PROCESS | 1651 | RSS: Main: 268959744 12:28:09 INFO - PROCESS | 1651 | 12:31:12 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 12:31:13 INFO - PROCESS | 1651 | RSS: Main: 265035776 12:31:13 INFO - PROCESS | 1651 | 12:34:16 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 12:34:16 INFO - PROCESS | 1651 | RSS: Main: 314806272 12:34:16 INFO - PROCESS | 1651 | 12:34:16 INFO - PROCESS | 1651 | __start_tp_report 12:34:16 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 12:34:16 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 12:34:16 INFO - PROCESS | 1651 | |i|pagename|runs| 12:34:16 INFO - PROCESS | 1651 | |0;dojo.html;3458.5158077869105;3461.376952148613;3512.104413374591;3535.3106144301873;3558.964410355896;5830.067189249721;5893.970530147349;5923;5934.554908381867;5977.193078934337;5304.7268655522685;5347.385050719159;5845.678487683176;5913.763449462027;5916.112583112525;5326.547243484309;5345.625806193568;5390.676559406428;5415.810446634368;5432.864178395532;5322.20166974953;5329.600279978998;5454.10007348787;5473.589480788937;5488.368837583689;5387.0841956867425;5409.43200963899;5412.4587541245955;5418.187271909225;5434.864128396782;5332.733363331838;5357.089294819851;5394.406615272317;5398.865028374283;5408.4050754416985;5296.2055691646565;5390.407055223922;5405.21624364465;5429.484199001088;5435.239066530688;5718.914216286759;5749.540036797046;5923.437273459058;5979.073243647198;6051.485623721989;6225.626462412224;6232.189815323979;6264.27960784511;6312.715927783215;6313.210848643919;6257.155284036642;6263.217097862767;6268.749250029993;6302.46429053531;6315.3684631536935;5763.7118144093465;5960.403959604005;5964.045752679551;5968.283805943314;5968.7015649217365;6252.3122456529745;6293.433590976742;6296.275928268216;6327.17746692927;6377.872442551123;6252.874942501125;6276.529260305404;6278.183836101278;6304.527160462983;6313.210848643919;6246.250449946036;6285.465735412449;6288.622682639057;6305;6311.274203466568;6119.074419021604;6203.720832562545;6290.716917738713;6294.464970477561;6337.7781777637565;6306.621602703761;6322.36776322364;6325.462335701425;6335.746570137235;6342;5004.799808007639;5051.772670229775;5057;5070.492950704974;5098.107831129538;4461.843835465743;4521.547845215452;4552.453705555288;4565.0641618468135;4596.88507787308;5987.401259873977;5996.430339117776;6000.489958353589;6010.609310394811;6019.819405417845;6296.9309705687365;6306;6320.5259605528845;6334.714937827809;6338.556301058881;5761.3950535194035;5781.19063331134;5840.912386314209;5884.794032208938;5952.987992041363;5535.474129957647;5540.445955404508;5542.0301447246575;5548.195511650788;5561.749721262553;6294.276158241769;6328.177336946167;6344.777932772423;6348.714307856158;6349.238091428873;6329.177206963065;6333.240011198685;6336.936630633634;6340.175777148941;6340.4927605792345;6442.581232220078;6446.645434501147;6450.48396128318;6456.354364563506;6464.709088091141;5197.376314842243;6259.874802504016;6260.28006779208;6327.209098862642;6334.809955701337;6266.091416744638;6293.465055470337;6307.211598550181;6316.021016742412;6337.588056776295;5303.443138470405;6222.968885155546;6288.937110629018;6316.494680425463;6337.493000559852;6118;6155.753769849156;6292;6309.747610095545;6324.494040476843;5135.204043373283;6082.878342433215;6099.085137229274;6114.453616902275;6167.753289868535;6307.495400368051;6315.684215789284;6316.463100636497;6317.052442133533;6325.493960483058;6097.969510152421;6103.298120716175;6117.510599152146;6151.415615516519;6154.292256390572 12:34:16 INFO - PROCESS | 1651 | |1;ext.html;532.1963834609738;542.3166809819627;549.2420459765524;566.3091028944687;567.8523583868193;32746.67253327466;36957.44563831545;42773;43857.56142438575;46146.76926615371;45197;45516;45518.31722524165;45605.7719711401;45663.858403539845;9933.006699330046;10130.290879638429;10149.441780702058;10163.796724065514;10171.288009839314;9273.629054837833;9502.097300756417;9502.47736374499;9604.855927161097;9620.518974051269;12181.57364492243;12459.065570082235;12466.065045121606;12639.178453400546;12646.925011374044;12397.938010309936;12493.75012499754;12508.937455312756;12516.687082822957;12566.623001309976;12145.149839511238;12223.449944752507;12228.082893783001;12237.571684991071;12245.448954796966;42918;43231.783841080905;43352.3497147543;43400.3489947651;43422.78288608568;3520.119970007498;3607.4047782115917;3671.5594128704724;3848.4804551385487;4152.356384760367;29974.55038174429;31112.755489780382;31119.22201944947;31353.68646313553;33274.3345133096;3357.5131605917004;3436.1581412554083;3524.9647503524893;3558.7864728116137;3563.928721425557;501415;502516;504452;505779;506496;64540.354596454374;64705;64803.351966479735;64820;64860.67569662121;68213;68347.97478037834;68355;68555.31444685589;68601;17909;18115.63768724618;18148.727769083474;18167.182476788577;18230.726539101925;14289.214093224973;14374.640633984025;14386.496472623408;14392.712145757236;14396;15983.881128320905;16321.428749993693;16351.59121021984;16907.32370705158;18262.543436414195;6658.267590565034;6769.424598909148;7708.421868359896;7815.726449574237;7842.215778422112;888.7467071884482;959.4291396619001;1011.1405305490274;1119.729107463019;1150.2925700694013;31259.374812504077;31295.53056704151;31565.684343156732;32172.83913580417;32327;1049.6011515624166;1136.3409222650844;1157.4849192109598;1178.834963105166;1210.7154818617619;16344.10107444102;16353.754693679604;16374.426895058616;16411.261493232832;16570.171491425623;673420;682451;683963;685770;687521;45924.770376147906;54020.45979540233;54580.18129728057;58610;61107.694461527404;1417.2559406311768;1440.9351579178963;1447.992760036193;1454.142056186855;1457.2131049233296;28697.56953645655;28747.5687864678;31367.372652547278;32977.67022329842;32978.34043319168;55001;55367.72316138555;55397.72301138468;55644;55671.16493252685;395356;659374;668567.6571617111;890581;914386;40503;41060.76817695474;41345;41427.58572414237;41500.792496038535;48660.02679946311;49014;49062.75468622777;49170.770730732016;49470.752646236535;40196.3970540448;40208.798956005034;40287.59712402838;40346;41706.95732606709;39700.00749981274;40292.597074030055;40369.1926161481;41281.58718412778;41685.74942751722;38716.6128338713;39059.6094039056;39123.60876391314;39162;39450.013749656486;33763.32473350568;34670.613175472696;35395.292094157456;35477.64522354847;35625.82187089048;22406;23550;24628;26476.73523264743;27478.0382686605 12:34:16 INFO - PROCESS | 1651 | |2;jquery.html;350.511037103241;380.49964296949526;391.9764814111153;393.39220903703773;410.97945102744853;19377.806221937775;21756.782432175674;22294.777052229492;22633.434164145903;22852.65721014182;21591.892040539813;21643.45891352717;21789.225855148357;21975.011124499397;22225.888870555664;5625.353084395296;6073.180120683695;6140.723667434954;6142.170806941072;6147.90778138326;4290.506591741942;4389.429374181368;6049.758009679607;6160.229971253593;6162.260528736558;6714.328567143271;6803.727850885984;6811.863762724743;6814.080099186621;6848.6918088686125;6551.410373066423;6780.593164410151;6800.50388914438;6816.38652521273;6829.829254268633;5779.7404362030775;5904.350521442638;5940.910886336708;5954.285485741739;5963.194968679216;26590.86704566484;27041.864790676118;27072.86463567689;27171.1848644541;27406;2140.7538133114736;2252.3693365857584;2266.6600009998633;2348.377679914807;2425.7331693513697;8449.95775021121;8698.260647844942;10396.740081497948;10627.36235825853;10838.783224335548;1910.3409323783274;2000.1799262302386;2011.757672379437;2015.737954065962;2046.5088378789133;123892;126759;129330;131347;133246;10510;10909.345439273511;10962.780744385227;11666.824997625043;11668.416579171007;14966.70066598662;14968.775468367983;14970.775438368433;14992.025518341274;15000.399984000518;7401.703931842666;9026.277897768163;9033.864492032624;9069.41048831837;9130.771730706652;8998.775030624287;9075.092490751003;9086.318526110568;9254.074592540692;9324.020977797234;3901.882943511699;4626.144163329727;4626.514216007338;4626.606738427204;4680.063987202505;1818.8363047325804;1837.742486832338;1934.6517626827306;1962.6172896285373;1975.3382616823237;389.23709529322844;392.71135715249267;826.2522417212432;923.6213152607398;992.3549692699803;11495.965363117359;11940.104492163122;11952.88047119535;11954.760904781855;12339.93830030844;353.50509286997897;373.89344036949336;426.9914601708011;427.07964336854127;433.3521385528592;6140.723667434976;6179.474744646755;6197.876042479125;6201.81394558164;6330.208723909512;587756;678763;679527.0236488156;689492;695853;133352;153708;153838;161324;161840.19079904526;1007.1238022920106;1041.6406339812752;1053.9736506587396;1053.994730026345;1057.7937302225992;19051.95214263229;19931.900340498203;20126.76405050755;20293.695594565797;20357.69463458079;56803;58915.52711182255;59750.50623734268;60538.69730651318;60744.696276518334;83779.5811020941;83851;87754.56122719345;87828.5608571953;90989.54505227432;10828.512716927915;11469.483873225892;11789.587364442203;12422;12624;12532.561360352343;14122.152670839783;14336.856631433553;14425.062370945854;14429.49496767608;8971.372003959921;11168.274062185932;12033.338166400932;12308.81536776967;12363.567275145328;11781.646550603497;11915;11944.64166075019;11987.160898737005;12272.938635306766;11912.40437978115;12035.879641203826;12089.939550302191;12325.75348493043;12601;12782;13035;13232.206067635972;13465.124766890121;13507.662308442368;11906.940465297617;12147.81778273309;12252.387380631111;12351.135420520477;12406.689832754253 12:34:16 INFO - PROCESS | 1651 | |3;mootools.html;1426.736053830041;1565.6633823727896;1753.5703752580619;1902.5814320849408;1936.7482227310447;8876.689315873939;9402;9406.811863762721;9425.057494250572;9458.76353091173;8223.794405139875;8562.65749370026;8907.643694252221;9095.272378209744;9128.041555636662;2428.64784606232;2466.6053431450973;2468.7531246875346;2471.0486462711897;2474.91337803176;2387.761223877607;2474.059857254241;2474.7401522840114;2476.2818782553036;2478.228066932143;2445.4742230420457;2452.31335226137;2475.356407334097;2477.8884950177285;2478.491909158618;2431.8419302745265;2453.2885463215734;2457.0663148003823;2457.1400009996446;2461.6061430171085;2398.1846172301325;2412.529556736437;2446.156076153724;2451.0685939343116;2452.644366566838;9155.313351498598;9280.303977201736;9283;9286;9287.58205880737;5479.424660410639;5610.943890561124;5620.269364982567;5625.437456254342;5639.971800140973;3640.6177351377987;3753.549574051104;3827.425886117077;3827.5024246847734;3827.8086095695103;1100.4497751124438;1121.5121422181296;1125.9211855170142;1144.2791041643795;1152.815549512074;12282.570110046196;12301.01591872648;12305.815412768816;12326.198797078161;12362.567310144192;4281.807318670667;4771.618270538349;4791.544803243686;4825.782839772219;4970.950290497121;10383.584656613803;10392.636257730943;10420.32267902584;10422.947885260524;10434.06093451593;5591.9720401397735;5592.5246354059545;5594.160875868571;5595.860103497445;5596.468335508121;4547.113312904018;4607.585317321457;4777.331173635694;4988.90022199554;5111.923321150111;3507.6667716566885;4053.0880551875593;4149.647279981175;4173.686973476941;4194.161167766459;1288.5361269942814;1298.9870101299055;1302.5961951794975;1314.7567699975534;1320.1485042147954;769.2768797330491;860.7891066688576;904.1907492793913;946.7112530678072;952.3761935931975;5017.347744793226;6085.17850090241;6103.42017508336;6171.537134714914;6326.49388048955;820.5240960243045;990.8860481044628;1003.2626019875386;1006.4816619440994;1032.4579595712312;3561.5904171020147;3787.3429826570796;3990.1620659661216;4026.0941288210506;4141.5237247716295;10924.781504369868;11318;11326.490307936163;11327.490262938187;11340.716482087848;10748.301360411548;11031.503582338813;11252.549898003988;11262.042726368187;11263.943680281545;7890.5265684057995;8579.142085791496;8582.227599516074;8585.055643879294;8593.78515537104;6077;6096.451319381277;6126.172966649624;6146.907796382969;6335.429811317003;10123.190144788547;10231.232657550863;10443.321184123008;10598.20513461478;10812.35125892449;10875.945620271848;10883;10895.291806032583;10908;10913.618023369145;7467.738629148171;7861.882071769042;7965.761027169194;8018.278354947849;8029.919700802917;8629.82740345177;8641.222289993932;8725.650973961225;8732.825343492968;8742.344324175585;7808.180141085331;7812.375009999073;7890.605469726605;7921.722739704082;7962.960185199037;7642.5032372895585;7739.845203095794;7784.766457006299;7789.610519474117;7815.882761758692;7133.5719856808755;7226.74706385274;7262;7273.709051637875;7317.26827317264;4514.413126293561;4925.753712314298;4984.651074424755;5103.617228707936;5170.069387510284;4444.977775111104;5043.193089105872;5051.520105589963;5141.922871156861;5298.602604804732 12:34:16 INFO - PROCESS | 1651 | |4;prototype.html;267.7122093749219;305.0786624394328;308.69593450451305;314.1658895632096;316.9998654245855;5305;5382.354117505895;5433.347998240211;5478.45215478452;5488.917666235;4057.959420405795;4504.414426124599;5114.1871970416305;5281.841544753664;5381.784728610861;3874.140412601953;3942.56631770505;4066.329055705805;4099.139180772041;4139.2135494256145;3688.9077773055756;4125.61791799746;4126;4141.689373296999;4142.088740477106;3280.2609820799544;3782.9432558511644;3845.961590370598;4117.46472958515;4160.188763191179;3767.434884767307;4122.752634841919;4127.525334586531;4133.855315063974;4147.6358475668885;3599.9100022499383;3601.657842504958;3622.8913132606062;3627.059523155099;3642.963570364289;4473.597376236155;5157.200633901752;5202.817901373433;5353.437889021675;5357.544608708265;4715.504871988426;4717.551832575899;4737.455192652855;4767.475577686451;4799.904001919942;5600.103983362683;5643.4886475518415;5647.599770097692;5654.547636189095;5657.434256574351;3970.68234541236;3974.225026119908;3980.9299164434333;3987.4018897165365;4026.355783074694;5181.766820493087;5484.285278786986;5928.42113680546;5987.0121429964;5993.430624090748;3182.3158021025592;3876.1666241757594;3900.64894159527;3931.803409829497;3936.992134011675;4019.21625283067;4019.2966230909474;4024.1348110156455;4025.6980726445636;4027.778472184058;4395.362672412482;4614.9385641302015;4632.073585282957;4634.629229661619;4694.413198350207;4664.183767840615;5648.435156484319;5689.544836413077;5694.572907031989;5714.5999780015;1332.367125615325;1348.8516263211038;1350.3990724127668;1353.4518519999417;1355.1259437662652;841.2933136165528;845.446232717571;869.4783130121876;875.6234819027752;879.520661239626;5284.260203571503;5375.81184658535;5384.6499977501335;5395.514403703607;5439.972800136054;5164.579740571373;5365.597580181502;5817.650940943557;5828.6502809831545;5857.941420585739;5168.664036837594;5430.755615997289;5467.371252305956;5489.451054894558;5553.583836121763;3056.801307914978;3071.3396619726864;3095.678241319011;3101.4882544379925;3101.9069427917198;5270.578353731769;5809.535237181015;6093;6120.540959428061;6170.444659980623;4746.715197088117;6015.428534289235;6040.214772079689;6048;6078.726457309432;5939.4557415072395;6018.960424985442;6143.815685529441;6169.5064394848305;6207.689615519296;5733.450451169868;5786.4213578643485;5831.446012628793;5893.5874488785375;5902.970485147547;5013.448520662797;5791.53667706574;5793.246877905845;5802.448767367094;5824.388439213991;5161.638685291993;5769.740096845269;6068.844201015536;6120.234970628671;6151.477124444294;3348.8158151301914;3910.8240129194824;3916.9608303917735;3930.3711406174875;3939.7439166454087;4702.976485117552;4788.922492439313;5934.525237980864;5964.522838172849;6008.579399441997;4924.384451943507;5187.325647665779;5341.023821186186;5773.393793651606;5811.27359080115;5377.650452720561;5513.944860551504;5752.769889204553;5812.389699081705;5816.738246778989;4863.659543831898;5413.971345444353;5603.523700485342;5702.885942281214;5717.313922329347;4986.650934434555;5291.894162116813;5532;5658.745356458887;5770.653760774367;4859.173940430064;5406.270153529381;5577.637453565505;5640.182173584889;5645.68948707825 12:34:16 INFO - PROCESS | 1651 | |5;yui.html;710.1655554723199;734.963251837408;757.7120694136228;770.7726220764874;870.6909047288217;16489.670206595874;17125.97244165351;17136.228869700863;17143.228554715035;17176.828231717696;15121;15293.388264469408;15296;15304.311305991228;15335.463258785945;743.0488974113143;762.1045271805606;768.0591275687294;893.7854914820429;907.9909200907989;893.3657103456553;908.9909100908973;914.6387177065055;921.5714692667908;926.3839546701469;974.9756256093619;975.8975307592707;977.3354119198942;977.7946631207456;982.773961988743;965.7440778193784;968.2205824311427;969.5976169889487;970.1850445625673;970.4904924914406;727.6834576958987;728.9562626242442;730.4375630764282;730.5762657658545;732.0044739154745;15874.920625396799;15919.920400397923;16031.519054428385;16034.5991350216;16045.518634440985;14809.629759255997;15256.131388317917;15491.457798977095;15844.683106337809;15863.127527985956;12081.335526546036;12082.6375208743;12119.33343666098;12201.45093470796;12596;3966.86115985942;3977.602239776028;3981.3828856527284;4060.3909413587903;4062.410950412174;126342;126547;126833.73166268312;127845;133421.33289333587;11233.71915702114;11714.945654890931;11960.521579136912;12021.579244726392;12060.095492838072;20980.895095524425;24989.375265618506;25081.749182508305;25110.37224069413;25275.62086568703;8089.635966381527;8525.275351595059;8554.401191916631;8602.096779838152;8604;4670.906581868344;4701.694389864648;4811.398575178103;4907.067657145202;4951.8266860659705;3827.827747751358;3944.1322908960556;3955.7428767130045;3962.5046869141356;3976.045749020272;758.8027112950563;779.1662920674937;785.0932173339802;794.6940427935286;802.06959926485;607.8206928955968;663.6117871045396;667.4827009067914;670.8893032649559;685.1469919949694;9375.5312234388;9861.753456163653;10178.440185789852;10290.639827605997;10394.844077338847;513.432656914112;562.9838142153452;576.7519966414482;595.8867815115115;621.6891554222889;4608.6082682971655;4719.646026547954;4932.1122198004705;5006.199008158677;5007.924881126786;98320.50839745755;137595.93606095915;152451;160082;164341.356586435;101586;124079.3796031014;138435;138671;141675;121965.39017304857;123242;123245.38377308236;125836;127795.49840514398;9339.85990210161;9415.011423800403;9531.857022144535;9556.044395560388;9616.134547890724;65629;66920.6653966727;67346.99999999804;67792.66103669647;68495.65752171406;101122.42704224202;102446;103802;104961.47519262355;105258.94741052491;12672.809907851573;12924.676883077998;12972.50221437118;13420.865791341961;13473;13480.93259533696;13671;13686;14405.85594144087;14427;12607.747845043232;12799;12959.35203239853;13384.130031547918;13425.909876536833;12195.206514147867;12466.626001219978;13234.338283086;13382.665433364244;13738.10702304347;12662.746745065231;12806;13155.473781048651;13162.736745265232;13278.933605331911;10755.623553175601;11166.944165279121;11464;11566.190366674253;11776.52893884235;10847.511861966073;11167.497462614365;11399.601013964471;11411.714707132389;11429.028532574492 12:34:16 INFO - PROCESS | 1651 | __end_tp_report 12:34:16 INFO - PROCESS | 1651 | __start_cc_report 12:34:16 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1194 12:34:16 INFO - PROCESS | 1651 | __end_cc_report 12:34:16 INFO - PROCESS | 1651 | __startTimestamp1479155656354__endTimestamp 12:34:16 INFO - PROCESS | 1651 | 12:34:16 INFO - PROCESS | 1651 | ------- Summary: start ------- 12:34:16 INFO - PROCESS | 1651 | Number of tests: 6 12:34:16 INFO - PROCESS | 1651 | 12:34:16 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5860.08 Median:6114.45 stddev:625.80 (10.2%) stddev-sans-first:598.69 12:34:16 INFO - PROCESS | 1651 | Values: 3458.5 3461.4 3512.1 3535.3 3559.0 5830.1 5894.0 5923.0 5934.6 5977.2 5304.7 5347.4 5845.7 5913.8 5916.1 5326.5 5345.6 5390.7 5415.8 5432.9 5322.2 5329.6 5454.1 5473.6 5488.4 5387.1 5409.4 5412.5 5418.2 5434.9 5332.7 5357.1 5394.4 5398.9 5408.4 5296.2 5390.4 5405.2 5429.5 5435.2 5718.9 5749.5 5923.4 5979.1 6051.5 6225.6 6232.2 6264.3 6312.7 6313.2 6257.2 6263.2 6268.7 6302.5 6315.4 5763.7 5960.4 5964.0 5968.3 5968.7 6252.3 6293.4 6296.3 6327.2 6377.9 6252.9 6276.5 6278.2 6304.5 6313.2 6246.3 6285.5 6288.6 6305.0 6311.3 6119.1 6203.7 6290.7 6294.5 6337.8 6306.6 6322.4 6325.5 6335.7 6342.0 5004.8 5051.8 5057.0 5070.5 5098.1 4461.8 4521.5 4552.5 4565.1 4596.9 5987.4 5996.4 6000.5 6010.6 6019.8 6296.9 6306.0 6320.5 6334.7 6338.6 5761.4 5781.2 5840.9 5884.8 5953.0 5535.5 5540.4 5542.0 5548.2 5561.7 6294.3 6328.2 6344.8 6348.7 6349.2 6329.2 6333.2 6336.9 6340.2 6340.5 6442.6 6446.6 6450.5 6456.4 6464.7 5197.4 6259.9 6260.3 6327.2 6334.8 6266.1 6293.5 6307.2 6316.0 6337.6 5303.4 6223.0 6288.9 6316.5 6337.5 6118.0 6155.8 6292.0 6309.7 6324.5 5135.2 6082.9 6099.1 6114.5 6167.8 6307.5 6315.7 6316.5 6317.1 6325.5 6098.0 6103.3 6117.5 6151.4 6154.3 12:34:16 INFO - PROCESS | 1651 | 12:34:16 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:76967.50 Median:39142.80 stddev:173405.93 (443.0%) stddev-sans-first:173797.42 12:34:16 INFO - PROCESS | 1651 | Values: 532.2 542.3 549.2 566.3 567.9 32746.7 36957.4 42773.0 43857.6 46146.8 45197.0 45516.0 45518.3 45605.8 45663.9 9933.0 10130.3 10149.4 10163.8 10171.3 9273.6 9502.1 9502.5 9604.9 9620.5 12181.6 12459.1 12466.1 12639.2 12646.9 12397.9 12493.8 12508.9 12516.7 12566.6 12145.1 12223.4 12228.1 12237.6 12245.4 42918.0 43231.8 43352.3 43400.3 43422.8 3520.1 3607.4 3671.6 3848.5 4152.4 29974.6 31112.8 31119.2 31353.7 33274.3 3357.5 3436.2 3525.0 3558.8 3563.9 501415.0 502516.0 504452.0 505779.0 506496.0 64540.4 64705.0 64803.4 64820.0 64860.7 68213.0 68348.0 68355.0 68555.3 68601.0 17909.0 18115.6 18148.7 18167.2 18230.7 14289.2 14374.6 14386.5 14392.7 14396.0 15983.9 16321.4 16351.6 16907.3 18262.5 6658.3 6769.4 7708.4 7815.7 7842.2 888.7 959.4 1011.1 1119.7 1150.3 31259.4 31295.5 31565.7 32172.8 32327.0 1049.6 1136.3 1157.5 1178.8 1210.7 16344.1 16353.8 16374.4 16411.3 16570.2 673420.0 682451.0 683963.0 685770.0 687521.0 45924.8 54020.5 54580.2 58610.0 61107.7 1417.3 1440.9 1448.0 1454.1 1457.2 28697.6 28747.6 31367.4 32977.7 32978.3 55001.0 55367.7 55397.7 55644.0 55671.2 395356.0 659374.0 668567.7 890581.0 914386.0 40503.0 41060.8 41345.0 41427.6 41500.8 48660.0 49014.0 49062.8 49170.8 49470.8 40196.4 40208.8 40287.6 40346.0 41707.0 39700.0 40292.6 40369.2 41281.6 41685.7 38716.6 39059.6 39123.6 39162.0 39450.0 33763.3 34670.6 35395.3 35477.6 35625.8 22406.0 23550.0 24628.0 26476.7 27478.0 12:34:16 INFO - PROCESS | 1651 | 12:34:16 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:38546.07 Median:12273.57 stddev:111786.41 (910.8%) stddev-sans-first:112063.21 12:34:16 INFO - PROCESS | 1651 | Values: 350.5 380.5 392.0 393.4 411.0 19377.8 21756.8 22294.8 22633.4 22852.7 21591.9 21643.5 21789.2 21975.0 22225.9 5625.4 6073.2 6140.7 6142.2 6147.9 4290.5 4389.4 6049.8 6160.2 6162.3 6714.3 6803.7 6811.9 6814.1 6848.7 6551.4 6780.6 6800.5 6816.4 6829.8 5779.7 5904.4 5940.9 5954.3 5963.2 26590.9 27041.9 27072.9 27171.2 27406.0 2140.8 2252.4 2266.7 2348.4 2425.7 8450.0 8698.3 10396.7 10627.4 10838.8 1910.3 2000.2 2011.8 2015.7 2046.5 123892.0 126759.0 129330.0 131347.0 133246.0 10510.0 10909.3 10962.8 11666.8 11668.4 14966.7 14968.8 14970.8 14992.0 15000.4 7401.7 9026.3 9033.9 9069.4 9130.8 8998.8 9075.1 9086.3 9254.1 9324.0 3901.9 4626.1 4626.5 4626.6 4680.1 1818.8 1837.7 1934.7 1962.6 1975.3 389.2 392.7 826.3 923.6 992.4 11496.0 11940.1 11952.9 11954.8 12339.9 353.5 373.9 427.0 427.1 433.4 6140.7 6179.5 6197.9 6201.8 6330.2 587756.0 678763.0 679527.0 689492.0 695853.0 133352.0 153708.0 153838.0 161324.0 161840.2 1007.1 1041.6 1054.0 1054.0 1057.8 19052.0 19931.9 20126.8 20293.7 20357.7 56803.0 58915.5 59750.5 60538.7 60744.7 83779.6 83851.0 87754.6 87828.6 90989.5 10828.5 11469.5 11789.6 12422.0 12624.0 12532.6 14122.2 14336.9 14425.1 14429.5 8971.4 11168.3 12033.3 12308.8 12363.6 11781.6 11915.0 11944.6 11987.2 12272.9 11912.4 12035.9 12089.9 12325.8 12601.0 12782.0 13035.0 13232.2 13465.1 13507.7 11906.9 12147.8 12252.4 12351.1 12406.7 12:34:16 INFO - PROCESS | 1651 | 12:34:16 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5955.34 Median:4530.76 stddev:3380.75 (74.6%) stddev-sans-first:3373.10 12:34:16 INFO - PROCESS | 1651 | Values: 1426.7 1565.7 1753.6 1902.6 1936.7 8876.7 9402.0 9406.8 9425.1 9458.8 8223.8 8562.7 8907.6 9095.3 9128.0 2428.6 2466.6 2468.8 2471.0 2474.9 2387.8 2474.1 2474.7 2476.3 2478.2 2445.5 2452.3 2475.4 2477.9 2478.5 2431.8 2453.3 2457.1 2457.1 2461.6 2398.2 2412.5 2446.2 2451.1 2452.6 9155.3 9280.3 9283.0 9286.0 9287.6 5479.4 5610.9 5620.3 5625.4 5640.0 3640.6 3753.5 3827.4 3827.5 3827.8 1100.4 1121.5 1125.9 1144.3 1152.8 12282.6 12301.0 12305.8 12326.2 12362.6 4281.8 4771.6 4791.5 4825.8 4971.0 10383.6 10392.6 10420.3 10422.9 10434.1 5592.0 5592.5 5594.2 5595.9 5596.5 4547.1 4607.6 4777.3 4988.9 5111.9 3507.7 4053.1 4149.6 4173.7 4194.2 1288.5 1299.0 1302.6 1314.8 1320.1 769.3 860.8 904.2 946.7 952.4 5017.3 6085.2 6103.4 6171.5 6326.5 820.5 990.9 1003.3 1006.5 1032.5 3561.6 3787.3 3990.2 4026.1 4141.5 10924.8 11318.0 11326.5 11327.5 11340.7 10748.3 11031.5 11252.5 11262.0 11263.9 7890.5 8579.1 8582.2 8585.1 8593.8 6077.0 6096.5 6126.2 6146.9 6335.4 10123.2 10231.2 10443.3 10598.2 10812.4 10875.9 10883.0 10895.3 10908.0 10913.6 7467.7 7861.9 7965.8 8018.3 8029.9 8629.8 8641.2 8725.7 8732.8 8742.3 7808.2 7812.4 7890.6 7921.7 7963.0 7642.5 7739.8 7784.8 7789.6 7815.9 7133.6 7226.7 7262.0 7273.7 7317.3 4514.4 4925.8 4984.7 5103.6 5170.1 4445.0 5043.2 5051.5 5141.9 5298.6 12:34:16 INFO - PROCESS | 1651 | 12:34:16 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4631.35 Median:5276.21 stddev:1426.39 (27.0%) stddev-sans-first:1392.28 12:34:16 INFO - PROCESS | 1651 | Values: 267.7 305.1 308.7 314.2 317.0 5305.0 5382.4 5433.3 5478.5 5488.9 4058.0 4504.4 5114.2 5281.8 5381.8 3874.1 3942.6 4066.3 4099.1 4139.2 3688.9 4125.6 4126.0 4141.7 4142.1 3280.3 3782.9 3846.0 4117.5 4160.2 3767.4 4122.8 4127.5 4133.9 4147.6 3599.9 3601.7 3622.9 3627.1 3643.0 4473.6 5157.2 5202.8 5353.4 5357.5 4715.5 4717.6 4737.5 4767.5 4799.9 5600.1 5643.5 5647.6 5654.5 5657.4 3970.7 3974.2 3980.9 3987.4 4026.4 5181.8 5484.3 5928.4 5987.0 5993.4 3182.3 3876.2 3900.6 3931.8 3937.0 4019.2 4019.3 4024.1 4025.7 4027.8 4395.4 4614.9 4632.1 4634.6 4694.4 4664.2 5648.4 5689.5 5694.6 5714.6 1332.4 1348.9 1350.4 1353.5 1355.1 841.3 845.4 869.5 875.6 879.5 5284.3 5375.8 5384.6 5395.5 5440.0 5164.6 5365.6 5817.7 5828.7 5857.9 5168.7 5430.8 5467.4 5489.5 5553.6 3056.8 3071.3 3095.7 3101.5 3101.9 5270.6 5809.5 6093.0 6120.5 6170.4 4746.7 6015.4 6040.2 6048.0 6078.7 5939.5 6019.0 6143.8 6169.5 6207.7 5733.5 5786.4 5831.4 5893.6 5903.0 5013.4 5791.5 5793.2 5802.4 5824.4 5161.6 5769.7 6068.8 6120.2 6151.5 3348.8 3910.8 3917.0 3930.4 3939.7 4703.0 4788.9 5934.5 5964.5 6008.6 4924.4 5187.3 5341.0 5773.4 5811.3 5377.7 5513.9 5752.8 5812.4 5816.7 4863.7 5414.0 5603.5 5702.9 5717.3 4986.7 5291.9 5532.0 5658.7 5770.7 4859.2 5406.3 5577.6 5640.2 5645.7 12:34:16 INFO - PROCESS | 1651 | 12:34:16 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:26341.60 Median:17160.03 stddev:42047.01 (245.0%) stddev-sans-first:42120.92 12:34:16 INFO - PROCESS | 1651 | Values: 710.2 735.0 757.7 770.8 870.7 16489.7 17126.0 17136.2 17143.2 17176.8 15121.0 15293.4 15296.0 15304.3 15335.5 743.0 762.1 768.1 893.8 908.0 893.4 909.0 914.6 921.6 926.4 975.0 975.9 977.3 977.8 982.8 965.7 968.2 969.6 970.2 970.5 727.7 729.0 730.4 730.6 732.0 15874.9 15919.9 16031.5 16034.6 16045.5 14809.6 15256.1 15491.5 15844.7 15863.1 12081.3 12082.6 12119.3 12201.5 12596.0 3966.9 3977.6 3981.4 4060.4 4062.4 126342.0 126547.0 126833.7 127845.0 133421.3 11233.7 11714.9 11960.5 12021.6 12060.1 20980.9 24989.4 25081.7 25110.4 25275.6 8089.6 8525.3 8554.4 8602.1 8604.0 4670.9 4701.7 4811.4 4907.1 4951.8 3827.8 3944.1 3955.7 3962.5 3976.0 758.8 779.2 785.1 794.7 802.1 607.8 663.6 667.5 670.9 685.1 9375.5 9861.8 10178.4 10290.6 10394.8 513.4 563.0 576.8 595.9 621.7 4608.6 4719.6 4932.1 5006.2 5007.9 98320.5 137595.9 152451.0 160082.0 164341.4 101586.0 124079.4 138435.0 138671.0 141675.0 121965.4 123242.0 123245.4 125836.0 127795.5 9339.9 9415.0 9531.9 9556.0 9616.1 65629.0 66920.7 67347.0 67792.7 68495.7 101122.4 102446.0 103802.0 104961.5 105258.9 12672.8 12924.7 12972.5 13420.9 13473.0 13480.9 13671.0 13686.0 14405.9 14427.0 12607.7 12799.0 12959.4 13384.1 13425.9 12195.2 12466.6 13234.3 13382.7 13738.1 12662.7 12806.0 13155.5 13162.7 13278.9 10755.6 11166.9 11464.0 11566.2 11776.5 10847.5 11167.5 11399.6 11411.7 11429.0 12:34:16 INFO - PROCESS | 1651 | -------- Summary: end -------- 12:34:16 INFO - PROCESS | 1651 | 12:34:16 INFO - TEST-INFO | 1651: exit 0 12:34:16 INFO - TEST-OK | dromaeo_css | took 1114663ms 12:34:16 INFO - TEST-START | kraken 12:34:16 INFO - operating with platform_type : mac_ 12:34:16 INFO - Initialising browser for kraken test... 12:34:16 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpnTxcwy/profile http://localhost:49271/getInfo.html) 12:34:19 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 12:34:19 INFO - PROCESS | 1662 | colorDepth:24 12:34:19 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 12:34:19 INFO - PROCESS | 1662 | __metrics 12:34:19 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:34:19 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:34:19 INFO - TEST-INFO | 1662: exit 0 12:34:19 INFO - Browser initialized. 12:34:19 INFO - Running cycle 1/1 for kraken test... 12:34:19 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/tmpnTxcwy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:34:31 INFO - PROCESS | 1664 | RSS: Main: 168747008 12:34:31 INFO - PROCESS | 1664 | 12:34:34 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 12:34:35 INFO - PROCESS | 1664 | RSS: Main: 217837568 12:34:35 INFO - PROCESS | 1664 | 12:34:37 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 12:34:38 INFO - PROCESS | 1664 | RSS: Main: 228098048 12:34:38 INFO - PROCESS | 1664 | 12:34:41 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 12:34:42 INFO - PROCESS | 1664 | RSS: Main: 327036928 12:34:42 INFO - PROCESS | 1664 | 12:34:44 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 12:34:44 INFO - PROCESS | 1664 | RSS: Main: 227487744 12:34:44 INFO - PROCESS | 1664 | 12:34:46 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:34:47 INFO - PROCESS | 1664 | RSS: Main: 227745792 12:34:47 INFO - PROCESS | 1664 | 12:34:50 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 12:34:50 INFO - PROCESS | 1664 | RSS: Main: 266104832 12:34:50 INFO - PROCESS | 1664 | 12:34:53 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 12:34:54 INFO - PROCESS | 1664 | RSS: Main: 266489856 12:34:54 INFO - PROCESS | 1664 | 12:34:57 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 12:34:57 INFO - PROCESS | 1664 | RSS: Main: 266629120 12:34:57 INFO - PROCESS | 1664 | 12:34:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:34:59 INFO - PROCESS | 1664 | RSS: Main: 240238592 12:34:59 INFO - PROCESS | 1664 | 12:35:01 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:35:02 INFO - PROCESS | 1664 | RSS: Main: 244027392 12:35:02 INFO - PROCESS | 1664 | 12:35:04 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:35:05 INFO - PROCESS | 1664 | RSS: Main: 249913344 12:35:05 INFO - PROCESS | 1664 | 12:35:07 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:35:08 INFO - PROCESS | 1664 | RSS: Main: 276131840 12:35:08 INFO - PROCESS | 1664 | 12:35:11 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:35:11 INFO - PROCESS | 1664 | RSS: Main: 265953280 12:35:11 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 12:35:13 INFO - PROCESS | 1664 | RSS: Main: 309911552 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | __start_tp_report 12:35:13 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 12:35:13 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 12:35:13 INFO - PROCESS | 1664 | |i|pagename|runs| 12:35:13 INFO - PROCESS | 1664 | |0;ai-astar;116;113;113;112;113;114;114;114;113;114 12:35:13 INFO - PROCESS | 1664 | |1;audio-beat-detection;143;110;106;132;119;107;107;103;135;106 12:35:13 INFO - PROCESS | 1664 | |2;audio-dft;182;183;191;180;182;184;180;183;183;182 12:35:13 INFO - PROCESS | 1664 | |3;audio-fft;80;57;61;88;60;58;57;57;79;57 12:35:13 INFO - PROCESS | 1664 | |4;audio-oscillator;84;69;116;97;96;81;91;67;68;89 12:35:13 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;89;85;89;125;89;85;90;90;90;85 12:35:13 INFO - PROCESS | 1664 | |6;imaging-darkroom;130;94;94;94;94;97;90;104;146;146 12:35:13 INFO - PROCESS | 1664 | |7;imaging-desaturate;84;86;84;86;85;84;84;84;91;90 12:35:13 INFO - PROCESS | 1664 | |8;json-parse-financial;55;51;52;51;56;56;55;55;55;55 12:35:13 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;63;73;75;71;71;67;69;69;69;69 12:35:13 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;83;80;81;83;81;83;82;88;88;99 12:35:13 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;134;136;133;139;146;147;128;138;136;141 12:35:13 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;152;158;158;162;160;163;159;160;160;159 12:35:13 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;65;64;67;66;65;66;68;83;82;81 12:35:13 INFO - PROCESS | 1664 | __end_tp_report 12:35:13 INFO - PROCESS | 1664 | __start_cc_report 12:35:13 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1849 12:35:13 INFO - PROCESS | 1664 | __end_cc_report 12:35:13 INFO - PROCESS | 1664 | __startTimestamp1479155713850__endTimestamp 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | ------- Summary: start ------- 12:35:13 INFO - PROCESS | 1664 | Number of tests: 14 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:0.71 12:35:13 INFO - PROCESS | 1664 | Values: 116.0 113.0 113.0 112.0 113.0 114.0 114.0 114.0 113.0 114.0 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:116.80 Median:114.50 stddev:14.59 (12.7%) stddev-sans-first:12.00 12:35:13 INFO - PROCESS | 1664 | Values: 143.0 110.0 106.0 132.0 119.0 107.0 107.0 103.0 135.0 106.0 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.00 stddev:3.09 (1.7%) stddev-sans-first:3.26 12:35:13 INFO - PROCESS | 1664 | Values: 182.0 183.0 191.0 180.0 182.0 184.0 180.0 183.0 183.0 182.0 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:65.40 Median:60.50 stddev:11.99 (19.8%) stddev-sans-first:11.50 12:35:13 INFO - PROCESS | 1664 | Values: 80.0 57.0 61.0 88.0 60.0 58.0 57.0 57.0 79.0 57.0 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:85.80 Median:86.50 stddev:15.48 (17.9%) stddev-sans-first:16.41 12:35:13 INFO - PROCESS | 1664 | Values: 84.0 69.0 116.0 97.0 96.0 81.0 91.0 67.0 68.0 89.0 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:91.70 Median:89.00 stddev:11.90 (13.4%) stddev-sans-first:12.58 12:35:13 INFO - PROCESS | 1664 | Values: 89.0 85.0 89.0 125.0 89.0 85.0 90.0 90.0 90.0 85.0 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:108.90 Median:94.00 stddev:22.63 (24.1%) stddev-sans-first:22.68 12:35:13 INFO - PROCESS | 1664 | Values: 130.0 94.0 94.0 94.0 94.0 97.0 90.0 104.0 146.0 146.0 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:85.50 stddev:2.62 (3.1%) stddev-sans-first:2.69 12:35:13 INFO - PROCESS | 1664 | Values: 84.0 86.0 84.0 86.0 85.0 84.0 84.0 84.0 91.0 90.0 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:55.00 stddev:1.97 (3.6%) stddev-sans-first:2.06 12:35:13 INFO - PROCESS | 1664 | Values: 55.0 51.0 52.0 51.0 56.0 56.0 55.0 55.0 55.0 55.0 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:70.00 stddev:3.27 (4.7%) stddev-sans-first:2.45 12:35:13 INFO - PROCESS | 1664 | Values: 63.0 73.0 75.0 71.0 71.0 67.0 69.0 69.0 69.0 69.0 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:83.00 stddev:5.69 (6.9%) stddev-sans-first:6.00 12:35:13 INFO - PROCESS | 1664 | Values: 83.0 80.0 81.0 83.0 81.0 83.0 82.0 88.0 88.0 99.0 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:138.50 stddev:5.81 (4.2%) stddev-sans-first:6.00 12:35:13 INFO - PROCESS | 1664 | Values: 134.0 136.0 133.0 139.0 146.0 147.0 128.0 138.0 136.0 141.0 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:160.00 stddev:2.96 (1.9%) stddev-sans-first:1.69 12:35:13 INFO - PROCESS | 1664 | Values: 152.0 158.0 158.0 162.0 160.0 163.0 159.0 160.0 160.0 159.0 12:35:13 INFO - PROCESS | 1664 | 12:35:13 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:67.50 stddev:7.89 (11.7%) stddev-sans-first:8.09 12:35:13 INFO - PROCESS | 1664 | Values: 65.0 64.0 67.0 66.0 65.0 66.0 68.0 83.0 82.0 81.0 12:35:13 INFO - PROCESS | 1664 | -------- Summary: end -------- 12:35:13 INFO - PROCESS | 1664 | 12:35:14 INFO - TEST-INFO | 1664: exit 0 12:35:14 INFO - TEST-OK | kraken | took 57695ms 12:35:14 INFO - SUITE-END | took 1172s 12:35:14 INFO - Completed test suite (00:19:32) 12:35:15 INFO - javascript benchmark 12:35:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3458.5158077869105, 3461.376952148613, 3512.104413374591, 3535.3106144301873, 3558.964410355896, 5830.067189249721, 5893.970530147349, 5923.0, 5934.554908381867, 5977.193078934337, 5304.7268655522685, 5347.385050719159, 5845.678487683176, 5913.763449462027, 5916.112583112525, 5326.547243484309, 5345.625806193568, 5390.676559406428, 5415.810446634368, 5432.864178395532, 5322.20166974953, 5329.600279978998, 5454.10007348787, 5473.589480788937, 5488.368837583689, 5387.0841956867425, 5409.43200963899, 5412.4587541245955, 5418.187271909225, 5434.864128396782, 5332.733363331838, 5357.089294819851, 5394.406615272317, 5398.865028374283, 5408.4050754416985, 5296.2055691646565, 5390.407055223922, 5405.21624364465, 5429.484199001088, 5435.239066530688, 5718.914216286759, 5749.540036797046, 5923.437273459058, 5979.073243647198, 6051.485623721989, 6225.626462412224, 6232.189815323979, 6264.27960784511, 6312.715927783215, 6313.210848643919, 6257.155284036642, 6263.217097862767, 6268.749250029993, 6302.46429053531, 6315.3684631536935, 5763.7118144093465, 5960.403959604005, 5964.045752679551, 5968.283805943314, 5968.7015649217365, 6252.3122456529745, 6293.433590976742, 6296.275928268216, 6327.17746692927, 6377.872442551123, 6252.874942501125, 6276.529260305404, 6278.183836101278, 6304.527160462983, 6313.210848643919, 6246.250449946036, 6285.465735412449, 6288.622682639057, 6305.0, 6311.274203466568, 6119.074419021604, 6203.720832562545, 6290.716917738713, 6294.464970477561, 6337.7781777637565, 6306.621602703761, 6322.36776322364, 6325.462335701425, 6335.746570137235, 6342.0, 5004.799808007639, 5051.772670229775, 5057.0, 5070.492950704974, 5098.107831129538, 4461.843835465743, 4521.547845215452, 4552.453705555288, 4565.0641618468135, 4596.88507787308, 5987.401259873977, 5996.430339117776, 6000.489958353589, 6010.609310394811, 6019.819405417845, 6296.9309705687365, 6306.0, 6320.5259605528845, 6334.714937827809, 6338.556301058881, 5761.3950535194035, 5781.19063331134, 5840.912386314209, 5884.794032208938, 5952.987992041363, 5535.474129957647, 5540.445955404508, 5542.0301447246575, 5548.195511650788, 5561.749721262553, 6294.276158241769, 6328.177336946167, 6344.777932772423, 6348.714307856158, 6349.238091428873, 6329.177206963065, 6333.240011198685, 6336.936630633634, 6340.175777148941, 6340.4927605792345, 6442.581232220078, 6446.645434501147, 6450.48396128318, 6456.354364563506, 6464.709088091141, 5197.376314842243, 6259.874802504016, 6260.28006779208, 6327.209098862642, 6334.809955701337, 6266.091416744638, 6293.465055470337, 6307.211598550181, 6316.021016742412, 6337.588056776295, 5303.443138470405, 6222.968885155546, 6288.937110629018, 6316.494680425463, 6337.493000559852, 6118.0, 6155.753769849156, 6292.0, 6309.747610095545, 6324.494040476843, 5135.204043373283, 6082.878342433215, 6099.085137229274, 6114.453616902275, 6167.753289868535, 6307.495400368051, 6315.684215789284, 6316.463100636497, 6317.052442133533, 6325.493960483058, 6097.969510152421, 6103.298120716175, 6117.510599152146, 6151.415615516519, 6154.292256390572], "value": 5822.338455785524, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.1963834609738, 542.3166809819627, 549.2420459765524, 566.3091028944687, 567.8523583868193, 32746.67253327466, 36957.44563831545, 42773.0, 43857.56142438575, 46146.76926615371, 45197.0, 45516.0, 45518.31722524165, 45605.7719711401, 45663.858403539845, 9933.006699330046, 10130.290879638429, 10149.441780702058, 10163.796724065514, 10171.288009839314, 9273.629054837833, 9502.097300756417, 9502.47736374499, 9604.855927161097, 9620.518974051269, 12181.57364492243, 12459.065570082235, 12466.065045121606, 12639.178453400546, 12646.925011374044, 12397.938010309936, 12493.75012499754, 12508.937455312756, 12516.687082822957, 12566.623001309976, 12145.149839511238, 12223.449944752507, 12228.082893783001, 12237.571684991071, 12245.448954796966, 42918.0, 43231.783841080905, 43352.3497147543, 43400.3489947651, 43422.78288608568, 3520.119970007498, 3607.4047782115917, 3671.5594128704724, 3848.4804551385487, 4152.356384760367, 29974.55038174429, 31112.755489780382, 31119.22201944947, 31353.68646313553, 33274.3345133096, 3357.5131605917004, 3436.1581412554083, 3524.9647503524893, 3558.7864728116137, 3563.928721425557, 501415.0, 502516.0, 504452.0, 505779.0, 506496.0, 64540.354596454374, 64705.0, 64803.351966479735, 64820.0, 64860.67569662121, 68213.0, 68347.97478037834, 68355.0, 68555.31444685589, 68601.0, 17909.0, 18115.63768724618, 18148.727769083474, 18167.182476788577, 18230.726539101925, 14289.214093224973, 14374.640633984025, 14386.496472623408, 14392.712145757236, 14396.0, 15983.881128320905, 16321.428749993693, 16351.59121021984, 16907.32370705158, 18262.543436414195, 6658.267590565034, 6769.424598909148, 7708.421868359896, 7815.726449574237, 7842.215778422112, 888.7467071884482, 959.4291396619001, 1011.1405305490274, 1119.729107463019, 1150.2925700694013, 31259.374812504077, 31295.53056704151, 31565.684343156732, 32172.83913580417, 32327.0, 1049.6011515624166, 1136.3409222650844, 1157.4849192109598, 1178.834963105166, 1210.7154818617619, 16344.10107444102, 16353.754693679604, 16374.426895058616, 16411.261493232832, 16570.171491425623, 673420.0, 682451.0, 683963.0, 685770.0, 687521.0, 45924.770376147906, 54020.45979540233, 54580.18129728057, 58610.0, 61107.694461527404, 1417.2559406311768, 1440.9351579178963, 1447.992760036193, 1454.142056186855, 1457.2131049233296, 28697.56953645655, 28747.5687864678, 31367.372652547278, 32977.67022329842, 32978.34043319168, 55001.0, 55367.72316138555, 55397.72301138468, 55644.0, 55671.16493252685, 395356.0, 659374.0, 668567.6571617111, 890581.0, 914386.0, 40503.0, 41060.76817695474, 41345.0, 41427.58572414237, 41500.792496038535, 48660.02679946311, 49014.0, 49062.75468622777, 49170.770730732016, 49470.752646236535, 40196.3970540448, 40208.798956005034, 40287.59712402838, 40346.0, 41706.95732606709, 39700.00749981274, 40292.597074030055, 40369.1926161481, 41281.58718412778, 41685.74942751722, 38716.6128338713, 39059.6094039056, 39123.60876391314, 39162.0, 39450.013749656486, 33763.32473350568, 34670.613175472696, 35395.292094157456, 35477.64522354847, 35625.82187089048, 22406.0, 23550.0, 24628.0, 26476.73523264743, 27478.0382686605], "value": 21592.77564807425, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.511037103241, 380.49964296949526, 391.9764814111153, 393.39220903703773, 410.97945102744853, 19377.806221937775, 21756.782432175674, 22294.777052229492, 22633.434164145903, 22852.65721014182, 21591.892040539813, 21643.45891352717, 21789.225855148357, 21975.011124499397, 22225.888870555664, 5625.353084395296, 6073.180120683695, 6140.723667434954, 6142.170806941072, 6147.90778138326, 4290.506591741942, 4389.429374181368, 6049.758009679607, 6160.229971253593, 6162.260528736558, 6714.328567143271, 6803.727850885984, 6811.863762724743, 6814.080099186621, 6848.6918088686125, 6551.410373066423, 6780.593164410151, 6800.50388914438, 6816.38652521273, 6829.829254268633, 5779.7404362030775, 5904.350521442638, 5940.910886336708, 5954.285485741739, 5963.194968679216, 26590.86704566484, 27041.864790676118, 27072.86463567689, 27171.1848644541, 27406.0, 2140.7538133114736, 2252.3693365857584, 2266.6600009998633, 2348.377679914807, 2425.7331693513697, 8449.95775021121, 8698.260647844942, 10396.740081497948, 10627.36235825853, 10838.783224335548, 1910.3409323783274, 2000.1799262302386, 2011.757672379437, 2015.737954065962, 2046.5088378789133, 123892.0, 126759.0, 129330.0, 131347.0, 133246.0, 10510.0, 10909.345439273511, 10962.780744385227, 11666.824997625043, 11668.416579171007, 14966.70066598662, 14968.775468367983, 14970.775438368433, 14992.025518341274, 15000.399984000518, 7401.703931842666, 9026.277897768163, 9033.864492032624, 9069.41048831837, 9130.771730706652, 8998.775030624287, 9075.092490751003, 9086.318526110568, 9254.074592540692, 9324.020977797234, 3901.882943511699, 4626.144163329727, 4626.514216007338, 4626.606738427204, 4680.063987202505, 1818.8363047325804, 1837.742486832338, 1934.6517626827306, 1962.6172896285373, 1975.3382616823237, 389.23709529322844, 392.71135715249267, 826.2522417212432, 923.6213152607398, 992.3549692699803, 11495.965363117359, 11940.104492163122, 11952.88047119535, 11954.760904781855, 12339.93830030844, 353.50509286997897, 373.89344036949336, 426.9914601708011, 427.07964336854127, 433.3521385528592, 6140.723667434976, 6179.474744646755, 6197.876042479125, 6201.81394558164, 6330.208723909512, 587756.0, 678763.0, 679527.0236488156, 689492.0, 695853.0, 133352.0, 153708.0, 153838.0, 161324.0, 161840.19079904526, 1007.1238022920106, 1041.6406339812752, 1053.9736506587396, 1053.994730026345, 1057.7937302225992, 19051.95214263229, 19931.900340498203, 20126.76405050755, 20293.695594565797, 20357.69463458079, 56803.0, 58915.52711182255, 59750.50623734268, 60538.69730651318, 60744.696276518334, 83779.5811020941, 83851.0, 87754.56122719345, 87828.5608571953, 90989.54505227432, 10828.512716927915, 11469.483873225892, 11789.587364442203, 12422.0, 12624.0, 12532.561360352343, 14122.152670839783, 14336.856631433553, 14425.062370945854, 14429.49496767608, 8971.372003959921, 11168.274062185932, 12033.338166400932, 12308.81536776967, 12363.567275145328, 11781.646550603497, 11915.0, 11944.64166075019, 11987.160898737005, 12272.938635306766, 11912.40437978115, 12035.879641203826, 12089.939550302191, 12325.75348493043, 12601.0, 12782.0, 13035.0, 13232.206067635972, 13465.124766890121, 13507.662308442368, 11906.940465297617, 12147.81778273309, 12252.387380631111, 12351.135420520477, 12406.689832754253], "value": 9667.962030767781, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.736053830041, 1565.6633823727896, 1753.5703752580619, 1902.5814320849408, 1936.7482227310447, 8876.689315873939, 9402.0, 9406.811863762721, 9425.057494250572, 9458.76353091173, 8223.794405139875, 8562.65749370026, 8907.643694252221, 9095.272378209744, 9128.041555636662, 2428.64784606232, 2466.6053431450973, 2468.7531246875346, 2471.0486462711897, 2474.91337803176, 2387.761223877607, 2474.059857254241, 2474.7401522840114, 2476.2818782553036, 2478.228066932143, 2445.4742230420457, 2452.31335226137, 2475.356407334097, 2477.8884950177285, 2478.491909158618, 2431.8419302745265, 2453.2885463215734, 2457.0663148003823, 2457.1400009996446, 2461.6061430171085, 2398.1846172301325, 2412.529556736437, 2446.156076153724, 2451.0685939343116, 2452.644366566838, 9155.313351498598, 9280.303977201736, 9283.0, 9286.0, 9287.58205880737, 5479.424660410639, 5610.943890561124, 5620.269364982567, 5625.437456254342, 5639.971800140973, 3640.6177351377987, 3753.549574051104, 3827.425886117077, 3827.5024246847734, 3827.8086095695103, 1100.4497751124438, 1121.5121422181296, 1125.9211855170142, 1144.2791041643795, 1152.815549512074, 12282.570110046196, 12301.01591872648, 12305.815412768816, 12326.198797078161, 12362.567310144192, 4281.807318670667, 4771.618270538349, 4791.544803243686, 4825.782839772219, 4970.950290497121, 10383.584656613803, 10392.636257730943, 10420.32267902584, 10422.947885260524, 10434.06093451593, 5591.9720401397735, 5592.5246354059545, 5594.160875868571, 5595.860103497445, 5596.468335508121, 4547.113312904018, 4607.585317321457, 4777.331173635694, 4988.90022199554, 5111.923321150111, 3507.6667716566885, 4053.0880551875593, 4149.647279981175, 4173.686973476941, 4194.161167766459, 1288.5361269942814, 1298.9870101299055, 1302.5961951794975, 1314.7567699975534, 1320.1485042147954, 769.2768797330491, 860.7891066688576, 904.1907492793913, 946.7112530678072, 952.3761935931975, 5017.347744793226, 6085.17850090241, 6103.42017508336, 6171.537134714914, 6326.49388048955, 820.5240960243045, 990.8860481044628, 1003.2626019875386, 1006.4816619440994, 1032.4579595712312, 3561.5904171020147, 3787.3429826570796, 3990.1620659661216, 4026.0941288210506, 4141.5237247716295, 10924.781504369868, 11318.0, 11326.490307936163, 11327.490262938187, 11340.716482087848, 10748.301360411548, 11031.503582338813, 11252.549898003988, 11262.042726368187, 11263.943680281545, 7890.5265684057995, 8579.142085791496, 8582.227599516074, 8585.055643879294, 8593.78515537104, 6077.0, 6096.451319381277, 6126.172966649624, 6146.907796382969, 6335.429811317003, 10123.190144788547, 10231.232657550863, 10443.321184123008, 10598.20513461478, 10812.35125892449, 10875.945620271848, 10883.0, 10895.291806032583, 10908.0, 10913.618023369145, 7467.738629148171, 7861.882071769042, 7965.761027169194, 8018.278354947849, 8029.919700802917, 8629.82740345177, 8641.222289993932, 8725.650973961225, 8732.825343492968, 8742.344324175585, 7808.180141085331, 7812.375009999073, 7890.605469726605, 7921.722739704082, 7962.960185199037, 7642.5032372895585, 7739.845203095794, 7784.766457006299, 7789.610519474117, 7815.882761758692, 7133.5719856808755, 7226.74706385274, 7262.0, 7273.709051637875, 7317.26827317264, 4514.413126293561, 4925.753712314298, 4984.651074424755, 5103.617228707936, 5170.069387510284, 4444.977775111104, 5043.193089105872, 5051.520105589963, 5141.922871156861, 5298.602604804732], "value": 4766.732383407361, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.7122093749219, 305.0786624394328, 308.69593450451305, 314.1658895632096, 316.9998654245855, 5305.0, 5382.354117505895, 5433.347998240211, 5478.45215478452, 5488.917666235, 4057.959420405795, 4504.414426124599, 5114.1871970416305, 5281.841544753664, 5381.784728610861, 3874.140412601953, 3942.56631770505, 4066.329055705805, 4099.139180772041, 4139.2135494256145, 3688.9077773055756, 4125.61791799746, 4126.0, 4141.689373296999, 4142.088740477106, 3280.2609820799544, 3782.9432558511644, 3845.961590370598, 4117.46472958515, 4160.188763191179, 3767.434884767307, 4122.752634841919, 4127.525334586531, 4133.855315063974, 4147.6358475668885, 3599.9100022499383, 3601.657842504958, 3622.8913132606062, 3627.059523155099, 3642.963570364289, 4473.597376236155, 5157.200633901752, 5202.817901373433, 5353.437889021675, 5357.544608708265, 4715.504871988426, 4717.551832575899, 4737.455192652855, 4767.475577686451, 4799.904001919942, 5600.103983362683, 5643.4886475518415, 5647.599770097692, 5654.547636189095, 5657.434256574351, 3970.68234541236, 3974.225026119908, 3980.9299164434333, 3987.4018897165365, 4026.355783074694, 5181.766820493087, 5484.285278786986, 5928.42113680546, 5987.0121429964, 5993.430624090748, 3182.3158021025592, 3876.1666241757594, 3900.64894159527, 3931.803409829497, 3936.992134011675, 4019.21625283067, 4019.2966230909474, 4024.1348110156455, 4025.6980726445636, 4027.778472184058, 4395.362672412482, 4614.9385641302015, 4632.073585282957, 4634.629229661619, 4694.413198350207, 4664.183767840615, 5648.435156484319, 5689.544836413077, 5694.572907031989, 5714.5999780015, 1332.367125615325, 1348.8516263211038, 1350.3990724127668, 1353.4518519999417, 1355.1259437662652, 841.2933136165528, 845.446232717571, 869.4783130121876, 875.6234819027752, 879.520661239626, 5284.260203571503, 5375.81184658535, 5384.6499977501335, 5395.514403703607, 5439.972800136054, 5164.579740571373, 5365.597580181502, 5817.650940943557, 5828.6502809831545, 5857.941420585739, 5168.664036837594, 5430.755615997289, 5467.371252305956, 5489.451054894558, 5553.583836121763, 3056.801307914978, 3071.3396619726864, 3095.678241319011, 3101.4882544379925, 3101.9069427917198, 5270.578353731769, 5809.535237181015, 6093.0, 6120.540959428061, 6170.444659980623, 4746.715197088117, 6015.428534289235, 6040.214772079689, 6048.0, 6078.726457309432, 5939.4557415072395, 6018.960424985442, 6143.815685529441, 6169.5064394848305, 6207.689615519296, 5733.450451169868, 5786.4213578643485, 5831.446012628793, 5893.5874488785375, 5902.970485147547, 5013.448520662797, 5791.53667706574, 5793.246877905845, 5802.448767367094, 5824.388439213991, 5161.638685291993, 5769.740096845269, 6068.844201015536, 6120.234970628671, 6151.477124444294, 3348.8158151301914, 3910.8240129194824, 3916.9608303917735, 3930.3711406174875, 3939.7439166454087, 4702.976485117552, 4788.922492439313, 5934.525237980864, 5964.522838172849, 6008.579399441997, 4924.384451943507, 5187.325647665779, 5341.023821186186, 5773.393793651606, 5811.27359080115, 5377.650452720561, 5513.944860551504, 5752.769889204553, 5812.389699081705, 5816.738246778989, 4863.659543831898, 5413.971345444353, 5603.523700485342, 5702.885942281214, 5717.313922329347, 4986.650934434555, 5291.894162116813, 5532.0, 5658.745356458887, 5770.653760774367, 4859.173940430064, 5406.270153529381, 5577.637453565505, 5640.182173584889, 5645.68948707825], "value": 4170.041776876211, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.1655554723199, 734.963251837408, 757.7120694136228, 770.7726220764874, 870.6909047288217, 16489.670206595874, 17125.97244165351, 17136.228869700863, 17143.228554715035, 17176.828231717696, 15121.0, 15293.388264469408, 15296.0, 15304.311305991228, 15335.463258785945, 743.0488974113143, 762.1045271805606, 768.0591275687294, 893.7854914820429, 907.9909200907989, 893.3657103456553, 908.9909100908973, 914.6387177065055, 921.5714692667908, 926.3839546701469, 974.9756256093619, 975.8975307592707, 977.3354119198942, 977.7946631207456, 982.773961988743, 965.7440778193784, 968.2205824311427, 969.5976169889487, 970.1850445625673, 970.4904924914406, 727.6834576958987, 728.9562626242442, 730.4375630764282, 730.5762657658545, 732.0044739154745, 15874.920625396799, 15919.920400397923, 16031.519054428385, 16034.5991350216, 16045.518634440985, 14809.629759255997, 15256.131388317917, 15491.457798977095, 15844.683106337809, 15863.127527985956, 12081.335526546036, 12082.6375208743, 12119.33343666098, 12201.45093470796, 12596.0, 3966.86115985942, 3977.602239776028, 3981.3828856527284, 4060.3909413587903, 4062.410950412174, 126342.0, 126547.0, 126833.73166268312, 127845.0, 133421.33289333587, 11233.71915702114, 11714.945654890931, 11960.521579136912, 12021.579244726392, 12060.095492838072, 20980.895095524425, 24989.375265618506, 25081.749182508305, 25110.37224069413, 25275.62086568703, 8089.635966381527, 8525.275351595059, 8554.401191916631, 8602.096779838152, 8604.0, 4670.906581868344, 4701.694389864648, 4811.398575178103, 4907.067657145202, 4951.8266860659705, 3827.827747751358, 3944.1322908960556, 3955.7428767130045, 3962.5046869141356, 3976.045749020272, 758.8027112950563, 779.1662920674937, 785.0932173339802, 794.6940427935286, 802.06959926485, 607.8206928955968, 663.6117871045396, 667.4827009067914, 670.8893032649559, 685.1469919949694, 9375.5312234388, 9861.753456163653, 10178.440185789852, 10290.639827605997, 10394.844077338847, 513.432656914112, 562.9838142153452, 576.7519966414482, 595.8867815115115, 621.6891554222889, 4608.6082682971655, 4719.646026547954, 4932.1122198004705, 5006.199008158677, 5007.924881126786, 98320.50839745755, 137595.93606095915, 152451.0, 160082.0, 164341.356586435, 101586.0, 124079.3796031014, 138435.0, 138671.0, 141675.0, 121965.39017304857, 123242.0, 123245.38377308236, 125836.0, 127795.49840514398, 9339.85990210161, 9415.011423800403, 9531.857022144535, 9556.044395560388, 9616.134547890724, 65629.0, 66920.6653966727, 67346.99999999804, 67792.66103669647, 68495.65752171406, 101122.42704224202, 102446.0, 103802.0, 104961.47519262355, 105258.94741052491, 12672.809907851573, 12924.676883077998, 12972.50221437118, 13420.865791341961, 13473.0, 13480.93259533696, 13671.0, 13686.0, 14405.85594144087, 14427.0, 12607.747845043232, 12799.0, 12959.35203239853, 13384.130031547918, 13425.909876536833, 12195.206514147867, 12466.626001219978, 13234.338283086, 13382.665433364244, 13738.10702304347, 12662.746745065231, 12806.0, 13155.473781048651, 13162.736745265232, 13278.933605331911, 10755.623553175601, 11166.944165279121, 11464.0, 11566.190366674253, 11776.52893884235, 10847.511861966073, 11167.497462614365, 11399.601013964471, 11411.714707132389, 11429.028532574492], "value": 8210.7116503817, "unit": "score"}], "name": "dromaeo_css", "value": 7636.978451570712, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 113.0, 113.0, 112.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 106.0, 132.0, 119.0, 107.0, 107.0, 103.0, 135.0, 106.0], "value": 116.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 191.0, 180.0, 182.0, 184.0, 180.0, 183.0, 183.0, 182.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 61.0, 88.0, 60.0, 58.0, 57.0, 57.0, 79.0, 57.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 116.0, 97.0, 96.0, 81.0, 91.0, 67.0, 68.0, 89.0], "value": 85.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 125.0, 89.0, 85.0, 90.0, 90.0, 90.0, 85.0], "value": 91.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 94.0, 94.0, 94.0, 94.0, 97.0, 90.0, 104.0, 146.0, 146.0], "value": 108.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 86.0, 85.0, 84.0, 84.0, 84.0, 91.0, 90.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 52.0, 51.0, 56.0, 56.0, 55.0, 55.0, 55.0, 55.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 73.0, 75.0, 71.0, 71.0, 67.0, 69.0, 69.0, 69.0, 69.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 81.0, 83.0, 81.0, 83.0, 82.0, 88.0, 88.0, 99.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 133.0, 139.0, 146.0, 147.0, 128.0, 138.0, 136.0, 141.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 158.0, 158.0, 162.0, 160.0, 163.0, 159.0, 160.0, 160.0, 159.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 67.0, 66.0, 65.0, 66.0, 68.0, 83.0, 82.0, 81.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1427.1, "alertThreshold": 2.0}]} 12:35:15 INFO - Return code: 0 12:35:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:35:15 INFO - # TBPL SUCCESS # 12:35:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:35:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:35:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:35:15 INFO - 2016-11-14 12:35:15.181 screenresolution[1668:10889] starting screenresolution argv=screenresolution get 12:35:15 INFO - 2016-11-14 12:35:15.184 screenresolution[1668:10889] Display 0: 1600x1200x32@60 12:35:15 INFO - 2016-11-14 12:35:15.190 screenresolution[1669:10892] starting screenresolution argv=screenresolution list 12:35:15 INFO - Available Modes on Display 0 12:35:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:35:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:35:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:35:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:35:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:35:15 INFO - Intel Iris: 12:35:15 INFO - Chipset Model: Intel Iris 12:35:15 INFO - Type: GPU 12:35:15 INFO - Bus: Built-In 12:35:15 INFO - VRAM (Dynamic, Max): 1536 MB 12:35:15 INFO - Vendor: Intel (0x8086) 12:35:15 INFO - Device ID: 0x0a2e 12:35:15 INFO - Revision ID: 0x0009 12:35:15 INFO - Displays: 12:35:15 INFO - Display: 12:35:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:35:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:35:15 INFO - Display Serial Number: 1600x1200 60 12:35:15 INFO - Main Display: Yes 12:35:15 INFO - Mirror: Off 12:35:15 INFO - Online: Yes 12:35:15 INFO - Rotation: Supported 12:35:15 INFO - Return code: 0 12:35:15 INFO - Running post-action listener: _resource_record_post_action 12:35:15 INFO - [mozharness: 2016-11-14 20:35:15.426131Z] Finished run-tests step (success) 12:35:15 INFO - Running post-run listener: _resource_record_post_run 12:35:15 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 36770816; Write bytes: 494976000; Read time: 238; Write time: 1555 12:35:15 INFO - TinderboxPrint: CPU usage
53.6% 12:35:15 INFO - TinderboxPrint: I/O read bytes / time
36,770,816 / 238 12:35:15 INFO - TinderboxPrint: I/O write bytes / time
494,976,000 / 1,555 12:35:15 INFO - TinderboxPrint: CPU idle
2,220.5 (46.4%) 12:35:15 INFO - TinderboxPrint: CPU system
957.9 (20.0%) 12:35:15 INFO - TinderboxPrint: CPU user
1,603.3 (33.5%) 12:35:15 INFO - TinderboxPrint: Swap in / out
232,108,032 / 0 12:35:15 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194429440; Write bytes: 189106176; Read time: 17859; Write time: 400 12:35:15 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 34681856; Write bytes: 295564288; Read time: 218; Write time: 1125 12:35:15 INFO - Running post-run listener: _upload_blobber_files 12:35:15 INFO - Blob upload gear active. 12:35:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:35:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:35:16 INFO - (blobuploader) - INFO - Open directory for files ... 12:35:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:35:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:35:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:16 INFO - (blobuploader) - INFO - Done attempting. 12:35:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:35:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:35:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:17 INFO - (blobuploader) - INFO - Done attempting. 12:35:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:35:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:35:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:20 INFO - (blobuploader) - INFO - Done attempting. 12:35:20 INFO - (blobuploader) - INFO - Iteration through files over. 12:35:20 INFO - Return code: 0 12:35:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:35:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:35:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1dc761e2dbc53a41d7947991cf8c4edf3d28f3cacf39166a8d5b3cfe20c957e7368c65ba5257c824883f4e92fb94b15c11514370601d0bd157cefa9e6ebf1c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0050fb27b1dac8e71d6029319fa326d44548f398c3a89d557bde70ade37ba10781c33d5e47cb4a2a339f6a9d6199f55f8ec3cba370dd9d62e8880a246dd2418b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/50cb8772fa80dd01bf5dfa6b2f42d4721007e8b3fd2c21038783df320a8a821577751a26e463a075740806efcbd4c8b4f49a3b0281c4b717e9503f24791646fb"} 12:35:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:35:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:35:20 INFO - Contents: 12:35:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1dc761e2dbc53a41d7947991cf8c4edf3d28f3cacf39166a8d5b3cfe20c957e7368c65ba5257c824883f4e92fb94b15c11514370601d0bd157cefa9e6ebf1c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0050fb27b1dac8e71d6029319fa326d44548f398c3a89d557bde70ade37ba10781c33d5e47cb4a2a339f6a9d6199f55f8ec3cba370dd9d62e8880a246dd2418b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/50cb8772fa80dd01bf5dfa6b2f42d4721007e8b3fd2c21038783df320a8a821577751a26e463a075740806efcbd4c8b4f49a3b0281c4b717e9503f24791646fb"} 12:35:20 INFO - Running post-run listener: copy_logs_to_upload_dir 12:35:20 INFO - Copying logs to upload dir... 12:35:20 INFO - mkdir: /builds/slave/test/build/upload/logs 12:35:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.468608 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-11-14 12:35:20.253124) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:35:20.256628) ========= 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.cfXnUkqyeV/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.LVmo9vaeAS/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1dc761e2dbc53a41d7947991cf8c4edf3d28f3cacf39166a8d5b3cfe20c957e7368c65ba5257c824883f4e92fb94b15c11514370601d0bd157cefa9e6ebf1c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0050fb27b1dac8e71d6029319fa326d44548f398c3a89d557bde70ade37ba10781c33d5e47cb4a2a339f6a9d6199f55f8ec3cba370dd9d62e8880a246dd2418b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/50cb8772fa80dd01bf5dfa6b2f42d4721007e8b3fd2c21038783df320a8a821577751a26e463a075740806efcbd4c8b4f49a3b0281c4b717e9503f24791646fb"} build_url:https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010783 build_url: 'https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c1dc761e2dbc53a41d7947991cf8c4edf3d28f3cacf39166a8d5b3cfe20c957e7368c65ba5257c824883f4e92fb94b15c11514370601d0bd157cefa9e6ebf1c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0050fb27b1dac8e71d6029319fa326d44548f398c3a89d557bde70ade37ba10781c33d5e47cb4a2a339f6a9d6199f55f8ec3cba370dd9d62e8880a246dd2418b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/50cb8772fa80dd01bf5dfa6b2f42d4721007e8b3fd2c21038783df320a8a821577751a26e463a075740806efcbd4c8b4f49a3b0281c4b717e9503f24791646fb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:35:20.289539) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:35:20.289867) ========= 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.cfXnUkqyeV/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.LVmo9vaeAS/Listeners TMPDIR=/var/folders/hr/hkb07m1j4sq5c29hg511636400000w/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.004808 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:35:20.338918) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:35:20.339288) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:35:20.339716) ========= ========= Total master_lag: 0.18 =========