builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0348 starttime: 1479154841.68 results: success (0) buildid: 20161114091743 builduid: 42ed84f7fcb64e2fb957c8f0e52037f0 revision: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:41.678096) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:41.678534) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:41.678816) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:41.707409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:41.707783) ========= 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.AgRMpgVhLO/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.7syJv26WL9/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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:20:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 137M=0s 2016-11-14 12:20:41 (137 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.161857 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:41.892124) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:41.892443) ========= 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.AgRMpgVhLO/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.7syJv26WL9/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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.023937 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:41.943935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:41.944296) ========= 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.AgRMpgVhLO/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.7syJv26WL9/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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:20:42,033 truncating revision to first 12 chars 2016-11-14 12:20:42,033 Setting DEBUG logging. 2016-11-14 12:20:42,033 attempt 1/10 2016-11-14 12:20:42,033 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:20:42,673 unpacking tar archive at: mozilla-beta-fd3c6c15ec64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.914403 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:42.881180) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:42.881511) ========= script_repo_revision: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:42.881928) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:42.882215) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 12:20:42.901582) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-11-14 12:20:42.901994) ========= /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.AgRMpgVhLO/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.7syJv26WL9/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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:20:43 INFO - MultiFileLogger online at 20161114 12:20:43 in /builds/slave/test 12:20:43 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:20:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:20:43 INFO - {'append_to_log': False, 12:20:43 INFO - 'base_work_dir': '/builds/slave/test', 12:20:43 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:20:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:20:43 INFO - 'branch': 'Mozilla-Beta', 12:20:43 INFO - 'buildbot_json_path': 'buildprops.json', 12:20:43 INFO - 'config_files': ('talos/mac_config.py',), 12:20:43 INFO - 'default_actions': ('clobber', 12:20:43 INFO - 'read-buildbot-config', 12:20:43 INFO - 'download-and-extract', 12:20:43 INFO - 'populate-webroot', 12:20:43 INFO - 'create-virtualenv', 12:20:43 INFO - 'install', 12:20:43 INFO - 'run-tests'), 12:20:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:20:43 INFO - 'download_minidump_stackwalk': True, 12:20:43 INFO - 'download_symbols': 'ondemand', 12:20:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:20:43 INFO - 'tooltool.py': '/tools/tooltool.py', 12:20:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:20:43 INFO - '/tools/misc-python/virtualenv.py')}, 12:20:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:20:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:20:43 INFO - 'installer_path': 'installer.exe', 12:20:43 INFO - 'log_level': 'info', 12:20:43 INFO - 'log_name': 'talos', 12:20:43 INFO - 'log_to_console': True, 12:20:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:20:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:20:43 INFO - 'opt_config_files': (), 12:20:43 INFO - 'pip_index': False, 12:20:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:20:43 INFO - 'cmd': ('bash', 12:20:43 INFO - '-c', 12:20:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:20:43 INFO - 'enabled': True, 12:20:43 INFO - 'halt_on_failure': False, 12:20:43 INFO - 'name': 'check_screen_resolution'},), 12:20:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:20:43 INFO - 'cmd': ('bash', 12:20:43 INFO - '-c', 12:20:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:20:43 INFO - 'enabled': True, 12:20:43 INFO - 'halt_on_failure': False, 12:20:43 INFO - 'name': 'check_screen_resolution'},), 12:20:43 INFO - 'run_cmd_checks_enabled': True, 12:20:43 INFO - 'sps_profile': False, 12:20:43 INFO - 'sps_profile_interval': 0, 12:20:43 INFO - 'suite': 'dromaeojs', 12:20:43 INFO - 'system_bits': '32', 12:20:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:20:43 INFO - 'title': 't-yosemite-r7-0348', 12:20:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:20:43 INFO - 'use_talos_json': True, 12:20:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:20:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:20:43 INFO - 'work_dir': 'build'} 12:20:43 INFO - [mozharness: 2016-11-14 20:20:43.123658Z] Running clobber step. 12:20:43 INFO - Running pre-action listener: _resource_record_pre_action 12:20:43 INFO - Running main action method: clobber 12:20:43 INFO - rmtree: /builds/slave/test/build 12:20:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:20:45 INFO - Running post-action listener: _resource_record_post_action 12:20:45 INFO - [mozharness: 2016-11-14 20:20:45.278613Z] Finished clobber step (success) 12:20:45 INFO - [mozharness: 2016-11-14 20:20:45.278741Z] Running read-buildbot-config step. 12:20:45 INFO - Running pre-action listener: _resource_record_pre_action 12:20:45 INFO - Running main action method: read_buildbot_config 12:20:45 INFO - Using buildbot properties: 12:20:45 INFO - { 12:20:45 INFO - "project": "", 12:20:45 INFO - "product": "firefox", 12:20:45 INFO - "script_repo_revision": "production", 12:20:45 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 12:20:45 INFO - "repository": "", 12:20:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 12:20:45 INFO - "buildid": "20161114091743", 12:20:45 INFO - "pgo_build": "False", 12:20:45 INFO - "basedir": "/builds/slave/test", 12:20:45 INFO - "buildnumber": 63, 12:20:45 INFO - "slavename": "t-yosemite-r7-0348", 12:20:45 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 12:20:45 INFO - "platform": "yosemite_r7", 12:20:45 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:20:45 INFO - "branch": "mozilla-beta", 12:20:45 INFO - "repo_path": "releases/mozilla-beta", 12:20:45 INFO - "revision": "fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1", 12:20:45 INFO - "stage_platform": "macosx64", 12:20:45 INFO - "builduid": "42ed84f7fcb64e2fb957c8f0e52037f0", 12:20:45 INFO - "slavebuilddir": "test" 12:20:45 INFO - } 12:20:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 12:20:45 INFO - Running post-action listener: _resource_record_post_action 12:20:45 INFO - [mozharness: 2016-11-14 20:20:45.281867Z] Finished read-buildbot-config step (success) 12:20:45 INFO - [mozharness: 2016-11-14 20:20:45.281961Z] Running download-and-extract step. 12:20:45 INFO - Running pre-action listener: _resource_record_pre_action 12:20:45 INFO - Running main action method: download_and_extract 12:20:45 INFO - mkdir: /builds/slave/test/build/tests 12:20:45 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:20:45 INFO - trying https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 12:20:45 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:20:45 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:20:46 INFO - Downloaded 1165 bytes. 12:20:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:20:46 INFO - Using the following test package requirements: 12:20:46 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:20:46 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:20:46 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 12:20:46 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:20:46 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 12:20:46 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:20:46 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:20:46 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 12:20:46 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:20:46 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:20:46 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 12:20:46 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:20:46 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 12:20:46 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:20:46 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 12:20:46 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:20:46 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 12:20:46 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 12:20:46 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:20:46 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:20:46 INFO - Fetch https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:20:47 INFO - Expected file size: 16231342 12:20:54 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:20:54 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:20:54 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:20:54 INFO - Fetch https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:20:55 INFO - Expected file size: 16231342 12:21:01 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:21:01 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:21:01 INFO - Fetch https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 12:21:02 INFO - Expected file size: 14414089 12:21:02 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:21:02 INFO - trying https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:21:02 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:21:02 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:21:05 INFO - Downloaded 86010818 bytes. 12:21:05 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:21:05 INFO - mkdir: /builds/slave/test/properties 12:21:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:21:05 INFO - Writing to file /builds/slave/test/properties/build_url 12:21:05 INFO - Contents: 12:21:05 INFO - build_url:https://queue.taskcluster.net/v1/task/IwhJdfYOTniFWpjGgcwpMQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:21:05 INFO - Running post-action listener: _resource_record_post_action 12:21:05 INFO - Running post-action listener: set_extra_try_arguments 12:21:05 INFO - [mozharness: 2016-11-14 20:21:05.870796Z] Finished download-and-extract step (success) 12:21:05 INFO - [mozharness: 2016-11-14 20:21:05.870950Z] Running populate-webroot step. 12:21:05 INFO - Running pre-action listener: _resource_record_pre_action 12:21:05 INFO - Running main action method: populate_webroot 12:21:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:21:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:21:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:21:05 INFO - '--tppagecycles', 12:21:05 INFO - '7'], 12:21:05 INFO - 'tests': ['tsvgm']}}, 12:21:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:21:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:21:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:21:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:21:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:21:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:21:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:05 INFO - 'talos_options': ['--disable-e10s'], 12:21:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:21:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:21:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:05 INFO - 'talos_options': ['--disable-e10s'], 12:21:05 INFO - 'tests': ['damp', 'tps']}, 12:21:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:05 INFO - 'tests': ['damp', 'tps']}, 12:21:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:21:05 INFO - 'tests': ['dromaeo_dom']}, 12:21:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:21:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:21:05 INFO - 'tests': ['basic_compositor_video']}, 12:21:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:21:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:21:05 INFO - 'tests': ['a11yr', 12:21:05 INFO - 'ts_paint', 12:21:05 INFO - 'tpaint', 12:21:05 INFO - 'sessionrestore', 12:21:05 INFO - 'sessionrestore_no_auto_restore', 12:21:05 INFO - 'tabpaint']}, 12:21:05 INFO - 'other-e10s': {'tests': ['a11yr', 12:21:05 INFO - 'ts_paint', 12:21:05 INFO - 'tpaint', 12:21:05 INFO - 'sessionrestore', 12:21:05 INFO - 'sessionrestore_no_auto_restore', 12:21:05 INFO - 'tabpaint']}, 12:21:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:21:05 INFO - 'ts_paint', 12:21:05 INFO - 'tpaint', 12:21:05 INFO - 'sessionrestore', 12:21:05 INFO - 'sessionrestore_no_auto_restore', 12:21:05 INFO - 'tabpaint']}, 12:21:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:21:05 INFO - 'ts_paint', 12:21:05 INFO - 'tpaint', 12:21:05 INFO - 'sessionrestore', 12:21:05 INFO - 'sessionrestore_no_auto_restore', 12:21:05 INFO - 'tabpaint']}, 12:21:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:21:05 INFO - 'tests': ['a11yr', 12:21:05 INFO - 'ts_paint', 12:21:05 INFO - 'tpaint', 12:21:05 INFO - 'sessionrestore', 12:21:05 INFO - 'sessionrestore_no_auto_restore', 12:21:05 INFO - 'tabpaint']}, 12:21:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:21:05 INFO - 'tests': ['a11yr', 12:21:05 INFO - 'ts_paint', 12:21:05 INFO - 'tpaint', 12:21:05 INFO - 'sessionrestore', 12:21:05 INFO - 'sessionrestore_no_auto_restore', 12:21:05 INFO - 'tabpaint']}, 12:21:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:21:05 INFO - 'tests': ['tsvgx', 12:21:05 INFO - 'tsvgr_opacity', 12:21:05 INFO - 'tart', 12:21:05 INFO - 'tscrollx', 12:21:05 INFO - 'cart']}, 12:21:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:21:05 INFO - 'tsvgr_opacity', 12:21:05 INFO - 'tart', 12:21:05 INFO - 'tscrollx', 12:21:05 INFO - 'cart']}, 12:21:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:05 INFO - 'talos_options': ['--disable-e10s'], 12:21:05 INFO - 'tests': ['tp5o']}, 12:21:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:05 INFO - 'tests': ['tp5o']}, 12:21:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:05 INFO - 'talos_options': ['--disable-e10s', 12:21:05 INFO - '--xperf_path', 12:21:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:21:05 INFO - 'tests': ['tp5n']}, 12:21:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:21:05 INFO - 'talos_options': ['--xperf_path', 12:21:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:21:05 INFO - 'tests': ['tp5n']}}, 12:21:05 INFO - 'talos.zip': {'path': '', 12:21:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:21:05 INFO - Running post-action listener: _resource_record_post_action 12:21:05 INFO - [mozharness: 2016-11-14 20:21:05.889690Z] Finished populate-webroot step (success) 12:21:05 INFO - [mozharness: 2016-11-14 20:21:05.889795Z] Running create-virtualenv step. 12:21:05 INFO - Running pre-action listener: _resource_record_pre_action 12:21:05 INFO - Running main action method: create_virtualenv 12:21:05 INFO - Creating virtualenv /builds/slave/test/build/venv 12:21:05 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:21:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:21:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:21:06 INFO - Using real prefix '/tools/python27' 12:21:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:21:06 INFO - Installing distribute.............................................................................................................................................................................................done. 12:21:09 INFO - Installing pip.................done. 12:21:09 INFO - Return code: 0 12:21:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:09 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 0x1039c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10393d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff861d83fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dbd30>, '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 0x103641db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d3b20>, '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.AgRMpgVhLO/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.7syJv26WL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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:21:09 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:21:09 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:21:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgRMpgVhLO/Render', 12:21:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:09 INFO - 'HOME': '/Users/cltbld', 12:21:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:09 INFO - 'LOGNAME': 'cltbld', 12:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:09 INFO - 'MOZ_NO_REMOTE': '1', 12:21:09 INFO - 'NO_EM_RESTART': '1', 12:21:09 INFO - 'PAGER': '/bin/cat', 12:21:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:09 INFO - 'PWD': '/builds/slave/test', 12:21:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:09 INFO - 'SHELL': '/bin/bash', 12:21:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7syJv26WL9/Listeners', 12:21:09 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 12:21:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:09 INFO - 'USER': 'cltbld', 12:21:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:09 INFO - 'XPC_FLAGS': '0x0', 12:21:09 INFO - 'XPC_SERVICE_NAME': '0', 12:21:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:09 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:21:09 INFO - Cleaning up... 12:21:09 INFO - Return code: 0 12:21:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:09 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 0x1039c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10393d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff861d83fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dbd30>, '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 0x103641db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d3b20>, '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.AgRMpgVhLO/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.7syJv26WL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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:21:09 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:21:09 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:21:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgRMpgVhLO/Render', 12:21:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:09 INFO - 'HOME': '/Users/cltbld', 12:21:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:09 INFO - 'LOGNAME': 'cltbld', 12:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:09 INFO - 'MOZ_NO_REMOTE': '1', 12:21:09 INFO - 'NO_EM_RESTART': '1', 12:21:09 INFO - 'PAGER': '/bin/cat', 12:21:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:09 INFO - 'PWD': '/builds/slave/test', 12:21:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:09 INFO - 'SHELL': '/bin/bash', 12:21:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7syJv26WL9/Listeners', 12:21:09 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 12:21:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:09 INFO - 'USER': 'cltbld', 12:21:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:09 INFO - 'XPC_FLAGS': '0x0', 12:21:09 INFO - 'XPC_SERVICE_NAME': '0', 12:21:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:10 INFO - Downloading/unpacking psutil>=3.1.1 12:21:10 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:21:10 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:21:10 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:21:10 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:21:10 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:21:10 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:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:21:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:21:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:21:12 INFO - Installing collected packages: psutil 12:21:12 INFO - Running setup.py install for psutil 12:21:12 INFO - building 'psutil._psutil_osx' extension 12:21:12 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:21:13 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:21:13 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:21:13 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:21:13 INFO - building 'psutil._psutil_posix' extension 12:21:13 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:21:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:21:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:21:13 INFO - ^ 12:21:13 INFO - 1 warning generated. 12:21:13 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:21:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:21:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:21:13 INFO - Successfully installed psutil 12:21:13 INFO - Cleaning up... 12:21:14 INFO - Return code: 0 12:21:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:21:14 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:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:14 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:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:14 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 0x1039c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10393d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff861d83fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dbd30>, '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 0x103641db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d3b20>, '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.AgRMpgVhLO/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.7syJv26WL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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:21:14 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:21:14 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:21:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgRMpgVhLO/Render', 12:21:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:14 INFO - 'HOME': '/Users/cltbld', 12:21:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:14 INFO - 'LOGNAME': 'cltbld', 12:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:14 INFO - 'MOZ_NO_REMOTE': '1', 12:21:14 INFO - 'NO_EM_RESTART': '1', 12:21:14 INFO - 'PAGER': '/bin/cat', 12:21:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:14 INFO - 'PWD': '/builds/slave/test', 12:21:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:14 INFO - 'SHELL': '/bin/bash', 12:21:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7syJv26WL9/Listeners', 12:21:14 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 12:21:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:14 INFO - 'USER': 'cltbld', 12:21:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:14 INFO - 'XPC_FLAGS': '0x0', 12:21:14 INFO - 'XPC_SERVICE_NAME': '0', 12:21:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:21:14 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:21:14 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:21:14 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:21:14 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:21:14 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:21:14 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:21:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:21:16 INFO - Installing collected packages: mozsystemmonitor 12:21:16 INFO - Running setup.py install for mozsystemmonitor 12:21:16 INFO - Successfully installed mozsystemmonitor 12:21:16 INFO - Cleaning up... 12:21:17 INFO - Return code: 0 12:21:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:17 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 0x1039c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10393d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff861d83fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dbd30>, '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 0x103641db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d3b20>, '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.AgRMpgVhLO/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.7syJv26WL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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:21:17 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:21:17 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:21:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgRMpgVhLO/Render', 12:21:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:17 INFO - 'HOME': '/Users/cltbld', 12:21:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:17 INFO - 'LOGNAME': 'cltbld', 12:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:17 INFO - 'MOZ_NO_REMOTE': '1', 12:21:17 INFO - 'NO_EM_RESTART': '1', 12:21:17 INFO - 'PAGER': '/bin/cat', 12:21:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:17 INFO - 'PWD': '/builds/slave/test', 12:21:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:17 INFO - 'SHELL': '/bin/bash', 12:21:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7syJv26WL9/Listeners', 12:21:17 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 12:21:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:17 INFO - 'USER': 'cltbld', 12:21:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:17 INFO - 'XPC_FLAGS': '0x0', 12:21:17 INFO - 'XPC_SERVICE_NAME': '0', 12:21:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:17 INFO - Downloading/unpacking jsonschema==2.5.1 12:21:17 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:21:17 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:21:17 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:21:17 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:21:17 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:21:17 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:21:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:21:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:21:19 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:21:19 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:21:19 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:21:19 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:21:19 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:21:19 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:21:20 INFO - Downloading functools32-3.2.3-2.tar.gz 12:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:21:20 INFO - warning: no files found matching '*.txt' 12:21:20 INFO - no previously-included directories found matching 'build' 12:21:20 INFO - no previously-included directories found matching 'dist' 12:21:20 INFO - no previously-included directories found matching '.git*' 12:21:20 INFO - Installing collected packages: jsonschema, functools32 12:21:20 INFO - Running setup.py install for functools32 12:21:20 INFO - warning: no files found matching '*.txt' 12:21:20 INFO - no previously-included directories found matching 'build' 12:21:20 INFO - no previously-included directories found matching 'dist' 12:21:20 INFO - no previously-included directories found matching '.git*' 12:21:20 INFO - Successfully installed jsonschema functools32 12:21:20 INFO - Cleaning up... 12:21:20 INFO - Return code: 0 12:21:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:20 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 0x1039c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10393d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff861d83fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dbd30>, '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 0x103641db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d3b20>, '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.AgRMpgVhLO/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.7syJv26WL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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:21:20 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:21:20 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:21:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgRMpgVhLO/Render', 12:21:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:20 INFO - 'HOME': '/Users/cltbld', 12:21:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:20 INFO - 'LOGNAME': 'cltbld', 12:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:20 INFO - 'MOZ_NO_REMOTE': '1', 12:21:20 INFO - 'NO_EM_RESTART': '1', 12:21:20 INFO - 'PAGER': '/bin/cat', 12:21:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:20 INFO - 'PWD': '/builds/slave/test', 12:21:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:20 INFO - 'SHELL': '/bin/bash', 12:21:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7syJv26WL9/Listeners', 12:21:20 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 12:21:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:20 INFO - 'USER': 'cltbld', 12:21:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:20 INFO - 'XPC_FLAGS': '0x0', 12:21:20 INFO - 'XPC_SERVICE_NAME': '0', 12:21:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:21:20 INFO - Cleaning up... 12:21:20 INFO - Return code: 0 12:21:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:20 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 0x1039c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10393d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff861d83fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dbd30>, '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 0x103641db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d3b20>, '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.AgRMpgVhLO/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.7syJv26WL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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:21:20 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:21:20 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:21:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgRMpgVhLO/Render', 12:21:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:20 INFO - 'HOME': '/Users/cltbld', 12:21:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:20 INFO - 'LOGNAME': 'cltbld', 12:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:20 INFO - 'MOZ_NO_REMOTE': '1', 12:21:20 INFO - 'NO_EM_RESTART': '1', 12:21:20 INFO - 'PAGER': '/bin/cat', 12:21:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:20 INFO - 'PWD': '/builds/slave/test', 12:21:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:20 INFO - 'SHELL': '/bin/bash', 12:21:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7syJv26WL9/Listeners', 12:21:20 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 12:21:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:20 INFO - 'USER': 'cltbld', 12:21:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:20 INFO - 'XPC_FLAGS': '0x0', 12:21:20 INFO - 'XPC_SERVICE_NAME': '0', 12:21:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:21 INFO - Downloading/unpacking blobuploader==1.2.4 12:21:21 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:21:21 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:21:21 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:21:21 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:21:21 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:21:21 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:21:23 INFO - Downloading blobuploader-1.2.4.tar.gz 12:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:21:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:21:23 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:21:23 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:21:23 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:21:23 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:21:23 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:21:23 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:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:21:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:21:24 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:21:24 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:21:24 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:21:24 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:21:24 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:21:24 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:21:24 INFO - Downloading docopt-0.6.1.tar.gz 12:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:21:24 INFO - Installing collected packages: blobuploader, requests, docopt 12:21:24 INFO - Running setup.py install for blobuploader 12:21:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:21:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:21:25 INFO - Running setup.py install for requests 12:21:25 INFO - Running setup.py install for docopt 12:21:25 INFO - Successfully installed blobuploader requests docopt 12:21:25 INFO - Cleaning up... 12:21:25 INFO - Return code: 0 12:21:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:25 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 0x1039c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10393d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff861d83fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dbd30>, '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 0x103641db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d3b20>, '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.AgRMpgVhLO/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.7syJv26WL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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:21:25 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:21:25 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:21:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgRMpgVhLO/Render', 12:21:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:25 INFO - 'HOME': '/Users/cltbld', 12:21:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:25 INFO - 'LOGNAME': 'cltbld', 12:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:25 INFO - 'MOZ_NO_REMOTE': '1', 12:21:25 INFO - 'NO_EM_RESTART': '1', 12:21:25 INFO - 'PAGER': '/bin/cat', 12:21:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:25 INFO - 'PWD': '/builds/slave/test', 12:21:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:25 INFO - 'SHELL': '/bin/bash', 12:21:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7syJv26WL9/Listeners', 12:21:25 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 12:21:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:25 INFO - 'USER': 'cltbld', 12:21:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:25 INFO - 'XPC_FLAGS': '0x0', 12:21:25 INFO - 'XPC_SERVICE_NAME': '0', 12:21:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:21:26 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-XUeDT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:21:26 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-hocqrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:21:26 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-BpswYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:21:26 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-9oXQa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:21:26 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-p0_V96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:21:26 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-hbzrfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:21:26 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-vrBYBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:21:26 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-YWv5fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:21:26 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-_bKwuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:21:27 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-MLz_M_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:21:27 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-Qqn0Hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:21:27 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-Ed4uWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:21:27 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-XNF6DT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:21:27 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-MeQIVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:27 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-MmL3zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:21:27 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-HeLwLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:21:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:21:27 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-QdCkPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:21:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:21:27 INFO - Running setup.py install for manifestparser 12:21:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:21:27 INFO - Running setup.py install for mozcrash 12:21:28 INFO - Running setup.py install for mozdebug 12:21:28 INFO - Running setup.py install for mozdevice 12:21:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:21:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:21:28 INFO - Running setup.py install for mozfile 12:21:28 INFO - Running setup.py install for mozhttpd 12:21:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:21:28 INFO - Running setup.py install for mozinfo 12:21:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:21:28 INFO - Running setup.py install for mozInstall 12:21:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:21:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:21:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:21:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:21:29 INFO - Running setup.py install for mozleak 12:21:29 INFO - Running setup.py install for mozlog 12:21:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:21:29 INFO - Running setup.py install for moznetwork 12:21:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:21:29 INFO - Running setup.py install for mozprocess 12:21:29 INFO - Running setup.py install for mozprofile 12:21:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:21:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:21:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:21:29 INFO - Running setup.py install for mozrunner 12:21:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:21:29 INFO - Running setup.py install for mozscreenshot 12:21:30 INFO - Running setup.py install for moztest 12:21:30 INFO - Running setup.py install for mozversion 12:21:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:21:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:21:30 INFO - Cleaning up... 12:21:30 INFO - Return code: 0 12:21:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21:30 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:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:30 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:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:30 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 0x1039c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10393d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff861d83fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dbd30>, '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 0x103641db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d3b20>, '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.AgRMpgVhLO/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.7syJv26WL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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:21:30 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:21:30 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:21:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgRMpgVhLO/Render', 12:21:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:30 INFO - 'HOME': '/Users/cltbld', 12:21:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:30 INFO - 'LOGNAME': 'cltbld', 12:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:30 INFO - 'MOZ_NO_REMOTE': '1', 12:21:30 INFO - 'NO_EM_RESTART': '1', 12:21:30 INFO - 'PAGER': '/bin/cat', 12:21:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:30 INFO - 'PWD': '/builds/slave/test', 12:21:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:30 INFO - 'SHELL': '/bin/bash', 12:21:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7syJv26WL9/Listeners', 12:21:30 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 12:21:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:30 INFO - 'USER': 'cltbld', 12:21:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:30 INFO - 'XPC_FLAGS': '0x0', 12:21:30 INFO - 'XPC_SERVICE_NAME': '0', 12:21:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:21:30 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-NQUBNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:21:30 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:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:21:30 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-fFY5ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:21:30 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:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:21:30 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-WUVm_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:21:31 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:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:21:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-0Elnj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:21:31 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:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:21:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-U6be8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:21:31 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:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:21:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-6gO9_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:21:31 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:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:21:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-BFGZhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:21:31 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:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:21:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-3_pG_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:21:31 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:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:21:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-tmPgSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:21:31 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:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:21:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-j5giAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:21:31 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:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:21:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-eYZEd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:21:31 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:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:21:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-8KhsdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:21:31 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:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:21:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-ElaqZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:21:32 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:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:21:32 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-uWIa0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:21:32 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:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:32 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-UJFJyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:21:32 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:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:21:32 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-5a_rD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:21:32 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:21:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:21:32 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-tPwxJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:21:32 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:21:32 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:21:32 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:21:32 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:21:32 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:21:32 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:21:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:21:35 INFO - Downloading blessings-1.6.tar.gz 12:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:21:35 INFO - Installing collected packages: blessings 12:21:35 INFO - Running setup.py install for blessings 12:21:35 INFO - Successfully installed blessings 12:21:35 INFO - Cleaning up... 12:21:35 INFO - Return code: 0 12:21:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:21:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:21:35 INFO - Reading from file tmpfile_stdout 12:21:35 INFO - Current package versions: 12:21:35 INFO - blessings == 1.6 12:21:35 INFO - blobuploader == 1.2.4 12:21:35 INFO - docopt == 0.6.1 12:21:35 INFO - functools32 == 3.2.3-2 12:21:35 INFO - jsonschema == 2.5.1 12:21:35 INFO - manifestparser == 1.1 12:21:35 INFO - mozInstall == 1.12 12:21:35 INFO - mozcrash == 0.17 12:21:35 INFO - mozdebug == 0.1 12:21:35 INFO - mozdevice == 0.48 12:21:35 INFO - mozfile == 1.2 12:21:35 INFO - mozhttpd == 0.7 12:21:35 INFO - mozinfo == 0.9 12:21:35 INFO - mozleak == 0.1 12:21:35 INFO - mozlog == 3.4 12:21:35 INFO - moznetwork == 0.27 12:21:35 INFO - mozprocess == 0.23 12:21:35 INFO - mozprofile == 0.28 12:21:35 INFO - mozrunner == 6.12 12:21:35 INFO - mozscreenshot == 0.1 12:21:35 INFO - mozsystemmonitor == 0.3 12:21:35 INFO - moztest == 0.7 12:21:35 INFO - mozversion == 1.4 12:21:35 INFO - psutil == 3.1.1 12:21:35 INFO - requests == 1.2.3 12:21:35 INFO - wsgiref == 0.1.2 12:21:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:35 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 0x1039c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10393d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff861d83fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dbd30>, '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 0x103641db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d3b20>, '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.AgRMpgVhLO/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.7syJv26WL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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:21:35 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:21:35 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:21:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgRMpgVhLO/Render', 12:21:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:35 INFO - 'HOME': '/Users/cltbld', 12:21:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:35 INFO - 'LOGNAME': 'cltbld', 12:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:35 INFO - 'MOZ_NO_REMOTE': '1', 12:21:35 INFO - 'NO_EM_RESTART': '1', 12:21:35 INFO - 'PAGER': '/bin/cat', 12:21:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:35 INFO - 'PWD': '/builds/slave/test', 12:21:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:35 INFO - 'SHELL': '/bin/bash', 12:21:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7syJv26WL9/Listeners', 12:21:35 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 12:21:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:35 INFO - 'USER': 'cltbld', 12:21:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:35 INFO - 'XPC_FLAGS': '0x0', 12:21:35 INFO - 'XPC_SERVICE_NAME': '0', 12:21:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:35 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:21:35 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:21:35 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:21:35 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:21:35 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:21:35 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:21:35 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:21:35 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:21:35 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:21:35 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:21:35 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:21:35 INFO - Cleaning up... 12:21:35 INFO - Return code: 0 12:21:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:21:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:21:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:21:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:21:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1039c7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10393d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff861d83fb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037dbd30>, '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 0x103641db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d3b20>, '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.AgRMpgVhLO/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.7syJv26WL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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:21:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:21:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgRMpgVhLO/Render', 12:21:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:35 INFO - 'HOME': '/Users/cltbld', 12:21:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:35 INFO - 'LOGNAME': 'cltbld', 12:21:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:35 INFO - 'MOZ_NO_REMOTE': '1', 12:21:35 INFO - 'NO_EM_RESTART': '1', 12:21:35 INFO - 'PAGER': '/bin/cat', 12:21:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:35 INFO - 'PWD': '/builds/slave/test', 12:21:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:35 INFO - 'SHELL': '/bin/bash', 12:21:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7syJv26WL9/Listeners', 12:21:35 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 12:21:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:35 INFO - 'USER': 'cltbld', 12:21:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:35 INFO - 'XPC_FLAGS': '0x0', 12:21:35 INFO - 'XPC_SERVICE_NAME': '0', 12:21:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:21:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:21:36 INFO - Cleaning up... 12:21:36 INFO - Return code: 0 12:21:36 INFO - Running post-action listener: _resource_record_post_action 12:21:36 INFO - Running post-action listener: _start_resource_monitoring 12:21:36 INFO - Starting resource monitoring. 12:21:36 INFO - [mozharness: 2016-11-14 20:21:36.280230Z] Finished create-virtualenv step (success) 12:21:36 INFO - [mozharness: 2016-11-14 20:21:36.281216Z] Running install step. 12:21:36 INFO - Running pre-action listener: _resource_record_pre_action 12:21:36 INFO - Running main action method: install 12:21:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:21:36 INFO - Reading from file tmpfile_stdout 12:21:36 INFO - Detecting whether we're running mozinstall >=1.0... 12:21:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:21:36 INFO - Reading from file tmpfile_stdout 12:21:36 INFO - Output received: 12:21:36 INFO - Usage: mozinstall [options] installer 12:21:36 INFO - Options: 12:21:36 INFO - -h, --help show this help message and exit 12:21:36 INFO - -d DEST, --destination=DEST 12:21:36 INFO - Directory to install application into. [default: 12:21:36 INFO - "/builds/slave/test"] 12:21:36 INFO - --app=APP Application being installed. [default: firefox] 12:21:36 INFO - mkdir: /builds/slave/test/build/application 12:21:36 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:21:36 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:21:58 INFO - Reading from file tmpfile_stdout 12:21:58 INFO - Output received: 12:21:58 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:21:58 INFO - Running post-action listener: _resource_record_post_action 12:21:58 INFO - [mozharness: 2016-11-14 20:21:58.613484Z] Finished install step (success) 12:21:58 INFO - [mozharness: 2016-11-14 20:21:58.613660Z] Running run-tests step. 12:21:58 INFO - Running pre-action listener: _resource_record_pre_action 12:21:58 INFO - Running main action method: run_tests 12:21:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:21:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:21:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:21:58 INFO - 2016-11-14 12:21:58.628 screenresolution[1638:7317] starting screenresolution argv=screenresolution get 12:21:58 INFO - 2016-11-14 12:21:58.630 screenresolution[1638:7317] Display 0: 1600x1200x32@60 12:21:58 INFO - 2016-11-14 12:21:58.636 screenresolution[1639:7319] starting screenresolution argv=screenresolution list 12:21:58 INFO - Available Modes on Display 0 12:21:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:21:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:21:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:21:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:21:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:21:58 INFO - Intel Iris: 12:21:58 INFO - Chipset Model: Intel Iris 12:21:58 INFO - Type: GPU 12:21:58 INFO - Bus: Built-In 12:21:58 INFO - VRAM (Dynamic, Max): 1536 MB 12:21:58 INFO - Vendor: Intel (0x8086) 12:21:58 INFO - Device ID: 0x0a2e 12:21:58 INFO - Revision ID: 0x0009 12:21:58 INFO - Displays: 12:21:58 INFO - Display: 12:21:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:21:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:21:58 INFO - Display Serial Number: 1600x1200 60 12:21:58 INFO - Main Display: Yes 12:21:58 INFO - Mirror: Off 12:21:58 INFO - Online: Yes 12:21:58 INFO - Rotation: Supported 12:21:58 INFO - Return code: 0 12:21:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:21:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:21:58 INFO - Python 2.7.3 12:21:58 INFO - Return code: 0 12:21:58 INFO - grabbing minidump binary from tooltool 12:21:58 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:21:58 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 0x1037dbd30>, '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 0x103641db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1037d3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:21:58 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:21:58 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:21:58 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:21:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:21:58 INFO - Return code: 0 12:21:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:21:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:21:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:21:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:21:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:21:58 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-0348', '--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:21:58 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-0348 --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:21:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AgRMpgVhLO/Render', 12:21:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:21:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:21:58 INFO - 'HOME': '/Users/cltbld', 12:21:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:21:58 INFO - 'LOGNAME': 'cltbld', 12:21:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:21:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:21:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:21:58 INFO - 'MOZ_NO_REMOTE': '1', 12:21:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:21:58 INFO - 'NO_EM_RESTART': '1', 12:21:58 INFO - 'PAGER': '/bin/cat', 12:21:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:21:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:21:58 INFO - 'PWD': '/builds/slave/test', 12:21:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:21:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:21:58 INFO - 'SHELL': '/bin/bash', 12:21:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7syJv26WL9/Listeners', 12:21:58 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 12:21:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:21:58 INFO - 'USER': 'cltbld', 12:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:21:59 INFO - 'XPC_FLAGS': '0x0', 12:21:59 INFO - 'XPC_SERVICE_NAME': '0', 12:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:21:59 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-0348', '--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:21:59 INFO - mozversion application_buildid: 20161114091743 12:21:59 INFO - mozversion application_changeset: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 12:21:59 INFO - mozversion application_display_name: Firefox 12:21:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:21:59 INFO - mozversion application_name: Firefox 12:21:59 INFO - mozversion application_remotingname: firefox 12:21:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:21:59 INFO - mozversion application_vendor: Mozilla 12:21:59 INFO - mozversion application_version: 51.0 12:21:59 INFO - mozversion platform_buildid: 20161114091743 12:21:59 INFO - mozversion platform_changeset: fd3c6c15ec64591b145ab1b6dd71c5a2e7b8d9b1 12:21:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:21:59 INFO - mozversion platform_version: 51.0 12:21:59 INFO - using testdate: 1479154919 12:21:59 INFO - actual date: 1479154919 12:21:59 INFO - starting webserver on 'localhost:49266' 12:21:59 INFO - SUITE-START | Running 2 tests 12:21:59 INFO - TEST-START | dromaeo_css 12:21:59 INFO - operating with platform_type : mac_ 12:21:59 INFO - Initialising browser for dromaeo_css test... 12:21:59 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmpqqBFtt/profile http://localhost:49266/getInfo.html) 12:22:01 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 12:22:01 INFO - PROCESS | 1649 | colorDepth:24 12:22:01 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 12:22:01 INFO - PROCESS | 1649 | __metrics 12:22:01 INFO - PROCESS | 1649 | 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:22:01 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:22:02 INFO - TEST-INFO | 1649: exit 0 12:22:02 INFO - Browser initialized. 12:22:02 INFO - Running cycle 1/1 for dromaeo_css test... 12:22:02 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmpqqBFtt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:22:14 INFO - PROCESS | 1652 | RSS: Main: 167948288 12:22:14 INFO - PROCESS | 1652 | 12:23:05 INFO - PROCESS | 1652 | 1479154985077 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:25:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 12:25:17 INFO - PROCESS | 1652 | RSS: Main: 297963520 12:25:17 INFO - PROCESS | 1652 | 12:28:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 12:28:21 INFO - PROCESS | 1652 | RSS: Main: 302493696 12:28:21 INFO - PROCESS | 1652 | 12:31:23 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 12:31:24 INFO - PROCESS | 1652 | RSS: Main: 281026560 12:31:24 INFO - PROCESS | 1652 | 12:34:26 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 12:34:27 INFO - PROCESS | 1652 | RSS: Main: 274833408 12:34:27 INFO - PROCESS | 1652 | 12:37:30 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 12:37:30 INFO - PROCESS | 1652 | RSS: Main: 262705152 12:37:30 INFO - PROCESS | 1652 | 12:40:33 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 12:40:34 INFO - PROCESS | 1652 | RSS: Main: 339091456 12:40:34 INFO - PROCESS | 1652 | 12:40:34 INFO - PROCESS | 1652 | __start_tp_report 12:40:34 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 12:40:34 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 12:40:34 INFO - PROCESS | 1652 | |i|pagename|runs| 12:40:34 INFO - PROCESS | 1652 | |0;dojo.html;3481.164520515076;3486.982565087175;3515.63085875983;3517.4723791431297;3564.322778672052;5683.232763576916;5757.337906140795;5880.558958078151;5891.116332550114;5913.73388197531;5813.883722325551;5876.353601103875;5903.380145084769;5911.467967882901;5918.34898161203;5293.9735301323535;5327.653702509344;5357.196420536931;5410.3507579090565;5460.099083651193;5283.735813209343;5290.6825590464505;5442.346918369801;5456.590755693319;5464.672119672812;5325.440828712987;5356.678599284036;5372.409035006166;5411.783528658849;5414.648047876895;4353.28170851809;5369.543588794957;5393.514583687487;5437.34751829779;5444.292242008553;5327.627066105374;5357.973210133963;5393.406725260218;5417.864553386157;5420.810271640513;5712.942870571283;5737.082066869322;5742.167385729046;5895.528357731414;5920.615160014585;6208.534359923024;6244.438000579969;6273.7176827042895;6309.211348581427;6314.463270621956;6234.781782637631;6260.467860231885;6265.7493700251935;6268.028455589391;6289.182406287154;5774.105013722879;5834.3290521589715;5944.494717949023;5951.107333899907;5964.015937370329;6241.095041218998;6261.186045814106;6291.937080629226;6299.086632438362;6358.77744278948;6295.716692748746;6297;6298.212723409574;6312.337204593543;6318.936810631927;6148.077788331697;6274.749010039639;6297.653629050446;6298.0552917062805;6298.811035668938;6146.985747351637;6177.96911015442;6202.627842329474;6293.779717709858;6326.841828954313;6241.18864547615;6286.402791734778;6303.401176888188;6303.621782693053;6311.810645680637;5062.594992400599;5092.26162206478;5111.821086261963;5115.974420127875;5144.048351054992;4486.865394038119;4520.2315606347;4543.34121552373;4549.863504094882;4583.197940360424;5851.473367396869;5916.467517923407;5978.222831031938;5988.191594134823;6084.9351363511205;6233.2208473940755;6269.059641053878;6270.655113968684;6272.8118156455375;6276.780312689034;6012.188354572077;6022.879542409128;6024.277086749618;6038.245219347582;6064.999275119644;5432.945670543323;5453.23654688344;5487.6158668892795;5501.339839219319;5538.501534861882;6417.807465776034;6458.967705161444;6470.7088181032905;6478.222613286436;6483.3516648335735;6263.843403914939;6269.122322874892;6270.216222972129;6278.309385967631;6279.591826531261;6217.595856269328;6249.437550620284;6257.2804127525915;6407;6495.0906873036865;6217.502599792097;6271.749130034747;6276.215473065867;6279.560430769802;6291;5026.673266237683;6084.90872636902;6262.373762623702;6282.623042617458;6303.716332764945;6243.157173781481;6275.3724627536885;6291.150694656346;6303.212098487689;6316.778912738032;6077.179580756718;6110.77140286259;6143.634700640197;6230.532710046674;6299.559030867796;6020.51835853122;6161.815145545641;6164.075388691553;6179.6910154493;6191.566590338633;6215.192025036717;6259.6870156492905;6259.718312675849;6260.530460215411;6280.905786413116;5972.13404056418;6028.728707208274;6163.445289923929;6174.753009879554;6176.3514830943905 12:40:34 INFO - PROCESS | 1652 | |1;ext.html;493.90121975604865;508.5829619711835;516.2823675091621;528.3659608469836;532.5473347654492;31135.532967005485;32037.038888833315;41185.176296474056;42211.36682949758;42268.36597451041;43299.78350108245;43521.782391088076;43608;43632.56367436333;43657.56342436575;10069.44618046009;10279.126274266697;10281.897181028206;10293.330933489337;10304.690859274233;9414.199793017602;9646.662366817163;12281.815772763415;12535.373231338443;12554.309512976828;12452.81320780189;12515.749685006294;12525.43635536403;12547.309897955609;12558.686032849206;12467.43896524654;12539.498420063186;12544.310062946533;12559.183653062613;12577.182483138567;10975.83536246957;12065.758684826254;12374.195677281037;12459.314737689423;12461.875381246162;40575.18849623021;40792;40823;40849.387259191135;40880.79559602213;3428.7599868009247;3507.57909050913;3534.045807631925;3551.8401671924826;3569.8572057117685;30420.847895760602;31286.68713312883;31360.37279254402;31671.049868503982;31837.363252735046;3098.829564373981;3230.70771691323;3324.7838890472285;3426.0407086015957;3453.3611281912927;532666;533197;533735;533808;534811;33230.66769332276;59772.70113649404;60117.09824352638;60169.69915150396;60286.698566506886;33916.83041584776;35251;35568.466473002925;35607.82196089003;35638;15744.212789360487;15899.841001590068;15906.9204653976;15929;15931.283092260875;12315.953143982862;12665.36673166338;13443.46226150943;13517.797233041512;13518;6918.377346038881;6968.79093627192;6973.9887716280855;7666.731664391719;7853.253940875607;2920.4597149527403;3324.9219237976263;3363.6972672459597;3380.2901390707734;3408.5398471206568;933.9206167475704;981.5681100315838;983.6901376066517;1027.8047171037479;1064.8668916385452;25392.746072539037;31335.589898454626;31446.84276578648;31817.52273715896;31978.360432791214;1036.4403222260046;1051.9105876000626;1118.9776204476027;1145.8854114588476;1147.1912301827192;13127.474901003852;16298;16318.428854990017;16365.263563139688;16761.7485737714;735533;740368;743929;744297;745115;54249.64375890634;57827.55431114256;60641.69679151576;61254.693726531084;61307.080393793236;1246.1463897230426;1260.5399029354219;1283.9037072219621;1386.9514566990106;1408.2465880753748;31548;31603.36793264168;32310.030699079067;32390.83804580962;32790.180245494055;50536.494635053175;51088.233676494136;51125;51244.23133653073;51257.974840503724;597414;600283;600490;602062;871093;23961.400964975317;26536.7346326542;27169.456610868066;27255.86372068127;27919.581206282328;46557.53442465532;47588.28617570808;48582;49397.25904111513;49499;34902;38051.80974095112;40733.38899916445;40856.93572981979;41740.373894392214;41132.79433602933;41333;41926.95182620459;41975.950601235214;42342.57657423386;39164.82505524839;39444.60555394524;39565.802170990115;39709.80145099256;40041.59958400495;34440;35319.47020794639;36142.63857361498;36200;36259.818700906326;25704;26444.735552644997;26686.46627067409;26748.866255668596;27477.17568472949 12:40:34 INFO - PROCESS | 1652 | |2;jquery.html;375.05299119722713;382.81050879814495;390.5918315360448;391.823679344295;411.7632361392198;19234.80765192348;21784;21791.782082179172;21965.560688786216;22188.334349969507;19963;20558.69161962572;20824.583508329823;21075.156993720233;21932.342029739095;5446.428125046872;5479.2602998595075;5571.275734154554;5640.464155905203;5645.915311270334;4073.8574149904757;4194.0982688721915;5546.112621980484;5642.7742890284335;5645.5483561314995;4218.346156345771;4356.847510337139;6966.198887127995;7067.85864282714;7069.363757261845;6710.798676039727;6908.5509441886115;7046.577205367668;7054.717811287543;7055.188653304885;6142.6007309525185;6156.353582873823;6157.692115394212;6166.013437849967;6181.721822517952;13347.86652133476;13592.184468931895;13623.386947587382;13710.45158193671;19180.040997950186;1963.4011626453926;2056.4139220322136;2265.184533567914;2460.950780984388;2959.141848863827;9978.151857092156;10157.949210253975;10288.537015834305;10568.418736969463;10572.577096916115;1898.1648074847024;1927.6915693488975;1937.6124775044907;2024.5343570978757;2025.4835017070552;86973;91521.1695766081;91776;93839;129433.35283323617;10929.836052459219;11173.273737207055;11665.416729163508;11675;11861.347625880659;14693.971422000357;14801.18593477369;14810.407583696748;14831.961762676725;14862.959592828614;6725;6836.077129587442;8550.486970781772;9029.41308814925;9164.404313719588;9037.322200834964;9071.410358326688;9094.772630684154;9221.216196623362;9240.815183696288;4512.9097418052115;4592.6555508337005;4595.655325850507;4665.136949664323;4670.089332580114;1930.2375561653068;1962.1464662871697;1963.4207908666976;1982.9773630896404;1997.4207479830977;853.8548446764065;866.1641515937151;911.1207684584408;1029.994850025745;1078.9568417263379;17454.56363590895;19810.504737381394;21281.36155915325;21285.40359473046;21294.467638309165;937.0676177203726;944.320089535547;978.9363691360039;989.6931951095183;990.7919336939179;10624.734381640521;10945.616903408501;11136.443177841076;11154.832677509843;11193.272437291713;576326.1183694055;624273;631656;636734;654501;103305.31428971278;113301;133271;133496;140010;977.7164622259465;989.3124278626285;1021.6322124035341;1022.749426390539;1022.7749895023231;19017.23931042798;19550.315738949637;19595.216191352756;19722.50693732668;19752.604947901247;57427;57631;57834.42165578459;57876.13185802132;58774;63925.680371597846;80148.19851801408;80600.19399806162;81715;84795.5760221195;7681.462297639112;7825.334846538108;7920.84158316842;7925.841483170419;7928.722494712657;10286.897131028893;10896.564137434414;11090.889091108986;12282.955948744457;12405.565805196775;10322.380657160595;10660.040596346365;10776.353418794897;11036.392998384845;11043.944780276048;9248.398854074463;9606.183474404754;10449.425281609585;10450.320729152581;10851;10927.071198948179;11033.172512061788;11068.612598559012;11145.2198346115;11406;6492.675366231575;7750.8449831001935;7812.453128280966;7954.244346787046;8001.799955000939;10686.465676715978;10731.356118632906;10779.622713205;10857.945710271713;11015.182494888253 12:40:34 INFO - PROCESS | 1652 | |3;mootools.html;1557.6183834960436;1588.6743217640385;1783.6878546254402;1919.7600299962514;1945.2996921108406;8491.702790402338;9540.475273859953;9553;9553.092456216657;9557.28320375972;8333.083360830318;8546.359023073279;8575.142485751438;8624.784380390493;9294.907050929489;1905.799891011441;2386.081358676913;2459.963100553493;2464.149868295435;2466.580681284186;2432.404061005056;2458.1887976967646;2464.7658472445178;2470.505898820234;2481.838680485772;2436.1595249638845;2455.4107014316523;2467.592847180213;2468.4322605800676;2470.7899828514596;2429.866357350345;2445.9755402446017;2450.1669432393073;2452.3623857796924;2462.6059830427225;2449.669294645218;2452.399162205253;2453.595156799126;2457.3733697907096;2461.200109964269;9221.53892305382;9432.103950124727;9432.292578056604;9438.52807359636;9502.90497095027;5485.067538518461;5656.858578535528;5670.432956704338;5681.914771278434;5688.374278829326;3571.3750093733493;3647.1611529348133;3764.171882185915;3768.660820526138;3771.340015497277;1062.3625824505311;1088.1186239146239;1088.9618863339745;1113.6158025481195;1114.1755101225117;12288.815667764991;12451.128421010533;12474.376281185905;12482.937585312015;12499.250044997329;4811.639127065414;4851.708897466093;4875.1224779540025;4969.82605608802;4985.376827896513;10626.681199564026;10639.627613033506;10642.840357394645;10646.787064258671;10652.467376631292;5627.296587926509;5634.1830434586755;5644.943550564524;5650.660960342392;5653.152027195953;4932.890099727604;5039.823606173766;5146.330976972969;5149.76826042829;5152.381714194245;4169.374593810952;4182.393552934807;4192.601702838226;4221.092465120014;4229.0273237155625;1275.457930379585;1286;1306.4251729239104;1309.0640192262388;1310.8492523359746;922.4050487435701;929.5305870535336;931.2829121576484;952.3571589177416;977.130353984954;5958.689088400545;6001.459868611759;6003.459688628044;6091;6248.250769661335;441.05613986069835;446.21688935917257;447.19728088081973;448.9214387482178;451.3996384808197;4106.404571337199;4106.897327566835;4110.547839737626;4110.609492098246;4144.109016561393;10865.40240286776;11449.54201831934;11460.656180314603;11472.254303470414;11478.483468243949;11277.984981351718;11321.943390282995;11378.544858205745;11395.715107122389;11416;8194.344452443791;8485.151484851589;8603.311735061305;8608.956955215184;8616.138386161334;6224.2842073160355;6274.560780745304;6341.175647165839;6354.3963323484195;6404.327545607644;10160.644377446753;10248.026437488426;10500.317479363817;10513;10534.841977370499;9912.851307230254;10911;10917.563297468012;10918.890811091787;10922.453877306261;7399.223081576357;7669.271419215165;7832.216778322122;8016;8121.715739949073;8515.8722619162;8749;8776.16626420489;8780.78048048804;8890.511021893857;6517.641529715911;7718.266764657348;7724.497907635986;7747.767566973;7808.141104478616;7437.665305061177;7485.588292643739;7510.924890751241;7567.054118235221;7637.5035622684345;7330.963345183453;7338.596377199306;7406.4074874008875;7449.664765085476;7463.888041679271;4967.081089998362;5022;5279.656822306538;5321.068812957639;5398.5951053671915;4769.737664428351;5217.634765566374;5221.008008478377;5405.4594540547205;5473.507384335429 12:40:34 INFO - PROCESS | 1652 | |4;prototype.html;297.70824591899935;307.8630009645707;308.9814611123332;312.35654551623657;314.3430230817591;5008.79788850676;5346.893062138764;5507.311586051744;5524.298719857695;5666.546676265899;4835.395575553056;5482.314710661168;5579.856129493454;5586.441355864412;5623.4938855503;3363.360961417335;4009.879703608889;4103.835846566134;4209.2423363794505;4217.36739489076;3465.878694245702;4203.726757760735;4204.7056706030435;4214.976811130644;4319.632831209351;3656.067702735799;4013.4983127109113;4163.5836416358425;4193.769342686151;4195.895102622444;3606.855725770966;4107;4160.332747394231;4178.540360560336;4237.894052648678;3034.742046926014;3167.509036099408;3657.1040095176586;3664.047347689593;3667.523221981152;5423.83728488146;5440.735558664769;5445;5464.754086066137;5499.285092937933;3679.5952445231005;4566.611837993774;4661.137689527448;4866.537678920497;4868.732219727914;4839.830605928811;5019.64862459628;5820.097884827858;5832.62087964281;5834.5915785895;3549.8402571884326;4045.5549889512426;4053;4053.97973010136;4064.979675101635;5293.523582877521;5843.750156189897;6195.415392609481;6214.70056079249;6238;4068.3897415387337;4105.261053010487;4116.938245926313;4124.958750412457;4125;3416.777909435879;3533.381658209803;3779.905502362408;4150.343779980814;4182.2681030819485;4782.9760851196215;4827.758612069382;4835.758212089381;4847.854564363075;4904.288878112654;4461.977690111528;4687.390709153932;5779.306483222041;5837.532997360201;5966.910496342558;1188.9002672527877;1348.2651954684525;1365.1604263377951;1365.603974847283;1376.4631793600504;789.5854676294877;819.9016118065871;839.706102864005;847.0047693959696;852.8848605438186;4710.4347478302825;5415.377231618336;5559.63862348946;5592.692401917852;5599.8880022400135;6032.607880487842;6039.516838652898;6073.969630151821;6079.270487541435;6106.458254212546;5252.579793616502;5300.402802626762;5546.833594992076;5617.185508101303;5645.294338207724;2677.906273280426;2998.430298243327;3117.423276693819;3155.8106513609255;3160.9094862272477;5171.3535808024;5666.801661941812;6247.531435142382;6250.843728906813;6299.842503937347;5389.407165211824;5809;6191.504679625619;6210.9068363974575;6269.96865015672;6330.01884707871;6331.335209802996;6335.904961425582;6360.522960777867;6378.872422551523;5009.223570346602;5484.533814625802;5911.527077833677;6108.541859360477;6181.567290289637;5202.8959420812125;5645;5809.779946211343;5971.91042134377;5979.880402392015;5371.758270877898;5937.287525496968;6245.375462453719;6251;6278.968605156945;3454.5681789776277;3463.7402194834985;3979.3036218662196;4017.5178978522763;4025.2955732747237;4782.832600858953;5225.843224703265;5700.486956173964;5987.700614969147;6141.692915354304;5727.427257274406;5871.178035075179;5876.529877609695;5881.794137205177;5986.910196346971;4869.70781753096;4890.486498917705;5735.483806457439;5915.822525324247;5998.34018258;5504.834854954358;5639.774409023593;5738.856528586819;5841.269841269841;5847.181394604674;5478.890422191614;5835.4748072673665;5885.234919460443;5935.376785437639;5955.910661339996;5469.398366179637;5801.8549536261935;5807.854803629774;5820.5925585210325;5841.912371314349 12:40:34 INFO - PROCESS | 1652 | |5;yui.html;683.9110915580974;746.5595298773724;797.7686470923433;815.9755207343778;824.1593574553959;16075.437359692412;17124.143792810373;17149.399771008;17150.14249287537;17173.656526869454;15389.691876190509;15421.614459638515;15421.922890385533;15422.151781652005;15458.61353466164;706.1984647425159;720.3840716187663;726.5640615630606;875.4834647557956;888.5424006636588;893.530896279452;899.5052721003422;907.3331101640289;909.0954500272238;909.6816114359988;961.8845738511353;967.1585720423242;968.5883499512714;969.8351280282334;972.5088830140804;954.9904500954971;959.3332633819498;960.4957397366438;960.6445615122415;962.8603852441391;710.073354272674;710.7974227345234;711.1856923822246;711.9537230080028;713.0908092182457;15767.526974190792;16083.91958040214;16182.19089045543;16215.837841621551;16222.594435139097;13757.931210343984;13761.518346857913;13883;15121.832188796236;15254.38982440712;11810.586629468013;12225.755484890253;12397.690057748538;13545.796813047813;13664.93167534156;3984.900377490557;4020.718549701522;4047.0691740899465;4063.2686116499017;4093.8157782899543;123670;133391;137771;139258;141089;11387.544498220144;11680.357580332993;11684.591039313584;11788.528458861721;11831.230969986924;23348.883255583612;23545.64681529744;23740.287791366285;23743;23914.163004294765;7848.489848159851;8000.399970002157;8246.257836794717;8344.332453403713;8459.027211870714;3685.355062863988;4228.8308467660945;4483.461667887309;4652.55800698933;4683.391159149357;3769.4911186989953;3917.9020524486546;3927.626875446828;3933.6656384207663;3942.6057394260342;616.3774587666489;664.8304682306077;755.6335177438938;770.4837758701683;771.5139462138817;594.3966873623276;628.8019273928697;694.6492021529095;697.8639165362807;715.9856802863914;9279.164875161134;10018.589961420897;10141.543630536644;10182.796344073076;10502;653.4641593893057;674.7166190200128;693.8751024815481;706.8974998625171;715.5027256057094;4510.323451482238;4515.006698526319;4834.299026641117;4850.733244576152;4874.634402419832;114386;137171;139820;145695.2715236417;145876;90906.09093908976;93188;127355.08967365496;127548;128925.42149156965;109761.45119274512;110574.89425105807;111417;111563.44218278857;115557;10010.749731256778;10183.236257280585;10415.635452759117;10457.947710261704;10462.947685261524;63507.68246158925;66161.7146371094;66418.33581664122;66986.66026679342;67028;90639.5468022682;94475;99433;100335.49832251084;100391;13449.596512104652;13541.796873046715;13653.385597647932;13669.384877680726;13896.652583685489;14956.925215373854;14978.550643480714;15336.309866056277;15636.530904072895;16322;13544.187348759106;13546.79679804784;13967.860321397062;14272.286385680467;14706.77939830882;14063.367148478548;14107.506237282056;14329.283535822959;14370;14814.925925370304;13004.219746814842;14188.645283867985;14335.139891606537;14438.205898675673;14743.483978060716;11351.205415620827;11482.196246262682;11675.416229188337;12028.037756979596;12160.878391215974;11172;11741.236819606698;11958.402079895797;11967.461464233957;12027.75944481123 12:40:34 INFO - PROCESS | 1652 | __end_tp_report 12:40:34 INFO - PROCESS | 1652 | __start_cc_report 12:40:34 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1259 12:40:34 INFO - PROCESS | 1652 | __end_cc_report 12:40:34 INFO - PROCESS | 1652 | __startTimestamp1479156034033__endTimestamp 12:40:34 INFO - PROCESS | 1652 | 12:40:34 INFO - PROCESS | 1652 | ------- Summary: start ------- 12:40:34 INFO - PROCESS | 1652 | Number of tests: 6 12:40:34 INFO - PROCESS | 1652 | 12:40:34 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5854.86 Median:6143.63 stddev:623.58 (10.2%) stddev-sans-first:597.05 12:40:34 INFO - PROCESS | 1652 | Values: 3481.2 3487.0 3515.6 3517.5 3564.3 5683.2 5757.3 5880.6 5891.1 5913.7 5813.9 5876.4 5903.4 5911.5 5918.3 5294.0 5327.7 5357.2 5410.4 5460.1 5283.7 5290.7 5442.3 5456.6 5464.7 5325.4 5356.7 5372.4 5411.8 5414.6 4353.3 5369.5 5393.5 5437.3 5444.3 5327.6 5358.0 5393.4 5417.9 5420.8 5712.9 5737.1 5742.2 5895.5 5920.6 6208.5 6244.4 6273.7 6309.2 6314.5 6234.8 6260.5 6265.7 6268.0 6289.2 5774.1 5834.3 5944.5 5951.1 5964.0 6241.1 6261.2 6291.9 6299.1 6358.8 6295.7 6297.0 6298.2 6312.3 6318.9 6148.1 6274.7 6297.7 6298.1 6298.8 6147.0 6178.0 6202.6 6293.8 6326.8 6241.2 6286.4 6303.4 6303.6 6311.8 5062.6 5092.3 5111.8 5116.0 5144.0 4486.9 4520.2 4543.3 4549.9 4583.2 5851.5 5916.5 5978.2 5988.2 6084.9 6233.2 6269.1 6270.7 6272.8 6276.8 6012.2 6022.9 6024.3 6038.2 6065.0 5432.9 5453.2 5487.6 5501.3 5538.5 6417.8 6459.0 6470.7 6478.2 6483.4 6263.8 6269.1 6270.2 6278.3 6279.6 6217.6 6249.4 6257.3 6407.0 6495.1 6217.5 6271.7 6276.2 6279.6 6291.0 5026.7 6084.9 6262.4 6282.6 6303.7 6243.2 6275.4 6291.2 6303.2 6316.8 6077.2 6110.8 6143.6 6230.5 6299.6 6020.5 6161.8 6164.1 6179.7 6191.6 6215.2 6259.7 6259.7 6260.5 6280.9 5972.1 6028.7 6163.4 6174.8 6176.4 12:40:34 INFO - PROCESS | 1652 | 12:40:34 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:75783.13 Median:19177.68 stddev:175125.41 (913.2%) stddev-sans-first:175525.45 12:40:34 INFO - PROCESS | 1652 | Values: 493.9 508.6 516.3 528.4 532.5 31135.5 32037.0 41185.2 42211.4 42268.4 43299.8 43521.8 43608.0 43632.6 43657.6 10069.4 10279.1 10281.9 10293.3 10304.7 9414.2 9646.7 12281.8 12535.4 12554.3 12452.8 12515.7 12525.4 12547.3 12558.7 12467.4 12539.5 12544.3 12559.2 12577.2 10975.8 12065.8 12374.2 12459.3 12461.9 40575.2 40792.0 40823.0 40849.4 40880.8 3428.8 3507.6 3534.0 3551.8 3569.9 30420.8 31286.7 31360.4 31671.0 31837.4 3098.8 3230.7 3324.8 3426.0 3453.4 532666.0 533197.0 533735.0 533808.0 534811.0 33230.7 59772.7 60117.1 60169.7 60286.7 33916.8 35251.0 35568.5 35607.8 35638.0 15744.2 15899.8 15906.9 15929.0 15931.3 12316.0 12665.4 13443.5 13517.8 13518.0 6918.4 6968.8 6974.0 7666.7 7853.3 2920.5 3324.9 3363.7 3380.3 3408.5 933.9 981.6 983.7 1027.8 1064.9 25392.7 31335.6 31446.8 31817.5 31978.4 1036.4 1051.9 1119.0 1145.9 1147.2 13127.5 16298.0 16318.4 16365.3 16761.7 735533.0 740368.0 743929.0 744297.0 745115.0 54249.6 57827.6 60641.7 61254.7 61307.1 1246.1 1260.5 1283.9 1387.0 1408.2 31548.0 31603.4 32310.0 32390.8 32790.2 50536.5 51088.2 51125.0 51244.2 51258.0 597414.0 600283.0 600490.0 602062.0 871093.0 23961.4 26536.7 27169.5 27255.9 27919.6 46557.5 47588.3 48582.0 49397.3 49499.0 34902.0 38051.8 40733.4 40856.9 41740.4 41132.8 41333.0 41927.0 41976.0 42342.6 39164.8 39444.6 39565.8 39709.8 40041.6 34440.0 35319.5 36142.6 36200.0 36259.8 25704.0 26444.7 26686.5 26748.9 27477.2 12:40:34 INFO - PROCESS | 1652 | 12:40:34 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:34977.95 Median:2363.07 stddev:103796.99 (4392.5%) stddev-sans-first:104055.65 12:40:34 INFO - PROCESS | 1652 | Values: 375.1 382.8 390.6 391.8 411.8 19234.8 21784.0 21791.8 21965.6 22188.3 19963.0 20558.7 20824.6 21075.2 21932.3 5446.4 5479.3 5571.3 5640.5 5645.9 4073.9 4194.1 5546.1 5642.8 5645.5 4218.3 4356.8 6966.2 7067.9 7069.4 6710.8 6908.6 7046.6 7054.7 7055.2 6142.6 6156.4 6157.7 6166.0 6181.7 13347.9 13592.2 13623.4 13710.5 19180.0 1963.4 2056.4 2265.2 2461.0 2959.1 9978.2 10157.9 10288.5 10568.4 10572.6 1898.2 1927.7 1937.6 2024.5 2025.5 86973.0 91521.2 91776.0 93839.0 129433.4 10929.8 11173.3 11665.4 11675.0 11861.3 14694.0 14801.2 14810.4 14832.0 14863.0 6725.0 6836.1 8550.5 9029.4 9164.4 9037.3 9071.4 9094.8 9221.2 9240.8 4512.9 4592.7 4595.7 4665.1 4670.1 1930.2 1962.1 1963.4 1983.0 1997.4 853.9 866.2 911.1 1030.0 1079.0 17454.6 19810.5 21281.4 21285.4 21294.5 937.1 944.3 978.9 989.7 990.8 10624.7 10945.6 11136.4 11154.8 11193.3 576326.1 624273.0 631656.0 636734.0 654501.0 103305.3 113301.0 133271.0 133496.0 140010.0 977.7 989.3 1021.6 1022.7 1022.8 19017.2 19550.3 19595.2 19722.5 19752.6 57427.0 57631.0 57834.4 57876.1 58774.0 63925.7 80148.2 80600.2 81715.0 84795.6 7681.5 7825.3 7920.8 7925.8 7928.7 10286.9 10896.6 11090.9 12283.0 12405.6 10322.4 10660.0 10776.4 11036.4 11043.9 9248.4 9606.2 10449.4 10450.3 10851.0 10927.1 11033.2 11068.6 11145.2 11406.0 6492.7 7750.8 7812.5 7954.2 8001.8 10686.5 10731.4 10779.6 10857.9 11015.2 12:40:34 INFO - PROCESS | 1652 | 12:40:34 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5988.02 Median:4831.67 stddev:3410.49 (70.6%) stddev-sans-first:3403.80 12:40:34 INFO - PROCESS | 1652 | Values: 1557.6 1588.7 1783.7 1919.8 1945.3 8491.7 9540.5 9553.0 9553.1 9557.3 8333.1 8546.4 8575.1 8624.8 9294.9 1905.8 2386.1 2460.0 2464.1 2466.6 2432.4 2458.2 2464.8 2470.5 2481.8 2436.2 2455.4 2467.6 2468.4 2470.8 2429.9 2446.0 2450.2 2452.4 2462.6 2449.7 2452.4 2453.6 2457.4 2461.2 9221.5 9432.1 9432.3 9438.5 9502.9 5485.1 5656.9 5670.4 5681.9 5688.4 3571.4 3647.2 3764.2 3768.7 3771.3 1062.4 1088.1 1089.0 1113.6 1114.2 12288.8 12451.1 12474.4 12482.9 12499.3 4811.6 4851.7 4875.1 4969.8 4985.4 10626.7 10639.6 10642.8 10646.8 10652.5 5627.3 5634.2 5644.9 5650.7 5653.2 4932.9 5039.8 5146.3 5149.8 5152.4 4169.4 4182.4 4192.6 4221.1 4229.0 1275.5 1286.0 1306.4 1309.1 1310.8 922.4 929.5 931.3 952.4 977.1 5958.7 6001.5 6003.5 6091.0 6248.3 441.1 446.2 447.2 448.9 451.4 4106.4 4106.9 4110.5 4110.6 4144.1 10865.4 11449.5 11460.7 11472.3 11478.5 11278.0 11321.9 11378.5 11395.7 11416.0 8194.3 8485.2 8603.3 8609.0 8616.1 6224.3 6274.6 6341.2 6354.4 6404.3 10160.6 10248.0 10500.3 10513.0 10534.8 9912.9 10911.0 10917.6 10918.9 10922.5 7399.2 7669.3 7832.2 8016.0 8121.7 8515.9 8749.0 8776.2 8780.8 8890.5 6517.6 7718.3 7724.5 7747.8 7808.1 7437.7 7485.6 7510.9 7567.1 7637.5 7331.0 7338.6 7406.4 7449.7 7463.9 4967.1 5022.0 5279.7 5321.1 5398.6 4769.7 5217.6 5221.0 5405.5 5473.5 12:40:34 INFO - PROCESS | 1652 | 12:40:34 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4722.87 Median:5419.61 stddev:1498.24 (27.6%) stddev-sans-first:1465.16 12:40:34 INFO - PROCESS | 1652 | Values: 297.7 307.9 309.0 312.4 314.3 5008.8 5346.9 5507.3 5524.3 5666.5 4835.4 5482.3 5579.9 5586.4 5623.5 3363.4 4009.9 4103.8 4209.2 4217.4 3465.9 4203.7 4204.7 4215.0 4319.6 3656.1 4013.5 4163.6 4193.8 4195.9 3606.9 4107.0 4160.3 4178.5 4237.9 3034.7 3167.5 3657.1 3664.0 3667.5 5423.8 5440.7 5445.0 5464.8 5499.3 3679.6 4566.6 4661.1 4866.5 4868.7 4839.8 5019.6 5820.1 5832.6 5834.6 3549.8 4045.6 4053.0 4054.0 4065.0 5293.5 5843.8 6195.4 6214.7 6238.0 4068.4 4105.3 4116.9 4125.0 4125.0 3416.8 3533.4 3779.9 4150.3 4182.3 4783.0 4827.8 4835.8 4847.9 4904.3 4462.0 4687.4 5779.3 5837.5 5966.9 1188.9 1348.3 1365.2 1365.6 1376.5 789.6 819.9 839.7 847.0 852.9 4710.4 5415.4 5559.6 5592.7 5599.9 6032.6 6039.5 6074.0 6079.3 6106.5 5252.6 5300.4 5546.8 5617.2 5645.3 2677.9 2998.4 3117.4 3155.8 3160.9 5171.4 5666.8 6247.5 6250.8 6299.8 5389.4 5809.0 6191.5 6210.9 6270.0 6330.0 6331.3 6335.9 6360.5 6378.9 5009.2 5484.5 5911.5 6108.5 6181.6 5202.9 5645.0 5809.8 5971.9 5979.9 5371.8 5937.3 6245.4 6251.0 6279.0 3454.6 3463.7 3979.3 4017.5 4025.3 4782.8 5225.8 5700.5 5987.7 6141.7 5727.4 5871.2 5876.5 5881.8 5986.9 4869.7 4890.5 5735.5 5915.8 5998.3 5504.8 5639.8 5738.9 5841.3 5847.2 5478.9 5835.5 5885.2 5935.4 5955.9 5469.4 5801.9 5807.9 5820.6 5841.9 12:40:34 INFO - PROCESS | 1652 | 12:40:34 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:25519.52 Median:17136.77 stddev:39772.30 (232.1%) stddev-sans-first:39840.15 12:40:34 INFO - PROCESS | 1652 | Values: 683.9 746.6 797.8 816.0 824.2 16075.4 17124.1 17149.4 17150.1 17173.7 15389.7 15421.6 15421.9 15422.2 15458.6 706.2 720.4 726.6 875.5 888.5 893.5 899.5 907.3 909.1 909.7 961.9 967.2 968.6 969.8 972.5 955.0 959.3 960.5 960.6 962.9 710.1 710.8 711.2 712.0 713.1 15767.5 16083.9 16182.2 16215.8 16222.6 13757.9 13761.5 13883.0 15121.8 15254.4 11810.6 12225.8 12397.7 13545.8 13664.9 3984.9 4020.7 4047.1 4063.3 4093.8 123670.0 133391.0 137771.0 139258.0 141089.0 11387.5 11680.4 11684.6 11788.5 11831.2 23348.9 23545.6 23740.3 23743.0 23914.2 7848.5 8000.4 8246.3 8344.3 8459.0 3685.4 4228.8 4483.5 4652.6 4683.4 3769.5 3917.9 3927.6 3933.7 3942.6 616.4 664.8 755.6 770.5 771.5 594.4 628.8 694.6 697.9 716.0 9279.2 10018.6 10141.5 10182.8 10502.0 653.5 674.7 693.9 706.9 715.5 4510.3 4515.0 4834.3 4850.7 4874.6 114386.0 137171.0 139820.0 145695.3 145876.0 90906.1 93188.0 127355.1 127548.0 128925.4 109761.5 110574.9 111417.0 111563.4 115557.0 10010.7 10183.2 10415.6 10457.9 10462.9 63507.7 66161.7 66418.3 66986.7 67028.0 90639.5 94475.0 99433.0 100335.5 100391.0 13449.6 13541.8 13653.4 13669.4 13896.7 14956.9 14978.6 15336.3 15636.5 16322.0 13544.2 13546.8 13967.9 14272.3 14706.8 14063.4 14107.5 14329.3 14370.0 14814.9 13004.2 14188.6 14335.1 14438.2 14743.5 11351.2 11482.2 11675.4 12028.0 12160.9 11172.0 11741.2 11958.4 11967.5 12027.8 12:40:34 INFO - PROCESS | 1652 | -------- Summary: end -------- 12:40:34 INFO - PROCESS | 1652 | 12:40:34 INFO - TEST-INFO | 1652: exit 0 12:40:34 INFO - TEST-OK | dromaeo_css | took 1115372ms 12:40:34 INFO - TEST-START | kraken 12:40:34 INFO - operating with platform_type : mac_ 12:40:34 INFO - Initialising browser for kraken test... 12:40:34 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmpZroLir/profile http://localhost:49266/getInfo.html) 12:40:36 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 12:40:36 INFO - PROCESS | 1663 | colorDepth:24 12:40:36 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 12:40:36 INFO - PROCESS | 1663 | __metrics 12:40:36 INFO - PROCESS | 1663 | 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:40:36 INFO - PROCESS | 1663 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:40:37 INFO - TEST-INFO | 1663: exit 0 12:40:37 INFO - Browser initialized. 12:40:37 INFO - Running cycle 1/1 for kraken test... 12:40:37 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmpZroLir/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:40:49 INFO - PROCESS | 1665 | RSS: Main: 168583168 12:40:49 INFO - PROCESS | 1665 | 12:40:52 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 12:40:53 INFO - PROCESS | 1665 | RSS: Main: 218525696 12:40:53 INFO - PROCESS | 1665 | 12:40:55 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 12:40:56 INFO - PROCESS | 1665 | RSS: Main: 228544512 12:40:56 INFO - PROCESS | 1665 | 12:40:59 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 12:41:00 INFO - PROCESS | 1665 | RSS: Main: 326848512 12:41:00 INFO - PROCESS | 1665 | 12:41:02 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 12:41:02 INFO - PROCESS | 1665 | RSS: Main: 228757504 12:41:02 INFO - PROCESS | 1665 | 12:41:04 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:41:05 INFO - PROCESS | 1665 | RSS: Main: 229539840 12:41:05 INFO - PROCESS | 1665 | 12:41:08 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 12:41:08 INFO - PROCESS | 1665 | RSS: Main: 265662464 12:41:08 INFO - PROCESS | 1665 | 12:41:11 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 12:41:12 INFO - PROCESS | 1665 | RSS: Main: 266317824 12:41:12 INFO - PROCESS | 1665 | 12:41:15 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 12:41:15 INFO - PROCESS | 1665 | RSS: Main: 264388608 12:41:15 INFO - PROCESS | 1665 | 12:41:17 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:41:17 INFO - PROCESS | 1665 | RSS: Main: 240496640 12:41:17 INFO - PROCESS | 1665 | 12:41:19 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:41:20 INFO - PROCESS | 1665 | RSS: Main: 245059584 12:41:20 INFO - PROCESS | 1665 | 12:41:22 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:41:23 INFO - PROCESS | 1665 | RSS: Main: 249982976 12:41:23 INFO - PROCESS | 1665 | 12:41:25 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:41:26 INFO - PROCESS | 1665 | RSS: Main: 276209664 12:41:26 INFO - PROCESS | 1665 | 12:41:29 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:41:29 INFO - PROCESS | 1665 | RSS: Main: 263847936 12:41:29 INFO - PROCESS | 1665 | 12:41:31 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 12:41:32 INFO - PROCESS | 1665 | RSS: Main: 307621888 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | __start_tp_report 12:41:32 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 12:41:32 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 12:41:32 INFO - PROCESS | 1665 | |i|pagename|runs| 12:41:32 INFO - PROCESS | 1665 | |0;ai-astar;114;113;114;110;112;113;111;114;160;161 12:41:32 INFO - PROCESS | 1665 | |1;audio-beat-detection;139;107;108;139;107;107;109;107;138;108 12:41:32 INFO - PROCESS | 1665 | |2;audio-dft;183;213;260;197;183;184;183;180;182;181 12:41:32 INFO - PROCESS | 1665 | |3;audio-fft;80;60;58;88;61;58;59;57;82;58 12:41:32 INFO - PROCESS | 1665 | |4;audio-oscillator;88;71;93;69;68;70;90;68;67;88 12:41:32 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;90;85;90;86;89;86;88;74;97;131 12:41:32 INFO - PROCESS | 1665 | |6;imaging-darkroom;94;101;93;148;149;135;94;94;94;94 12:41:32 INFO - PROCESS | 1665 | |7;imaging-desaturate;85;85;84;93;85;85;86;84;84;86 12:41:32 INFO - PROCESS | 1665 | |8;json-parse-financial;55;53;53;54;57;57;56;55;56;55 12:41:32 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;67;67;62;74;70;67;69;67;68;68 12:41:32 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;84;83;81;84;84;82;88;88;82;91 12:41:32 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;130;140;141;139;129;131;134;133;134;139 12:41:32 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;209;196;163;162;160;161;160;161;166;160 12:41:32 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;68;72;83;80;82;76;65;65;64;65 12:41:32 INFO - PROCESS | 1665 | __end_tp_report 12:41:32 INFO - PROCESS | 1665 | __start_cc_report 12:41:32 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1865 12:41:32 INFO - PROCESS | 1665 | __end_cc_report 12:41:32 INFO - PROCESS | 1665 | __startTimestamp1479156091998__endTimestamp 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | ------- Summary: start ------- 12:41:32 INFO - PROCESS | 1665 | Number of tests: 14 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:122.20 Median:114.00 stddev:20.23 (17.7%) stddev-sans-first:21.24 12:41:32 INFO - PROCESS | 1665 | Values: 114.0 113.0 114.0 110.0 112.0 113.0 111.0 114.0 160.0 161.0 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:116.90 Median:108.50 stddev:15.04 (13.9%) stddev-sans-first:13.66 12:41:32 INFO - PROCESS | 1665 | Values: 139.0 107.0 108.0 139.0 107.0 107.0 109.0 107.0 138.0 108.0 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:194.60 Median:183.50 stddev:25.15 (13.7%) stddev-sans-first:26.33 12:41:32 INFO - PROCESS | 1665 | Values: 183.0 213.0 260.0 197.0 183.0 184.0 183.0 180.0 182.0 181.0 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:66.10 Median:60.50 stddev:12.11 (20.0%) stddev-sans-first:11.75 12:41:32 INFO - PROCESS | 1665 | Values: 80.0 60.0 58.0 88.0 61.0 58.0 59.0 57.0 82.0 58.0 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:79.50 stddev:10.94 (13.8%) stddev-sans-first:10.89 12:41:32 INFO - PROCESS | 1665 | Values: 88.0 71.0 93.0 69.0 68.0 70.0 90.0 68.0 67.0 88.0 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:91.60 Median:88.50 stddev:14.99 (16.9%) stddev-sans-first:15.89 12:41:32 INFO - PROCESS | 1665 | Values: 90.0 85.0 90.0 86.0 89.0 86.0 88.0 74.0 97.0 131.0 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:109.60 Median:94.00 stddev:24.13 (25.7%) stddev-sans-first:24.92 12:41:32 INFO - PROCESS | 1665 | Values: 94.0 101.0 93.0 148.0 149.0 135.0 94.0 94.0 94.0 94.0 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:85.00 stddev:2.67 (3.1%) stddev-sans-first:2.82 12:41:32 INFO - PROCESS | 1665 | Values: 85.0 85.0 84.0 93.0 85.0 85.0 86.0 84.0 84.0 86.0 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:1.45 (2.6%) stddev-sans-first:1.54 12:41:32 INFO - PROCESS | 1665 | Values: 55.0 53.0 53.0 54.0 57.0 57.0 56.0 55.0 56.0 55.0 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:3.00 (4.4%) stddev-sans-first:3.16 12:41:32 INFO - PROCESS | 1665 | Values: 67.0 67.0 62.0 74.0 70.0 67.0 69.0 67.0 68.0 68.0 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:3.23 (3.8%) stddev-sans-first:3.42 12:41:32 INFO - PROCESS | 1665 | Values: 84.0 83.0 81.0 84.0 84.0 82.0 88.0 88.0 82.0 91.0 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:135.00 Median:136.50 stddev:4.42 (3.2%) stddev-sans-first:4.30 12:41:32 INFO - PROCESS | 1665 | Values: 130.0 140.0 141.0 139.0 129.0 131.0 134.0 133.0 134.0 139.0 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:162.50 stddev:17.60 (10.8%) stddev-sans-first:11.62 12:41:32 INFO - PROCESS | 1665 | Values: 209.0 196.0 163.0 162.0 160.0 161.0 160.0 161.0 166.0 160.0 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:74.00 stddev:7.66 (10.4%) stddev-sans-first:7.99 12:41:32 INFO - PROCESS | 1665 | Values: 68.0 72.0 83.0 80.0 82.0 76.0 65.0 65.0 64.0 65.0 12:41:32 INFO - PROCESS | 1665 | -------- Summary: end -------- 12:41:32 INFO - PROCESS | 1665 | 12:41:32 INFO - TEST-INFO | 1665: exit 0 12:41:32 INFO - TEST-OK | kraken | took 58174ms 12:41:32 INFO - SUITE-END | took 1173s 12:41:33 INFO - Completed test suite (00:19:33) 12:41:33 INFO - javascript benchmark 12:41:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3481.164520515076, 3486.982565087175, 3515.63085875983, 3517.4723791431297, 3564.322778672052, 5683.232763576916, 5757.337906140795, 5880.558958078151, 5891.116332550114, 5913.73388197531, 5813.883722325551, 5876.353601103875, 5903.380145084769, 5911.467967882901, 5918.34898161203, 5293.9735301323535, 5327.653702509344, 5357.196420536931, 5410.3507579090565, 5460.099083651193, 5283.735813209343, 5290.6825590464505, 5442.346918369801, 5456.590755693319, 5464.672119672812, 5325.440828712987, 5356.678599284036, 5372.409035006166, 5411.783528658849, 5414.648047876895, 4353.28170851809, 5369.543588794957, 5393.514583687487, 5437.34751829779, 5444.292242008553, 5327.627066105374, 5357.973210133963, 5393.406725260218, 5417.864553386157, 5420.810271640513, 5712.942870571283, 5737.082066869322, 5742.167385729046, 5895.528357731414, 5920.615160014585, 6208.534359923024, 6244.438000579969, 6273.7176827042895, 6309.211348581427, 6314.463270621956, 6234.781782637631, 6260.467860231885, 6265.7493700251935, 6268.028455589391, 6289.182406287154, 5774.105013722879, 5834.3290521589715, 5944.494717949023, 5951.107333899907, 5964.015937370329, 6241.095041218998, 6261.186045814106, 6291.937080629226, 6299.086632438362, 6358.77744278948, 6295.716692748746, 6297.0, 6298.212723409574, 6312.337204593543, 6318.936810631927, 6148.077788331697, 6274.749010039639, 6297.653629050446, 6298.0552917062805, 6298.811035668938, 6146.985747351637, 6177.96911015442, 6202.627842329474, 6293.779717709858, 6326.841828954313, 6241.18864547615, 6286.402791734778, 6303.401176888188, 6303.621782693053, 6311.810645680637, 5062.594992400599, 5092.26162206478, 5111.821086261963, 5115.974420127875, 5144.048351054992, 4486.865394038119, 4520.2315606347, 4543.34121552373, 4549.863504094882, 4583.197940360424, 5851.473367396869, 5916.467517923407, 5978.222831031938, 5988.191594134823, 6084.9351363511205, 6233.2208473940755, 6269.059641053878, 6270.655113968684, 6272.8118156455375, 6276.780312689034, 6012.188354572077, 6022.879542409128, 6024.277086749618, 6038.245219347582, 6064.999275119644, 5432.945670543323, 5453.23654688344, 5487.6158668892795, 5501.339839219319, 5538.501534861882, 6417.807465776034, 6458.967705161444, 6470.7088181032905, 6478.222613286436, 6483.3516648335735, 6263.843403914939, 6269.122322874892, 6270.216222972129, 6278.309385967631, 6279.591826531261, 6217.595856269328, 6249.437550620284, 6257.2804127525915, 6407.0, 6495.0906873036865, 6217.502599792097, 6271.749130034747, 6276.215473065867, 6279.560430769802, 6291.0, 5026.673266237683, 6084.90872636902, 6262.373762623702, 6282.623042617458, 6303.716332764945, 6243.157173781481, 6275.3724627536885, 6291.150694656346, 6303.212098487689, 6316.778912738032, 6077.179580756718, 6110.77140286259, 6143.634700640197, 6230.532710046674, 6299.559030867796, 6020.51835853122, 6161.815145545641, 6164.075388691553, 6179.6910154493, 6191.566590338633, 6215.192025036717, 6259.6870156492905, 6259.718312675849, 6260.530460215411, 6280.905786413116, 5972.13404056418, 6028.728707208274, 6163.445289923929, 6174.753009879554, 6176.3514830943905], "value": 5816.99749811119, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.90121975604865, 508.5829619711835, 516.2823675091621, 528.3659608469836, 532.5473347654492, 31135.532967005485, 32037.038888833315, 41185.176296474056, 42211.36682949758, 42268.36597451041, 43299.78350108245, 43521.782391088076, 43608.0, 43632.56367436333, 43657.56342436575, 10069.44618046009, 10279.126274266697, 10281.897181028206, 10293.330933489337, 10304.690859274233, 9414.199793017602, 9646.662366817163, 12281.815772763415, 12535.373231338443, 12554.309512976828, 12452.81320780189, 12515.749685006294, 12525.43635536403, 12547.309897955609, 12558.686032849206, 12467.43896524654, 12539.498420063186, 12544.310062946533, 12559.183653062613, 12577.182483138567, 10975.83536246957, 12065.758684826254, 12374.195677281037, 12459.314737689423, 12461.875381246162, 40575.18849623021, 40792.0, 40823.0, 40849.387259191135, 40880.79559602213, 3428.7599868009247, 3507.57909050913, 3534.045807631925, 3551.8401671924826, 3569.8572057117685, 30420.847895760602, 31286.68713312883, 31360.37279254402, 31671.049868503982, 31837.363252735046, 3098.829564373981, 3230.70771691323, 3324.7838890472285, 3426.0407086015957, 3453.3611281912927, 532666.0, 533197.0, 533735.0, 533808.0, 534811.0, 33230.66769332276, 59772.70113649404, 60117.09824352638, 60169.69915150396, 60286.698566506886, 33916.83041584776, 35251.0, 35568.466473002925, 35607.82196089003, 35638.0, 15744.212789360487, 15899.841001590068, 15906.9204653976, 15929.0, 15931.283092260875, 12315.953143982862, 12665.36673166338, 13443.46226150943, 13517.797233041512, 13518.0, 6918.377346038881, 6968.79093627192, 6973.9887716280855, 7666.731664391719, 7853.253940875607, 2920.4597149527403, 3324.9219237976263, 3363.6972672459597, 3380.2901390707734, 3408.5398471206568, 933.9206167475704, 981.5681100315838, 983.6901376066517, 1027.8047171037479, 1064.8668916385452, 25392.746072539037, 31335.589898454626, 31446.84276578648, 31817.52273715896, 31978.360432791214, 1036.4403222260046, 1051.9105876000626, 1118.9776204476027, 1145.8854114588476, 1147.1912301827192, 13127.474901003852, 16298.0, 16318.428854990017, 16365.263563139688, 16761.7485737714, 735533.0, 740368.0, 743929.0, 744297.0, 745115.0, 54249.64375890634, 57827.55431114256, 60641.69679151576, 61254.693726531084, 61307.080393793236, 1246.1463897230426, 1260.5399029354219, 1283.9037072219621, 1386.9514566990106, 1408.2465880753748, 31548.0, 31603.36793264168, 32310.030699079067, 32390.83804580962, 32790.180245494055, 50536.494635053175, 51088.233676494136, 51125.0, 51244.23133653073, 51257.974840503724, 597414.0, 600283.0, 600490.0, 602062.0, 871093.0, 23961.400964975317, 26536.7346326542, 27169.456610868066, 27255.86372068127, 27919.581206282328, 46557.53442465532, 47588.28617570808, 48582.0, 49397.25904111513, 49499.0, 34902.0, 38051.80974095112, 40733.38899916445, 40856.93572981979, 41740.373894392214, 41132.79433602933, 41333.0, 41926.95182620459, 41975.950601235214, 42342.57657423386, 39164.82505524839, 39444.60555394524, 39565.802170990115, 39709.80145099256, 40041.59958400495, 34440.0, 35319.47020794639, 36142.63857361498, 36200.0, 36259.818700906326, 25704.0, 26444.735552644997, 26686.46627067409, 26748.866255668596, 27477.17568472949], "value": 19651.306040560787, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.05299119722713, 382.81050879814495, 390.5918315360448, 391.823679344295, 411.7632361392198, 19234.80765192348, 21784.0, 21791.782082179172, 21965.560688786216, 22188.334349969507, 19963.0, 20558.69161962572, 20824.583508329823, 21075.156993720233, 21932.342029739095, 5446.428125046872, 5479.2602998595075, 5571.275734154554, 5640.464155905203, 5645.915311270334, 4073.8574149904757, 4194.0982688721915, 5546.112621980484, 5642.7742890284335, 5645.5483561314995, 4218.346156345771, 4356.847510337139, 6966.198887127995, 7067.85864282714, 7069.363757261845, 6710.798676039727, 6908.5509441886115, 7046.577205367668, 7054.717811287543, 7055.188653304885, 6142.6007309525185, 6156.353582873823, 6157.692115394212, 6166.013437849967, 6181.721822517952, 13347.86652133476, 13592.184468931895, 13623.386947587382, 13710.45158193671, 19180.040997950186, 1963.4011626453926, 2056.4139220322136, 2265.184533567914, 2460.950780984388, 2959.141848863827, 9978.151857092156, 10157.949210253975, 10288.537015834305, 10568.418736969463, 10572.577096916115, 1898.1648074847024, 1927.6915693488975, 1937.6124775044907, 2024.5343570978757, 2025.4835017070552, 86973.0, 91521.1695766081, 91776.0, 93839.0, 129433.35283323617, 10929.836052459219, 11173.273737207055, 11665.416729163508, 11675.0, 11861.347625880659, 14693.971422000357, 14801.18593477369, 14810.407583696748, 14831.961762676725, 14862.959592828614, 6725.0, 6836.077129587442, 8550.486970781772, 9029.41308814925, 9164.404313719588, 9037.322200834964, 9071.410358326688, 9094.772630684154, 9221.216196623362, 9240.815183696288, 4512.9097418052115, 4592.6555508337005, 4595.655325850507, 4665.136949664323, 4670.089332580114, 1930.2375561653068, 1962.1464662871697, 1963.4207908666976, 1982.9773630896404, 1997.4207479830977, 853.8548446764065, 866.1641515937151, 911.1207684584408, 1029.994850025745, 1078.9568417263379, 17454.56363590895, 19810.504737381394, 21281.36155915325, 21285.40359473046, 21294.467638309165, 937.0676177203726, 944.320089535547, 978.9363691360039, 989.6931951095183, 990.7919336939179, 10624.734381640521, 10945.616903408501, 11136.443177841076, 11154.832677509843, 11193.272437291713, 576326.1183694055, 624273.0, 631656.0, 636734.0, 654501.0, 103305.31428971278, 113301.0, 133271.0, 133496.0, 140010.0, 977.7164622259465, 989.3124278626285, 1021.6322124035341, 1022.749426390539, 1022.7749895023231, 19017.23931042798, 19550.315738949637, 19595.216191352756, 19722.50693732668, 19752.604947901247, 57427.0, 57631.0, 57834.42165578459, 57876.13185802132, 58774.0, 63925.680371597846, 80148.19851801408, 80600.19399806162, 81715.0, 84795.5760221195, 7681.462297639112, 7825.334846538108, 7920.84158316842, 7925.841483170419, 7928.722494712657, 10286.897131028893, 10896.564137434414, 11090.889091108986, 12282.955948744457, 12405.565805196775, 10322.380657160595, 10660.040596346365, 10776.353418794897, 11036.392998384845, 11043.944780276048, 9248.398854074463, 9606.183474404754, 10449.425281609585, 10450.320729152581, 10851.0, 10927.071198948179, 11033.172512061788, 11068.612598559012, 11145.2198346115, 11406.0, 6492.675366231575, 7750.8449831001935, 7812.453128280966, 7954.244346787046, 8001.799955000939, 10686.465676715978, 10731.356118632906, 10779.622713205, 10857.945710271713, 11015.182494888253], "value": 9433.08582401164, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1557.6183834960436, 1588.6743217640385, 1783.6878546254402, 1919.7600299962514, 1945.2996921108406, 8491.702790402338, 9540.475273859953, 9553.0, 9553.092456216657, 9557.28320375972, 8333.083360830318, 8546.359023073279, 8575.142485751438, 8624.784380390493, 9294.907050929489, 1905.799891011441, 2386.081358676913, 2459.963100553493, 2464.149868295435, 2466.580681284186, 2432.404061005056, 2458.1887976967646, 2464.7658472445178, 2470.505898820234, 2481.838680485772, 2436.1595249638845, 2455.4107014316523, 2467.592847180213, 2468.4322605800676, 2470.7899828514596, 2429.866357350345, 2445.9755402446017, 2450.1669432393073, 2452.3623857796924, 2462.6059830427225, 2449.669294645218, 2452.399162205253, 2453.595156799126, 2457.3733697907096, 2461.200109964269, 9221.53892305382, 9432.103950124727, 9432.292578056604, 9438.52807359636, 9502.90497095027, 5485.067538518461, 5656.858578535528, 5670.432956704338, 5681.914771278434, 5688.374278829326, 3571.3750093733493, 3647.1611529348133, 3764.171882185915, 3768.660820526138, 3771.340015497277, 1062.3625824505311, 1088.1186239146239, 1088.9618863339745, 1113.6158025481195, 1114.1755101225117, 12288.815667764991, 12451.128421010533, 12474.376281185905, 12482.937585312015, 12499.250044997329, 4811.639127065414, 4851.708897466093, 4875.1224779540025, 4969.82605608802, 4985.376827896513, 10626.681199564026, 10639.627613033506, 10642.840357394645, 10646.787064258671, 10652.467376631292, 5627.296587926509, 5634.1830434586755, 5644.943550564524, 5650.660960342392, 5653.152027195953, 4932.890099727604, 5039.823606173766, 5146.330976972969, 5149.76826042829, 5152.381714194245, 4169.374593810952, 4182.393552934807, 4192.601702838226, 4221.092465120014, 4229.0273237155625, 1275.457930379585, 1286.0, 1306.4251729239104, 1309.0640192262388, 1310.8492523359746, 922.4050487435701, 929.5305870535336, 931.2829121576484, 952.3571589177416, 977.130353984954, 5958.689088400545, 6001.459868611759, 6003.459688628044, 6091.0, 6248.250769661335, 441.05613986069835, 446.21688935917257, 447.19728088081973, 448.9214387482178, 451.3996384808197, 4106.404571337199, 4106.897327566835, 4110.547839737626, 4110.609492098246, 4144.109016561393, 10865.40240286776, 11449.54201831934, 11460.656180314603, 11472.254303470414, 11478.483468243949, 11277.984981351718, 11321.943390282995, 11378.544858205745, 11395.715107122389, 11416.0, 8194.344452443791, 8485.151484851589, 8603.311735061305, 8608.956955215184, 8616.138386161334, 6224.2842073160355, 6274.560780745304, 6341.175647165839, 6354.3963323484195, 6404.327545607644, 10160.644377446753, 10248.026437488426, 10500.317479363817, 10513.0, 10534.841977370499, 9912.851307230254, 10911.0, 10917.563297468012, 10918.890811091787, 10922.453877306261, 7399.223081576357, 7669.271419215165, 7832.216778322122, 8016.0, 8121.715739949073, 8515.8722619162, 8749.0, 8776.16626420489, 8780.78048048804, 8890.511021893857, 6517.641529715911, 7718.266764657348, 7724.497907635986, 7747.767566973, 7808.141104478616, 7437.665305061177, 7485.588292643739, 7510.924890751241, 7567.054118235221, 7637.5035622684345, 7330.963345183453, 7338.596377199306, 7406.4074874008875, 7449.664765085476, 7463.888041679271, 4967.081089998362, 5022.0, 5279.656822306538, 5321.068812957639, 5398.5951053671915, 4769.737664428351, 5217.634765566374, 5221.008008478377, 5405.4594540547205, 5473.507384335429], "value": 4707.295190933742, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.70824591899935, 307.8630009645707, 308.9814611123332, 312.35654551623657, 314.3430230817591, 5008.79788850676, 5346.893062138764, 5507.311586051744, 5524.298719857695, 5666.546676265899, 4835.395575553056, 5482.314710661168, 5579.856129493454, 5586.441355864412, 5623.4938855503, 3363.360961417335, 4009.879703608889, 4103.835846566134, 4209.2423363794505, 4217.36739489076, 3465.878694245702, 4203.726757760735, 4204.7056706030435, 4214.976811130644, 4319.632831209351, 3656.067702735799, 4013.4983127109113, 4163.5836416358425, 4193.769342686151, 4195.895102622444, 3606.855725770966, 4107.0, 4160.332747394231, 4178.540360560336, 4237.894052648678, 3034.742046926014, 3167.509036099408, 3657.1040095176586, 3664.047347689593, 3667.523221981152, 5423.83728488146, 5440.735558664769, 5445.0, 5464.754086066137, 5499.285092937933, 3679.5952445231005, 4566.611837993774, 4661.137689527448, 4866.537678920497, 4868.732219727914, 4839.830605928811, 5019.64862459628, 5820.097884827858, 5832.62087964281, 5834.5915785895, 3549.8402571884326, 4045.5549889512426, 4053.0, 4053.97973010136, 4064.979675101635, 5293.523582877521, 5843.750156189897, 6195.415392609481, 6214.70056079249, 6238.0, 4068.3897415387337, 4105.261053010487, 4116.938245926313, 4124.958750412457, 4125.0, 3416.777909435879, 3533.381658209803, 3779.905502362408, 4150.343779980814, 4182.2681030819485, 4782.9760851196215, 4827.758612069382, 4835.758212089381, 4847.854564363075, 4904.288878112654, 4461.977690111528, 4687.390709153932, 5779.306483222041, 5837.532997360201, 5966.910496342558, 1188.9002672527877, 1348.2651954684525, 1365.1604263377951, 1365.603974847283, 1376.4631793600504, 789.5854676294877, 819.9016118065871, 839.706102864005, 847.0047693959696, 852.8848605438186, 4710.4347478302825, 5415.377231618336, 5559.63862348946, 5592.692401917852, 5599.8880022400135, 6032.607880487842, 6039.516838652898, 6073.969630151821, 6079.270487541435, 6106.458254212546, 5252.579793616502, 5300.402802626762, 5546.833594992076, 5617.185508101303, 5645.294338207724, 2677.906273280426, 2998.430298243327, 3117.423276693819, 3155.8106513609255, 3160.9094862272477, 5171.3535808024, 5666.801661941812, 6247.531435142382, 6250.843728906813, 6299.842503937347, 5389.407165211824, 5809.0, 6191.504679625619, 6210.9068363974575, 6269.96865015672, 6330.01884707871, 6331.335209802996, 6335.904961425582, 6360.522960777867, 6378.872422551523, 5009.223570346602, 5484.533814625802, 5911.527077833677, 6108.541859360477, 6181.567290289637, 5202.8959420812125, 5645.0, 5809.779946211343, 5971.91042134377, 5979.880402392015, 5371.758270877898, 5937.287525496968, 6245.375462453719, 6251.0, 6278.968605156945, 3454.5681789776277, 3463.7402194834985, 3979.3036218662196, 4017.5178978522763, 4025.2955732747237, 4782.832600858953, 5225.843224703265, 5700.486956173964, 5987.700614969147, 6141.692915354304, 5727.427257274406, 5871.178035075179, 5876.529877609695, 5881.794137205177, 5986.910196346971, 4869.70781753096, 4890.486498917705, 5735.483806457439, 5915.822525324247, 5998.34018258, 5504.834854954358, 5639.774409023593, 5738.856528586819, 5841.269841269841, 5847.181394604674, 5478.890422191614, 5835.4748072673665, 5885.234919460443, 5935.376785437639, 5955.910661339996, 5469.398366179637, 5801.8549536261935, 5807.854803629774, 5820.5925585210325, 5841.912371314349], "value": 4234.59243020643, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.9110915580974, 746.5595298773724, 797.7686470923433, 815.9755207343778, 824.1593574553959, 16075.437359692412, 17124.143792810373, 17149.399771008, 17150.14249287537, 17173.656526869454, 15389.691876190509, 15421.614459638515, 15421.922890385533, 15422.151781652005, 15458.61353466164, 706.1984647425159, 720.3840716187663, 726.5640615630606, 875.4834647557956, 888.5424006636588, 893.530896279452, 899.5052721003422, 907.3331101640289, 909.0954500272238, 909.6816114359988, 961.8845738511353, 967.1585720423242, 968.5883499512714, 969.8351280282334, 972.5088830140804, 954.9904500954971, 959.3332633819498, 960.4957397366438, 960.6445615122415, 962.8603852441391, 710.073354272674, 710.7974227345234, 711.1856923822246, 711.9537230080028, 713.0908092182457, 15767.526974190792, 16083.91958040214, 16182.19089045543, 16215.837841621551, 16222.594435139097, 13757.931210343984, 13761.518346857913, 13883.0, 15121.832188796236, 15254.38982440712, 11810.586629468013, 12225.755484890253, 12397.690057748538, 13545.796813047813, 13664.93167534156, 3984.900377490557, 4020.718549701522, 4047.0691740899465, 4063.2686116499017, 4093.8157782899543, 123670.0, 133391.0, 137771.0, 139258.0, 141089.0, 11387.544498220144, 11680.357580332993, 11684.591039313584, 11788.528458861721, 11831.230969986924, 23348.883255583612, 23545.64681529744, 23740.287791366285, 23743.0, 23914.163004294765, 7848.489848159851, 8000.399970002157, 8246.257836794717, 8344.332453403713, 8459.027211870714, 3685.355062863988, 4228.8308467660945, 4483.461667887309, 4652.55800698933, 4683.391159149357, 3769.4911186989953, 3917.9020524486546, 3927.626875446828, 3933.6656384207663, 3942.6057394260342, 616.3774587666489, 664.8304682306077, 755.6335177438938, 770.4837758701683, 771.5139462138817, 594.3966873623276, 628.8019273928697, 694.6492021529095, 697.8639165362807, 715.9856802863914, 9279.164875161134, 10018.589961420897, 10141.543630536644, 10182.796344073076, 10502.0, 653.4641593893057, 674.7166190200128, 693.8751024815481, 706.8974998625171, 715.5027256057094, 4510.323451482238, 4515.006698526319, 4834.299026641117, 4850.733244576152, 4874.634402419832, 114386.0, 137171.0, 139820.0, 145695.2715236417, 145876.0, 90906.09093908976, 93188.0, 127355.08967365496, 127548.0, 128925.42149156965, 109761.45119274512, 110574.89425105807, 111417.0, 111563.44218278857, 115557.0, 10010.749731256778, 10183.236257280585, 10415.635452759117, 10457.947710261704, 10462.947685261524, 63507.68246158925, 66161.7146371094, 66418.33581664122, 66986.66026679342, 67028.0, 90639.5468022682, 94475.0, 99433.0, 100335.49832251084, 100391.0, 13449.596512104652, 13541.796873046715, 13653.385597647932, 13669.384877680726, 13896.652583685489, 14956.925215373854, 14978.550643480714, 15336.309866056277, 15636.530904072895, 16322.0, 13544.187348759106, 13546.79679804784, 13967.860321397062, 14272.286385680467, 14706.77939830882, 14063.367148478548, 14107.506237282056, 14329.283535822959, 14370.0, 14814.925925370304, 13004.219746814842, 14188.645283867985, 14335.139891606537, 14438.205898675673, 14743.483978060716, 11351.205415620827, 11482.196246262682, 11675.416229188337, 12028.037756979596, 12160.878391215974, 11172.0, 11741.236819606698, 11958.402079895797, 11967.461464233957, 12027.75944481123], "value": 8220.395201974494, "unit": "score"}], "name": "dromaeo_css", "value": 7491.0679450249, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 110.0, 112.0, 113.0, 111.0, 114.0, 160.0, 161.0], "value": 122.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 107.0, 108.0, 139.0, 107.0, 107.0, 109.0, 107.0, 138.0, 108.0], "value": 116.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 213.0, 260.0, 197.0, 183.0, 184.0, 183.0, 180.0, 182.0, 181.0], "value": 194.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 58.0, 88.0, 61.0, 58.0, 59.0, 57.0, 82.0, 58.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 93.0, 69.0, 68.0, 70.0, 90.0, 68.0, 67.0, 88.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 90.0, 86.0, 89.0, 86.0, 88.0, 74.0, 97.0, 131.0], "value": 91.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 101.0, 93.0, 148.0, 149.0, 135.0, 94.0, 94.0, 94.0, 94.0], "value": 109.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 93.0, 85.0, 85.0, 86.0, 84.0, 84.0, 86.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 54.0, 57.0, 57.0, 56.0, 55.0, 56.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 62.0, 74.0, 70.0, 67.0, 69.0, 67.0, 68.0, 68.0], "value": 67.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 81.0, 84.0, 84.0, 82.0, 88.0, 88.0, 82.0, 91.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 140.0, 141.0, 139.0, 129.0, 131.0, 134.0, 133.0, 134.0, 139.0], "value": 135.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 196.0, 163.0, 162.0, 160.0, 161.0, 160.0, 161.0, 166.0, 160.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 83.0, 80.0, 82.0, 76.0, 65.0, 65.0, 64.0, 65.0], "value": 72.0, "unit": "score"}], "name": "kraken", "value": 1448.4, "alertThreshold": 2.0}]} 12:41:33 INFO - Return code: 0 12:41:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:41:33 INFO - # TBPL SUCCESS # 12:41:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:41:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:41:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:41:33 INFO - 2016-11-14 12:41:33.311 screenresolution[1669:9690] starting screenresolution argv=screenresolution get 12:41:33 INFO - 2016-11-14 12:41:33.314 screenresolution[1669:9690] Display 0: 1600x1200x32@60 12:41:33 INFO - 2016-11-14 12:41:33.320 screenresolution[1670:9693] starting screenresolution argv=screenresolution list 12:41:33 INFO - Available Modes on Display 0 12:41:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:41:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:41:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:41:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:41:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:41:33 INFO - Intel Iris: 12:41:33 INFO - Chipset Model: Intel Iris 12:41:33 INFO - Type: GPU 12:41:33 INFO - Bus: Built-In 12:41:33 INFO - VRAM (Dynamic, Max): 1536 MB 12:41:33 INFO - Vendor: Intel (0x8086) 12:41:33 INFO - Device ID: 0x0a2e 12:41:33 INFO - Revision ID: 0x0009 12:41:33 INFO - Displays: 12:41:33 INFO - Display: 12:41:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:41:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:41:33 INFO - Display Serial Number: 1600x1200 60 12:41:33 INFO - Main Display: Yes 12:41:33 INFO - Mirror: Off 12:41:33 INFO - Online: Yes 12:41:33 INFO - Rotation: Supported 12:41:33 INFO - Return code: 0 12:41:33 INFO - Running post-action listener: _resource_record_post_action 12:41:33 INFO - [mozharness: 2016-11-14 20:41:33.559357Z] Finished run-tests step (success) 12:41:33 INFO - Running post-run listener: _resource_record_post_run 12:41:33 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 37573632; Write bytes: 494430208; Read time: 241; Write time: 1551 12:41:33 INFO - TinderboxPrint: CPU usage
53.2% 12:41:33 INFO - TinderboxPrint: I/O read bytes / time
37,573,632 / 241 12:41:33 INFO - TinderboxPrint: I/O write bytes / time
494,430,208 / 1,551 12:41:33 INFO - TinderboxPrint: CPU idle
2,241.9 (46.8%) 12:41:33 INFO - TinderboxPrint: CPU system
954.9 (20.0%) 12:41:33 INFO - TinderboxPrint: CPU user
1,588.8 (33.2%) 12:41:33 INFO - TinderboxPrint: Swap in / out
232,988,672 / 0 12:41:33 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192336384; Write bytes: 188175872; Read time: 17877; Write time: 407 12:41:33 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 35529728; Write bytes: 294973952; Read time: 222; Write time: 1111 12:41:34 INFO - Running post-run listener: _upload_blobber_files 12:41:34 INFO - Blob upload gear active. 12:41:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:41:34 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:41:34 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:41:34 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:41:34 INFO - (blobuploader) - INFO - Open directory for files ... 12:41:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:41:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:41:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:35 INFO - (blobuploader) - INFO - Done attempting. 12:41:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:41:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:41:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:36 INFO - (blobuploader) - INFO - Done attempting. 12:41:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:41:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:41:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:41:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:41:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:41:38 INFO - (blobuploader) - INFO - Done attempting. 12:41:38 INFO - (blobuploader) - INFO - Iteration through files over. 12:41:38 INFO - Return code: 0 12:41:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:41:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:41:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1cc6b8b90ca0c8d4d5d61658be2b210a1e99ba14d2e9b9eb2a4d977b21f5e985c709ed916ad800a360b399f96da0dddfa06bbf88b27dc0a20e744f2d92724266", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae8a96433336d86199dfb28e78d3fa29c0584c4b7960050d6ebbb4b13ed8e7221eb4e32b96e7303a1c41c9ae45da4a6f5ff749450d439e79ccaf8482414bffe0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/670c766f745f0a7f2adcbaaf732a6521c1eb4d555c19431a6c9718a4f23faf6339ee7160a530b9c7e394044f9c85a54d218f966f7684e282b1f90b506c93ea7a"} 12:41:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:41:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:41:38 INFO - Contents: 12:41:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1cc6b8b90ca0c8d4d5d61658be2b210a1e99ba14d2e9b9eb2a4d977b21f5e985c709ed916ad800a360b399f96da0dddfa06bbf88b27dc0a20e744f2d92724266", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae8a96433336d86199dfb28e78d3fa29c0584c4b7960050d6ebbb4b13ed8e7221eb4e32b96e7303a1c41c9ae45da4a6f5ff749450d439e79ccaf8482414bffe0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/670c766f745f0a7f2adcbaaf732a6521c1eb4d555c19431a6c9718a4f23faf6339ee7160a530b9c7e394044f9c85a54d218f966f7684e282b1f90b506c93ea7a"} 12:41:38 INFO - Running post-run listener: copy_logs_to_upload_dir 12:41:38 INFO - Copying logs to upload dir... 12:41:38 INFO - mkdir: /builds/slave/test/build/upload/logs 12:41:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.855023 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-11-14 12:41:38.808386) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:41:38.812868) ========= 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.AgRMpgVhLO/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.7syJv26WL9/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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/1cc6b8b90ca0c8d4d5d61658be2b210a1e99ba14d2e9b9eb2a4d977b21f5e985c709ed916ad800a360b399f96da0dddfa06bbf88b27dc0a20e744f2d92724266", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae8a96433336d86199dfb28e78d3fa29c0584c4b7960050d6ebbb4b13ed8e7221eb4e32b96e7303a1c41c9ae45da4a6f5ff749450d439e79ccaf8482414bffe0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/670c766f745f0a7f2adcbaaf732a6521c1eb4d555c19431a6c9718a4f23faf6339ee7160a530b9c7e394044f9c85a54d218f966f7684e282b1f90b506c93ea7a"} 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.011196 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/1cc6b8b90ca0c8d4d5d61658be2b210a1e99ba14d2e9b9eb2a4d977b21f5e985c709ed916ad800a360b399f96da0dddfa06bbf88b27dc0a20e744f2d92724266", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae8a96433336d86199dfb28e78d3fa29c0584c4b7960050d6ebbb4b13ed8e7221eb4e32b96e7303a1c41c9ae45da4a6f5ff749450d439e79ccaf8482414bffe0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/670c766f745f0a7f2adcbaaf732a6521c1eb4d555c19431a6c9718a4f23faf6339ee7160a530b9c7e394044f9c85a54d218f966f7684e282b1f90b506c93ea7a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 12:41:38.852019) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:41:38.852635) ========= 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.AgRMpgVhLO/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.7syJv26WL9/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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.005069 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:41:38.903698) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:41:38.904248) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 12:41:38.904837) ========= ========= Total master_lag: 0.20 =========