builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0128 starttime: 1480475485.99 results: success (0) buildid: 20161129164126 builduid: d6472abbd91349a089aa6c0718327cf0 revision: 9afe68360fa82c16b760b448b2156230a90caf11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:25.987715) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:25.988154) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:25.988427) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:26.013927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:26.014279) ========= 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.tCccl62Im5/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.RF8MljZQpo/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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-29 19:11:26-- 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% 164M=0s 2016-11-29 19:11:26 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086564 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:26.123974) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:26.124292) ========= 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.tCccl62Im5/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.RF8MljZQpo/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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.021277 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:26.172451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 19:11:26.172804) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9afe68360fa82c16b760b448b2156230a90caf11 --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 9afe68360fa82c16b760b448b2156230a90caf11 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tCccl62Im5/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.RF8MljZQpo/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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-29 19:11:26,256 truncating revision to first 12 chars 2016-11-29 19:11:26,256 Setting DEBUG logging. 2016-11-29 19:11:26,256 attempt 1/10 2016-11-29 19:11:26,256 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9afe68360fa8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 19:11:27,521 unpacking tar archive at: mozilla-beta-9afe68360fa8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.544668 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 19:11:27.740610) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:27.740941) ========= script_repo_revision: 9afe68360fa82c16b760b448b2156230a90caf11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:27.741595) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:27.741878) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:27.761685) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-29 19:11:27.761963) ========= /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.tCccl62Im5/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.RF8MljZQpo/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 19:11:27 INFO - MultiFileLogger online at 20161129 19:11:27 in /builds/slave/test 19:11:27 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 19:11:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:11:27 INFO - {'append_to_log': False, 19:11:27 INFO - 'base_work_dir': '/builds/slave/test', 19:11:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:11:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:11:27 INFO - 'branch': 'Mozilla-Beta', 19:11:27 INFO - 'buildbot_json_path': 'buildprops.json', 19:11:27 INFO - 'config_files': ('talos/mac_config.py',), 19:11:27 INFO - 'default_actions': ('clobber', 19:11:27 INFO - 'read-buildbot-config', 19:11:27 INFO - 'download-and-extract', 19:11:27 INFO - 'populate-webroot', 19:11:27 INFO - 'create-virtualenv', 19:11:27 INFO - 'install', 19:11:27 INFO - 'run-tests'), 19:11:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:11:27 INFO - 'download_minidump_stackwalk': True, 19:11:27 INFO - 'download_symbols': 'ondemand', 19:11:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:11:27 INFO - 'tooltool.py': '/tools/tooltool.py', 19:11:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:11:27 INFO - '/tools/misc-python/virtualenv.py')}, 19:11:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:11:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:11:27 INFO - 'installer_path': 'installer.exe', 19:11:27 INFO - 'log_level': 'info', 19:11:27 INFO - 'log_name': 'talos', 19:11:27 INFO - 'log_to_console': True, 19:11:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:11:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:11:27 INFO - 'opt_config_files': (), 19:11:27 INFO - 'pip_index': False, 19:11:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:11:27 INFO - 'cmd': ('bash', 19:11:27 INFO - '-c', 19:11:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:11:27 INFO - 'enabled': True, 19:11:27 INFO - 'halt_on_failure': False, 19:11:27 INFO - 'name': 'check_screen_resolution'},), 19:11:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:11:27 INFO - 'cmd': ('bash', 19:11:27 INFO - '-c', 19:11:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:11:27 INFO - 'enabled': True, 19:11:27 INFO - 'halt_on_failure': False, 19:11:27 INFO - 'name': 'check_screen_resolution'},), 19:11:27 INFO - 'run_cmd_checks_enabled': True, 19:11:27 INFO - 'sps_profile': False, 19:11:27 INFO - 'sps_profile_interval': 0, 19:11:27 INFO - 'suite': 'dromaeojs', 19:11:27 INFO - 'system_bits': '32', 19:11:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:11:27 INFO - 'title': 't-yosemite-r7-0128', 19:11:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:11:27 INFO - 'use_talos_json': True, 19:11:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:11:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:11:27 INFO - 'work_dir': 'build'} 19:11:27 INFO - [mozharness: 2016-11-30 03:11:27.971095Z] Running clobber step. 19:11:27 INFO - Running pre-action listener: _resource_record_pre_action 19:11:27 INFO - Running main action method: clobber 19:11:27 INFO - rmtree: /builds/slave/test/build 19:11:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:11:28 INFO - Running post-action listener: _resource_record_post_action 19:11:28 INFO - [mozharness: 2016-11-30 03:11:28.498066Z] Finished clobber step (success) 19:11:28 INFO - [mozharness: 2016-11-30 03:11:28.498247Z] Running read-buildbot-config step. 19:11:28 INFO - Running pre-action listener: _resource_record_pre_action 19:11:28 INFO - Running main action method: read_buildbot_config 19:11:28 INFO - Using buildbot properties: 19:11:28 INFO - { 19:11:28 INFO - "project": "", 19:11:28 INFO - "product": "firefox", 19:11:28 INFO - "script_repo_revision": "production", 19:11:28 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 19:11:28 INFO - "repository": "", 19:11:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 19:11:28 INFO - "buildid": "20161129164126", 19:11:28 INFO - "pgo_build": "False", 19:11:28 INFO - "basedir": "/builds/slave/test", 19:11:28 INFO - "buildnumber": 0, 19:11:28 INFO - "slavename": "t-yosemite-r7-0128", 19:11:28 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 19:11:28 INFO - "platform": "yosemite_r7", 19:11:28 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 19:11:28 INFO - "branch": "mozilla-beta", 19:11:28 INFO - "repo_path": "releases/mozilla-beta", 19:11:28 INFO - "revision": "9afe68360fa82c16b760b448b2156230a90caf11", 19:11:28 INFO - "stage_platform": "macosx64", 19:11:28 INFO - "builduid": "d6472abbd91349a089aa6c0718327cf0", 19:11:28 INFO - "slavebuilddir": "test" 19:11:28 INFO - } 19:11:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 19:11:28 INFO - Running post-action listener: _resource_record_post_action 19:11:28 INFO - [mozharness: 2016-11-30 03:11:28.502100Z] Finished read-buildbot-config step (success) 19:11:28 INFO - [mozharness: 2016-11-30 03:11:28.502277Z] Running download-and-extract step. 19:11:28 INFO - Running pre-action listener: _resource_record_pre_action 19:11:28 INFO - Running main action method: download_and_extract 19:11:28 INFO - mkdir: /builds/slave/test/build/tests 19:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:28 INFO - trying https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 19:11:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/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 19:11:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/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 19:11:29 INFO - Downloaded 1165 bytes. 19:11:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 19:11:29 INFO - Using the following test package requirements: 19:11:29 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 19:11:29 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 19:11:29 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 19:11:29 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 19:11:29 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 19:11:29 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:11:29 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 19:11:29 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 19:11:29 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 19:11:29 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 19:11:29 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 19:11:29 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 19:11:29 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 19:11:29 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 19:11:29 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 19:11:29 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 19:11:29 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 19:11:29 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 19:11:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 19:11:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 19:11:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 19:11:30 INFO - Expected file size: 16233053 19:11:37 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 19:11:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 19:11:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 19:11:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 19:11:37 INFO - Expected file size: 16233053 19:11:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 19:11:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 19:11:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 19:11:45 INFO - Expected file size: 14414089 19:11:46 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')]} 19:11:46 INFO - trying https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.dmg 19:11:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 19:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/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 19:11:48 INFO - Downloaded 86054865 bytes. 19:11:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.dmg 19:11:49 INFO - mkdir: /builds/slave/test/properties 19:11:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:11:49 INFO - Writing to file /builds/slave/test/properties/build_url 19:11:49 INFO - Contents: 19:11:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.dmg 19:11:49 INFO - Running post-action listener: _resource_record_post_action 19:11:49 INFO - Running post-action listener: set_extra_try_arguments 19:11:49 INFO - [mozharness: 2016-11-30 03:11:49.658783Z] Finished download-and-extract step (success) 19:11:49 INFO - [mozharness: 2016-11-30 03:11:49.658940Z] Running populate-webroot step. 19:11:49 INFO - Running pre-action listener: _resource_record_pre_action 19:11:49 INFO - Running main action method: populate_webroot 19:11:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:11:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:11:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:11:49 INFO - '--tppagecycles', 19:11:49 INFO - '7'], 19:11:49 INFO - 'tests': ['tsvgm']}}, 19:11:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:11:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:11:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:11:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:11:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:11:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:11:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:49 INFO - 'talos_options': ['--disable-e10s'], 19:11:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:11:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:49 INFO - 'talos_options': ['--disable-e10s'], 19:11:49 INFO - 'tests': ['damp', 'tps']}, 19:11:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:49 INFO - 'tests': ['damp', 'tps']}, 19:11:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:11:49 INFO - 'tests': ['dromaeo_dom']}, 19:11:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:11:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:11:49 INFO - 'tests': ['basic_compositor_video']}, 19:11:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:11:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:11:49 INFO - 'tests': ['a11yr', 19:11:49 INFO - 'ts_paint', 19:11:49 INFO - 'tpaint', 19:11:49 INFO - 'sessionrestore', 19:11:49 INFO - 'sessionrestore_no_auto_restore', 19:11:49 INFO - 'tabpaint']}, 19:11:49 INFO - 'other-e10s': {'tests': ['a11yr', 19:11:49 INFO - 'ts_paint', 19:11:49 INFO - 'tpaint', 19:11:49 INFO - 'sessionrestore', 19:11:49 INFO - 'sessionrestore_no_auto_restore', 19:11:49 INFO - 'tabpaint']}, 19:11:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:11:49 INFO - 'ts_paint', 19:11:49 INFO - 'tpaint', 19:11:49 INFO - 'sessionrestore', 19:11:49 INFO - 'sessionrestore_no_auto_restore', 19:11:49 INFO - 'tabpaint']}, 19:11:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:11:49 INFO - 'ts_paint', 19:11:49 INFO - 'tpaint', 19:11:49 INFO - 'sessionrestore', 19:11:49 INFO - 'sessionrestore_no_auto_restore', 19:11:49 INFO - 'tabpaint']}, 19:11:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:11:49 INFO - 'tests': ['a11yr', 19:11:49 INFO - 'ts_paint', 19:11:49 INFO - 'tpaint', 19:11:49 INFO - 'sessionrestore', 19:11:49 INFO - 'sessionrestore_no_auto_restore', 19:11:49 INFO - 'tabpaint']}, 19:11:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:11:49 INFO - 'tests': ['a11yr', 19:11:49 INFO - 'ts_paint', 19:11:49 INFO - 'tpaint', 19:11:49 INFO - 'sessionrestore', 19:11:49 INFO - 'sessionrestore_no_auto_restore', 19:11:49 INFO - 'tabpaint']}, 19:11:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:11:49 INFO - 'tests': ['tsvgx', 19:11:49 INFO - 'tsvgr_opacity', 19:11:49 INFO - 'tart', 19:11:49 INFO - 'tscrollx', 19:11:49 INFO - 'cart']}, 19:11:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:11:49 INFO - 'tsvgr_opacity', 19:11:49 INFO - 'tart', 19:11:49 INFO - 'tscrollx', 19:11:49 INFO - 'cart']}, 19:11:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:49 INFO - 'talos_options': ['--disable-e10s'], 19:11:49 INFO - 'tests': ['tp5o']}, 19:11:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:49 INFO - 'tests': ['tp5o']}, 19:11:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:49 INFO - 'talos_options': ['--disable-e10s', 19:11:49 INFO - '--xperf_path', 19:11:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:49 INFO - 'tests': ['tp5n']}, 19:11:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:11:49 INFO - 'talos_options': ['--xperf_path', 19:11:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:11:49 INFO - 'tests': ['tp5n']}}, 19:11:49 INFO - 'talos.zip': {'path': '', 19:11:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:11:49 INFO - Running post-action listener: _resource_record_post_action 19:11:49 INFO - [mozharness: 2016-11-30 03:11:49.677760Z] Finished populate-webroot step (success) 19:11:49 INFO - [mozharness: 2016-11-30 03:11:49.677885Z] Running create-virtualenv step. 19:11:49 INFO - Running pre-action listener: _resource_record_pre_action 19:11:49 INFO - Running main action method: create_virtualenv 19:11:49 INFO - Creating virtualenv /builds/slave/test/build/venv 19:11:49 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 19:11:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:11:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:11:49 INFO - Using real prefix '/tools/python27' 19:11:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:11:50 INFO - Installing distribute.............................................................................................................................................................................................done. 19:11:53 INFO - Installing pip.................done. 19:11:53 INFO - Return code: 0 19:11:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101de8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb01d95ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfcd30>, '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 0x101a62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf4b20>, '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.tCccl62Im5/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.RF8MljZQpo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 19:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tCccl62Im5/Render', 19:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:53 INFO - 'HOME': '/Users/cltbld', 19:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:53 INFO - 'LOGNAME': 'cltbld', 19:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:53 INFO - 'MOZ_NO_REMOTE': '1', 19:11:53 INFO - 'NO_EM_RESTART': '1', 19:11:53 INFO - 'PAGER': '/bin/cat', 19:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:53 INFO - 'PWD': '/builds/slave/test', 19:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:53 INFO - 'SHELL': '/bin/bash', 19:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF8MljZQpo/Listeners', 19:11:53 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 19:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:53 INFO - 'USER': 'cltbld', 19:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:53 INFO - 'XPC_FLAGS': '0x0', 19:11:53 INFO - 'XPC_SERVICE_NAME': '0', 19:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:53 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 19:11:53 INFO - Cleaning up... 19:11:53 INFO - Return code: 0 19:11:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101de8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb01d95ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfcd30>, '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 0x101a62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf4b20>, '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.tCccl62Im5/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.RF8MljZQpo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 19:11:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:11:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:11:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tCccl62Im5/Render', 19:11:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:53 INFO - 'HOME': '/Users/cltbld', 19:11:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:53 INFO - 'LOGNAME': 'cltbld', 19:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:53 INFO - 'MOZ_NO_REMOTE': '1', 19:11:53 INFO - 'NO_EM_RESTART': '1', 19:11:53 INFO - 'PAGER': '/bin/cat', 19:11:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:53 INFO - 'PWD': '/builds/slave/test', 19:11:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:53 INFO - 'SHELL': '/bin/bash', 19:11:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF8MljZQpo/Listeners', 19:11:53 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 19:11:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:53 INFO - 'USER': 'cltbld', 19:11:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:53 INFO - 'XPC_FLAGS': '0x0', 19:11:53 INFO - 'XPC_SERVICE_NAME': '0', 19:11:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:53 INFO - Downloading/unpacking psutil>=3.1.1 19:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:11:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:57 INFO - Installing collected packages: psutil 19:11:57 INFO - Running setup.py install for psutil 19:11:57 INFO - building 'psutil._psutil_osx' extension 19:11:57 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 19:11:57 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 19:11:57 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 19:11:58 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 19:11:58 INFO - building 'psutil._psutil_posix' extension 19:11:58 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 19:11:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:11:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:11:58 INFO - ^ 19:11:58 INFO - 1 warning generated. 19:11:58 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 19:11:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:11:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:11:58 INFO - Successfully installed psutil 19:11:58 INFO - Cleaning up... 19:11:58 INFO - Return code: 0 19:11:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:11: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')]} 19:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11: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')]} 19:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:11:58 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 0x101de8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb01d95ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfcd30>, '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 0x101a62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf4b20>, '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.tCccl62Im5/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.RF8MljZQpo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 19:11:58 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 19:11:58 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 19:11:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tCccl62Im5/Render', 19:11:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:11:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:11:58 INFO - 'HOME': '/Users/cltbld', 19:11:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:11:58 INFO - 'LOGNAME': 'cltbld', 19:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:11:58 INFO - 'MOZ_NO_REMOTE': '1', 19:11:58 INFO - 'NO_EM_RESTART': '1', 19:11:58 INFO - 'PAGER': '/bin/cat', 19:11:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:11:58 INFO - 'PWD': '/builds/slave/test', 19:11:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:11:58 INFO - 'SHELL': '/bin/bash', 19:11:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF8MljZQpo/Listeners', 19:11:58 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 19:11:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:11:58 INFO - 'USER': 'cltbld', 19:11:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:11:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:11:58 INFO - 'XPC_FLAGS': '0x0', 19:11:58 INFO - 'XPC_SERVICE_NAME': '0', 19:11:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:11:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:11:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:12:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:12:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:12:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:12:01 INFO - Installing collected packages: mozsystemmonitor 19:12:01 INFO - Running setup.py install for mozsystemmonitor 19:12:01 INFO - Successfully installed mozsystemmonitor 19:12:01 INFO - Cleaning up... 19:12:01 INFO - Return code: 0 19:12:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:12:01 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')]} 19:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:01 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')]} 19:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:01 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 0x101de8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb01d95ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfcd30>, '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 0x101a62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf4b20>, '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.tCccl62Im5/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.RF8MljZQpo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 19:12:01 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 19:12:01 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 19:12:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tCccl62Im5/Render', 19:12:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:12:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:12:01 INFO - 'HOME': '/Users/cltbld', 19:12:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:12:01 INFO - 'LOGNAME': 'cltbld', 19:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:01 INFO - 'MOZ_NO_REMOTE': '1', 19:12:01 INFO - 'NO_EM_RESTART': '1', 19:12:01 INFO - 'PAGER': '/bin/cat', 19:12:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:01 INFO - 'PWD': '/builds/slave/test', 19:12:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:12:01 INFO - 'SHELL': '/bin/bash', 19:12:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF8MljZQpo/Listeners', 19:12:01 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 19:12:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:12:01 INFO - 'USER': 'cltbld', 19:12:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:12:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:01 INFO - 'XPC_FLAGS': '0x0', 19:12:01 INFO - 'XPC_SERVICE_NAME': '0', 19:12:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:01 INFO - Downloading/unpacking jsonschema==2.5.1 19:12:01 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 19:12:01 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 19:12:01 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 19:12:01 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 19:12:01 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 19:12:01 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 19:12:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:12:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:12:04 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 19:12:04 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 19:12:04 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 19:12:04 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 19:12:04 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 19:12:04 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 19:12:04 INFO - Downloading functools32-3.2.3-2.tar.gz 19:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:12:04 INFO - warning: no files found matching '*.txt' 19:12:04 INFO - no previously-included directories found matching 'build' 19:12:04 INFO - no previously-included directories found matching 'dist' 19:12:04 INFO - no previously-included directories found matching '.git*' 19:12:04 INFO - Installing collected packages: jsonschema, functools32 19:12:05 INFO - Running setup.py install for functools32 19:12:05 INFO - warning: no files found matching '*.txt' 19:12:05 INFO - no previously-included directories found matching 'build' 19:12:05 INFO - no previously-included directories found matching 'dist' 19:12:05 INFO - no previously-included directories found matching '.git*' 19:12:05 INFO - Successfully installed jsonschema functools32 19:12:05 INFO - Cleaning up... 19:12:05 INFO - Return code: 0 19:12:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:12:05 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')]} 19:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:05 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')]} 19:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:05 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 0x101de8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb01d95ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfcd30>, '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 0x101a62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf4b20>, '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.tCccl62Im5/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.RF8MljZQpo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 19:12:05 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 19:12:05 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 19:12:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tCccl62Im5/Render', 19:12:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:12:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:12:05 INFO - 'HOME': '/Users/cltbld', 19:12:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:12:05 INFO - 'LOGNAME': 'cltbld', 19:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:05 INFO - 'MOZ_NO_REMOTE': '1', 19:12:05 INFO - 'NO_EM_RESTART': '1', 19:12:05 INFO - 'PAGER': '/bin/cat', 19:12:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:05 INFO - 'PWD': '/builds/slave/test', 19:12:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:12:05 INFO - 'SHELL': '/bin/bash', 19:12:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF8MljZQpo/Listeners', 19:12:05 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 19:12:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:12:05 INFO - 'USER': 'cltbld', 19:12:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:12:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:05 INFO - 'XPC_FLAGS': '0x0', 19:12:05 INFO - 'XPC_SERVICE_NAME': '0', 19:12:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:12:05 INFO - Cleaning up... 19:12:05 INFO - Return code: 0 19:12:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:12:05 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')]} 19:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:05 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')]} 19:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:05 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 0x101de8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb01d95ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfcd30>, '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 0x101a62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf4b20>, '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.tCccl62Im5/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.RF8MljZQpo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 19:12:05 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 19:12:05 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 19:12:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tCccl62Im5/Render', 19:12:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:12:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:12:05 INFO - 'HOME': '/Users/cltbld', 19:12:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:12:05 INFO - 'LOGNAME': 'cltbld', 19:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:05 INFO - 'MOZ_NO_REMOTE': '1', 19:12:05 INFO - 'NO_EM_RESTART': '1', 19:12:05 INFO - 'PAGER': '/bin/cat', 19:12:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:05 INFO - 'PWD': '/builds/slave/test', 19:12:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:12:05 INFO - 'SHELL': '/bin/bash', 19:12:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF8MljZQpo/Listeners', 19:12:05 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 19:12:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:12:05 INFO - 'USER': 'cltbld', 19:12:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:12:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:05 INFO - 'XPC_FLAGS': '0x0', 19:12:05 INFO - 'XPC_SERVICE_NAME': '0', 19:12:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:05 INFO - Downloading/unpacking blobuploader==1.2.4 19:12:05 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 19:12:05 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 19:12:05 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 19:12:05 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 19:12:05 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 19:12:05 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 19:12:08 INFO - Downloading blobuploader-1.2.4.tar.gz 19:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:12:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:12:08 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 19:12:08 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 19:12:08 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 19:12:08 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 19:12:08 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 19:12:08 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 19:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:12:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:12:09 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 19:12:09 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 19:12:09 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 19:12:09 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 19:12:09 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 19:12:09 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 19:12:09 INFO - Downloading docopt-0.6.1.tar.gz 19:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:12:09 INFO - Installing collected packages: blobuploader, requests, docopt 19:12:09 INFO - Running setup.py install for blobuploader 19:12:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:12:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:12:09 INFO - Running setup.py install for requests 19:12:10 INFO - Running setup.py install for docopt 19:12:10 INFO - Successfully installed blobuploader requests docopt 19:12:10 INFO - Cleaning up... 19:12:10 INFO - Return code: 0 19:12:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:10 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 0x101de8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb01d95ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfcd30>, '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 0x101a62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf4b20>, '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.tCccl62Im5/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.RF8MljZQpo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 19:12:10 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 19:12:10 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 19:12:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tCccl62Im5/Render', 19:12:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:12:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:12:10 INFO - 'HOME': '/Users/cltbld', 19:12:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:12:10 INFO - 'LOGNAME': 'cltbld', 19:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:10 INFO - 'MOZ_NO_REMOTE': '1', 19:12:10 INFO - 'NO_EM_RESTART': '1', 19:12:10 INFO - 'PAGER': '/bin/cat', 19:12:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:10 INFO - 'PWD': '/builds/slave/test', 19:12:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:12:10 INFO - 'SHELL': '/bin/bash', 19:12:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF8MljZQpo/Listeners', 19:12:10 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 19:12:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:12:10 INFO - 'USER': 'cltbld', 19:12:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:12:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:10 INFO - 'XPC_FLAGS': '0x0', 19:12:10 INFO - 'XPC_SERVICE_NAME': '0', 19:12:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:12:10 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-o0tCRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:12:10 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-29WPzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:12:10 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-VBJDpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:12:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-4xgmkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:12:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-8nrEQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:12:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-jXMbvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:12:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-AROj9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:12:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-50o5YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:12:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-Nam4nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:12:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-wevqZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:12:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-cFw75k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:12:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:12:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-h5nDNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:12:12 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-uQZlzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:12:12 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-Urx39u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:12 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-URcUFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:12:12 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-DapvBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:12:12 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-mT08KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:12:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:12:12 INFO - Running setup.py install for manifestparser 19:12:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:12:12 INFO - Running setup.py install for mozcrash 19:12:12 INFO - Running setup.py install for mozdebug 19:12:13 INFO - Running setup.py install for mozdevice 19:12:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:12:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:12:13 INFO - Running setup.py install for mozfile 19:12:13 INFO - Running setup.py install for mozhttpd 19:12:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:12:13 INFO - Running setup.py install for mozinfo 19:12:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:12:13 INFO - Running setup.py install for mozInstall 19:12:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:12:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:12:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:12:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:12:13 INFO - Running setup.py install for mozleak 19:12:13 INFO - Running setup.py install for mozlog 19:12:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:12:14 INFO - Running setup.py install for moznetwork 19:12:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:12:14 INFO - Running setup.py install for mozprocess 19:12:14 INFO - Running setup.py install for mozprofile 19:12:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:12:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:12:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:12:14 INFO - Running setup.py install for mozrunner 19:12:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:12:14 INFO - Running setup.py install for mozscreenshot 19:12:14 INFO - Running setup.py install for moztest 19:12:15 INFO - Running setup.py install for mozversion 19:12:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:12:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:12:15 INFO - Cleaning up... 19:12:15 INFO - Return code: 0 19:12:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12:15 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')]} 19:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:15 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')]} 19:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:15 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 0x101de8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb01d95ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfcd30>, '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 0x101a62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf4b20>, '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.tCccl62Im5/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.RF8MljZQpo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 19:12:15 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 19:12:15 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 19:12:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tCccl62Im5/Render', 19:12:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:12:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:12:15 INFO - 'HOME': '/Users/cltbld', 19:12:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:12:15 INFO - 'LOGNAME': 'cltbld', 19:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:15 INFO - 'MOZ_NO_REMOTE': '1', 19:12:15 INFO - 'NO_EM_RESTART': '1', 19:12:15 INFO - 'PAGER': '/bin/cat', 19:12:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:15 INFO - 'PWD': '/builds/slave/test', 19:12:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:12:15 INFO - 'SHELL': '/bin/bash', 19:12:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF8MljZQpo/Listeners', 19:12:15 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 19:12:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:12:15 INFO - 'USER': 'cltbld', 19:12:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:12:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:15 INFO - 'XPC_FLAGS': '0x0', 19:12:15 INFO - 'XPC_SERVICE_NAME': '0', 19:12:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:12:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:12:15 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-rA1v1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:12:15 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)) 19:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:12:15 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-vRrGgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:12:15 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)) 19:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:12:15 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-g2nz7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:12:15 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)) 19:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:12:15 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-nZ1ErP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:12:15 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)) 19:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:12:15 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-NE1jKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:12:15 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)) 19:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:12:15 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-JDre8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:12:16 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)) 19:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:12:16 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-6U4Dw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:12:16 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)) 19:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:12:16 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-f3Y2aQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:12:16 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)) 19:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:12:16 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-3iKEjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:12:16 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)) 19:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:12:16 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-UM_l2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:12:16 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)) 19:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:12:16 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-xjrNzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:12:16 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)) 19:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:12:16 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-_pjTNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:12:16 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)) 19:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:12:16 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-lKWL9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:12:16 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)) 19:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:12:16 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-LCmvJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:12:16 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)) 19:12:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:16 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-gVATXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:12:17 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)) 19:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:12:17 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-ACPz4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:12:17 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)) 19:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:12:17 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-efUPsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:12:17 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)) 19:12:17 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)) 19:12:17 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)) 19:12:17 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)) 19:12:17 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)) 19:12:17 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)) 19:12:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:12: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 19:12: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 19:12: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 19:12: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 19:12: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 19:12: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 19:12:19 INFO - Downloading blessings-1.6.tar.gz 19:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:12:19 INFO - Installing collected packages: blessings 19:12:19 INFO - Running setup.py install for blessings 19:12:20 INFO - Successfully installed blessings 19:12:20 INFO - Cleaning up... 19:12:20 INFO - Return code: 0 19:12:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:12:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:12:20 INFO - Reading from file tmpfile_stdout 19:12:20 INFO - Current package versions: 19:12:20 INFO - blessings == 1.6 19:12:20 INFO - blobuploader == 1.2.4 19:12:20 INFO - docopt == 0.6.1 19:12:20 INFO - functools32 == 3.2.3-2 19:12:20 INFO - jsonschema == 2.5.1 19:12:20 INFO - manifestparser == 1.1 19:12:20 INFO - mozInstall == 1.12 19:12:20 INFO - mozcrash == 0.17 19:12:20 INFO - mozdebug == 0.1 19:12:20 INFO - mozdevice == 0.48 19:12:20 INFO - mozfile == 1.2 19:12:20 INFO - mozhttpd == 0.7 19:12:20 INFO - mozinfo == 0.9 19:12:20 INFO - mozleak == 0.1 19:12:20 INFO - mozlog == 3.4 19:12:20 INFO - moznetwork == 0.27 19:12:20 INFO - mozprocess == 0.23 19:12:20 INFO - mozprofile == 0.28 19:12:20 INFO - mozrunner == 6.12 19:12:20 INFO - mozscreenshot == 0.1 19:12:20 INFO - mozsystemmonitor == 0.3 19:12:20 INFO - moztest == 0.7 19:12:20 INFO - mozversion == 1.4 19:12:20 INFO - psutil == 3.1.1 19:12:20 INFO - requests == 1.2.3 19:12:20 INFO - wsgiref == 0.1.2 19:12:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:12: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')]} 19:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12: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')]} 19:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12:20 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 0x101de8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb01d95ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfcd30>, '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 0x101a62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf4b20>, '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.tCccl62Im5/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.RF8MljZQpo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 19:12:20 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 19:12:20 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 19:12:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tCccl62Im5/Render', 19:12:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:12:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:12:20 INFO - 'HOME': '/Users/cltbld', 19:12:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:12:20 INFO - 'LOGNAME': 'cltbld', 19:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:20 INFO - 'MOZ_NO_REMOTE': '1', 19:12:20 INFO - 'NO_EM_RESTART': '1', 19:12:20 INFO - 'PAGER': '/bin/cat', 19:12:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:20 INFO - 'PWD': '/builds/slave/test', 19:12:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:12:20 INFO - 'SHELL': '/bin/bash', 19:12:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF8MljZQpo/Listeners', 19:12:20 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 19:12:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:12:20 INFO - 'USER': 'cltbld', 19:12:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:12:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:20 INFO - 'XPC_FLAGS': '0x0', 19:12:20 INFO - 'XPC_SERVICE_NAME': '0', 19:12:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:20 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)) 19:12:20 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)) 19:12:20 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)) 19:12:20 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)) 19:12:20 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)) 19:12:20 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)) 19:12:20 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)) 19:12:20 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)) 19:12:20 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)) 19:12:20 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)) 19:12:20 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)) 19:12:20 INFO - Cleaning up... 19:12:20 INFO - Return code: 0 19:12:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:12: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')]} 19:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12: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')]} 19:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:12: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101de8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d5e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb01d95ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bfcd30>, '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 0x101a62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf4b20>, '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.tCccl62Im5/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.RF8MljZQpo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 19:12: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', 'jsonschema'] in /builds/slave/test/build 19:12: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 jsonschema 19:12:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tCccl62Im5/Render', 19:12:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:12:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:12:20 INFO - 'HOME': '/Users/cltbld', 19:12:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:12:20 INFO - 'LOGNAME': 'cltbld', 19:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:20 INFO - 'MOZ_NO_REMOTE': '1', 19:12:20 INFO - 'NO_EM_RESTART': '1', 19:12:20 INFO - 'PAGER': '/bin/cat', 19:12:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:20 INFO - 'PWD': '/builds/slave/test', 19:12:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:12:20 INFO - 'SHELL': '/bin/bash', 19:12:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF8MljZQpo/Listeners', 19:12:20 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 19:12:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:12:20 INFO - 'USER': 'cltbld', 19:12:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:12:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:20 INFO - 'XPC_FLAGS': '0x0', 19:12:20 INFO - 'XPC_SERVICE_NAME': '0', 19:12:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:12:20 INFO - Cleaning up... 19:12:21 INFO - Return code: 0 19:12:21 INFO - Running post-action listener: _resource_record_post_action 19:12:21 INFO - Running post-action listener: _start_resource_monitoring 19:12:21 INFO - Starting resource monitoring. 19:12:21 INFO - [mozharness: 2016-11-30 03:12:21.027527Z] Finished create-virtualenv step (success) 19:12:21 INFO - [mozharness: 2016-11-30 03:12:21.028546Z] Running install step. 19:12:21 INFO - Running pre-action listener: _resource_record_pre_action 19:12:21 INFO - Running main action method: install 19:12:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:12:21 INFO - Reading from file tmpfile_stdout 19:12:21 INFO - Detecting whether we're running mozinstall >=1.0... 19:12:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:12:21 INFO - Reading from file tmpfile_stdout 19:12:21 INFO - Output received: 19:12:21 INFO - Usage: mozinstall [options] installer 19:12:21 INFO - Options: 19:12:21 INFO - -h, --help show this help message and exit 19:12:21 INFO - -d DEST, --destination=DEST 19:12:21 INFO - Directory to install application into. [default: 19:12:21 INFO - "/builds/slave/test"] 19:12:21 INFO - --app=APP Application being installed. [default: firefox] 19:12:21 INFO - mkdir: /builds/slave/test/build/application 19:12:21 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'] 19:12:21 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 19:12:43 INFO - Reading from file tmpfile_stdout 19:12:43 INFO - Output received: 19:12:43 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 19:12:43 INFO - Running post-action listener: _resource_record_post_action 19:12:43 INFO - [mozharness: 2016-11-30 03:12:43.380162Z] Finished install step (success) 19:12:43 INFO - [mozharness: 2016-11-30 03:12:43.380292Z] Running run-tests step. 19:12:43 INFO - Running pre-action listener: _resource_record_pre_action 19:12:43 INFO - Running main action method: run_tests 19:12:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:12:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:12:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:12:43 INFO - 2016-11-29 19:12:43.395 screenresolution[6345:108569] starting screenresolution argv=screenresolution get 19:12:43 INFO - 2016-11-29 19:12:43.397 screenresolution[6345:108569] Display 0: 1600x1200x32@60 19:12:43 INFO - 2016-11-29 19:12:43.403 screenresolution[6346:108572] starting screenresolution argv=screenresolution list 19:12:43 INFO - Available Modes on Display 0 19:12:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:12:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:12:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:12:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:12:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:12:43 INFO - Intel Iris: 19:12:43 INFO - Chipset Model: Intel Iris 19:12:43 INFO - Type: GPU 19:12:43 INFO - Bus: Built-In 19:12:43 INFO - VRAM (Dynamic, Max): 1536 MB 19:12:43 INFO - Vendor: Intel (0x8086) 19:12:43 INFO - Device ID: 0x0a2e 19:12:43 INFO - Revision ID: 0x0009 19:12:43 INFO - Displays: 19:12:43 INFO - Display: 19:12:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:12:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:12:43 INFO - Display Serial Number: 1600x1200 60 19:12:43 INFO - Main Display: Yes 19:12:43 INFO - Mirror: Off 19:12:43 INFO - Online: Yes 19:12:43 INFO - Rotation: Supported 19:12:43 INFO - Return code: 0 19:12:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:12:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:12:43 INFO - Python 2.7.3 19:12:43 INFO - Return code: 0 19:12:43 INFO - grabbing minidump binary from tooltool 19:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:12:43 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 0x101bfcd30>, '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 0x101a62db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101bf4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:12:43 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 19:12:43 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 19:12:43 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 19:12:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:12:43 INFO - Return code: 0 19:12:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:12:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:12:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:12:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:12:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:12:43 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/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0128', '--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 19:12:43 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/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0128 --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 19:12:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tCccl62Im5/Render', 19:12:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:12:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:12:43 INFO - 'HOME': '/Users/cltbld', 19:12:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:12:43 INFO - 'LOGNAME': 'cltbld', 19:12:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:12:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:12:43 INFO - 'MOZ_NO_REMOTE': '1', 19:12:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:12:43 INFO - 'NO_EM_RESTART': '1', 19:12:43 INFO - 'PAGER': '/bin/cat', 19:12:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:12:43 INFO - 'PWD': '/builds/slave/test', 19:12:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:12:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:12:43 INFO - 'SHELL': '/bin/bash', 19:12:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RF8MljZQpo/Listeners', 19:12:43 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 19:12:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:12:43 INFO - 'USER': 'cltbld', 19:12:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:12:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:12:43 INFO - 'XPC_FLAGS': '0x0', 19:12:43 INFO - 'XPC_SERVICE_NAME': '0', 19:12:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:12:43 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/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0128', '--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 19:12:43 INFO - mozversion application_buildid: 20161129164126 19:12:43 INFO - mozversion application_changeset: 9afe68360fa82c16b760b448b2156230a90caf11 19:12:43 INFO - mozversion application_display_name: Firefox 19:12:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:12:43 INFO - mozversion application_name: Firefox 19:12:43 INFO - mozversion application_remotingname: firefox 19:12:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:12:43 INFO - mozversion application_vendor: Mozilla 19:12:43 INFO - mozversion application_version: 51.0 19:12:43 INFO - mozversion platform_buildid: 20161129164126 19:12:43 INFO - mozversion platform_changeset: 9afe68360fa82c16b760b448b2156230a90caf11 19:12:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:12:43 INFO - mozversion platform_version: 51.0 19:12:43 INFO - using testdate: 1480475563 19:12:43 INFO - actual date: 1480475563 19:12:43 INFO - starting webserver on 'localhost:57295' 19:12:43 INFO - SUITE-START | Running 2 tests 19:12:43 INFO - TEST-START | dromaeo_css 19:12:43 INFO - operating with platform_type : mac_ 19:12:43 INFO - Initialising browser for dromaeo_css test... 19:12:44 INFO - TEST-INFO | started process 6356 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmpzo0jH_/profile http://localhost:57295/getInfo.html) 19:12:46 INFO - PROCESS | 6356 | __metrics Screen width/height:1600/1200 19:12:46 INFO - PROCESS | 6356 | colorDepth:24 19:12:46 INFO - PROCESS | 6356 | Browser inner width/height: 1024/689 19:12:46 INFO - PROCESS | 6356 | __metrics 19:12:46 INFO - PROCESS | 6356 | 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" 19:12:46 INFO - PROCESS | 6356 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:12:47 INFO - TEST-INFO | 6356: exit 0 19:12:47 INFO - Browser initialized. 19:12:47 INFO - Running cycle 1/1 for dromaeo_css test... 19:12:47 INFO - TEST-INFO | started process 6359 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmpzo0jH_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:12:59 INFO - PROCESS | 6359 | RSS: Main: 169017344 19:12:59 INFO - PROCESS | 6359 | 19:13:50 INFO - PROCESS | 6359 | 1480475630945 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] 19:16:01 INFO - PROCESS | 6359 | Cycle 1(1): loaded http://localhost:57295/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57295/tests/dromaeo/cssquery-ext.html) 19:16:02 INFO - PROCESS | 6359 | RSS: Main: 325898240 19:16:02 INFO - PROCESS | 6359 | 19:19:05 INFO - PROCESS | 6359 | Cycle 1(1): loaded http://localhost:57295/tests/dromaeo/cssquery-ext.html (next: http://localhost:57295/tests/dromaeo/cssquery-jquery.html) 19:19:06 INFO - PROCESS | 6359 | RSS: Main: 300834816 19:19:06 INFO - PROCESS | 6359 | 19:22:08 INFO - PROCESS | 6359 | Cycle 1(1): loaded http://localhost:57295/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57295/tests/dromaeo/cssquery-mootools.html) 19:22:08 INFO - PROCESS | 6359 | RSS: Main: 302309376 19:22:08 INFO - PROCESS | 6359 | 19:25:11 INFO - PROCESS | 6359 | Cycle 1(1): loaded http://localhost:57295/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57295/tests/dromaeo/cssquery-prototype.html) 19:25:11 INFO - PROCESS | 6359 | RSS: Main: 275517440 19:25:11 INFO - PROCESS | 6359 | 19:28:15 INFO - PROCESS | 6359 | Cycle 1(1): loaded http://localhost:57295/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57295/tests/dromaeo/cssquery-yui.html) 19:28:15 INFO - PROCESS | 6359 | RSS: Main: 262389760 19:28:15 INFO - PROCESS | 6359 | 19:31:18 INFO - PROCESS | 6359 | Cycle 1(1): loaded http://localhost:57295/tests/dromaeo/cssquery-yui.html (next: http://localhost:57295/tests/dromaeo/cssquery-dojo.html) 19:31:18 INFO - PROCESS | 6359 | RSS: Main: 346025984 19:31:18 INFO - PROCESS | 6359 | 19:31:18 INFO - PROCESS | 6359 | __start_tp_report 19:31:18 INFO - PROCESS | 6359 | _x_x_mozilla_page_load 19:31:18 INFO - PROCESS | 6359 | _x_x_mozilla_page_load_details 19:31:18 INFO - PROCESS | 6359 | |i|pagename|runs| 19:31:18 INFO - PROCESS | 6359 | |0;dojo.html;3375.578052743407;3419.9829000855007;3426.1948442116104;3466.7746596471243;3507.8421471033803;5764.164196191549;5850.063989761639;5851.7074146292725;5877.9412205877925;5882.382349853268;5704.800331988381;5848.444397782215;5852.590318677694;5857.619254748438;5890.116482527623;5257.500537448946;5274.367075950891;5331.360236771573;5363.383210930754;5363.973180134094;5250.579953603722;5257.7108259045735;5260.684358938457;5379.731013449312;5392.433794451585;5294.391145018314;5317.12267475866;5320.281761962144;5322.627416080876;5341.839744807662;5322.627416080876;5347.171188465794;5367.114426119686;5375.354957405098;5439.592030597721;5174.793008279665;5241.475852414728;5308.840734777963;5345.412004679482;5351;5677.630953987978;5711.457411545896;5717.142428635738;5773.826785196409;5775.27809023872;6151.815445536641;6195.535334849904;6207.0379091240475;6254;6255.155554000243;6237.968810155966;6249.781257656005;6287.056941458772;6307.842303942392;6312.873742525169;5706.343770466408;5796.652200867961;5802.912956305659;5877.294724633071;5879.735411906389;6402.263739669905;6414.839629009312;6428.325025872216;6434;6434.420902118738;6179.104029915727;6200.968995154995;6205.5345849061505;6215.502759779207;6220.533459990428;6147.508199344042;6171.907421388682;6198.318184999646;6252.874482593177;6269.905951410732;6200.720967556471;6218.31598524162;6233.625982441068;6282;6296.150019747367;6220.0047992321015;6279.403456671609;6280.748770049238;6301.960176570906;6303.338149494329;4426.44669416323;4893.339399181136;4996.850094497098;5012.774425150877;5070.797168113234;4442.600165985077;4478.305862591304;4503.166914120898;4509.255972764523;4575.496695363508;6037.275526936795;6054.788082417094;6057.7879774207695;6059.909101363483;6063.605865618721;6197.442230199214;6262.592931459531;6268.2478102627065;6279.7488100476385;6288.308286088527;5827.475527202572;5924.526037916957;5977.342492325841;5993.880122397528;6116.633002019893;5431.728413579305;5493.505584497414;5499.230107784913;5514.558835293167;5523.613347065747;6478.773242936474;6488.156539649815;6504;6507.251666058369;6512.641804700692;5143.768530416215;6152;6185;6240.500759939285;6298.401651843067;6400.071989561395;6478.740850365933;6492.577982431127;6498.350164983463;6503.447206987459;6266.467350275278;6267.185265915402;6267.373262673696;6280.120783090462;6288.905666414916;6170.969145154246;6185.721642526187;6200.472959798468;6211.16149319836;6275.090111933835;5978.551608629283;6107.8778424430375;6129.08063790435;6207.472364849038;6217.658028808459;6183.659898705614;6195.16365290698;6200.689965501797;6219.471344935731;6233.812985610439;5897.587168898136;5951.55363347742;6077.848053798691;6086.513078953584;6087.665178415053;6095.908561371672;6105.732692890381;6124.991279909952;6141.863755205122;6233.470155036691;5061.266116413026;5953.553483488842;6120.17377654011;6120.908186377119;6151.384861513813 19:31:18 INFO - PROCESS | 6359 | |1;ext.html;484.56389249675266;486.5645247503482;521.7704210147534;537.2934591012819;538.6983289357958;31352.529712054307;33351;42423.57576424235;43794.781026094824;44005.33991990123;42038.579614203845;45729.542704572945;45763.542364576344;45805.541944580546;45810.541894581045;9964.153046991014;10146.695599132001;10151.746206344864;10155.28912976092;10157.238207134458;9283.25733941283;9525.428474291564;9819.607215711363;12050.337231452266;12491;12373.938130309381;12400.13199076065;12439.813402798965;12464.252144871336;12480.063995200351;12401.689957751083;12478.43847026886;12503.49986000559;12505.874941250608;12515.499380024788;12254.877451225462;12346.691332716753;12363.381830908418;12370.876291237062;12390.690232744164;42708;42755.78622106901;43099.353509697066;43228;43274.56725432737;3426.8971930842113;3471.9132021699406;3543.539339885798;3712.2761061593;4007.3988901664693;26972;33040.84357047492;33125;33138.50292245618;33574.68677170695;3248.123300995101;3282.4091663500562;3326.3513614845115;3381;3490.8603655853735;391611;391763;392026;392470;392850.0714992871;30462.933797316986;64356.67821660862;64495.35504644988;64537.35462645407;64779;31160.53259201114;32285.838570807464;32322.35355292881;32322.35355292881;32334.514982275286;15948.2823272953;16115.838841611669;16120.193990300439;16148.90064291658;16158;12325.815112773316;13431.194128352136;13535.255560944242;13536;13537.39081741324;7702.8844567331535;7842.803929901684;7861.2531809478005;7869.370450363957;7870.527768333918;3353.83230838462;3420.110771199506;3427.9314413712086;3428.879989200366;3454.861805527801;1005.582683186484;1023.2223510132353;1056.2606175676904;1131.338167172197;1165.3648761425043;25616.487670246865;31388.843055784575;31465.21336966594;31477.527837082464;32657;836.9204925532065;1025.2054657640388;1034.4982683398546;1111.9388433636227;1119.2556949628406;14033;14685.905349280143;16123.516294511184;16284.592885177964;16659.16704164787;666525;668498.3150168534;668832;676086;676762;62321.68839155866;62838.68580657068;63005.05492417618;63012;63386.049209261895;1424.0316584722282;1448.7754398068316;1459.4162335065846;1459.6204986703322;1459.88320934325;29997.400051999273;30350.39299213959;31229.68770312268;31467.84266078655;32099.679003210604;53258;53729;53746.731266344985;53755.731221343645;53833;473203;474025;475306;475768;476104;24918.252452426455;25274.36814079589;27639.170824875288;28381.290467738472;28793.7120628791;45702;49808.501914980385;50037.747546409366;50617;51327.743361282955;39570.406443902786;41349.79325103355;41998.30651989815;42658.78670606627;42905;41065.58934410618;41214.58785412108;41950.79024604979;42119;42705.78647106745;39981.40027899526;40610.59389406068;40752.3887141699;41141;41187;28612.856935715186;29630.85184574063;33178.834105829315;36618.45072323864;36634.45048324224;26774;26814.06150784713;27037.729622703522;27040.647967601148;27096.703852196224 19:31:18 INFO - PROCESS | 6359 | |2;jquery.html;341.011067903081;348.5190437196669;362.1995390187685;400.98396064157436;409.7050123910783;20245.088970996305;21139.47151321218;21745.456363590878;22066.558668826634;22252.109915603356;12289.815652765215;12477.376131193449;16009.719222462205;20667.483312917186;21421.35735927921;4596.264597664374;5658.8019419320335;5775.075987841946;5779.190913272145;5783.710814459281;6113.81658550242;6269.122322874801;6272.466840318556;6277.591956522834;6283.246010478726;5990.341062483123;6214.720337584797;6217.844553886144;6239.9064014039595;6265.404786545271;6210.50315974721;6250.1874756281395;6253.374662533733;6254.280757712876;6261.968690156543;5327.547158491533;5510.8071217507195;5545.916811247835;5581.6371935824045;5584.246126772915;19028.953407562578;26461;26572.335691607863;26740.598891016456;26812.46375072507;2384.8211384146084;2399.7240317363553;2796.175128337125;3004.60334662305;3065.877364905401;14478.493252736103;15533;15852.445164419305;15884.285207165705;16626.75059874103;1892.1674463236131;1916.597514521952;1924.4707705381131;1978.7724411692695;1994.6409646263812;128924.35537822345;128937.35531322377;136301;138864.61135388617;140694.29652851773;11312.547498100148;11596.420178991186;11850.585229516926;11889.464974076187;12069.462816904119;15309.08145511273;15324;15345.539633811004;15356.462523811613;15391.615209619626;7769.951056607399;7848.411369147337;7910.288074073361;7944.880826787603;7972.880406793903;7341.265873412616;7353.558786472829;7369.336759691653;7485.925140748632;7524.661390237453;4553.772311384418;4581;4598.540145985442;4611.1469378164475;4691.9530804692195;1548.442560678155;1892.337681811355;1895;1957.4421289932586;1960.460873259865;867.5922316511229;890.283321925856;921.1847514949318;978.9314747967717;1038.3406536849154;19948.20207191696;21466.356009319432;21666.72457696542;21680.674789878165;21832.799196044052;919.4069824962995;924.4961495984704;955.5699935029264;956.0582825916466;983.0611765763679;9873.75315617101;10366.844497332546;11327.376994265394;11328.620989592278;11584.47869845859;589248;615789;622196;622505;629850;137189;138430;141984.87022694462;144451;149727.25136374249;1009.9141572966233;1016.1921272588162;1038.5949479702922;1046.2676126711333;1046.9059832475082;15672.981256218765;16175.59561010937;19533.70699439481;19640.214391424182;19760;37417.812910935274;51052;56735;58581.70709146598;61632;69439.61120777455;80380.79428808455;80727.59636201781;81375.18624813676;81857.59071204606;7562.924370756442;7578.621068946421;7767.689292428239;8100.2304781045705;8921.420107692978;9390.342676012613;11046;13144.40850161726;13146.40841162169;13871.375788089359;11501.712457188638;11667.124965627441;11675.649730508097;11927;12166.087543434101;11412.600558980395;11550.768984620092;11579.594714184963;11841;11978.64064078079;10465.738356541147;11684.532618695157;11788.528458861549;11877.22798018126;11922;8589.742307730778;8703.695370661997;8771.210591046836;8801.163889430494;8805.471671699719;8669.436486628349;10878.782424351626;11768.529258829893;12091.334976576372;12147.088968327234 19:31:18 INFO - PROCESS | 6359 | |3;mootools.html;1357.368823497074;1394.532831501447;1495.7382458069842;1544.2587557972174;1908.5991941692234;8242.835143297138;8651.264642505386;8723.476591404513;9153.862692059607;9157.679481218158;8986.550672466383;9063.95468022659;9078.319126065555;9085.954570227139;9086.09139086091;2397.184957114581;2432.416220107179;2433.2092070077206;2433.452473193526;2437.0373702387546;2390.8565486070806;2404.0984630763464;2415.0460568075687;2431.586630272849;2432.659427680126;2162.816160626349;2255.8984845681985;2411.8191135664806;2414.0102557951245;2421.2615152378517;2333.5449587330477;2341.2976107167783;2341.3210169050953;2342.9297121086393;2414.5653782319177;2363.1847012780563;2383.1420688552107;2388.438716901544;2399.4601214726545;2400.819938504602;8817.250533704642;8986.505742184178;9066.637334506611;9104.499252541107;9129.77175570616;5363.570914326844;5551;5593.804216852432;5603.663780173202;5620.718964051822;2780.33272014717;3513.2797776456023;3547.4324108142573;3631.364511210528;3647.2705458908326;1095.5672509358837;1110.123002827765;1120.3222050659315;1125.8029844777132;1134.4384529657873;11791.646250612495;11893.40532973348;12017.819732704016;12026.27842329463;12057.819132713017;4792.4249090108715;4870.0746858096845;4931.432885218174;5006.69959802413;5026.4973502649445;10449.425281609432;10449.529771160316;10458.111060559786;10460.424676642857;10477.266591338534;5571.693556854331;5576.358718747315;5578.693171875505;5583.944160558423;5585.1901474286005;4214.789260536961;4453.799579018952;4600.079984003212;4866.7566621668775;5021.121303771825;3667.4865518827387;3845.788481633481;3961.2869683457257;3967.3453880110037;4104.486939132608;1111.6665000499818;1293.224065560656;1316.1905428161804;1317.328162637062;1327.9004074694437;916.2852974679761;942.5852624845046;943.5659596585648;957.7940742740344;993.513178542509;5714.171445140514;5764.654120752768;5874.089516125007;5945.375735547792;6173.9073913891325;376.8266597365243;459.46013434214666;462.7501149379365;463.8724350803556;466.4682262221071;3933.9213215735526;3943.901402464904;4014.41790940312;4028.4762980812307;4095.9590404096175;10656.78686426267;10854.945725271324;10964.56141754321;11115.388653623966;11137.941895519913;10985.890141098647;11086.16853735973;11105.666829995112;11111.555537778399;11123.666290011313;8374.706885258987;8451.323894088458;8552.871706924401;8563.058063612998;8568.057513673491;5696.259486266758;5755.3381361144;5923.555733319932;5954.315253745702;6000.489958353589;10168.33905796121;10212.642557510451;10265.665463489699;10372.11836993864;10392.06471417576;9920.007999200023;10522;10571.36571805694;10576.20678449104;10588.99404556566;6907.34380233877;7118;7482.289182527651;7565.735199268;8211.671533138608;8340.291075258428;8603.91396086031;8789.34079943994;8800.559972001502;8801.207891289814;6477.546571739933;7729.265719756614;7762.728304509315;7778.299953004031;7860.017497812773;7442.516236444614;7549.547027178387;7621.771346859603;7647.158812530506;7697.422693297913;7081.362677359062;7236.674349654383;7242.710291588488;7245.891311630225;7247.383972362408;4576.6109880660515;5091.389033316026;5105.055564720538;5145.536901678867;5146.871328216825;5046.84859454217;5094.465081166424;5205.6616319939085;5207.3751149862255;5276.498732620395 19:31:18 INFO - PROCESS | 6359 | |4;prototype.html;279.50667072616835;310.60242889101943;316.49045037489645;321.7409984962106;323.495347258277;5219.321488206532;5301.602379821515;5302.946970530294;5326.786928522864;5376.8118115865955;4591.954080459194;4658.883527911804;4807.375041244633;5109.412417571981;5118.104331741949;3525.7179425646013;3711.9814400927958;3728.0866187783963;4073.30753771858;4089.631933126018;4056.6957478189106;4067.7966101694947;4089.6114869087387;4108.917821643566;4141.792910354486;3450.9482357764655;3890.8832735017995;3997.9800100999455;4050.6759459243335;4056.9797151014204;3220.758443116752;4002.7598344099156;4036.3945408189006;4082.2856000199845;4084.2239974404915;3561.8041007744564;3562.928741425183;3571.499990001402;3585.515955346021;3595.658412450839;4136.320731283236;5116.539511443988;5151.793928242866;5171.276021357013;5172.870678233075;3896.337622604164;4404.647628189737;4630.583247507707;4644.8374306899095;4654.4647365553055;4554.316852472122;5413.593980451482;5498;5525.281713377275;5546.27898373213;3912.804359782028;3914.471546341236;3931.606839316074;3935.1736135411597;3956.188981258835;4823.397075365579;5688.7298747764025;5709.942900570983;5741.397153298927;5829.708514574297;3570.98214508931;3738.8504459821847;3975.3043217436834;4004.439378487014;4022.5864481311564;3880.417937309426;4093.053001838671;4093.201825643971;4120.855770048034;4141.834326626901;4478.171538265431;4577.862664120082;4619.653525985565;4672.042231342634;4701;5487.807926722546;5492.265259623495;5503.724813759296;5511.035568775528;5519.420460851633;1364.6042647632273;1389.673426744714;1401.8668226518464;1401.927525443037;1407.5355132806149;819.868820988639;868.3747701654798;878.3017501086651;928.2666693312343;930.418488444722;4780.060262938268;4908.14094046891;5213.843584692465;5256.001359741636;5265.447128051576;5603.971980140073;5604.019296623156;5618.522425593788;5621.931832951808;5624.481390024671;4713.835015774432;4744.620430365562;5211.296474975906;5349.759260833272;5398.838034858961;2533;2948.277671970381;3040.2703351195996;3042.6196725409322;3045.680203578592;5409;5968.492678122321;5982.222311099529;5995.640261584319;6007.519398448201;4676.508966558463;5099.6685215460875;5668.489835914705;5849.1226316052935;5869.559783016291;5447.4552544746;5588.345535870429;5926;5940.673262970578;5945.18671805095;4315.525292217916;4994.076095922121;5502.367227768857;5776.249087618751;5801.926643570953;4585.77071146448;5725.312962444534;5737.5983681141915;5739.167820666064;5759.193712880116;4935.580475659609;5563.635454931718;5983.551233657406;6014.248218972629;6025.8852112359355;3667.5965643779696;3891.9805400972814;3930.5479869814194;3943.72393932422;3948.4669569607736;5306.9203961941375;5756.510696590669;5771.8557036074435;5772.874289513505;5808.157817116579;5328.653637513549;5686.829395118153;5687.60186786921;5694.266751959166;5697.259356283656;4749.881252968704;4804.855854324376;5568.888622227614;5586.413426590149;5601.599600099975;5233.816816411408;5460.754266058117;5463.787166197696;5466.699331536804;5474.233607294902;4959.603231741524;5524.4199359068325;5569.275994120901;5571.220029195835;5615.7192140392;4682.578567928903;4757.952420475751;5346.359590631765;5409.486098820606;5503.834884953458 19:31:18 INFO - PROCESS | 6359 | |5;yui.html;717.6124892558022;725.8185453636592;769.5575044349497;799.0132186749363;852.5779739029182;16284.755728664064;17075.316987320493;17085.914570427132;17096.914515427437;17100;15271.160086195256;15366.231688415563;15373.538793836204;15376.23118844056;15384.61538461539;593.5073888672391;702.062746233776;714.3784907130778;879.0594064351147;881.2597418168737;892.143542199486;892.7723430525207;906.1391677905983;907.0929070929071;907.6233363154283;970.398353021128;973.868527748752;974.59554284972;974.8927617962054;976.0581039297077;963.3641796414333;964.599691128181;965.8744363232735;966.0050148347214;967.1972263021676;706.1843570675877;708.4049398505229;709.893515972603;710.1442761472414;710.989335159973;15964.840351596451;16031.599210019725;16063.598410039725;16072;16090.678186436206;10728.302660327132;13615;13789.310534473336;14045.508407205802;14267.928660356632;11735.237209581435;12035.277883327028;12136.757264854654;12469.376531173495;13708.725825483534;3716.2939041582013;4005.439238506611;4055.4119652650497;4128.442660240859;4152.730072545275;121016.57966840614;125551.74448255492;125795.3710231443;126141.99999999908;127423;10702.839457408145;11041.116710663127;11541.307521548733;11575.942120289345;11586.826197607043;19005.904970475058;23117.72852493129;23494.177703780286;23495.647565286534;23517.764822351557;6633.369829866155;7602.657880395395;7693.884591731128;8243.381746369047;8418.831623367621;4407.559244075631;4517.186906356887;4649.5350464953235;4654.325122857234;4762.9523704763205;3737.663610275088;3801.581825999138;3851.826667799956;3857.3056849767313;3859.710521710883;672.4821887146967;685.9691313890887;687.3092541995263;692.6571347183076;692.840646651273;583.1224007868216;618.4001518527022;640.4108220437209;668.3316683316683;677.7864972533636;8225.547594882219;8522.914770852212;9177.816443671089;9512.47681377517;9536.952315238379;645.502962718704;671.9294474080249;674.5042393840523;679.4157024958532;703.0298188499837;4541.545845415498;4573.49691533931;4606.355110284563;4610.193216187154;4646.163690535736;122228;124340;149039;155265.22367388316;163814;116560;121973.78026219625;125779;127993;130335.34832325968;74073.6296318515;105222.47388763007;105353.94646053595;110531;111462.88537114687;9404.341696081208;9409.952950235478;9961.402315860782;9971.800563988825;10000.499975001367;60241.69879150576;60988;62285;62468.68765656143;64133;58276;67799.98300025602;71659.9838011355;86995.69506457282;98048;13002.869971300166;13537.781599656078;13552.25462599527;13679;13873.861261387661;13827.861721382658;14627.97857028611;14774.965752397658;14831.703365932837;16009.279582419053;14460.783088253895;14466.638334041732;14762.261886905826;14846.628834279229;15358.692826143191;12449.132630105556;12724.427400766803;13430.462781488632;13977.44090236379;14673.633159170678;13464.798028029392;13563.118397304144;13619.795703064265;14522.782158267846;14853.628659283173;11245.325280483197;11666.533338666359;11832.70418239551;11964.102692298287;12094.455749491119;11614.419279036183;11712.70718232051;11724.509442055885;11782.116341274268;11835.408229588314 19:31:18 INFO - PROCESS | 6359 | __end_tp_report 19:31:18 INFO - PROCESS | 6359 | __start_cc_report 19:31:18 INFO - PROCESS | 6359 | _x_x_mozilla_cycle_collect,1481 19:31:18 INFO - PROCESS | 6359 | __end_cc_report 19:31:18 INFO - PROCESS | 6359 | __startTimestamp1480476678778__endTimestamp 19:31:18 INFO - PROCESS | 6359 | 19:31:18 INFO - PROCESS | 6359 | ------- Summary: start ------- 19:31:18 INFO - PROCESS | 6359 | Number of tests: 6 19:31:18 INFO - PROCESS | 6359 | 19:31:18 INFO - PROCESS | 6359 | [#0] dojo.html Cycles:165 Average:5821.27 Median:6087.67 stddev:641.48 (10.5%) stddev-sans-first:614.08 19:31:18 INFO - PROCESS | 6359 | Values: 3375.6 3420.0 3426.2 3466.8 3507.8 5764.2 5850.1 5851.7 5877.9 5882.4 5704.8 5848.4 5852.6 5857.6 5890.1 5257.5 5274.4 5331.4 5363.4 5364.0 5250.6 5257.7 5260.7 5379.7 5392.4 5294.4 5317.1 5320.3 5322.6 5341.8 5322.6 5347.2 5367.1 5375.4 5439.6 5174.8 5241.5 5308.8 5345.4 5351.0 5677.6 5711.5 5717.1 5773.8 5775.3 6151.8 6195.5 6207.0 6254.0 6255.2 6238.0 6249.8 6287.1 6307.8 6312.9 5706.3 5796.7 5802.9 5877.3 5879.7 6402.3 6414.8 6428.3 6434.0 6434.4 6179.1 6201.0 6205.5 6215.5 6220.5 6147.5 6171.9 6198.3 6252.9 6269.9 6200.7 6218.3 6233.6 6282.0 6296.2 6220.0 6279.4 6280.7 6302.0 6303.3 4426.4 4893.3 4996.9 5012.8 5070.8 4442.6 4478.3 4503.2 4509.3 4575.5 6037.3 6054.8 6057.8 6059.9 6063.6 6197.4 6262.6 6268.2 6279.7 6288.3 5827.5 5924.5 5977.3 5993.9 6116.6 5431.7 5493.5 5499.2 5514.6 5523.6 6478.8 6488.2 6504.0 6507.3 6512.6 5143.8 6152.0 6185.0 6240.5 6298.4 6400.1 6478.7 6492.6 6498.4 6503.4 6266.5 6267.2 6267.4 6280.1 6288.9 6171.0 6185.7 6200.5 6211.2 6275.1 5978.6 6107.9 6129.1 6207.5 6217.7 6183.7 6195.2 6200.7 6219.5 6233.8 5897.6 5951.6 6077.8 6086.5 6087.7 6095.9 6105.7 6125.0 6141.9 6233.5 5061.3 5953.6 6120.2 6120.9 6151.4 19:31:18 INFO - PROCESS | 6359 | 19:31:18 INFO - PROCESS | 6359 | [#1] ext.html Cycles:180 Average:65309.97 Median:3400.56 stddev:140610.68 (4134.9%) stddev-sans-first:140920.89 19:31:18 INFO - PROCESS | 6359 | Values: 484.6 486.6 521.8 537.3 538.7 31352.5 33351.0 42423.6 43794.8 44005.3 42038.6 45729.5 45763.5 45805.5 45810.5 9964.2 10146.7 10151.7 10155.3 10157.2 9283.3 9525.4 9819.6 12050.3 12491.0 12373.9 12400.1 12439.8 12464.3 12480.1 12401.7 12478.4 12503.5 12505.9 12515.5 12254.9 12346.7 12363.4 12370.9 12390.7 42708.0 42755.8 43099.4 43228.0 43274.6 3426.9 3471.9 3543.5 3712.3 4007.4 26972.0 33040.8 33125.0 33138.5 33574.7 3248.1 3282.4 3326.4 3381.0 3490.9 391611.0 391763.0 392026.0 392470.0 392850.1 30462.9 64356.7 64495.4 64537.4 64779.0 31160.5 32285.8 32322.4 32322.4 32334.5 15948.3 16115.8 16120.2 16148.9 16158.0 12325.8 13431.2 13535.3 13536.0 13537.4 7702.9 7842.8 7861.3 7869.4 7870.5 3353.8 3420.1 3427.9 3428.9 3454.9 1005.6 1023.2 1056.3 1131.3 1165.4 25616.5 31388.8 31465.2 31477.5 32657.0 836.9 1025.2 1034.5 1111.9 1119.3 14033.0 14685.9 16123.5 16284.6 16659.2 666525.0 668498.3 668832.0 676086.0 676762.0 62321.7 62838.7 63005.1 63012.0 63386.0 1424.0 1448.8 1459.4 1459.6 1459.9 29997.4 30350.4 31229.7 31467.8 32099.7 53258.0 53729.0 53746.7 53755.7 53833.0 473203.0 474025.0 475306.0 475768.0 476104.0 24918.3 25274.4 27639.2 28381.3 28793.7 45702.0 49808.5 50037.7 50617.0 51327.7 39570.4 41349.8 41998.3 42658.8 42905.0 41065.6 41214.6 41950.8 42119.0 42705.8 39981.4 40610.6 40752.4 41141.0 41187.0 28612.9 29630.9 33178.8 36618.5 36634.5 26774.0 26814.1 27037.7 27040.6 27096.7 19:31:18 INFO - PROCESS | 6359 | 19:31:18 INFO - PROCESS | 6359 | [#2] jquery.html Cycles:180 Average:36543.53 Median:14430.36 stddev:103450.98 (716.9%) stddev-sans-first:103705.47 19:31:18 INFO - PROCESS | 6359 | Values: 341.0 348.5 362.2 401.0 409.7 20245.1 21139.5 21745.5 22066.6 22252.1 12289.8 12477.4 16009.7 20667.5 21421.4 4596.3 5658.8 5775.1 5779.2 5783.7 6113.8 6269.1 6272.5 6277.6 6283.2 5990.3 6214.7 6217.8 6239.9 6265.4 6210.5 6250.2 6253.4 6254.3 6262.0 5327.5 5510.8 5545.9 5581.6 5584.2 19029.0 26461.0 26572.3 26740.6 26812.5 2384.8 2399.7 2796.2 3004.6 3065.9 14478.5 15533.0 15852.4 15884.3 16626.8 1892.2 1916.6 1924.5 1978.8 1994.6 128924.4 128937.4 136301.0 138864.6 140694.3 11312.5 11596.4 11850.6 11889.5 12069.5 15309.1 15324.0 15345.5 15356.5 15391.6 7770.0 7848.4 7910.3 7944.9 7972.9 7341.3 7353.6 7369.3 7485.9 7524.7 4553.8 4581.0 4598.5 4611.1 4692.0 1548.4 1892.3 1895.0 1957.4 1960.5 867.6 890.3 921.2 978.9 1038.3 19948.2 21466.4 21666.7 21680.7 21832.8 919.4 924.5 955.6 956.1 983.1 9873.8 10366.8 11327.4 11328.6 11584.5 589248.0 615789.0 622196.0 622505.0 629850.0 137189.0 138430.0 141984.9 144451.0 149727.3 1009.9 1016.2 1038.6 1046.3 1046.9 15673.0 16175.6 19533.7 19640.2 19760.0 37417.8 51052.0 56735.0 58581.7 61632.0 69439.6 80380.8 80727.6 81375.2 81857.6 7562.9 7578.6 7767.7 8100.2 8921.4 9390.3 11046.0 13144.4 13146.4 13871.4 11501.7 11667.1 11675.6 11927.0 12166.1 11412.6 11550.8 11579.6 11841.0 11978.6 10465.7 11684.5 11788.5 11877.2 11922.0 8589.7 8703.7 8771.2 8801.2 8805.5 8669.4 10878.8 11768.5 12091.3 12147.1 19:31:18 INFO - PROCESS | 6359 | 19:31:18 INFO - PROCESS | 6359 | [#3] mootools.html Cycles:180 Average:5838.39 Median:463.31 stddev:3342.18 (721.4%) stddev-sans-first:3334.59 19:31:18 INFO - PROCESS | 6359 | Values: 1357.4 1394.5 1495.7 1544.3 1908.6 8242.8 8651.3 8723.5 9153.9 9157.7 8986.6 9064.0 9078.3 9086.0 9086.1 2397.2 2432.4 2433.2 2433.5 2437.0 2390.9 2404.1 2415.0 2431.6 2432.7 2162.8 2255.9 2411.8 2414.0 2421.3 2333.5 2341.3 2341.3 2342.9 2414.6 2363.2 2383.1 2388.4 2399.5 2400.8 8817.3 8986.5 9066.6 9104.5 9129.8 5363.6 5551.0 5593.8 5603.7 5620.7 2780.3 3513.3 3547.4 3631.4 3647.3 1095.6 1110.1 1120.3 1125.8 1134.4 11791.6 11893.4 12017.8 12026.3 12057.8 4792.4 4870.1 4931.4 5006.7 5026.5 10449.4 10449.5 10458.1 10460.4 10477.3 5571.7 5576.4 5578.7 5583.9 5585.2 4214.8 4453.8 4600.1 4866.8 5021.1 3667.5 3845.8 3961.3 3967.3 4104.5 1111.7 1293.2 1316.2 1317.3 1327.9 916.3 942.6 943.6 957.8 993.5 5714.2 5764.7 5874.1 5945.4 6173.9 376.8 459.5 462.8 463.9 466.5 3933.9 3943.9 4014.4 4028.5 4096.0 10656.8 10854.9 10964.6 11115.4 11137.9 10985.9 11086.2 11105.7 11111.6 11123.7 8374.7 8451.3 8552.9 8563.1 8568.1 5696.3 5755.3 5923.6 5954.3 6000.5 10168.3 10212.6 10265.7 10372.1 10392.1 9920.0 10522.0 10571.4 10576.2 10589.0 6907.3 7118.0 7482.3 7565.7 8211.7 8340.3 8603.9 8789.3 8800.6 8801.2 6477.5 7729.3 7762.7 7778.3 7860.0 7442.5 7549.5 7621.8 7647.2 7697.4 7081.4 7236.7 7242.7 7245.9 7247.4 4576.6 5091.4 5105.1 5145.5 5146.9 5046.8 5094.5 5205.7 5207.4 5276.5 19:31:18 INFO - PROCESS | 6359 | 19:31:18 INFO - PROCESS | 6359 | [#4] prototype.html Cycles:180 Average:4527.05 Median:5104.54 stddev:1370.58 (26.9%) stddev-sans-first:1336.83 19:31:18 INFO - PROCESS | 6359 | Values: 279.5 310.6 316.5 321.7 323.5 5219.3 5301.6 5302.9 5326.8 5376.8 4592.0 4658.9 4807.4 5109.4 5118.1 3525.7 3712.0 3728.1 4073.3 4089.6 4056.7 4067.8 4089.6 4108.9 4141.8 3450.9 3890.9 3998.0 4050.7 4057.0 3220.8 4002.8 4036.4 4082.3 4084.2 3561.8 3562.9 3571.5 3585.5 3595.7 4136.3 5116.5 5151.8 5171.3 5172.9 3896.3 4404.6 4630.6 4644.8 4654.5 4554.3 5413.6 5498.0 5525.3 5546.3 3912.8 3914.5 3931.6 3935.2 3956.2 4823.4 5688.7 5709.9 5741.4 5829.7 3571.0 3738.9 3975.3 4004.4 4022.6 3880.4 4093.1 4093.2 4120.9 4141.8 4478.2 4577.9 4619.7 4672.0 4701.0 5487.8 5492.3 5503.7 5511.0 5519.4 1364.6 1389.7 1401.9 1401.9 1407.5 819.9 868.4 878.3 928.3 930.4 4780.1 4908.1 5213.8 5256.0 5265.4 5604.0 5604.0 5618.5 5621.9 5624.5 4713.8 4744.6 5211.3 5349.8 5398.8 2533.0 2948.3 3040.3 3042.6 3045.7 5409.0 5968.5 5982.2 5995.6 6007.5 4676.5 5099.7 5668.5 5849.1 5869.6 5447.5 5588.3 5926.0 5940.7 5945.2 4315.5 4994.1 5502.4 5776.2 5801.9 4585.8 5725.3 5737.6 5739.2 5759.2 4935.6 5563.6 5983.6 6014.2 6025.9 3667.6 3892.0 3930.5 3943.7 3948.5 5306.9 5756.5 5771.9 5772.9 5808.2 5328.7 5686.8 5687.6 5694.3 5697.3 4749.9 4804.9 5568.9 5586.4 5601.6 5233.8 5460.8 5463.8 5466.7 5474.2 4959.6 5524.4 5569.3 5571.2 5615.7 4682.6 4758.0 5346.4 5409.5 5503.8 19:31:18 INFO - PROCESS | 6359 | 19:31:18 INFO - PROCESS | 6359 | [#5] yui.html Cycles:180 Average:24584.65 Median:3726.98 stddev:38791.66 (1040.8%) stddev-sans-first:38859.08 19:31:18 INFO - PROCESS | 6359 | Values: 717.6 725.8 769.6 799.0 852.6 16284.8 17075.3 17085.9 17096.9 17100.0 15271.2 15366.2 15373.5 15376.2 15384.6 593.5 702.1 714.4 879.1 881.3 892.1 892.8 906.1 907.1 907.6 970.4 973.9 974.6 974.9 976.1 963.4 964.6 965.9 966.0 967.2 706.2 708.4 709.9 710.1 711.0 15964.8 16031.6 16063.6 16072.0 16090.7 10728.3 13615.0 13789.3 14045.5 14267.9 11735.2 12035.3 12136.8 12469.4 13708.7 3716.3 4005.4 4055.4 4128.4 4152.7 121016.6 125551.7 125795.4 126142.0 127423.0 10702.8 11041.1 11541.3 11575.9 11586.8 19005.9 23117.7 23494.2 23495.6 23517.8 6633.4 7602.7 7693.9 8243.4 8418.8 4407.6 4517.2 4649.5 4654.3 4763.0 3737.7 3801.6 3851.8 3857.3 3859.7 672.5 686.0 687.3 692.7 692.8 583.1 618.4 640.4 668.3 677.8 8225.5 8522.9 9177.8 9512.5 9537.0 645.5 671.9 674.5 679.4 703.0 4541.5 4573.5 4606.4 4610.2 4646.2 122228.0 124340.0 149039.0 155265.2 163814.0 116560.0 121973.8 125779.0 127993.0 130335.3 74073.6 105222.5 105353.9 110531.0 111462.9 9404.3 9410.0 9961.4 9971.8 10000.5 60241.7 60988.0 62285.0 62468.7 64133.0 58276.0 67800.0 71660.0 86995.7 98048.0 13002.9 13537.8 13552.3 13679.0 13873.9 13827.9 14628.0 14775.0 14831.7 16009.3 14460.8 14466.6 14762.3 14846.6 15358.7 12449.1 12724.4 13430.5 13977.4 14673.6 13464.8 13563.1 13619.8 14522.8 14853.6 11245.3 11666.5 11832.7 11964.1 12094.5 11614.4 11712.7 11724.5 11782.1 11835.4 19:31:18 INFO - PROCESS | 6359 | -------- Summary: end -------- 19:31:18 INFO - PROCESS | 6359 | 19:31:19 INFO - TEST-INFO | 6359: exit 0 19:31:19 INFO - TEST-OK | dromaeo_css | took 1115363ms 19:31:19 INFO - TEST-START | kraken 19:31:19 INFO - operating with platform_type : mac_ 19:31:19 INFO - Initialising browser for kraken test... 19:31:19 INFO - TEST-INFO | started process 6363 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmp6b55nR/profile http://localhost:57295/getInfo.html) 19:31:21 INFO - PROCESS | 6363 | __metrics Screen width/height:1600/1200 19:31:21 INFO - PROCESS | 6363 | colorDepth:24 19:31:21 INFO - PROCESS | 6363 | Browser inner width/height: 1024/689 19:31:21 INFO - PROCESS | 6363 | __metrics 19:31:21 INFO - PROCESS | 6363 | 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" 19:31:21 INFO - PROCESS | 6363 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:31:22 INFO - TEST-INFO | 6363: exit 0 19:31:22 INFO - Browser initialized. 19:31:22 INFO - Running cycle 1/1 for kraken test... 19:31:22 INFO - TEST-INFO | started process 6365 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmp6b55nR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:34 INFO - PROCESS | 6365 | RSS: Main: 168820736 19:31:34 INFO - PROCESS | 6365 | 19:31:36 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:57295/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57295/tests/kraken/driver.html?testName=audio-beat-detection) 19:31:37 INFO - PROCESS | 6365 | RSS: Main: 219881472 19:31:37 INFO - PROCESS | 6365 | 19:31:40 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:57295/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57295/tests/kraken/driver.html?testName=audio-dft) 19:31:40 INFO - PROCESS | 6365 | RSS: Main: 231948288 19:31:40 INFO - PROCESS | 6365 | 19:31:44 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:57295/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57295/tests/kraken/driver.html?testName=audio-fft) 19:31:44 INFO - PROCESS | 6365 | RSS: Main: 330469376 19:31:44 INFO - PROCESS | 6365 | 19:31:46 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:57295/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57295/tests/kraken/driver.html?testName=audio-oscillator) 19:31:47 INFO - PROCESS | 6365 | RSS: Main: 228548608 19:31:47 INFO - PROCESS | 6365 | 19:31:49 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:57295/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57295/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:31:49 INFO - PROCESS | 6365 | RSS: Main: 228995072 19:31:49 INFO - PROCESS | 6365 | 19:31:52 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:57295/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57295/tests/kraken/driver.html?testName=imaging-darkroom) 19:31:53 INFO - PROCESS | 6365 | RSS: Main: 266371072 19:31:53 INFO - PROCESS | 6365 | 19:31:56 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:57295/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57295/tests/kraken/driver.html?testName=imaging-desaturate) 19:31:56 INFO - PROCESS | 6365 | RSS: Main: 268013568 19:31:56 INFO - PROCESS | 6365 | 19:31:59 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:57295/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57295/tests/kraken/driver.html?testName=json-parse-financial) 19:32:00 INFO - PROCESS | 6365 | RSS: Main: 267988992 19:32:00 INFO - PROCESS | 6365 | 19:32:01 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:57295/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57295/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:32:02 INFO - PROCESS | 6365 | RSS: Main: 240025600 19:32:02 INFO - PROCESS | 6365 | 19:32:03 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:57295/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57295/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:32:04 INFO - PROCESS | 6365 | RSS: Main: 244543488 19:32:04 INFO - PROCESS | 6365 | 19:32:06 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:57295/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57295/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:32:07 INFO - PROCESS | 6365 | RSS: Main: 246906880 19:32:07 INFO - PROCESS | 6365 | 19:32:10 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:57295/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:32:11 INFO - PROCESS | 6365 | RSS: Main: 260820992 19:32:11 INFO - PROCESS | 6365 | 19:32:13 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:57295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:32:14 INFO - PROCESS | 6365 | RSS: Main: 261292032 19:32:14 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:57295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57295/tests/kraken/driver.html?testName=ai-astar) 19:32:16 INFO - PROCESS | 6365 | RSS: Main: 304631808 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | __start_tp_report 19:32:16 INFO - PROCESS | 6365 | _x_x_mozilla_page_load 19:32:16 INFO - PROCESS | 6365 | _x_x_mozilla_page_load_details 19:32:16 INFO - PROCESS | 6365 | |i|pagename|runs| 19:32:16 INFO - PROCESS | 6365 | |0;ai-astar;113;112;111;111;112;111;112;111;110;111 19:32:16 INFO - PROCESS | 6365 | |1;audio-beat-detection;142;108;107;142;108;108;110;108;136;107 19:32:16 INFO - PROCESS | 6365 | |2;audio-dft;180;183;181;184;183;182;184;183;196;265 19:32:16 INFO - PROCESS | 6365 | |3;audio-fft;80;56;58;91;60;59;59;58;106;79 19:32:16 INFO - PROCESS | 6365 | |4;audio-oscillator;89;69;95;69;67;70;92;68;69;91 19:32:16 INFO - PROCESS | 6365 | |5;imaging-gaussian-blur;87;84;86;84;86;82;87;84;85;84 19:32:16 INFO - PROCESS | 6365 | |6;imaging-darkroom;93;93;93;105;148;128;93;93;94;93 19:32:16 INFO - PROCESS | 6365 | |7;imaging-desaturate;85;85;84;84;82;84;84;83;85;85 19:32:16 INFO - PROCESS | 6365 | |8;json-parse-financial;57;54;53;52;56;58;56;57;56;57 19:32:16 INFO - PROCESS | 6365 | |9;json-stringify-tinderbox;64;72;64;76;72;71;68;70;73;69 19:32:16 INFO - PROCESS | 6365 | |10;stanford-crypto-aes;94;95;100;99;77;82;96;100;99;99 19:32:16 INFO - PROCESS | 6365 | |11;stanford-crypto-ccm;139;145;145;133;138;141;142;137;200;157 19:32:16 INFO - PROCESS | 6365 | |12;stanford-crypto-pbkdf2;161;161;161;160;210;161;162;161;161;161 19:32:16 INFO - PROCESS | 6365 | |13;stanford-crypto-sha256-iterative;66;66;66;67;79;86;85;70;65;64 19:32:16 INFO - PROCESS | 6365 | __end_tp_report 19:32:16 INFO - PROCESS | 6365 | __start_cc_report 19:32:16 INFO - PROCESS | 6365 | _x_x_mozilla_cycle_collect,1836 19:32:16 INFO - PROCESS | 6365 | __end_cc_report 19:32:16 INFO - PROCESS | 6365 | __startTimestamp1480476736628__endTimestamp 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | ------- Summary: start ------- 19:32:16 INFO - PROCESS | 6365 | Number of tests: 14 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:0.84 (0.8%) stddev-sans-first:0.67 19:32:16 INFO - PROCESS | 6365 | Values: 113.0 112.0 111.0 111.0 112.0 111.0 112.0 111.0 110.0 111.0 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | [#1] audio-beat-detection Cycles:10 Average:117.60 Median:109.00 stddev:15.56 (14.3%) stddev-sans-first:13.78 19:32:16 INFO - PROCESS | 6365 | Values: 142.0 108.0 107.0 142.0 108.0 108.0 110.0 108.0 136.0 107.0 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | [#2] audio-dft Cycles:10 Average:192.10 Median:183.50 stddev:25.99 (14.2%) stddev-sans-first:27.20 19:32:16 INFO - PROCESS | 6365 | Values: 180.0 183.0 181.0 184.0 183.0 182.0 184.0 183.0 196.0 265.0 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | [#3] audio-fft Cycles:10 Average:70.60 Median:59.50 stddev:17.45 (29.3%) stddev-sans-first:18.17 19:32:16 INFO - PROCESS | 6365 | Values: 80.0 56.0 58.0 91.0 60.0 59.0 59.0 58.0 106.0 79.0 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:79.50 stddev:12.03 (15.1%) stddev-sans-first:12.07 19:32:16 INFO - PROCESS | 6365 | Values: 89.0 69.0 95.0 69.0 67.0 70.0 92.0 68.0 69.0 91.0 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | [#5] imaging-gaussian-blur Cycles:10 Average:84.90 Median:85.50 stddev:1.60 (1.9%) stddev-sans-first:1.50 19:32:16 INFO - PROCESS | 6365 | Values: 87.0 84.0 86.0 84.0 86.0 82.0 87.0 84.0 85.0 84.0 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | [#6] imaging-darkroom Cycles:10 Average:103.30 Median:93.00 stddev:19.25 (20.7%) stddev-sans-first:20.05 19:32:16 INFO - PROCESS | 6365 | Values: 93.0 93.0 93.0 105.0 148.0 128.0 93.0 93.0 94.0 93.0 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.50 stddev:0.99 (1.2%) stddev-sans-first:1.00 19:32:16 INFO - PROCESS | 6365 | Values: 85.0 85.0 84.0 84.0 82.0 84.0 84.0 83.0 85.0 85.0 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.50 stddev:1.96 (3.5%) stddev-sans-first:2.01 19:32:16 INFO - PROCESS | 6365 | Values: 57.0 54.0 53.0 52.0 56.0 58.0 56.0 57.0 56.0 57.0 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:71.50 stddev:3.81 (5.3%) stddev-sans-first:3.40 19:32:16 INFO - PROCESS | 6365 | Values: 64.0 72.0 64.0 76.0 72.0 71.0 68.0 70.0 73.0 69.0 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | [#10] stanford-crypto-aes Cycles:10 Average:94.10 Median:95.50 stddev:8.06 (8.4%) stddev-sans-first:8.55 19:32:16 INFO - PROCESS | 6365 | Values: 94.0 95.0 100.0 99.0 77.0 82.0 96.0 100.0 99.0 99.0 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:143.50 stddev:19.48 (13.6%) stddev-sans-first:20.40 19:32:16 INFO - PROCESS | 6365 | Values: 139.0 145.0 145.0 133.0 138.0 141.0 142.0 137.0 200.0 157.0 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:161.00 stddev:15.50 (9.6%) stddev-sans-first:16.34 19:32:16 INFO - PROCESS | 6365 | Values: 161.0 161.0 161.0 160.0 210.0 161.0 162.0 161.0 161.0 161.0 19:32:16 INFO - PROCESS | 6365 | 19:32:16 INFO - PROCESS | 6365 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:68.50 stddev:8.57 (12.5%) stddev-sans-first:8.86 19:32:16 INFO - PROCESS | 6365 | Values: 66.0 66.0 66.0 67.0 79.0 86.0 85.0 70.0 65.0 64.0 19:32:16 INFO - PROCESS | 6365 | -------- Summary: end -------- 19:32:16 INFO - PROCESS | 6365 | 19:32:17 INFO - TEST-INFO | 6365: exit 0 19:32:17 INFO - TEST-OK | kraken | took 58049ms 19:32:17 INFO - SUITE-END | took 1173s 19:32:17 INFO - Completed test suite (00:19:33) 19:32:17 INFO - javascript benchmark 19:32:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3375.578052743407, 3419.9829000855007, 3426.1948442116104, 3466.7746596471243, 3507.8421471033803, 5764.164196191549, 5850.063989761639, 5851.7074146292725, 5877.9412205877925, 5882.382349853268, 5704.800331988381, 5848.444397782215, 5852.590318677694, 5857.619254748438, 5890.116482527623, 5257.500537448946, 5274.367075950891, 5331.360236771573, 5363.383210930754, 5363.973180134094, 5250.579953603722, 5257.7108259045735, 5260.684358938457, 5379.731013449312, 5392.433794451585, 5294.391145018314, 5317.12267475866, 5320.281761962144, 5322.627416080876, 5341.839744807662, 5322.627416080876, 5347.171188465794, 5367.114426119686, 5375.354957405098, 5439.592030597721, 5174.793008279665, 5241.475852414728, 5308.840734777963, 5345.412004679482, 5351.0, 5677.630953987978, 5711.457411545896, 5717.142428635738, 5773.826785196409, 5775.27809023872, 6151.815445536641, 6195.535334849904, 6207.0379091240475, 6254.0, 6255.155554000243, 6237.968810155966, 6249.781257656005, 6287.056941458772, 6307.842303942392, 6312.873742525169, 5706.343770466408, 5796.652200867961, 5802.912956305659, 5877.294724633071, 5879.735411906389, 6402.263739669905, 6414.839629009312, 6428.325025872216, 6434.0, 6434.420902118738, 6179.104029915727, 6200.968995154995, 6205.5345849061505, 6215.502759779207, 6220.533459990428, 6147.508199344042, 6171.907421388682, 6198.318184999646, 6252.874482593177, 6269.905951410732, 6200.720967556471, 6218.31598524162, 6233.625982441068, 6282.0, 6296.150019747367, 6220.0047992321015, 6279.403456671609, 6280.748770049238, 6301.960176570906, 6303.338149494329, 4426.44669416323, 4893.339399181136, 4996.850094497098, 5012.774425150877, 5070.797168113234, 4442.600165985077, 4478.305862591304, 4503.166914120898, 4509.255972764523, 4575.496695363508, 6037.275526936795, 6054.788082417094, 6057.7879774207695, 6059.909101363483, 6063.605865618721, 6197.442230199214, 6262.592931459531, 6268.2478102627065, 6279.7488100476385, 6288.308286088527, 5827.475527202572, 5924.526037916957, 5977.342492325841, 5993.880122397528, 6116.633002019893, 5431.728413579305, 5493.505584497414, 5499.230107784913, 5514.558835293167, 5523.613347065747, 6478.773242936474, 6488.156539649815, 6504.0, 6507.251666058369, 6512.641804700692, 5143.768530416215, 6152.0, 6185.0, 6240.500759939285, 6298.401651843067, 6400.071989561395, 6478.740850365933, 6492.577982431127, 6498.350164983463, 6503.447206987459, 6266.467350275278, 6267.185265915402, 6267.373262673696, 6280.120783090462, 6288.905666414916, 6170.969145154246, 6185.721642526187, 6200.472959798468, 6211.16149319836, 6275.090111933835, 5978.551608629283, 6107.8778424430375, 6129.08063790435, 6207.472364849038, 6217.658028808459, 6183.659898705614, 6195.16365290698, 6200.689965501797, 6219.471344935731, 6233.812985610439, 5897.587168898136, 5951.55363347742, 6077.848053798691, 6086.513078953584, 6087.665178415053, 6095.908561371672, 6105.732692890381, 6124.991279909952, 6141.863755205122, 6233.470155036691, 5061.266116413026, 5953.553483488842, 6120.17377654011, 6120.908186377119, 6151.384861513813], "value": 5780.78884005511, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [484.56389249675266, 486.5645247503482, 521.7704210147534, 537.2934591012819, 538.6983289357958, 31352.529712054307, 33351.0, 42423.57576424235, 43794.781026094824, 44005.33991990123, 42038.579614203845, 45729.542704572945, 45763.542364576344, 45805.541944580546, 45810.541894581045, 9964.153046991014, 10146.695599132001, 10151.746206344864, 10155.28912976092, 10157.238207134458, 9283.25733941283, 9525.428474291564, 9819.607215711363, 12050.337231452266, 12491.0, 12373.938130309381, 12400.13199076065, 12439.813402798965, 12464.252144871336, 12480.063995200351, 12401.689957751083, 12478.43847026886, 12503.49986000559, 12505.874941250608, 12515.499380024788, 12254.877451225462, 12346.691332716753, 12363.381830908418, 12370.876291237062, 12390.690232744164, 42708.0, 42755.78622106901, 43099.353509697066, 43228.0, 43274.56725432737, 3426.8971930842113, 3471.9132021699406, 3543.539339885798, 3712.2761061593, 4007.3988901664693, 26972.0, 33040.84357047492, 33125.0, 33138.50292245618, 33574.68677170695, 3248.123300995101, 3282.4091663500562, 3326.3513614845115, 3381.0, 3490.8603655853735, 391611.0, 391763.0, 392026.0, 392470.0, 392850.0714992871, 30462.933797316986, 64356.67821660862, 64495.35504644988, 64537.35462645407, 64779.0, 31160.53259201114, 32285.838570807464, 32322.35355292881, 32322.35355292881, 32334.514982275286, 15948.2823272953, 16115.838841611669, 16120.193990300439, 16148.90064291658, 16158.0, 12325.815112773316, 13431.194128352136, 13535.255560944242, 13536.0, 13537.39081741324, 7702.8844567331535, 7842.803929901684, 7861.2531809478005, 7869.370450363957, 7870.527768333918, 3353.83230838462, 3420.110771199506, 3427.9314413712086, 3428.879989200366, 3454.861805527801, 1005.582683186484, 1023.2223510132353, 1056.2606175676904, 1131.338167172197, 1165.3648761425043, 25616.487670246865, 31388.843055784575, 31465.21336966594, 31477.527837082464, 32657.0, 836.9204925532065, 1025.2054657640388, 1034.4982683398546, 1111.9388433636227, 1119.2556949628406, 14033.0, 14685.905349280143, 16123.516294511184, 16284.592885177964, 16659.16704164787, 666525.0, 668498.3150168534, 668832.0, 676086.0, 676762.0, 62321.68839155866, 62838.68580657068, 63005.05492417618, 63012.0, 63386.049209261895, 1424.0316584722282, 1448.7754398068316, 1459.4162335065846, 1459.6204986703322, 1459.88320934325, 29997.400051999273, 30350.39299213959, 31229.68770312268, 31467.84266078655, 32099.679003210604, 53258.0, 53729.0, 53746.731266344985, 53755.731221343645, 53833.0, 473203.0, 474025.0, 475306.0, 475768.0, 476104.0, 24918.252452426455, 25274.36814079589, 27639.170824875288, 28381.290467738472, 28793.7120628791, 45702.0, 49808.501914980385, 50037.747546409366, 50617.0, 51327.743361282955, 39570.406443902786, 41349.79325103355, 41998.30651989815, 42658.78670606627, 42905.0, 41065.58934410618, 41214.58785412108, 41950.79024604979, 42119.0, 42705.78647106745, 39981.40027899526, 40610.59389406068, 40752.3887141699, 41141.0, 41187.0, 28612.856935715186, 29630.85184574063, 33178.834105829315, 36618.45072323864, 36634.45048324224, 26774.0, 26814.06150784713, 27037.729622703522, 27040.647967601148, 27096.703852196224], "value": 19501.837723773733, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.011067903081, 348.5190437196669, 362.1995390187685, 400.98396064157436, 409.7050123910783, 20245.088970996305, 21139.47151321218, 21745.456363590878, 22066.558668826634, 22252.109915603356, 12289.815652765215, 12477.376131193449, 16009.719222462205, 20667.483312917186, 21421.35735927921, 4596.264597664374, 5658.8019419320335, 5775.075987841946, 5779.190913272145, 5783.710814459281, 6113.81658550242, 6269.122322874801, 6272.466840318556, 6277.591956522834, 6283.246010478726, 5990.341062483123, 6214.720337584797, 6217.844553886144, 6239.9064014039595, 6265.404786545271, 6210.50315974721, 6250.1874756281395, 6253.374662533733, 6254.280757712876, 6261.968690156543, 5327.547158491533, 5510.8071217507195, 5545.916811247835, 5581.6371935824045, 5584.246126772915, 19028.953407562578, 26461.0, 26572.335691607863, 26740.598891016456, 26812.46375072507, 2384.8211384146084, 2399.7240317363553, 2796.175128337125, 3004.60334662305, 3065.877364905401, 14478.493252736103, 15533.0, 15852.445164419305, 15884.285207165705, 16626.75059874103, 1892.1674463236131, 1916.597514521952, 1924.4707705381131, 1978.7724411692695, 1994.6409646263812, 128924.35537822345, 128937.35531322377, 136301.0, 138864.61135388617, 140694.29652851773, 11312.547498100148, 11596.420178991186, 11850.585229516926, 11889.464974076187, 12069.462816904119, 15309.08145511273, 15324.0, 15345.539633811004, 15356.462523811613, 15391.615209619626, 7769.951056607399, 7848.411369147337, 7910.288074073361, 7944.880826787603, 7972.880406793903, 7341.265873412616, 7353.558786472829, 7369.336759691653, 7485.925140748632, 7524.661390237453, 4553.772311384418, 4581.0, 4598.540145985442, 4611.1469378164475, 4691.9530804692195, 1548.442560678155, 1892.337681811355, 1895.0, 1957.4421289932586, 1960.460873259865, 867.5922316511229, 890.283321925856, 921.1847514949318, 978.9314747967717, 1038.3406536849154, 19948.20207191696, 21466.356009319432, 21666.72457696542, 21680.674789878165, 21832.799196044052, 919.4069824962995, 924.4961495984704, 955.5699935029264, 956.0582825916466, 983.0611765763679, 9873.75315617101, 10366.844497332546, 11327.376994265394, 11328.620989592278, 11584.47869845859, 589248.0, 615789.0, 622196.0, 622505.0, 629850.0, 137189.0, 138430.0, 141984.87022694462, 144451.0, 149727.25136374249, 1009.9141572966233, 1016.1921272588162, 1038.5949479702922, 1046.2676126711333, 1046.9059832475082, 15672.981256218765, 16175.59561010937, 19533.70699439481, 19640.214391424182, 19760.0, 37417.812910935274, 51052.0, 56735.0, 58581.70709146598, 61632.0, 69439.61120777455, 80380.79428808455, 80727.59636201781, 81375.18624813676, 81857.59071204606, 7562.924370756442, 7578.621068946421, 7767.689292428239, 8100.2304781045705, 8921.420107692978, 9390.342676012613, 11046.0, 13144.40850161726, 13146.40841162169, 13871.375788089359, 11501.712457188638, 11667.124965627441, 11675.649730508097, 11927.0, 12166.087543434101, 11412.600558980395, 11550.768984620092, 11579.594714184963, 11841.0, 11978.64064078079, 10465.738356541147, 11684.532618695157, 11788.528458861549, 11877.22798018126, 11922.0, 8589.742307730778, 8703.695370661997, 8771.210591046836, 8801.163889430494, 8805.471671699719, 8669.436486628349, 10878.782424351626, 11768.529258829893, 12091.334976576372, 12147.088968327234], "value": 9822.298375445685, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.368823497074, 1394.532831501447, 1495.7382458069842, 1544.2587557972174, 1908.5991941692234, 8242.835143297138, 8651.264642505386, 8723.476591404513, 9153.862692059607, 9157.679481218158, 8986.550672466383, 9063.95468022659, 9078.319126065555, 9085.954570227139, 9086.09139086091, 2397.184957114581, 2432.416220107179, 2433.2092070077206, 2433.452473193526, 2437.0373702387546, 2390.8565486070806, 2404.0984630763464, 2415.0460568075687, 2431.586630272849, 2432.659427680126, 2162.816160626349, 2255.8984845681985, 2411.8191135664806, 2414.0102557951245, 2421.2615152378517, 2333.5449587330477, 2341.2976107167783, 2341.3210169050953, 2342.9297121086393, 2414.5653782319177, 2363.1847012780563, 2383.1420688552107, 2388.438716901544, 2399.4601214726545, 2400.819938504602, 8817.250533704642, 8986.505742184178, 9066.637334506611, 9104.499252541107, 9129.77175570616, 5363.570914326844, 5551.0, 5593.804216852432, 5603.663780173202, 5620.718964051822, 2780.33272014717, 3513.2797776456023, 3547.4324108142573, 3631.364511210528, 3647.2705458908326, 1095.5672509358837, 1110.123002827765, 1120.3222050659315, 1125.8029844777132, 1134.4384529657873, 11791.646250612495, 11893.40532973348, 12017.819732704016, 12026.27842329463, 12057.819132713017, 4792.4249090108715, 4870.0746858096845, 4931.432885218174, 5006.69959802413, 5026.4973502649445, 10449.425281609432, 10449.529771160316, 10458.111060559786, 10460.424676642857, 10477.266591338534, 5571.693556854331, 5576.358718747315, 5578.693171875505, 5583.944160558423, 5585.1901474286005, 4214.789260536961, 4453.799579018952, 4600.079984003212, 4866.7566621668775, 5021.121303771825, 3667.4865518827387, 3845.788481633481, 3961.2869683457257, 3967.3453880110037, 4104.486939132608, 1111.6665000499818, 1293.224065560656, 1316.1905428161804, 1317.328162637062, 1327.9004074694437, 916.2852974679761, 942.5852624845046, 943.5659596585648, 957.7940742740344, 993.513178542509, 5714.171445140514, 5764.654120752768, 5874.089516125007, 5945.375735547792, 6173.9073913891325, 376.8266597365243, 459.46013434214666, 462.7501149379365, 463.8724350803556, 466.4682262221071, 3933.9213215735526, 3943.901402464904, 4014.41790940312, 4028.4762980812307, 4095.9590404096175, 10656.78686426267, 10854.945725271324, 10964.56141754321, 11115.388653623966, 11137.941895519913, 10985.890141098647, 11086.16853735973, 11105.666829995112, 11111.555537778399, 11123.666290011313, 8374.706885258987, 8451.323894088458, 8552.871706924401, 8563.058063612998, 8568.057513673491, 5696.259486266758, 5755.3381361144, 5923.555733319932, 5954.315253745702, 6000.489958353589, 10168.33905796121, 10212.642557510451, 10265.665463489699, 10372.11836993864, 10392.06471417576, 9920.007999200023, 10522.0, 10571.36571805694, 10576.20678449104, 10588.99404556566, 6907.34380233877, 7118.0, 7482.289182527651, 7565.735199268, 8211.671533138608, 8340.291075258428, 8603.91396086031, 8789.34079943994, 8800.559972001502, 8801.207891289814, 6477.546571739933, 7729.265719756614, 7762.728304509315, 7778.299953004031, 7860.017497812773, 7442.516236444614, 7549.547027178387, 7621.771346859603, 7647.158812530506, 7697.422693297913, 7081.362677359062, 7236.674349654383, 7242.710291588488, 7245.891311630225, 7247.383972362408, 4576.6109880660515, 5091.389033316026, 5105.055564720538, 5145.536901678867, 5146.871328216825, 5046.84859454217, 5094.465081166424, 5205.6616319939085, 5207.3751149862255, 5276.498732620395], "value": 4584.769083757926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.50667072616835, 310.60242889101943, 316.49045037489645, 321.7409984962106, 323.495347258277, 5219.321488206532, 5301.602379821515, 5302.946970530294, 5326.786928522864, 5376.8118115865955, 4591.954080459194, 4658.883527911804, 4807.375041244633, 5109.412417571981, 5118.104331741949, 3525.7179425646013, 3711.9814400927958, 3728.0866187783963, 4073.30753771858, 4089.631933126018, 4056.6957478189106, 4067.7966101694947, 4089.6114869087387, 4108.917821643566, 4141.792910354486, 3450.9482357764655, 3890.8832735017995, 3997.9800100999455, 4050.6759459243335, 4056.9797151014204, 3220.758443116752, 4002.7598344099156, 4036.3945408189006, 4082.2856000199845, 4084.2239974404915, 3561.8041007744564, 3562.928741425183, 3571.499990001402, 3585.515955346021, 3595.658412450839, 4136.320731283236, 5116.539511443988, 5151.793928242866, 5171.276021357013, 5172.870678233075, 3896.337622604164, 4404.647628189737, 4630.583247507707, 4644.8374306899095, 4654.4647365553055, 4554.316852472122, 5413.593980451482, 5498.0, 5525.281713377275, 5546.27898373213, 3912.804359782028, 3914.471546341236, 3931.606839316074, 3935.1736135411597, 3956.188981258835, 4823.397075365579, 5688.7298747764025, 5709.942900570983, 5741.397153298927, 5829.708514574297, 3570.98214508931, 3738.8504459821847, 3975.3043217436834, 4004.439378487014, 4022.5864481311564, 3880.417937309426, 4093.053001838671, 4093.201825643971, 4120.855770048034, 4141.834326626901, 4478.171538265431, 4577.862664120082, 4619.653525985565, 4672.042231342634, 4701.0, 5487.807926722546, 5492.265259623495, 5503.724813759296, 5511.035568775528, 5519.420460851633, 1364.6042647632273, 1389.673426744714, 1401.8668226518464, 1401.927525443037, 1407.5355132806149, 819.868820988639, 868.3747701654798, 878.3017501086651, 928.2666693312343, 930.418488444722, 4780.060262938268, 4908.14094046891, 5213.843584692465, 5256.001359741636, 5265.447128051576, 5603.971980140073, 5604.019296623156, 5618.522425593788, 5621.931832951808, 5624.481390024671, 4713.835015774432, 4744.620430365562, 5211.296474975906, 5349.759260833272, 5398.838034858961, 2533.0, 2948.277671970381, 3040.2703351195996, 3042.6196725409322, 3045.680203578592, 5409.0, 5968.492678122321, 5982.222311099529, 5995.640261584319, 6007.519398448201, 4676.508966558463, 5099.6685215460875, 5668.489835914705, 5849.1226316052935, 5869.559783016291, 5447.4552544746, 5588.345535870429, 5926.0, 5940.673262970578, 5945.18671805095, 4315.525292217916, 4994.076095922121, 5502.367227768857, 5776.249087618751, 5801.926643570953, 4585.77071146448, 5725.312962444534, 5737.5983681141915, 5739.167820666064, 5759.193712880116, 4935.580475659609, 5563.635454931718, 5983.551233657406, 6014.248218972629, 6025.8852112359355, 3667.5965643779696, 3891.9805400972814, 3930.5479869814194, 3943.72393932422, 3948.4669569607736, 5306.9203961941375, 5756.510696590669, 5771.8557036074435, 5772.874289513505, 5808.157817116579, 5328.653637513549, 5686.829395118153, 5687.60186786921, 5694.266751959166, 5697.259356283656, 4749.881252968704, 4804.855854324376, 5568.888622227614, 5586.413426590149, 5601.599600099975, 5233.816816411408, 5460.754266058117, 5463.787166197696, 5466.699331536804, 5474.233607294902, 4959.603231741524, 5524.4199359068325, 5569.275994120901, 5571.220029195835, 5615.7192140392, 4682.578567928903, 4757.952420475751, 5346.359590631765, 5409.486098820606, 5503.834884953458], "value": 4093.95401220104, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.6124892558022, 725.8185453636592, 769.5575044349497, 799.0132186749363, 852.5779739029182, 16284.755728664064, 17075.316987320493, 17085.914570427132, 17096.914515427437, 17100.0, 15271.160086195256, 15366.231688415563, 15373.538793836204, 15376.23118844056, 15384.61538461539, 593.5073888672391, 702.062746233776, 714.3784907130778, 879.0594064351147, 881.2597418168737, 892.143542199486, 892.7723430525207, 906.1391677905983, 907.0929070929071, 907.6233363154283, 970.398353021128, 973.868527748752, 974.59554284972, 974.8927617962054, 976.0581039297077, 963.3641796414333, 964.599691128181, 965.8744363232735, 966.0050148347214, 967.1972263021676, 706.1843570675877, 708.4049398505229, 709.893515972603, 710.1442761472414, 710.989335159973, 15964.840351596451, 16031.599210019725, 16063.598410039725, 16072.0, 16090.678186436206, 10728.302660327132, 13615.0, 13789.310534473336, 14045.508407205802, 14267.928660356632, 11735.237209581435, 12035.277883327028, 12136.757264854654, 12469.376531173495, 13708.725825483534, 3716.2939041582013, 4005.439238506611, 4055.4119652650497, 4128.442660240859, 4152.730072545275, 121016.57966840614, 125551.74448255492, 125795.3710231443, 126141.99999999908, 127423.0, 10702.839457408145, 11041.116710663127, 11541.307521548733, 11575.942120289345, 11586.826197607043, 19005.904970475058, 23117.72852493129, 23494.177703780286, 23495.647565286534, 23517.764822351557, 6633.369829866155, 7602.657880395395, 7693.884591731128, 8243.381746369047, 8418.831623367621, 4407.559244075631, 4517.186906356887, 4649.5350464953235, 4654.325122857234, 4762.9523704763205, 3737.663610275088, 3801.581825999138, 3851.826667799956, 3857.3056849767313, 3859.710521710883, 672.4821887146967, 685.9691313890887, 687.3092541995263, 692.6571347183076, 692.840646651273, 583.1224007868216, 618.4001518527022, 640.4108220437209, 668.3316683316683, 677.7864972533636, 8225.547594882219, 8522.914770852212, 9177.816443671089, 9512.47681377517, 9536.952315238379, 645.502962718704, 671.9294474080249, 674.5042393840523, 679.4157024958532, 703.0298188499837, 4541.545845415498, 4573.49691533931, 4606.355110284563, 4610.193216187154, 4646.163690535736, 122228.0, 124340.0, 149039.0, 155265.22367388316, 163814.0, 116560.0, 121973.78026219625, 125779.0, 127993.0, 130335.34832325968, 74073.6296318515, 105222.47388763007, 105353.94646053595, 110531.0, 111462.88537114687, 9404.341696081208, 9409.952950235478, 9961.402315860782, 9971.800563988825, 10000.499975001367, 60241.69879150576, 60988.0, 62285.0, 62468.68765656143, 64133.0, 58276.0, 67799.98300025602, 71659.9838011355, 86995.69506457282, 98048.0, 13002.869971300166, 13537.781599656078, 13552.25462599527, 13679.0, 13873.861261387661, 13827.861721382658, 14627.97857028611, 14774.965752397658, 14831.703365932837, 16009.279582419053, 14460.783088253895, 14466.638334041732, 14762.261886905826, 14846.628834279229, 15358.692826143191, 12449.132630105556, 12724.427400766803, 13430.462781488632, 13977.44090236379, 14673.633159170678, 13464.798028029392, 13563.118397304144, 13619.795703064265, 14522.782158267846, 14853.628659283173, 11245.325280483197, 11666.533338666359, 11832.70418239551, 11964.102692298287, 12094.455749491119, 11614.419279036183, 11712.70718232051, 11724.509442055885, 11782.116341274268, 11835.408229588314], "value": 8004.255875231622, "unit": "score"}], "name": "dromaeo_css", "value": 7416.239453035582, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 111.0, 111.0, 112.0, 111.0, 112.0, 111.0, 110.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 107.0, 142.0, 108.0, 108.0, 110.0, 108.0, 136.0, 107.0], "value": 117.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 183.0, 181.0, 184.0, 183.0, 182.0, 184.0, 183.0, 196.0, 265.0], "value": 192.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 56.0, 58.0, 91.0, 60.0, 59.0, 59.0, 58.0, 106.0, 79.0], "value": 70.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 95.0, 69.0, 67.0, 70.0, 92.0, 68.0, 69.0, 91.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 86.0, 84.0, 86.0, 82.0, 87.0, 84.0, 85.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 105.0, 148.0, 128.0, 93.0, 93.0, 94.0, 93.0], "value": 103.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 82.0, 84.0, 84.0, 83.0, 85.0, 85.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 53.0, 52.0, 56.0, 58.0, 56.0, 57.0, 56.0, 57.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 64.0, 76.0, 72.0, 71.0, 68.0, 70.0, 73.0, 69.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 100.0, 99.0, 77.0, 82.0, 96.0, 100.0, 99.0, 99.0], "value": 94.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 145.0, 145.0, 133.0, 138.0, 141.0, 142.0, 137.0, 200.0, 157.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 210.0, 161.0, 162.0, 161.0, 161.0, 161.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 79.0, 86.0, 85.0, 70.0, 65.0, 64.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1446.5000000000002, "alertThreshold": 2.0}]} 19:32:17 INFO - Return code: 0 19:32:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:32:17 INFO - # TBPL SUCCESS # 19:32:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:32:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:32:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:32:17 INFO - 2016-11-29 19:32:17.934 screenresolution[6369:110656] starting screenresolution argv=screenresolution get 19:32:17 INFO - 2016-11-29 19:32:17.937 screenresolution[6369:110656] Display 0: 1600x1200x32@60 19:32:17 INFO - 2016-11-29 19:32:17.943 screenresolution[6370:110659] starting screenresolution argv=screenresolution list 19:32:17 INFO - Available Modes on Display 0 19:32:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:32:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:32:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:32:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:32:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:32:18 INFO - Intel Iris: 19:32:18 INFO - Chipset Model: Intel Iris 19:32:18 INFO - Type: GPU 19:32:18 INFO - Bus: Built-In 19:32:18 INFO - VRAM (Dynamic, Max): 1536 MB 19:32:18 INFO - Vendor: Intel (0x8086) 19:32:18 INFO - Device ID: 0x0a2e 19:32:18 INFO - Revision ID: 0x0009 19:32:18 INFO - Displays: 19:32:18 INFO - Display: 19:32:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:32:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:32:18 INFO - Display Serial Number: 1600x1200 60 19:32:18 INFO - Main Display: Yes 19:32:18 INFO - Mirror: Off 19:32:18 INFO - Online: Yes 19:32:18 INFO - Rotation: Supported 19:32:18 INFO - Return code: 0 19:32:18 INFO - Running post-action listener: _resource_record_post_action 19:32:18 INFO - [mozharness: 2016-11-30 03:32:18.178578Z] Finished run-tests step (success) 19:32:18 INFO - Running post-run listener: _resource_record_post_run 19:32:18 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 1612800; Write bytes: 494884864; Read time: 24; Write time: 1558 19:32:18 INFO - TinderboxPrint: CPU usage
53.1% 19:32:18 INFO - TinderboxPrint: I/O read bytes / time
1,612,800 / 24 19:32:18 INFO - TinderboxPrint: I/O write bytes / time
494,884,864 / 1,558 19:32:18 INFO - TinderboxPrint: CPU idle
2,246.6 (46.9%) 19:32:18 INFO - TinderboxPrint: CPU system
956.6 (20.0%) 19:32:18 INFO - TinderboxPrint: CPU user
1,582.5 (33.1%) 19:32:18 INFO - TinderboxPrint: Swap in / out
198,139,904 / 0 19:32:18 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192152064; Write bytes: 188901376; Read time: 17865; Write time: 391 19:32:18 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 1575936; Write bytes: 294703104; Read time: 24; Write time: 1129 19:32:18 INFO - Running post-run listener: _upload_blobber_files 19:32:18 INFO - Blob upload gear active. 19:32:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:32:18 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 19:32:18 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'] 19:32:18 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 19:32:19 INFO - (blobuploader) - INFO - Open directory for files ... 19:32:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:32:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:32:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:20 INFO - (blobuploader) - INFO - Done attempting. 19:32:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:32:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:32:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:21 INFO - (blobuploader) - INFO - Done attempting. 19:32:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:32:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:32:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:32:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:32:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:32:23 INFO - (blobuploader) - INFO - Done attempting. 19:32:23 INFO - (blobuploader) - INFO - Iteration through files over. 19:32:23 INFO - Return code: 0 19:32:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:32:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:32:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5e1ceccbdaacf9528a6b0eb0a8fdc8f4785198f8e698babcc83a2de84af9e6a7ed05b693c61037a0191237756af6f325de8f8feb5ac3ca13500ffa83b1d5aa8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c18cad94c982d3ce8ece0acd8922dcb85f1be1d0a494603a9baf10a98d669585e22188479fa4e5e4ca841db3e77ec7578895d31ab0d6200e022bf3c84072d029", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7da938b5dfe234b60d0f12ef829fbe026ff97ef7dfe373201722171c914bdedd20854e0777a7830a4acb0c7b29517bd17c55ec3415582018e3937a8e78e1653c"} 19:32:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:32:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:32:23 INFO - Contents: 19:32:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5e1ceccbdaacf9528a6b0eb0a8fdc8f4785198f8e698babcc83a2de84af9e6a7ed05b693c61037a0191237756af6f325de8f8feb5ac3ca13500ffa83b1d5aa8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c18cad94c982d3ce8ece0acd8922dcb85f1be1d0a494603a9baf10a98d669585e22188479fa4e5e4ca841db3e77ec7578895d31ab0d6200e022bf3c84072d029", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7da938b5dfe234b60d0f12ef829fbe026ff97ef7dfe373201722171c914bdedd20854e0777a7830a4acb0c7b29517bd17c55ec3415582018e3937a8e78e1653c"} 19:32:23 INFO - Running post-run listener: copy_logs_to_upload_dir 19:32:23 INFO - Copying logs to upload dir... 19:32:23 INFO - mkdir: /builds/slave/test/build/upload/logs 19:32:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.568064 ========= master_lag: 1.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-11-29 19:32:24.386504) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-11-29 19:32:24.395227) ========= 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.tCccl62Im5/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.RF8MljZQpo/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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/5e1ceccbdaacf9528a6b0eb0a8fdc8f4785198f8e698babcc83a2de84af9e6a7ed05b693c61037a0191237756af6f325de8f8feb5ac3ca13500ffa83b1d5aa8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c18cad94c982d3ce8ece0acd8922dcb85f1be1d0a494603a9baf10a98d669585e22188479fa4e5e4ca841db3e77ec7578895d31ab0d6200e022bf3c84072d029", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7da938b5dfe234b60d0f12ef829fbe026ff97ef7dfe373201722171c914bdedd20854e0777a7830a4acb0c7b29517bd17c55ec3415582018e3937a8e78e1653c"} build_url:https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011480 build_url: 'https://queue.taskcluster.net/v1/task/Vgl6GTwZSoGcwYLlE6gYog/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/5e1ceccbdaacf9528a6b0eb0a8fdc8f4785198f8e698babcc83a2de84af9e6a7ed05b693c61037a0191237756af6f325de8f8feb5ac3ca13500ffa83b1d5aa8d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c18cad94c982d3ce8ece0acd8922dcb85f1be1d0a494603a9baf10a98d669585e22188479fa4e5e4ca841db3e77ec7578895d31ab0d6200e022bf3c84072d029", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7da938b5dfe234b60d0f12ef829fbe026ff97ef7dfe373201722171c914bdedd20854e0777a7830a4acb0c7b29517bd17c55ec3415582018e3937a8e78e1653c"}' ========= master_lag: 3.58 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-11-29 19:32:27.984386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:32:27.984681) ========= 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.tCccl62Im5/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.RF8MljZQpo/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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.005510 ========= master_lag: 0.55 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:32:28.542977) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-11-29 19:32:28.543286) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-11-29 19:32:31.121962) ========= ========= Total master_lag: 5.26 =========