builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0356 starttime: 1478387733.29 results: success (0) buildid: 20161105060620 builduid: b916449ac61a4df986f58c0f4ee2b98e revision: 070cf059bb70aa991d50b4d266987adf26685915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.294047) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.294656) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.294948) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.341197) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.341447) ========= 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.1VE3BMzdrK/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.jB5ISD47Uq/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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-05 16:15:33-- 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% 18.7M=0.001s 2016-11-05 16:15:34 (18.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.800982 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:34.170457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:34.173813) ========= 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.1VE3BMzdrK/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.jB5ISD47Uq/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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.024515 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:34.226013) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-05 16:15:34.226357) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 070cf059bb70aa991d50b4d266987adf26685915 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 070cf059bb70aa991d50b4d266987adf26685915 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1VE3BMzdrK/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.jB5ISD47Uq/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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-05 16:15:34,310 truncating revision to first 12 chars 2016-11-05 16:15:34,311 Setting DEBUG logging. 2016-11-05 16:15:34,311 attempt 1/10 2016-11-05 16:15:34,311 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/070cf059bb70?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-05 16:15:35,438 unpacking tar archive at: mozilla-aurora-070cf059bb70/testing/mozharness/ program finished with exit code 0 elapsedTime=1.382109 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-05 16:15:35.632744) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:35.633025) ========= script_repo_revision: 070cf059bb70aa991d50b4d266987adf26685915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:35.633395) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:35.633666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:35.651701) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-05 16:15:35.651981) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1VE3BMzdrK/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.jB5ISD47Uq/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 16:15:35 INFO - MultiFileLogger online at 20161105 16:15:35 in /builds/slave/test 16:15:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:15:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:15:35 INFO - {'append_to_log': False, 16:15:35 INFO - 'base_work_dir': '/builds/slave/test', 16:15:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:15:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:15:35 INFO - 'branch': 'Mozilla-Aurora', 16:15:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:15:35 INFO - 'config_files': ('talos/mac_config.py',), 16:15:35 INFO - 'default_actions': ('clobber', 16:15:35 INFO - 'read-buildbot-config', 16:15:35 INFO - 'download-and-extract', 16:15:35 INFO - 'populate-webroot', 16:15:35 INFO - 'create-virtualenv', 16:15:35 INFO - 'install', 16:15:35 INFO - 'run-tests'), 16:15:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:15:35 INFO - 'download_minidump_stackwalk': True, 16:15:35 INFO - 'download_symbols': 'ondemand', 16:15:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:15:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:15:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:15:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:15:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:15:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:15:35 INFO - 'installer_path': 'installer.exe', 16:15:35 INFO - 'log_level': 'info', 16:15:35 INFO - 'log_name': 'talos', 16:15:35 INFO - 'log_to_console': True, 16:15:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:15:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:15:35 INFO - 'opt_config_files': (), 16:15:35 INFO - 'pip_index': False, 16:15:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:15:35 INFO - 'cmd': ('bash', 16:15:35 INFO - '-c', 16:15:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:15:35 INFO - 'enabled': True, 16:15:35 INFO - 'halt_on_failure': False, 16:15:35 INFO - 'name': 'check_screen_resolution'},), 16:15:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:15:35 INFO - 'cmd': ('bash', 16:15:35 INFO - '-c', 16:15:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:15:35 INFO - 'enabled': True, 16:15:35 INFO - 'halt_on_failure': False, 16:15:35 INFO - 'name': 'check_screen_resolution'},), 16:15:35 INFO - 'run_cmd_checks_enabled': True, 16:15:35 INFO - 'sps_profile': False, 16:15:35 INFO - 'sps_profile_interval': 0, 16:15:35 INFO - 'suite': 'dromaeojs-e10s', 16:15:35 INFO - 'system_bits': '32', 16:15:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:15:35 INFO - 'title': 't-yosemite-r7-0356', 16:15:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:15:35 INFO - 'use_talos_json': True, 16:15:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:15:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:15:35 INFO - 'work_dir': 'build'} 16:15:35 INFO - [mozharness: 2016-11-05 23:15:35.847526Z] Running clobber step. 16:15:35 INFO - Running pre-action listener: _resource_record_pre_action 16:15:35 INFO - Running main action method: clobber 16:15:35 INFO - rmtree: /builds/slave/test/build 16:15:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:15:38 INFO - Running post-action listener: _resource_record_post_action 16:15:38 INFO - [mozharness: 2016-11-05 23:15:38.214040Z] Finished clobber step (success) 16:15:38 INFO - [mozharness: 2016-11-05 23:15:38.214188Z] Running read-buildbot-config step. 16:15:38 INFO - Running pre-action listener: _resource_record_pre_action 16:15:38 INFO - Running main action method: read_buildbot_config 16:15:38 INFO - Using buildbot properties: 16:15:38 INFO - { 16:15:38 INFO - "project": "", 16:15:38 INFO - "product": "firefox", 16:15:38 INFO - "script_repo_revision": "production", 16:15:38 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 16:15:38 INFO - "repository": "", 16:15:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 16:15:38 INFO - "buildid": "20161105060620", 16:15:38 INFO - "pgo_build": "False", 16:15:38 INFO - "basedir": "/builds/slave/test", 16:15:38 INFO - "buildnumber": 8, 16:15:38 INFO - "slavename": "t-yosemite-r7-0356", 16:15:38 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 16:15:38 INFO - "platform": "yosemite_r7", 16:15:38 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:15:38 INFO - "branch": "mozilla-aurora", 16:15:38 INFO - "repo_path": "releases/mozilla-aurora", 16:15:38 INFO - "revision": "070cf059bb70aa991d50b4d266987adf26685915", 16:15:38 INFO - "stage_platform": "macosx64", 16:15:38 INFO - "builduid": "b916449ac61a4df986f58c0f4ee2b98e", 16:15:38 INFO - "slavebuilddir": "test" 16:15:38 INFO - } 16:15:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 16:15:38 INFO - Running post-action listener: _resource_record_post_action 16:15:38 INFO - [mozharness: 2016-11-05 23:15:38.217335Z] Finished read-buildbot-config step (success) 16:15:38 INFO - [mozharness: 2016-11-05 23:15:38.217446Z] Running download-and-extract step. 16:15:38 INFO - Running pre-action listener: _resource_record_pre_action 16:15:38 INFO - Running main action method: download_and_extract 16:15:38 INFO - mkdir: /builds/slave/test/build/tests 16:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:38 INFO - trying https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 16:15:38 INFO - Downloading https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:15:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 16:15:39 INFO - Downloaded 1199 bytes. 16:15:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 16:15:39 INFO - Using the following test package requirements: 16:15:39 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:15:39 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:39 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 16:15:39 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:39 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 16:15:39 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:39 INFO - u'jsshell-mac.zip'], 16:15:39 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:39 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 16:15:39 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 16:15:39 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:39 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 16:15:39 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:39 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 16:15:39 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:39 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 16:15:39 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 16:15:39 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 16:15:39 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:15:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:15:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:15:39 INFO - Fetch https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:15:39 INFO - Expected file size: 16421523 16:15:46 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:15:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 16:15:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:15:46 INFO - Fetch https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 16:15:47 INFO - Expected file size: 16421523 16:15:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 16:15:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:15:53 INFO - Fetch https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 16:15:55 INFO - Expected file size: 14414089 16:15:55 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')]} 16:15:55 INFO - trying https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:15:55 INFO - Downloading https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 16:15:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 16:15:58 INFO - Downloaded 115457788 bytes. 16:15:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:15:58 INFO - mkdir: /builds/slave/test/properties 16:15:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:15:58 INFO - Writing to file /builds/slave/test/properties/build_url 16:15:58 INFO - Contents: 16:15:58 INFO - build_url:https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 16:15:59 INFO - Running post-action listener: _resource_record_post_action 16:15:59 INFO - Running post-action listener: set_extra_try_arguments 16:15:59 INFO - [mozharness: 2016-11-05 23:15:59.382920Z] Finished download-and-extract step (success) 16:15:59 INFO - [mozharness: 2016-11-05 23:15:59.383041Z] Running populate-webroot step. 16:15:59 INFO - Running pre-action listener: _resource_record_pre_action 16:15:59 INFO - Running main action method: populate_webroot 16:15:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:15:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:15:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:15:59 INFO - '--tppagecycles', 16:15:59 INFO - '7'], 16:15:59 INFO - 'tests': ['tsvgm']}}, 16:15:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:15:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:15:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:15:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:15:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['damp', 'tps']}, 16:15:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'tests': ['damp', 'tps']}, 16:15:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['dromaeo_dom']}, 16:15:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:15:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['basic_compositor_video']}, 16:15:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:15:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['a11yr', 16:15:59 INFO - 'ts_paint', 16:15:59 INFO - 'tpaint', 16:15:59 INFO - 'sessionrestore', 16:15:59 INFO - 'sessionrestore_no_auto_restore', 16:15:59 INFO - 'tabpaint']}, 16:15:59 INFO - 'other-e10s': {'tests': ['a11yr', 16:15:59 INFO - 'ts_paint', 16:15:59 INFO - 'tpaint', 16:15:59 INFO - 'sessionrestore', 16:15:59 INFO - 'sessionrestore_no_auto_restore', 16:15:59 INFO - 'tabpaint']}, 16:15:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:15:59 INFO - 'ts_paint', 16:15:59 INFO - 'tpaint', 16:15:59 INFO - 'sessionrestore', 16:15:59 INFO - 'sessionrestore_no_auto_restore', 16:15:59 INFO - 'tabpaint']}, 16:15:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:15:59 INFO - 'ts_paint', 16:15:59 INFO - 'tpaint', 16:15:59 INFO - 'sessionrestore', 16:15:59 INFO - 'sessionrestore_no_auto_restore', 16:15:59 INFO - 'tabpaint']}, 16:15:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['a11yr', 16:15:59 INFO - 'ts_paint', 16:15:59 INFO - 'tpaint', 16:15:59 INFO - 'sessionrestore', 16:15:59 INFO - 'sessionrestore_no_auto_restore', 16:15:59 INFO - 'tabpaint']}, 16:15:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['a11yr', 16:15:59 INFO - 'ts_paint', 16:15:59 INFO - 'tpaint', 16:15:59 INFO - 'sessionrestore', 16:15:59 INFO - 'sessionrestore_no_auto_restore', 16:15:59 INFO - 'tabpaint']}, 16:15:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['tsvgx', 16:15:59 INFO - 'tsvgr_opacity', 16:15:59 INFO - 'tart', 16:15:59 INFO - 'tscrollx', 16:15:59 INFO - 'cart']}, 16:15:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:15:59 INFO - 'tsvgr_opacity', 16:15:59 INFO - 'tart', 16:15:59 INFO - 'tscrollx', 16:15:59 INFO - 'cart']}, 16:15:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'talos_options': ['--disable-e10s'], 16:15:59 INFO - 'tests': ['tp5o']}, 16:15:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'tests': ['tp5o']}, 16:15:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'talos_options': ['--disable-e10s', 16:15:59 INFO - '--xperf_path', 16:15:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:59 INFO - 'tests': ['tp5n']}, 16:15:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:59 INFO - 'talos_options': ['--xperf_path', 16:15:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:59 INFO - 'tests': ['tp5n']}}, 16:15:59 INFO - 'talos.zip': {'path': '', 16:15:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:15:59 INFO - Running post-action listener: _resource_record_post_action 16:15:59 INFO - [mozharness: 2016-11-05 23:15:59.402029Z] Finished populate-webroot step (success) 16:15:59 INFO - [mozharness: 2016-11-05 23:15:59.402159Z] Running create-virtualenv step. 16:15:59 INFO - Running pre-action listener: _resource_record_pre_action 16:15:59 INFO - Running main action method: create_virtualenv 16:15:59 INFO - Creating virtualenv /builds/slave/test/build/venv 16:15:59 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 16:15:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:15:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:15:59 INFO - Using real prefix '/tools/python27' 16:15:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:16:00 INFO - Installing distribute.............................................................................................................................................................................................done. 16:16:03 INFO - Installing pip.................done. 16:16:03 INFO - Return code: 0 16:16:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106df6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00d7e420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0ad30>, '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 0x106a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c02b20>, '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.1VE3BMzdrK/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.jB5ISD47Uq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 16:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1VE3BMzdrK/Render', 16:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:03 INFO - 'HOME': '/Users/cltbld', 16:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:03 INFO - 'LOGNAME': 'cltbld', 16:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:03 INFO - 'MOZ_NO_REMOTE': '1', 16:16:03 INFO - 'NO_EM_RESTART': '1', 16:16:03 INFO - 'PAGER': '/bin/cat', 16:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:03 INFO - 'PWD': '/builds/slave/test', 16:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:03 INFO - 'SHELL': '/bin/bash', 16:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB5ISD47Uq/Listeners', 16:16:03 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 16:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:03 INFO - 'USER': 'cltbld', 16:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:03 INFO - 'XPC_FLAGS': '0x0', 16:16:03 INFO - 'XPC_SERVICE_NAME': '0', 16:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:03 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 16:16:03 INFO - Cleaning up... 16:16:03 INFO - Return code: 0 16:16:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106df6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00d7e420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0ad30>, '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 0x106a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c02b20>, '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.1VE3BMzdrK/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.jB5ISD47Uq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 16:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1VE3BMzdrK/Render', 16:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:03 INFO - 'HOME': '/Users/cltbld', 16:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:03 INFO - 'LOGNAME': 'cltbld', 16:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:03 INFO - 'MOZ_NO_REMOTE': '1', 16:16:03 INFO - 'NO_EM_RESTART': '1', 16:16:03 INFO - 'PAGER': '/bin/cat', 16:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:03 INFO - 'PWD': '/builds/slave/test', 16:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:03 INFO - 'SHELL': '/bin/bash', 16:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB5ISD47Uq/Listeners', 16:16:03 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 16:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:03 INFO - 'USER': 'cltbld', 16:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:03 INFO - 'XPC_FLAGS': '0x0', 16:16:03 INFO - 'XPC_SERVICE_NAME': '0', 16:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:03 INFO - Downloading/unpacking psutil>=3.1.1 16:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:16:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:06 INFO - Installing collected packages: psutil 16:16:06 INFO - Running setup.py install for psutil 16:16:06 INFO - building 'psutil._psutil_osx' extension 16:16:06 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 16:16:07 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 16:16:07 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 16:16:07 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 16:16:07 INFO - building 'psutil._psutil_posix' extension 16:16:07 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 16:16:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:16:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:16:07 INFO - ^ 16:16:07 INFO - 1 warning generated. 16:16:07 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 16:16:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:07 INFO - Successfully installed psutil 16:16:07 INFO - Cleaning up... 16:16:07 INFO - Return code: 0 16:16:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:16:07 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')]} 16:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:07 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')]} 16:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:07 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 0x106df6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00d7e420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0ad30>, '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 0x106a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c02b20>, '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.1VE3BMzdrK/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.jB5ISD47Uq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 16:16:07 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 16:16:07 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 16:16:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1VE3BMzdrK/Render', 16:16:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:07 INFO - 'HOME': '/Users/cltbld', 16:16:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:07 INFO - 'LOGNAME': 'cltbld', 16:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:07 INFO - 'MOZ_NO_REMOTE': '1', 16:16:07 INFO - 'NO_EM_RESTART': '1', 16:16:07 INFO - 'PAGER': '/bin/cat', 16:16:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:07 INFO - 'PWD': '/builds/slave/test', 16:16:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:07 INFO - 'SHELL': '/bin/bash', 16:16:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB5ISD47Uq/Listeners', 16:16:07 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 16:16:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:07 INFO - 'USER': 'cltbld', 16:16:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:07 INFO - 'XPC_FLAGS': '0x0', 16:16:07 INFO - 'XPC_SERVICE_NAME': '0', 16:16:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:16:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:16:11 INFO - Installing collected packages: mozsystemmonitor 16:16:11 INFO - Running setup.py install for mozsystemmonitor 16:16:11 INFO - Successfully installed mozsystemmonitor 16:16:11 INFO - Cleaning up... 16:16:12 INFO - Return code: 0 16:16:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:16:12 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')]} 16:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:12 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')]} 16:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:12 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 0x106df6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00d7e420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0ad30>, '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 0x106a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c02b20>, '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.1VE3BMzdrK/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.jB5ISD47Uq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 16:16:12 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 16:16:12 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 16:16:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1VE3BMzdrK/Render', 16:16:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:12 INFO - 'HOME': '/Users/cltbld', 16:16:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:12 INFO - 'LOGNAME': 'cltbld', 16:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:12 INFO - 'MOZ_NO_REMOTE': '1', 16:16:12 INFO - 'NO_EM_RESTART': '1', 16:16:12 INFO - 'PAGER': '/bin/cat', 16:16:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:12 INFO - 'PWD': '/builds/slave/test', 16:16:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:12 INFO - 'SHELL': '/bin/bash', 16:16:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB5ISD47Uq/Listeners', 16:16:12 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 16:16:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:12 INFO - 'USER': 'cltbld', 16:16:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:12 INFO - 'XPC_FLAGS': '0x0', 16:16:12 INFO - 'XPC_SERVICE_NAME': '0', 16:16:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:12 INFO - Downloading/unpacking jsonschema==2.5.1 16:16:12 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 16:16:12 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 16:16:12 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 16:16:12 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 16:16:12 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 16:16:12 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 16:16:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:16:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:15 INFO - Downloading functools32-3.2.3-2.tar.gz 16:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:16:15 INFO - warning: no files found matching '*.txt' 16:16:15 INFO - no previously-included directories found matching 'build' 16:16:15 INFO - no previously-included directories found matching 'dist' 16:16:15 INFO - no previously-included directories found matching '.git*' 16:16:15 INFO - Installing collected packages: jsonschema, functools32 16:16:15 INFO - Running setup.py install for functools32 16:16:15 INFO - warning: no files found matching '*.txt' 16:16:15 INFO - no previously-included directories found matching 'build' 16:16:15 INFO - no previously-included directories found matching 'dist' 16:16:15 INFO - no previously-included directories found matching '.git*' 16:16:15 INFO - Successfully installed jsonschema functools32 16:16:15 INFO - Cleaning up... 16:16:15 INFO - Return code: 0 16:16:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:16: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')]} 16:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:15 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 0x106df6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00d7e420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0ad30>, '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 0x106a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c02b20>, '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.1VE3BMzdrK/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.jB5ISD47Uq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 16:16:15 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 16:16:15 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 16:16:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1VE3BMzdrK/Render', 16:16:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:15 INFO - 'HOME': '/Users/cltbld', 16:16:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:15 INFO - 'LOGNAME': 'cltbld', 16:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:15 INFO - 'MOZ_NO_REMOTE': '1', 16:16:15 INFO - 'NO_EM_RESTART': '1', 16:16:15 INFO - 'PAGER': '/bin/cat', 16:16:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:15 INFO - 'PWD': '/builds/slave/test', 16:16:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:15 INFO - 'SHELL': '/bin/bash', 16:16:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB5ISD47Uq/Listeners', 16:16:15 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 16:16:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:15 INFO - 'USER': 'cltbld', 16:16:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:15 INFO - 'XPC_FLAGS': '0x0', 16:16:15 INFO - 'XPC_SERVICE_NAME': '0', 16:16:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:16:16 INFO - Cleaning up... 16:16:16 INFO - Return code: 0 16:16:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:16:16 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')]} 16:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:16 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')]} 16:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:16 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 0x106df6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00d7e420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0ad30>, '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 0x106a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c02b20>, '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.1VE3BMzdrK/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.jB5ISD47Uq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 16:16:16 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 16:16:16 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 16:16:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1VE3BMzdrK/Render', 16:16:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:16 INFO - 'HOME': '/Users/cltbld', 16:16:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:16 INFO - 'LOGNAME': 'cltbld', 16:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:16 INFO - 'MOZ_NO_REMOTE': '1', 16:16:16 INFO - 'NO_EM_RESTART': '1', 16:16:16 INFO - 'PAGER': '/bin/cat', 16:16:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:16 INFO - 'PWD': '/builds/slave/test', 16:16:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:16 INFO - 'SHELL': '/bin/bash', 16:16:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB5ISD47Uq/Listeners', 16:16:16 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 16:16:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:16 INFO - 'USER': 'cltbld', 16:16:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:16 INFO - 'XPC_FLAGS': '0x0', 16:16:16 INFO - 'XPC_SERVICE_NAME': '0', 16:16:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:16 INFO - Downloading/unpacking blobuploader==1.2.4 16:16:16 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 16:16:16 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 16:16:16 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 16:16:16 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 16:16:16 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 16:16:16 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 16:16:18 INFO - Downloading blobuploader-1.2.4.tar.gz 16:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:16:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:16:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:20 INFO - Downloading docopt-0.6.1.tar.gz 16:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:16:20 INFO - Installing collected packages: blobuploader, requests, docopt 16:16:20 INFO - Running setup.py install for blobuploader 16:16:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:16:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:16:20 INFO - Running setup.py install for requests 16:16:20 INFO - Running setup.py install for docopt 16:16:21 INFO - Successfully installed blobuploader requests docopt 16:16:21 INFO - Cleaning up... 16:16:21 INFO - Return code: 0 16:16:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:21 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')]} 16:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:21 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')]} 16:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:21 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 0x106df6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00d7e420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0ad30>, '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 0x106a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c02b20>, '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.1VE3BMzdrK/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.jB5ISD47Uq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 16:16:21 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 16:16:21 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 16:16:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1VE3BMzdrK/Render', 16:16:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:21 INFO - 'HOME': '/Users/cltbld', 16:16:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:21 INFO - 'LOGNAME': 'cltbld', 16:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:21 INFO - 'MOZ_NO_REMOTE': '1', 16:16:21 INFO - 'NO_EM_RESTART': '1', 16:16:21 INFO - 'PAGER': '/bin/cat', 16:16:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:21 INFO - 'PWD': '/builds/slave/test', 16:16:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:21 INFO - 'SHELL': '/bin/bash', 16:16:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB5ISD47Uq/Listeners', 16:16:21 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 16:16:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:21 INFO - 'USER': 'cltbld', 16:16:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:21 INFO - 'XPC_FLAGS': '0x0', 16:16:21 INFO - 'XPC_SERVICE_NAME': '0', 16:16:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:21 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-inFWot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:21 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-wGVXkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:21 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-S2suiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:21 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-ylq5im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:21 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-RILg48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:21 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-_JiAV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-5rB3GJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-qK7P7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-mKTFSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-kAQ9Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-amsEw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-8L0y4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-kHPOZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-lcTXK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-EOGt_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:22 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-Xqqdo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:23 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-61Mz8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:16:23 INFO - Running setup.py install for manifestparser 16:16:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Running setup.py install for mozcrash 16:16:23 INFO - Running setup.py install for mozdebug 16:16:23 INFO - Running setup.py install for mozdevice 16:16:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Running setup.py install for mozfile 16:16:23 INFO - Running setup.py install for mozhttpd 16:16:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Running setup.py install for mozinfo 16:16:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Running setup.py install for mozInstall 16:16:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Running setup.py install for mozleak 16:16:24 INFO - Running setup.py install for mozlog 16:16:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Running setup.py install for moznetwork 16:16:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Running setup.py install for mozprocess 16:16:24 INFO - Running setup.py install for mozprofile 16:16:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:16:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:16:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:16:25 INFO - Running setup.py install for mozrunner 16:16:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:16:25 INFO - Running setup.py install for mozscreenshot 16:16:25 INFO - Running setup.py install for moztest 16:16:25 INFO - Running setup.py install for mozversion 16:16:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:16:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:16:25 INFO - Cleaning up... 16:16:25 INFO - Return code: 0 16:16:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:25 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 0x106df6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00d7e420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0ad30>, '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 0x106a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c02b20>, '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.1VE3BMzdrK/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.jB5ISD47Uq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 16:16:25 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 16:16:25 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 16:16:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1VE3BMzdrK/Render', 16:16:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:25 INFO - 'HOME': '/Users/cltbld', 16:16:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:25 INFO - 'LOGNAME': 'cltbld', 16:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:25 INFO - 'MOZ_NO_REMOTE': '1', 16:16:25 INFO - 'NO_EM_RESTART': '1', 16:16:25 INFO - 'PAGER': '/bin/cat', 16:16:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:25 INFO - 'PWD': '/builds/slave/test', 16:16:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:25 INFO - 'SHELL': '/bin/bash', 16:16:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB5ISD47Uq/Listeners', 16:16:25 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 16:16:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:25 INFO - 'USER': 'cltbld', 16:16:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:25 INFO - 'XPC_FLAGS': '0x0', 16:16:25 INFO - 'XPC_SERVICE_NAME': '0', 16:16:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:26 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-HlwUQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:26 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)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:26 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-ZppDoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:26 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)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:26 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-qtpsLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:26 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)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:26 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-HFkbE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:26 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)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:26 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-zzymJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:26 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)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:26 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-iRBQEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:26 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)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:26 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-rDboYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:26 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)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:26 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-DCjR58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:26 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)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:26 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-GgUfMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:26 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)) 16:16:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:26 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-4u90Dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:27 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)) 16:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:27 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-zbgnnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:27 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)) 16:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:27 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-aUSVtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:27 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)) 16:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:27 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-_p6R9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:27 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)) 16:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:27 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-3Vsi2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:27 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)) 16:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:27 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-2FDkpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:27 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)) 16:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:27 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-QE_p1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:27 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)) 16:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:27 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-Vvf1Jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:27 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)) 16:16:27 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)) 16:16:27 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)) 16:16:27 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)) 16:16:27 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)) 16:16:27 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)) 16:16:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:16:27 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 16:16:27 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 16:16:27 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 16:16:27 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 16:16:27 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 16:16:27 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 16:16:30 INFO - Downloading blessings-1.6.tar.gz 16:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:16:30 INFO - Installing collected packages: blessings 16:16:30 INFO - Running setup.py install for blessings 16:16:30 INFO - Successfully installed blessings 16:16:30 INFO - Cleaning up... 16:16:30 INFO - Return code: 0 16:16:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:16:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:30 INFO - Reading from file tmpfile_stdout 16:16:30 INFO - Current package versions: 16:16:30 INFO - blessings == 1.6 16:16:30 INFO - blobuploader == 1.2.4 16:16:30 INFO - docopt == 0.6.1 16:16:30 INFO - functools32 == 3.2.3-2 16:16:30 INFO - jsonschema == 2.5.1 16:16:30 INFO - manifestparser == 1.1 16:16:30 INFO - mozInstall == 1.12 16:16:30 INFO - mozcrash == 0.17 16:16:30 INFO - mozdebug == 0.1 16:16:30 INFO - mozdevice == 0.48 16:16:30 INFO - mozfile == 1.2 16:16:30 INFO - mozhttpd == 0.7 16:16:30 INFO - mozinfo == 0.9 16:16:30 INFO - mozleak == 0.1 16:16:30 INFO - mozlog == 3.4 16:16:30 INFO - moznetwork == 0.27 16:16:30 INFO - mozprocess == 0.23 16:16:30 INFO - mozprofile == 0.28 16:16:30 INFO - mozrunner == 6.12 16:16:30 INFO - mozscreenshot == 0.1 16:16:30 INFO - mozsystemmonitor == 0.3 16:16:30 INFO - moztest == 0.7 16:16:30 INFO - mozversion == 1.4 16:16:30 INFO - psutil == 3.1.1 16:16:30 INFO - requests == 1.2.3 16:16:30 INFO - wsgiref == 0.1.2 16:16:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:30 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 0x106df6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00d7e420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0ad30>, '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 0x106a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c02b20>, '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.1VE3BMzdrK/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.jB5ISD47Uq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 16:16:30 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 16:16:30 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 16:16:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1VE3BMzdrK/Render', 16:16:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:30 INFO - 'HOME': '/Users/cltbld', 16:16:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:30 INFO - 'LOGNAME': 'cltbld', 16:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:30 INFO - 'MOZ_NO_REMOTE': '1', 16:16:30 INFO - 'NO_EM_RESTART': '1', 16:16:30 INFO - 'PAGER': '/bin/cat', 16:16:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:30 INFO - 'PWD': '/builds/slave/test', 16:16:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:30 INFO - 'SHELL': '/bin/bash', 16:16:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB5ISD47Uq/Listeners', 16:16:30 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 16:16:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:30 INFO - 'USER': 'cltbld', 16:16:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:30 INFO - 'XPC_FLAGS': '0x0', 16:16:30 INFO - 'XPC_SERVICE_NAME': '0', 16:16:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 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)) 16:16:31 INFO - Cleaning up... 16:16:31 INFO - Return code: 0 16:16:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106df6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d6c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe00d7e420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106c0ad30>, '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 0x106a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c02b20>, '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.1VE3BMzdrK/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.jB5ISD47Uq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 16:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:16:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1VE3BMzdrK/Render', 16:16:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:31 INFO - 'HOME': '/Users/cltbld', 16:16:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:31 INFO - 'LOGNAME': 'cltbld', 16:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:31 INFO - 'MOZ_NO_REMOTE': '1', 16:16:31 INFO - 'NO_EM_RESTART': '1', 16:16:31 INFO - 'PAGER': '/bin/cat', 16:16:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:31 INFO - 'PWD': '/builds/slave/test', 16:16:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:31 INFO - 'SHELL': '/bin/bash', 16:16:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB5ISD47Uq/Listeners', 16:16:31 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 16:16:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:31 INFO - 'USER': 'cltbld', 16:16:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:31 INFO - 'XPC_FLAGS': '0x0', 16:16:31 INFO - 'XPC_SERVICE_NAME': '0', 16:16:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:16:31 INFO - Cleaning up... 16:16:31 INFO - Return code: 0 16:16:31 INFO - Running post-action listener: _resource_record_post_action 16:16:31 INFO - Running post-action listener: _start_resource_monitoring 16:16:31 INFO - Starting resource monitoring. 16:16:31 INFO - [mozharness: 2016-11-05 23:16:31.562704Z] Finished create-virtualenv step (success) 16:16:31 INFO - [mozharness: 2016-11-05 23:16:31.563710Z] Running install step. 16:16:31 INFO - Running pre-action listener: _resource_record_pre_action 16:16:31 INFO - Running main action method: install 16:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:31 INFO - Reading from file tmpfile_stdout 16:16:31 INFO - Detecting whether we're running mozinstall >=1.0... 16:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:16:31 INFO - Reading from file tmpfile_stdout 16:16:31 INFO - Output received: 16:16:31 INFO - Usage: mozinstall [options] installer 16:16:31 INFO - Options: 16:16:31 INFO - -h, --help show this help message and exit 16:16:31 INFO - -d DEST, --destination=DEST 16:16:31 INFO - Directory to install application into. [default: 16:16:31 INFO - "/builds/slave/test"] 16:16:31 INFO - --app=APP Application being installed. [default: firefox] 16:16:31 INFO - mkdir: /builds/slave/test/build/application 16:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:17:03 INFO - Reading from file tmpfile_stdout 16:17:03 INFO - Output received: 16:17:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:17:03 INFO - Running post-action listener: _resource_record_post_action 16:17:03 INFO - [mozharness: 2016-11-05 23:17:03.656476Z] Finished install step (success) 16:17:03 INFO - [mozharness: 2016-11-05 23:17:03.656619Z] Running run-tests step. 16:17:03 INFO - Running pre-action listener: _resource_record_pre_action 16:17:03 INFO - Running main action method: run_tests 16:17:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:17:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:17:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:17:03 INFO - 2016-11-05 16:17:03.670 screenresolution[1654:14069] starting screenresolution argv=screenresolution get 16:17:03 INFO - 2016-11-05 16:17:03.673 screenresolution[1654:14069] Display 0: 1600x1200x32@60 16:17:03 INFO - 2016-11-05 16:17:03.679 screenresolution[1655:14071] starting screenresolution argv=screenresolution list 16:17:03 INFO - Available Modes on Display 0 16:17:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:17:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:17:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:17:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:17:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:17:03 INFO - Intel Iris: 16:17:03 INFO - Chipset Model: Intel Iris 16:17:03 INFO - Type: GPU 16:17:03 INFO - Bus: Built-In 16:17:03 INFO - VRAM (Dynamic, Max): 1536 MB 16:17:03 INFO - Vendor: Intel (0x8086) 16:17:03 INFO - Device ID: 0x0a2e 16:17:03 INFO - Revision ID: 0x0009 16:17:03 INFO - Displays: 16:17:03 INFO - Display: 16:17:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:17:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:17:03 INFO - Display Serial Number: 1600x1200 60 16:17:03 INFO - Main Display: Yes 16:17:03 INFO - Mirror: Off 16:17:03 INFO - Online: Yes 16:17:03 INFO - Rotation: Supported 16:17:03 INFO - Return code: 0 16:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:17:03 INFO - Python 2.7.3 16:17:03 INFO - Return code: 0 16:17:03 INFO - grabbing minidump binary from tooltool 16:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:17:03 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 0x106c0ad30>, '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 0x106a70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106c02b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:17:03 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 16:17:03 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 16:17:03 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 16:17:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:17:04 INFO - Return code: 0 16:17:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:17:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:17:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:17:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:17:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0356', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0356 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1VE3BMzdrK/Render', 16:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:17:04 INFO - 'HOME': '/Users/cltbld', 16:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:17:04 INFO - 'LOGNAME': 'cltbld', 16:17:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:17:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:04 INFO - 'MOZ_NO_REMOTE': '1', 16:17:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:17:04 INFO - 'NO_EM_RESTART': '1', 16:17:04 INFO - 'PAGER': '/bin/cat', 16:17:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:04 INFO - 'PWD': '/builds/slave/test', 16:17:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:17:04 INFO - 'SHELL': '/bin/bash', 16:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jB5ISD47Uq/Listeners', 16:17:04 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 16:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:17:04 INFO - 'USER': 'cltbld', 16:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:04 INFO - 'XPC_FLAGS': '0x0', 16:17:04 INFO - 'XPC_SERVICE_NAME': '0', 16:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:17:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0356', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:17:04 INFO - mozversion application_buildid: 20161105060620 16:17:04 INFO - mozversion application_changeset: 070cf059bb70aa991d50b4d266987adf26685915 16:17:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:17:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:17:04 INFO - mozversion application_name: Firefox 16:17:04 INFO - mozversion application_remotingname: firefox-dev 16:17:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:17:04 INFO - mozversion application_vendor: Mozilla 16:17:04 INFO - mozversion application_version: 51.0a2 16:17:04 INFO - mozversion platform_buildid: 20161105060620 16:17:04 INFO - mozversion platform_changeset: 070cf059bb70aa991d50b4d266987adf26685915 16:17:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:17:04 INFO - mozversion platform_version: 51.0a2 16:17:04 INFO - using testdate: 1478387824 16:17:04 INFO - actual date: 1478387824 16:17:04 INFO - starting webserver on 'localhost:49273' 16:17:04 INFO - SUITE-START | Running 2 tests 16:17:04 INFO - TEST-START | dromaeo_css 16:17:04 INFO - operating with platform_type : mac_ 16:17:04 INFO - Initialising browser for dromaeo_css test... 16:17:04 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpOeEfAx/profile http://localhost:49273/getInfo.html) 16:17:07 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 16:17:07 INFO - PROCESS | 1665 | colorDepth:24 16:17:07 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 16:17:07 INFO - PROCESS | 1665 | __metrics 16:17:07 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 16:17:08 INFO - TEST-INFO | 1665: exit 0 16:17:08 INFO - Browser initialized. 16:17:08 INFO - Running cycle 1/1 for dromaeo_css test... 16:17:08 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpOeEfAx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:17:20 INFO - PROCESS | 1669 | RSS: Main: 225406976 16:17:20 INFO - PROCESS | 1669 | 16:18:09 INFO - PROCESS | 1669 | 1478387889819 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] 16:20:22 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 16:20:23 INFO - PROCESS | 1669 | RSS: Main: 237101056 16:20:23 INFO - PROCESS | 1669 | 16:23:26 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 16:23:26 INFO - PROCESS | 1669 | RSS: Main: 248602624 16:23:26 INFO - PROCESS | 1669 | 16:26:28 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 16:26:29 INFO - PROCESS | 1669 | RSS: Main: 251592704 16:26:29 INFO - PROCESS | 1669 | 16:29:31 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 16:29:31 INFO - PROCESS | 1669 | RSS: Main: 251736064 16:29:31 INFO - PROCESS | 1669 | 16:32:34 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 16:32:35 INFO - PROCESS | 1669 | RSS: Main: 256253952 16:32:35 INFO - PROCESS | 1669 | 16:35:37 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 16:35:38 INFO - PROCESS | 1669 | RSS: Main: 257966080 16:35:38 INFO - PROCESS | 1669 | 16:35:38 INFO - PROCESS | 1669 | __start_tp_report 16:35:38 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 16:35:38 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 16:35:38 INFO - PROCESS | 1669 | |i|pagename|runs| 16:35:38 INFO - PROCESS | 1669 | |0;dojo.html;3473.9999999999986;3487.232808782069;3504.5794504659443;3528.7177025837937;3539.628339024402;5905.5570832187595;5993.041113421853;6001.399860013997;6008.218931538894;6021.698915054246;5926.466618004379;5977.611455255416;6026.3371029186865;6037.818865434033;6050.909236361458;5382.192671099337;5409.972950135244;5418.268533747933;5487.945120548783;5556;5456.945430545684;5483.287172667568;5484.670919744828;5488.957098151339;5497.752601132938;5311.760970756306;5366.382865970424;5476.616636835403;5497.972510137443;5516.227728118067;4577.885552861188;5400;5409.513143817076;5416.51251387377;5448.91826622601;5367.75845086972;5379.5696344292755;5397.379301380352;5467.45325467454;5482.616216864821;5772.48047675707;6007.7596896124105;6056.515478761688;6092.329843717188;6106.419890110476;6198.101275315099;6237.126802247689;6253.437190652863;6322.083297921776;6333.271673757531;5823.980803359437;6409.198850143732;6427.196600424947;6449.35506449356;6464.288928217892;4378.737275763465;4486.955130448687;4988.526090021478;5920.911186332209;6024.789132380346;5530.364008139035;6405.071264666597;6523.543351965317;6523.575967562188;6542.542022058506;6017;6234.9688251559355;6274.466670332981;6286.088517164985;6308;6109.586862300737;6388.169537960129;6397.200349956255;6398.424141827258;6410.711517981702;6163.876722465526;6230.096635987847;6247.531435142382;6273.404026617464;6305.117283580303;6306.463950564162;6332.430081292706;6358.427741503287;6377.7767778127545;6381.074744162163;5048.545630893163;5083.822066227664;5111.284420181178;5127.692338459704;5169.069567477815;4495.033567782943;4518.932216016762;4535.9773201133785;4539.954600454019;4602.88492787683;5987.251593550806;6078.43819426152;6163.291221509494;6176.166217560662;6188.350223226586;6243.843903902348;6304.401081897304;6327.114204011442;6383.010633351838;6397.584157029872;6095.481884039907;6118.43644382056;6118.8323842141635;6194.5973511721595;6205.913965056097;5571.916421253684;5582.413846546136;5588.469095435927;5603.019471592455;5646.802361917313;6330.873382532415;6577.309382514863;6592.077109204811;6595.703193356215;6604.273529911802;6259.499240060693;6264.624122552661;6266;6300.684965751786;6390.9041364378645;6584.868302633825;6587.80236592903;6588.341165883373;6589.4069533742195;6593.274739778524;6290.370962903673;6290.779822706183;6333.619982801047;6342.23893132827;6351.333110023381;6058.030715085565;6238.937610623836;6240.344763799736;6292.433680968735;6310.7475700971445;6279.71741271653;6303.338149494237;6303.62178269287;6321.209848768904;6326.051092336186;6284.151639528605;6320.715567799368;6322.272938612118;6351.809445716636;6356.364363563606;6035.698215089315;6134.846628834136;6139.706800529315;6149.877002460015;6250.531210159347;6247.156633854372;6295.9370406297185;6298.622082675054;6299.842503937438;6324.083007963912;6172.475339596184;6213.782517611862;6222.408871157233;6236.563440559299;6253.280872699698 16:35:38 INFO - PROCESS | 1669 | |1;ext.html;502.8994201159769;516.411291128114;531.7022467418249;539.1454544546893;565.9717014149292;38816.80591597045;40854.59145408549;40878.38682419766;41018.9745256368;41041.794791026005;42311.15377692452;42684.786576067156;42828;42853.57146428535;42986.99999999992;7796.259355361231;7947.443678942476;8394.832103357929;9762.755931101743;9902.504874756234;8395.412321137492;8439.746807595751;9714.61141554337;9876.160526355268;9919.553620087114;8815.51514666693;8883.756274121628;9649.228061755042;9691.660791872286;9904.851427228597;8569.314454843598;9762.267829912786;9869.60521579136;9910.55402506889;9929.205663546934;8590.269827064707;9634.229261659051;9669.129778319915;9717.90282097177;9753.414795112316;32568.86008989674;40847.183056339;40849.795751021054;40859;40902.9774255643;3279.8196099214533;3343.3814744272145;3444.293919746446;3457.6023757267985;3517.4547945068557;30063.849680751675;30500.54249186264;31304.8434757827;31612.525812112835;32262.516062259085;3246.772725909187;3272.296456261915;3276.9419191667716;3328.2012317043977;3354.8322583870954;387463;392944;393665.0316748398;397971;398352;34014;35012.82493587516;63526.36473635204;63665.681671591345;63950;27616.861915690293;36113.09717257037;36134;36295.818520907225;36337.818310908275;15258.847411525965;15446.613834654223;15449.227538623023;15482.380704771907;15484.690306193814;12963.092583519063;12966.092373533951;13056.281904495345;13062.934685326703;13105.868941310655;7837.647305871249;7877.803054923673;7894.289513943772;7914.366850652049;7930.841383172305;3311.2384151644774;3327.1515763480156;3330.317284956578;3332.816850018257;3356.5832600527583;924;932.7994481186578;962.6245764151986;988.5847943863595;992.2409356842022;30370;30438.847805761274;31183.376332473676;31308.686913131034;31323.84338078295;1016.2124353625999;1034.9534270957674;1040.9063184313447;1055.1463268962864;1132.0208020062587;15586.45447409358;15858.365665373487;15991.36034558628;16173.514794556182;16395.754063689055;649478;717710;717714;718439;718813;57929.84140317254;58240.83518329694;58825.52936176544;58877;58880;1373.8282714660668;1378.4692893236177;1397.7064816388672;1400.0129908414544;1400.2578633324558;26937;29658.406831863675;30328.775960894447;30714.692853071185;31085.844570777;52268.95462090661;52402.47597524129;52471.21293180682;52589.47410525846;52659.47340526546;622957;627727;629878.9542365995;631913;632341;26486.675666216997;27120.32199195036;27494.72505275002;27578.44843103167;27702.168934931986;41804.58195418007;46864.82837929079;48314.75842620764;48403;48739;39727.80136099301;39770;40162.598374015884;40241;41224.587754122076;39382.803085984386;40406.401014022165;40416.79791601023;40470;40891.795541022104;30813.383732325678;36098.819505902306;37214.69748558787;38876.41685374778;39083.413748793224;26868.05961791328;28487.002954896478;28890.855545722978;29305.56041659334;30481.695183048774;22363.66454503151;26241.606375903993;26630.334241644116;26691.19926402211;26977.325566860985 16:35:38 INFO - PROCESS | 1669 | |2;jquery.html;336.9157710572356;357.93020361029596;375.13905586678555;389.82263070303014;404.9713727133082;19457.31899383522;20301.0864511097;20717.171313147493;21068.367948961535;21256.4685882853;11803.468843902023;11982.340971246578;12208.962238209762;12220.816687749691;12236.694082647939;4664.766761661912;5553;5560.082586373243;5567.638103523258;5572.749226284806;3393.898183054512;4156.147989662112;5426;5916.733746981375;6237.719302631393;6212.87574248517;6222.5644204905675;6248.96875515624;6250.437460628543;6251.281102673182;5799.971000145015;6369.235691717;6769.864602707943;6807.659617019179;6822.181338239393;5161.864389834231;5705.144228365737;6026.728797204137;7375.409967202664;7838.255365740246;22373.888130559404;28421;28661.85669071662;29092.709072909212;29212.123636290944;2369.5260947810507;2454.619533972237;2458.0659349447096;2545.9363515912064;3218.1793642621215;14386.496472623408;14971.850281497154;15246.009009414463;15721.685566288725;16459.753103703453;1703.2505697493186;1959.3632069577302;2030.1067530286628;2080.147139672727;2127.9893600532055;116045;127924.08113878299;135421.3228933859;148622.7706584413;154799;19201.135948882333;21823.781762182494;22775.772242277697;22969;23205.53588928212;35210;35307.29385412277;36036.819815901275;36112.458313125324;36171.819140904125;7707.845843083107;8989.10108989109;9199.586018629177;9426.010268921664;9546;7433.702651893864;7512.361449276764;7605.6957721691615;7671.884921726179;7674.040744906887;9616.855747163798;9691.806163876683;9754.902450975542;9855.605775769032;9966.501674916226;1569.5526774869336;1690.7463880418036;1694.2883988724766;3881.514810648669;3891.900518155382;373.86727711662513;381.8563402609203;392.78200598668013;838.5513750143766;897.6723495923941;11802;11878.762424751456;11915.165938384403;11943.462544185533;12027.879721202851;433.22452809470695;433.22452809471326;438.7257963772642;457.22043915125295;459.104745745797;5020.899582008339;6038.275406951107;6098.14625952367;6148.1699970504305;6216.191895053614;635153;642260;648345;657284;663097;139131.30434347966;144854.2757286228;147496;148504.25747871192;151014;827.185222555782;940.8965013848472;973.1776648731952;977.3695966101825;978.5792109393029;19284.13221405068;19718.90140549288;19898.60202795965;19903.900480497505;19994.400167994983;56161;56456;56931.43068569261;57321;57778.422215777304;83351.5832420834;84441.73337399821;85261.57369213115;85437.57281213554;86115.56942215249;6860.936554834008;7524.887126693214;7897.723579674684;7949.8410031800195;8148.511089334659;9347.672831450867;11386.373749443528;12136.453859576517;12369.567065152676;12413.75172496563;9046.954765226132;10423.478826058818;10428.374297542172;10950.616728414467;11020;10497.685069447623;10683.626073087406;10837;10932.398718070264;11097.945695158947;9990;10462.372257664565;10854.67435976922;11071.003609675168;11292.717682058013;7804.609769511615;8039.995000624922;8113.553754543556;8140.75577732669;8196.237808871121;6484.837879053061;7697.923020769945;8399.370047246359;10588.311759735901;10791.244612877023 16:35:38 INFO - PROCESS | 1669 | |3;mootools.html;1474.292339676955;1516.6587517808493;1555.929983150758;1672.9832701672979;1802.2790883646533;8041.396895232851;8428.620712067956;8543.188397102282;9079.682211122612;9145.725628231155;8566.528840913747;8845.778855528599;8886.688965886195;8979.506127163004;8988.235999940012;1977.9901100494478;2423.5879900416885;2430.890609922558;2433.148398060682;2437.609982402816;2028.4624574487773;2396.2571602803187;2414.263649586875;2416.8429052111646;2434.659147719312;2406.626972819216;2417.782399584037;2421.0436877433403;2437.5862000040024;2448.400141965221;2419.2863105383954;2422.1401402502124;2423.3578101803037;2429.392651837041;2432.89051992659;2405.2784164750506;2417.4528301886808;2418.1657328221913;2420.9394765130837;2425.34515680767;9024.909750902472;9086.591103400362;9088.772780680536;9100.180983711498;9105.590248438835;5281.867953301198;5363.54409875161;5451.209574611698;5461.317335333083;5472.097103977839;3546.4680297955256;3572.517710109154;3712.1090938174643;3719.6094410087094;3761.1161377076364;964.4888209249109;982.4400091947592;993.8757655293089;1112.1992165640727;1115.7712668902855;11821.763564728742;11940.164188506807;11973.521059157623;11975.88024119765;11992.28046317215;4745.074710431501;4802.255650374198;4822.228443449031;4857.392825896763;4921.753912304371;10036.598536058622;10114.848277275847;10125.392476451436;10128.797424051625;10153.289269751047;5383.300170977748;5397.59518036141;5398.379186393615;5418.810341638024;5425.945740542544;4040.5555388907196;4428.092241090569;4593.793279302439;4934.629902757236;4971.030649023478;4026.134381108076;4037.1723796621623;4121.567235440296;4152.397902304149;4173.874783756492;1310.1811367895066;1310.8689131086815;1321.9206847589176;1325.993370033163;1329.7207586406769;801.2988634944423;904.6381447421085;906.6600024990629;921.8386782313069;936.1060187520901;5704.458076482728;5730.942690573124;5814.534837213013;6032.969835150796;6071.058985857199;448.74197336531626;450.0279396503537;458.00841178847423;976.6679329028022;1046.4558429616557;2829.7311755383207;3415.6584341565645;3732.64539868712;4128;4211.705180637326;10615.1507879371;10783.46082695862;10810.945945270223;11008.449577521093;11014.44927753609;10864.619738309122;11000.779984400267;11026.338419694683;11046.723831904106;11069.280496767684;8105.55419451924;8312;8333;8377.078521362646;8400.159984001673;6023.855467461169;6053.545984051126;6062.909056364247;6128.32588415265;6146.631202127886;9969.30214884951;10026.749331266778;10209.33639313472;10277.229207809294;10299.124574411258;10187.08316251541;10472.266941314036;10481.895181048092;10487.265891387835;10488.94755526248;6318.27339855904;6726.932730672631;7249.818754530968;7654.2345765423015;7768.223177682186;7386.96306518464;8486.448380855225;8490.872636910575;8502.702405415781;8626.698065567674;7577.469577129548;7687.028822628511;7710.7686769397005;7812.335951444191;7830.4518683691595;7332.670029848777;7449.664765085476;7552.39580833543;7596.886046709194;7638.312551870358;6370.299267080525;7198.100237470317;7222.927770722225;7228.277172282729;7247.9637601811655;4896.36347274852;4932.457429682804;4998.550130488274;5023.648344615988;5080.7205603692155;4966.726830024383;5000.749962501933;5063.417706963599;5105.157648987875;5112.948870511396 16:35:38 INFO - PROCESS | 1669 | |4;prototype.html;299.6628792608317;300.92176034231096;308.4863701936277;309.66865453964266;312.199209028841;5331.067063263923;5490.313710786152;5503.09198982168;5582.581306402021;5634.971825140874;4592.08158368326;4743.383360163182;4879.463259041511;4991.675541089836;5357.785688572462;3987.872551908775;4123.855665051731;4173.603507666767;4177.764895780758;4188.057687020427;3936.350502167139;3948.6574564648013;3987.840486380556;4143.7513749175;4185.865208743532;3590.263995880838;3834.94247586285;4054.432379466877;4085.836566537335;4097.8770636880945;3600.3339382214244;4119.752814831105;4122.196171746511;4129.483814523184;4146.481689788777;3170.936581268385;3603.837827297778;3606.0790759484903;3610.656987586175;3614.8734794282336;5025.597952163818;5229.450907654679;5296.788128474856;5316.9202461963105;5339.225812257239;4702.31816386622;4706.811727530895;4729.148753224418;4748.287756836467;4758.595519380857;5040.521150490697;5463.289772329572;5698.572607054446;5744.109663002241;5779.653220806723;3251.8536665850093;3488.494168345601;3717.925641487155;3781.4516895050338;3873.4770805941403;5961.582689211757;5997.870755881643;6059.515238780887;6097.72560234786;6111.113888486145;3499.177693242086;3925.784081875467;3932.587078356731;3939.955911683406;3955.4857868476915;3737.7383583149463;3752.1932784451474;3983.7410568312966;3990.6408423242046;3998.980260033673;3946.960530394717;4668.696534725232;4685.8594242172785;4713.34013238147;4876.780544875489;5842;5875.23621929155;5894.440028197314;5901.40985901415;5918.964181268261;1158.692946369213;1228.4717571444364;1262.722201115753;1369.657585603599;1375.7523645743663;810.8905297784723;828.2131974624131;837.3426859914938;837.7989282572139;839.7816567692444;4054.675625949917;4215.536291007987;4614.7461889595725;4641.582257596832;4646.62826973848;4015.477987861559;4394.472663280427;4680.765961701902;4746.97939942907;4857.8299759508955;4004.3192657248337;4161.875143745692;4472.463304403427;4584.33527138563;4597.678162528591;2339.7660233976467;2604.8119579553268;2751.5184842652457;3158.6209654841564;3203.19920019995;5979.970100149559;6030.5778595497895;6254.34329395416;6317.515383884784;6326.2724786649205;5514.36584792754;5779.768809247583;5999.580029397987;6167.321594624587;6259.119346005506;4728.361671174347;5385.676859388371;5791.82624521265;6002.879942401128;6056.818295451144;5036.028743041623;5146.408163061146;6109.694515274307;6140.5701600887505;6167.136600875791;4999.800007999785;5181.896362072662;5711.942880571141;5955.255593050869;6030.7889223876955;6251.093066833229;6302.779402720883;6323.292710967921;6345.841353966188;6354.904676429765;3846.1346197105427;3849.538055433366;3902.570717221047;3974.7813870237414;4003.3994900763955;5072.847814565569;5312.070387682063;5970.283565972111;6059.87892239937;6165.93441197204;4896.877578060577;5645.322561292671;5728.770849165987;5818.854528636818;5874.471297583067;4960.652754307164;5392.732707813582;5459.617826752248;5613.522850557585;5913.172155898092;5305.522502974751;5442.537384322219;5757.913631295618;5810.883782324415;5834.474897259267;5858;5969.432903874125;5970.223870896755;5971.790987315597;5988.8802223956145;5554.944450555605;5738.626989245686;5821.155932389865;5849.824505264849;5881.529477641864 16:35:38 INFO - PROCESS | 1669 | |5;yui.html;538.8194954690176;734.0933946575981;735.9411247100229;766.9539827610344;791.3945831438947;14971.925140374296;15676.451324203656;15701.921490392531;15705.764413533778;15724.842751572494;14069.71860562788;14126.293685315719;14129.293535323244;14156.71686566268;14158.716825663481;672.6065251827687;692.7609974558794;827.0365024746163;834.2825170353491;850.9191626795445;709.5175280809048;842.5366048673236;849.5327569836596;850.6554845287668;853.0190281176634;737.9815504612374;909.2498688581946;916.4821875640242;921.3412410126758;925.0656836595053;894.369469523984;904.5296445848122;909.2180724576858;913.3332667152982;915.6108653822165;672.8856094463904;676.2730065179951;677.200902934537;678.6131904814258;680.4454369688688;14588.197649129293;14725.779113313309;14751.631209219748;14808.407663693439;14833.25833708321;13276.336183190802;13424.664383390396;14459.71080578393;14515.709685806225;14762.630934226623;11586.594469193538;11606.187566870323;11741.530338786439;11987.700307492296;12200.938995304967;3746.5635824095248;3830.9042273943096;3864.188520410717;3881.8835434936996;3983.5418926823495;113943.86056139415;116808;117528;118002.81997180004;118670;10855.402952837512;11180.105591552656;11195.4962026709;11263.26788758728;11629.77887321836;22589.77410225877;22628.094876205098;22696.092156313895;23013.654795178085;23029;8121.066077401175;8141.348692104618;8179.0594081681365;8183.549904755177;8227.71203007892;4396.538363471854;4509.6392288616835;4585.9770701146945;4605.930911036337;4628.907421851544;3561.1097225693575;3679.9080022999105;3680.595134535199;3680.7975561344383;3686.576043754949;655.8786624474487;661.5270081891471;662.8900814947345;682.6723172877047;686.7905288886838;488.6188772757255;596.314238625584;631.1006815288196;644.577801539992;683.6581709145428;6725.932740672531;8681.233027012759;9353.39202951806;9547.42715437076;9625.229981601455;451.0415367344393;521.9665063174859;527.9366476022902;540.1276937745513;603.474976770204;4400.185965596375;4650.325702773079;4661.580457758818;4670.439547254351;4761.0001899601475;96944;142994;144365.27817361057;166340.3365966325;169136;145512;146066;147620.26189868982;148414;151552.2422387881;119444;121295.78704213022;122770;123326.38336808438;124303.37848310881;8082.515049097073;8270.669173233004;8905.51019693923;9015.55751079824;9144.451332920045;66023.33976660365;66073.33926660864;67949.32050679627;68171.65914170397;68243.65878170577;103509;105643;106185.46907265414;107443.46278268559;108108;11469.254498457574;11699.532018719156;11887.16789824704;12010.219335743148;12013.63959081194;12968.157069790434;13012.544560940321;13146.868531314565;13224.272665003517;13471.393787279792;12028.819567706316;12033.939830300793;12188.57339993096;12493.562725304571;12687.11190216676;12004.39978001079;12047.75904481923;12178.756424871275;12265.38673066361;12536.937315313366;11039.39283339424;11423;11737.589184378507;12088.274703517816;12299.385030748248;9859.92341421779;10274.691759247235;10788.352698838095;11017.173711971795;11235.66293011211;8974.461532308082;9578.760530986781;9610.615575376907;9709.757256068655;9735.865966292358 16:35:38 INFO - PROCESS | 1669 | __end_tp_report 16:35:38 INFO - PROCESS | 1669 | __start_cc_report 16:35:38 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,364 16:35:38 INFO - PROCESS | 1669 | __end_cc_report 16:35:38 INFO - PROCESS | 1669 | __startTimestamp1478388938131__endTimestamp 16:35:38 INFO - PROCESS | 1669 | 16:35:38 INFO - PROCESS | 1669 | ------- Summary: start ------- 16:35:38 INFO - PROCESS | 1669 | Number of tests: 6 16:35:38 INFO - PROCESS | 1669 | 16:35:38 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5904.68 Median:6176.17 stddev:662.97 (10.7%) stddev-sans-first:636.99 16:35:38 INFO - PROCESS | 1669 | Values: 3474.0 3487.2 3504.6 3528.7 3539.6 5905.6 5993.0 6001.4 6008.2 6021.7 5926.5 5977.6 6026.3 6037.8 6050.9 5382.2 5410.0 5418.3 5487.9 5556.0 5456.9 5483.3 5484.7 5489.0 5497.8 5311.8 5366.4 5476.6 5498.0 5516.2 4577.9 5400.0 5409.5 5416.5 5448.9 5367.8 5379.6 5397.4 5467.5 5482.6 5772.5 6007.8 6056.5 6092.3 6106.4 6198.1 6237.1 6253.4 6322.1 6333.3 5824.0 6409.2 6427.2 6449.4 6464.3 4378.7 4487.0 4988.5 5920.9 6024.8 5530.4 6405.1 6523.5 6523.6 6542.5 6017.0 6235.0 6274.5 6286.1 6308.0 6109.6 6388.2 6397.2 6398.4 6410.7 6163.9 6230.1 6247.5 6273.4 6305.1 6306.5 6332.4 6358.4 6377.8 6381.1 5048.5 5083.8 5111.3 5127.7 5169.1 4495.0 4518.9 4536.0 4540.0 4602.9 5987.3 6078.4 6163.3 6176.2 6188.4 6243.8 6304.4 6327.1 6383.0 6397.6 6095.5 6118.4 6118.8 6194.6 6205.9 5571.9 5582.4 5588.5 5603.0 5646.8 6330.9 6577.3 6592.1 6595.7 6604.3 6259.5 6264.6 6266.0 6300.7 6390.9 6584.9 6587.8 6588.3 6589.4 6593.3 6290.4 6290.8 6333.6 6342.2 6351.3 6058.0 6238.9 6240.3 6292.4 6310.7 6279.7 6303.3 6303.6 6321.2 6326.1 6284.2 6320.7 6322.3 6351.8 6356.4 6035.7 6134.8 6139.7 6149.9 6250.5 6247.2 6295.9 6298.6 6299.8 6324.1 6172.5 6213.8 6222.4 6236.6 6253.3 16:35:38 INFO - PROCESS | 1669 | 16:35:38 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:69382.79 Median:398161.50 stddev:158814.02 (39.9%) stddev-sans-first:159175.33 16:35:38 INFO - PROCESS | 1669 | Values: 502.9 516.4 531.7 539.1 566.0 38816.8 40854.6 40878.4 41019.0 41041.8 42311.2 42684.8 42828.0 42853.6 42987.0 7796.3 7947.4 8394.8 9762.8 9902.5 8395.4 8439.7 9714.6 9876.2 9919.6 8815.5 8883.8 9649.2 9691.7 9904.9 8569.3 9762.3 9869.6 9910.6 9929.2 8590.3 9634.2 9669.1 9717.9 9753.4 32568.9 40847.2 40849.8 40859.0 40903.0 3279.8 3343.4 3444.3 3457.6 3517.5 30063.8 30500.5 31304.8 31612.5 32262.5 3246.8 3272.3 3276.9 3328.2 3354.8 387463.0 392944.0 393665.0 397971.0 398352.0 34014.0 35012.8 63526.4 63665.7 63950.0 27616.9 36113.1 36134.0 36295.8 36337.8 15258.8 15446.6 15449.2 15482.4 15484.7 12963.1 12966.1 13056.3 13062.9 13105.9 7837.6 7877.8 7894.3 7914.4 7930.8 3311.2 3327.2 3330.3 3332.8 3356.6 924.0 932.8 962.6 988.6 992.2 30370.0 30438.8 31183.4 31308.7 31323.8 1016.2 1035.0 1040.9 1055.1 1132.0 15586.5 15858.4 15991.4 16173.5 16395.8 649478.0 717710.0 717714.0 718439.0 718813.0 57929.8 58240.8 58825.5 58877.0 58880.0 1373.8 1378.5 1397.7 1400.0 1400.3 26937.0 29658.4 30328.8 30714.7 31085.8 52269.0 52402.5 52471.2 52589.5 52659.5 622957.0 627727.0 629879.0 631913.0 632341.0 26486.7 27120.3 27494.7 27578.4 27702.2 41804.6 46864.8 48314.8 48403.0 48739.0 39727.8 39770.0 40162.6 40241.0 41224.6 39382.8 40406.4 40416.8 40470.0 40891.8 30813.4 36098.8 37214.7 38876.4 39083.4 26868.1 28487.0 28890.9 29305.6 30481.7 22363.7 26241.6 26630.3 26691.2 26977.3 16:35:38 INFO - PROCESS | 1669 | 16:35:38 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:38280.54 Median:2142.34 stddev:108898.65 (5083.2%) stddev-sans-first:109166.87 16:35:38 INFO - PROCESS | 1669 | Values: 336.9 357.9 375.1 389.8 405.0 19457.3 20301.1 20717.2 21068.4 21256.5 11803.5 11982.3 12209.0 12220.8 12236.7 4664.8 5553.0 5560.1 5567.6 5572.7 3393.9 4156.1 5426.0 5916.7 6237.7 6212.9 6222.6 6249.0 6250.4 6251.3 5800.0 6369.2 6769.9 6807.7 6822.2 5161.9 5705.1 6026.7 7375.4 7838.3 22373.9 28421.0 28661.9 29092.7 29212.1 2369.5 2454.6 2458.1 2545.9 3218.2 14386.5 14971.9 15246.0 15721.7 16459.8 1703.3 1959.4 2030.1 2080.1 2128.0 116045.0 127924.1 135421.3 148622.8 154799.0 19201.1 21823.8 22775.8 22969.0 23205.5 35210.0 35307.3 36036.8 36112.5 36171.8 7707.8 8989.1 9199.6 9426.0 9546.0 7433.7 7512.4 7605.7 7671.9 7674.0 9616.9 9691.8 9754.9 9855.6 9966.5 1569.6 1690.7 1694.3 3881.5 3891.9 373.9 381.9 392.8 838.6 897.7 11802.0 11878.8 11915.2 11943.5 12027.9 433.2 433.2 438.7 457.2 459.1 5020.9 6038.3 6098.1 6148.2 6216.2 635153.0 642260.0 648345.0 657284.0 663097.0 139131.3 144854.3 147496.0 148504.3 151014.0 827.2 940.9 973.2 977.4 978.6 19284.1 19718.9 19898.6 19903.9 19994.4 56161.0 56456.0 56931.4 57321.0 57778.4 83351.6 84441.7 85261.6 85437.6 86115.6 6860.9 7524.9 7897.7 7949.8 8148.5 9347.7 11386.4 12136.5 12369.6 12413.8 9047.0 10423.5 10428.4 10950.6 11020.0 10497.7 10683.6 10837.0 10932.4 11097.9 9990.0 10462.4 10854.7 11071.0 11292.7 7804.6 8040.0 8113.6 8140.8 8196.2 6484.8 7697.9 8399.4 10588.3 10791.2 16:35:38 INFO - PROCESS | 1669 | 16:35:38 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5784.16 Median:4839.81 stddev:3284.98 (67.9%) stddev-sans-first:3278.23 16:35:38 INFO - PROCESS | 1669 | Values: 1474.3 1516.7 1555.9 1673.0 1802.3 8041.4 8428.6 8543.2 9079.7 9145.7 8566.5 8845.8 8886.7 8979.5 8988.2 1978.0 2423.6 2430.9 2433.1 2437.6 2028.5 2396.3 2414.3 2416.8 2434.7 2406.6 2417.8 2421.0 2437.6 2448.4 2419.3 2422.1 2423.4 2429.4 2432.9 2405.3 2417.5 2418.2 2420.9 2425.3 9024.9 9086.6 9088.8 9100.2 9105.6 5281.9 5363.5 5451.2 5461.3 5472.1 3546.5 3572.5 3712.1 3719.6 3761.1 964.5 982.4 993.9 1112.2 1115.8 11821.8 11940.2 11973.5 11975.9 11992.3 4745.1 4802.3 4822.2 4857.4 4921.8 10036.6 10114.8 10125.4 10128.8 10153.3 5383.3 5397.6 5398.4 5418.8 5425.9 4040.6 4428.1 4593.8 4934.6 4971.0 4026.1 4037.2 4121.6 4152.4 4173.9 1310.2 1310.9 1321.9 1326.0 1329.7 801.3 904.6 906.7 921.8 936.1 5704.5 5730.9 5814.5 6033.0 6071.1 448.7 450.0 458.0 976.7 1046.5 2829.7 3415.7 3732.6 4128.0 4211.7 10615.2 10783.5 10810.9 11008.4 11014.4 10864.6 11000.8 11026.3 11046.7 11069.3 8105.6 8312.0 8333.0 8377.1 8400.2 6023.9 6053.5 6062.9 6128.3 6146.6 9969.3 10026.7 10209.3 10277.2 10299.1 10187.1 10472.3 10481.9 10487.3 10488.9 6318.3 6726.9 7249.8 7654.2 7768.2 7387.0 8486.4 8490.9 8502.7 8626.7 7577.5 7687.0 7710.8 7812.3 7830.5 7332.7 7449.7 7552.4 7596.9 7638.3 6370.3 7198.1 7222.9 7228.3 7248.0 4896.4 4932.5 4998.6 5023.6 5080.7 4966.7 5000.7 5063.4 5105.2 5112.9 16:35:38 INFO - PROCESS | 1669 | 16:35:38 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:4594.47 Median:4976.16 stddev:1473.03 (29.6%) stddev-sans-first:1441.46 16:35:38 INFO - PROCESS | 1669 | Values: 299.7 300.9 308.5 309.7 312.2 5331.1 5490.3 5503.1 5582.6 5635.0 4592.1 4743.4 4879.5 4991.7 5357.8 3987.9 4123.9 4173.6 4177.8 4188.1 3936.4 3948.7 3987.8 4143.8 4185.9 3590.3 3834.9 4054.4 4085.8 4097.9 3600.3 4119.8 4122.2 4129.5 4146.5 3170.9 3603.8 3606.1 3610.7 3614.9 5025.6 5229.5 5296.8 5316.9 5339.2 4702.3 4706.8 4729.1 4748.3 4758.6 5040.5 5463.3 5698.6 5744.1 5779.7 3251.9 3488.5 3717.9 3781.5 3873.5 5961.6 5997.9 6059.5 6097.7 6111.1 3499.2 3925.8 3932.6 3940.0 3955.5 3737.7 3752.2 3983.7 3990.6 3999.0 3947.0 4668.7 4685.9 4713.3 4876.8 5842.0 5875.2 5894.4 5901.4 5919.0 1158.7 1228.5 1262.7 1369.7 1375.8 810.9 828.2 837.3 837.8 839.8 4054.7 4215.5 4614.7 4641.6 4646.6 4015.5 4394.5 4680.8 4747.0 4857.8 4004.3 4161.9 4472.5 4584.3 4597.7 2339.8 2604.8 2751.5 3158.6 3203.2 5980.0 6030.6 6254.3 6317.5 6326.3 5514.4 5779.8 5999.6 6167.3 6259.1 4728.4 5385.7 5791.8 6002.9 6056.8 5036.0 5146.4 6109.7 6140.6 6167.1 4999.8 5181.9 5711.9 5955.3 6030.8 6251.1 6302.8 6323.3 6345.8 6354.9 3846.1 3849.5 3902.6 3974.8 4003.4 5072.8 5312.1 5970.3 6059.9 6165.9 4896.9 5645.3 5728.8 5818.9 5874.5 4960.7 5392.7 5459.6 5613.5 5913.2 5305.5 5442.5 5757.9 5810.9 5834.5 5858.0 5969.4 5970.2 5971.8 5988.9 5554.9 5738.6 5821.2 5849.8 5881.5 16:35:38 INFO - PROCESS | 1669 | 16:35:38 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:26086.07 Median:3680.70 stddev:42964.81 (1167.3%) stddev-sans-first:43042.52 16:35:38 INFO - PROCESS | 1669 | Values: 538.8 734.1 735.9 767.0 791.4 14971.9 15676.5 15701.9 15705.8 15724.8 14069.7 14126.3 14129.3 14156.7 14158.7 672.6 692.8 827.0 834.3 850.9 709.5 842.5 849.5 850.7 853.0 738.0 909.2 916.5 921.3 925.1 894.4 904.5 909.2 913.3 915.6 672.9 676.3 677.2 678.6 680.4 14588.2 14725.8 14751.6 14808.4 14833.3 13276.3 13424.7 14459.7 14515.7 14762.6 11586.6 11606.2 11741.5 11987.7 12200.9 3746.6 3830.9 3864.2 3881.9 3983.5 113943.9 116808.0 117528.0 118002.8 118670.0 10855.4 11180.1 11195.5 11263.3 11629.8 22589.8 22628.1 22696.1 23013.7 23029.0 8121.1 8141.3 8179.1 8183.5 8227.7 4396.5 4509.6 4586.0 4605.9 4628.9 3561.1 3679.9 3680.6 3680.8 3686.6 655.9 661.5 662.9 682.7 686.8 488.6 596.3 631.1 644.6 683.7 6725.9 8681.2 9353.4 9547.4 9625.2 451.0 522.0 527.9 540.1 603.5 4400.2 4650.3 4661.6 4670.4 4761.0 96944.0 142994.0 144365.3 166340.3 169136.0 145512.0 146066.0 147620.3 148414.0 151552.2 119444.0 121295.8 122770.0 123326.4 124303.4 8082.5 8270.7 8905.5 9015.6 9144.5 66023.3 66073.3 67949.3 68171.7 68243.7 103509.0 105643.0 106185.5 107443.5 108108.0 11469.3 11699.5 11887.2 12010.2 12013.6 12968.2 13012.5 13146.9 13224.3 13471.4 12028.8 12033.9 12188.6 12493.6 12687.1 12004.4 12047.8 12178.8 12265.4 12536.9 11039.4 11423.0 11737.6 12088.3 12299.4 9859.9 10274.7 10788.4 11017.2 11235.7 8974.5 9578.8 9610.6 9709.8 9735.9 16:35:38 INFO - PROCESS | 1669 | -------- Summary: end -------- 16:35:38 INFO - PROCESS | 1669 | 16:35:38 INFO - TEST-INFO | 1669: exit 0 16:35:38 INFO - TEST-OK | dromaeo_css | took 1114456ms 16:35:38 INFO - TEST-START | kraken 16:35:38 INFO - operating with platform_type : mac_ 16:35:38 INFO - Initialising browser for kraken test... 16:35:38 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpGnl8P0/profile http://localhost:49273/getInfo.html) 16:35:41 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 16:35:41 INFO - PROCESS | 1677 | colorDepth:24 16:35:41 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 16:35:41 INFO - PROCESS | 1677 | __metrics 16:35:41 ERROR - PROCESS | 1677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 16:35:42 INFO - TEST-INFO | 1677: exit 0 16:35:42 INFO - Browser initialized. 16:35:42 INFO - Running cycle 1/1 for kraken test... 16:35:42 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpGnl8P0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:35:54 INFO - PROCESS | 1679 | RSS: Main: 225378304 16:35:54 INFO - PROCESS | 1679 | 16:35:57 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 16:35:58 INFO - PROCESS | 1679 | RSS: Main: 238039040 16:35:58 INFO - PROCESS | 1679 | 16:36:01 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 16:36:01 INFO - PROCESS | 1679 | RSS: Main: 245522432 16:36:01 INFO - PROCESS | 1679 | 16:36:05 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 16:36:05 INFO - PROCESS | 1679 | RSS: Main: 247443456 16:36:05 INFO - PROCESS | 1679 | 16:36:07 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 16:36:08 INFO - PROCESS | 1679 | RSS: Main: 250040320 16:36:08 INFO - PROCESS | 1679 | 16:36:10 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:36:11 INFO - PROCESS | 1679 | RSS: Main: 250368000 16:36:11 INFO - PROCESS | 1679 | 16:36:14 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 16:36:14 INFO - PROCESS | 1679 | RSS: Main: 251092992 16:36:14 INFO - PROCESS | 1679 | 16:36:17 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 16:36:18 INFO - PROCESS | 1679 | RSS: Main: 251334656 16:36:18 INFO - PROCESS | 1679 | 16:36:21 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 16:36:22 INFO - PROCESS | 1679 | RSS: Main: 251535360 16:36:22 INFO - PROCESS | 1679 | 16:36:23 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:36:24 INFO - PROCESS | 1679 | RSS: Main: 251228160 16:36:24 INFO - PROCESS | 1679 | 16:36:26 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:36:26 INFO - PROCESS | 1679 | RSS: Main: 251322368 16:36:26 INFO - PROCESS | 1679 | 16:36:29 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:36:29 INFO - PROCESS | 1679 | RSS: Main: 251297792 16:36:29 INFO - PROCESS | 1679 | 16:36:32 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:36:33 INFO - PROCESS | 1679 | RSS: Main: 251691008 16:36:33 INFO - PROCESS | 1679 | 16:36:36 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:36:36 INFO - PROCESS | 1679 | RSS: Main: 251695104 16:36:36 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 16:36:38 INFO - PROCESS | 1679 | RSS: Main: 253079552 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | __start_tp_report 16:36:38 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 16:36:38 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 16:36:38 INFO - PROCESS | 1679 | |i|pagename|runs| 16:36:38 INFO - PROCESS | 1679 | |0;ai-astar;107;117;119;118;118;119;119;117;117;119 16:36:38 INFO - PROCESS | 1679 | |1;audio-beat-detection;145;112;109;144;101;140;143;145;130;146 16:36:38 INFO - PROCESS | 1679 | |2;audio-dft;225;215;197;198;192;216;200;191;282;257 16:36:38 INFO - PROCESS | 1679 | |3;audio-fft;82;62;58;79;60;61;58;59;76;58 16:36:38 INFO - PROCESS | 1679 | |4;audio-oscillator;95;70;76;84;100;104;116;69;70;118 16:36:38 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;93;75;134;131;89;94;91;90;121;88 16:36:38 INFO - PROCESS | 1679 | |6;imaging-darkroom;112;151;113;96;96;97;97;111;124;97 16:36:38 INFO - PROCESS | 1679 | |7;imaging-desaturate;91;91;142;143;91;91;89;96;139;148 16:36:38 INFO - PROCESS | 1679 | |8;json-parse-financial;57;58;55;57;60;62;60;61;60;61 16:36:38 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;69;72;74;76;75;71;70;69;96;108 16:36:38 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;73;71;105;105;80;85;84;86;87;87 16:36:38 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;139;142;142;140;140;141;142;164;198;155 16:36:38 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;163;163;229;165;169;165;168;165;168;165 16:36:38 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;70;67;75;78;88;67;58;83;88;89 16:36:38 INFO - PROCESS | 1679 | __end_tp_report 16:36:38 INFO - PROCESS | 1679 | __start_cc_report 16:36:38 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,947 16:36:38 INFO - PROCESS | 1679 | __end_cc_report 16:36:38 INFO - PROCESS | 1679 | __startTimestamp1478388998834__endTimestamp 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | ------- Summary: start ------- 16:36:38 INFO - PROCESS | 1679 | Number of tests: 14 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:117.00 Median:118.50 stddev:3.62 (3.1%) stddev-sans-first:0.93 16:36:38 INFO - PROCESS | 1679 | Values: 107.0 117.0 119.0 118.0 118.0 119.0 119.0 117.0 117.0 119.0 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:131.50 Median:143.50 stddev:17.49 (12.2%) stddev-sans-first:17.86 16:36:38 INFO - PROCESS | 1679 | Values: 145.0 112.0 109.0 144.0 101.0 140.0 143.0 145.0 130.0 146.0 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:217.30 Median:215.50 stddev:30.27 (14.0%) stddev-sans-first:31.97 16:36:38 INFO - PROCESS | 1679 | Values: 225.0 215.0 197.0 198.0 192.0 216.0 200.0 191.0 282.0 257.0 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:65.30 Median:61.50 stddev:9.65 (15.7%) stddev-sans-first:8.13 16:36:38 INFO - PROCESS | 1679 | Values: 82.0 62.0 58.0 79.0 60.0 61.0 58.0 59.0 76.0 58.0 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:70.00 stddev:19.01 (27.2%) stddev-sans-first:20.09 16:36:38 INFO - PROCESS | 1679 | Values: 95.0 70.0 76.0 84.0 100.0 104.0 116.0 69.0 70.0 118.0 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:100.60 Median:89.50 stddev:20.30 (22.7%) stddev-sans-first:21.35 16:36:38 INFO - PROCESS | 1679 | Values: 93.0 75.0 134.0 131.0 89.0 94.0 91.0 90.0 121.0 88.0 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:109.40 Median:96.00 stddev:17.60 (18.3%) stddev-sans-first:18.64 16:36:38 INFO - PROCESS | 1679 | Values: 112.0 151.0 113.0 96.0 96.0 97.0 97.0 111.0 124.0 97.0 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:112.10 Median:91.00 stddev:26.74 (29.4%) stddev-sans-first:27.25 16:36:38 INFO - PROCESS | 1679 | Values: 91.0 91.0 142.0 143.0 91.0 91.0 89.0 96.0 139.0 148.0 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:60.00 stddev:2.23 (3.7%) stddev-sans-first:2.24 16:36:38 INFO - PROCESS | 1679 | Values: 57.0 58.0 55.0 57.0 60.0 62.0 60.0 61.0 60.0 61.0 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:78.00 Median:73.00 stddev:13.18 (18.1%) stddev-sans-first:13.57 16:36:38 INFO - PROCESS | 1679 | Values: 69.0 72.0 74.0 76.0 75.0 71.0 70.0 69.0 96.0 108.0 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:84.50 stddev:11.34 (13.4%) stddev-sans-first:10.96 16:36:38 INFO - PROCESS | 1679 | Values: 73.0 71.0 105.0 105.0 80.0 85.0 84.0 86.0 87.0 87.0 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:150.30 Median:142.00 stddev:18.61 (13.1%) stddev-sans-first:19.29 16:36:38 INFO - PROCESS | 1679 | Values: 139.0 142.0 142.0 140.0 140.0 141.0 142.0 164.0 198.0 155.0 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:166.50 stddev:20.13 (12.1%) stddev-sans-first:21.09 16:36:38 INFO - PROCESS | 1679 | Values: 163.0 163.0 229.0 165.0 169.0 165.0 168.0 165.0 168.0 165.0 16:36:38 INFO - PROCESS | 1679 | 16:36:38 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:80.50 stddev:10.71 (13.3%) stddev-sans-first:11.11 16:36:38 INFO - PROCESS | 1679 | Values: 70.0 67.0 75.0 78.0 88.0 67.0 58.0 83.0 88.0 89.0 16:36:38 INFO - PROCESS | 1679 | -------- Summary: end -------- 16:36:38 INFO - PROCESS | 1679 | 16:36:39 INFO - TEST-INFO | 1679: exit 0 16:36:39 INFO - TEST-OK | kraken | took 60968ms 16:36:39 INFO - SUITE-END | took 1175s 16:36:39 INFO - Completed test suite (00:19:35) 16:36:39 INFO - javascript benchmark 16:36:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7321.4206035277575, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3473.9999999999986, 3487.232808782069, 3504.5794504659443, 3528.7177025837937, 3539.628339024402, 5905.5570832187595, 5993.041113421853, 6001.399860013997, 6008.218931538894, 6021.698915054246, 5926.466618004379, 5977.611455255416, 6026.3371029186865, 6037.818865434033, 6050.909236361458, 5382.192671099337, 5409.972950135244, 5418.268533747933, 5487.945120548783, 5556.0, 5456.945430545684, 5483.287172667568, 5484.670919744828, 5488.957098151339, 5497.752601132938, 5311.760970756306, 5366.382865970424, 5476.616636835403, 5497.972510137443, 5516.227728118067, 4577.885552861188, 5400.0, 5409.513143817076, 5416.51251387377, 5448.91826622601, 5367.75845086972, 5379.5696344292755, 5397.379301380352, 5467.45325467454, 5482.616216864821, 5772.48047675707, 6007.7596896124105, 6056.515478761688, 6092.329843717188, 6106.419890110476, 6198.101275315099, 6237.126802247689, 6253.437190652863, 6322.083297921776, 6333.271673757531, 5823.980803359437, 6409.198850143732, 6427.196600424947, 6449.35506449356, 6464.288928217892, 4378.737275763465, 4486.955130448687, 4988.526090021478, 5920.911186332209, 6024.789132380346, 5530.364008139035, 6405.071264666597, 6523.543351965317, 6523.575967562188, 6542.542022058506, 6017.0, 6234.9688251559355, 6274.466670332981, 6286.088517164985, 6308.0, 6109.586862300737, 6388.169537960129, 6397.200349956255, 6398.424141827258, 6410.711517981702, 6163.876722465526, 6230.096635987847, 6247.531435142382, 6273.404026617464, 6305.117283580303, 6306.463950564162, 6332.430081292706, 6358.427741503287, 6377.7767778127545, 6381.074744162163, 5048.545630893163, 5083.822066227664, 5111.284420181178, 5127.692338459704, 5169.069567477815, 4495.033567782943, 4518.932216016762, 4535.9773201133785, 4539.954600454019, 4602.88492787683, 5987.251593550806, 6078.43819426152, 6163.291221509494, 6176.166217560662, 6188.350223226586, 6243.843903902348, 6304.401081897304, 6327.114204011442, 6383.010633351838, 6397.584157029872, 6095.481884039907, 6118.43644382056, 6118.8323842141635, 6194.5973511721595, 6205.913965056097, 5571.916421253684, 5582.413846546136, 5588.469095435927, 5603.019471592455, 5646.802361917313, 6330.873382532415, 6577.309382514863, 6592.077109204811, 6595.703193356215, 6604.273529911802, 6259.499240060693, 6264.624122552661, 6266.0, 6300.684965751786, 6390.9041364378645, 6584.868302633825, 6587.80236592903, 6588.341165883373, 6589.4069533742195, 6593.274739778524, 6290.370962903673, 6290.779822706183, 6333.619982801047, 6342.23893132827, 6351.333110023381, 6058.030715085565, 6238.937610623836, 6240.344763799736, 6292.433680968735, 6310.7475700971445, 6279.71741271653, 6303.338149494237, 6303.62178269287, 6321.209848768904, 6326.051092336186, 6284.151639528605, 6320.715567799368, 6322.272938612118, 6351.809445716636, 6356.364363563606, 6035.698215089315, 6134.846628834136, 6139.706800529315, 6149.877002460015, 6250.531210159347, 6247.156633854372, 6295.9370406297185, 6298.622082675054, 6299.842503937438, 6324.083007963912, 6172.475339596184, 6213.782517611862, 6222.408871157233, 6236.563440559299, 6253.280872699698], "value": 5863.386002202963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.8994201159769, 516.411291128114, 531.7022467418249, 539.1454544546893, 565.9717014149292, 38816.80591597045, 40854.59145408549, 40878.38682419766, 41018.9745256368, 41041.794791026005, 42311.15377692452, 42684.786576067156, 42828.0, 42853.57146428535, 42986.99999999992, 7796.259355361231, 7947.443678942476, 8394.832103357929, 9762.755931101743, 9902.504874756234, 8395.412321137492, 8439.746807595751, 9714.61141554337, 9876.160526355268, 9919.553620087114, 8815.51514666693, 8883.756274121628, 9649.228061755042, 9691.660791872286, 9904.851427228597, 8569.314454843598, 9762.267829912786, 9869.60521579136, 9910.55402506889, 9929.205663546934, 8590.269827064707, 9634.229261659051, 9669.129778319915, 9717.90282097177, 9753.414795112316, 32568.86008989674, 40847.183056339, 40849.795751021054, 40859.0, 40902.9774255643, 3279.8196099214533, 3343.3814744272145, 3444.293919746446, 3457.6023757267985, 3517.4547945068557, 30063.849680751675, 30500.54249186264, 31304.8434757827, 31612.525812112835, 32262.516062259085, 3246.772725909187, 3272.296456261915, 3276.9419191667716, 3328.2012317043977, 3354.8322583870954, 387463.0, 392944.0, 393665.0316748398, 397971.0, 398352.0, 34014.0, 35012.82493587516, 63526.36473635204, 63665.681671591345, 63950.0, 27616.861915690293, 36113.09717257037, 36134.0, 36295.818520907225, 36337.818310908275, 15258.847411525965, 15446.613834654223, 15449.227538623023, 15482.380704771907, 15484.690306193814, 12963.092583519063, 12966.092373533951, 13056.281904495345, 13062.934685326703, 13105.868941310655, 7837.647305871249, 7877.803054923673, 7894.289513943772, 7914.366850652049, 7930.841383172305, 3311.2384151644774, 3327.1515763480156, 3330.317284956578, 3332.816850018257, 3356.5832600527583, 924.0, 932.7994481186578, 962.6245764151986, 988.5847943863595, 992.2409356842022, 30370.0, 30438.847805761274, 31183.376332473676, 31308.686913131034, 31323.84338078295, 1016.2124353625999, 1034.9534270957674, 1040.9063184313447, 1055.1463268962864, 1132.0208020062587, 15586.45447409358, 15858.365665373487, 15991.36034558628, 16173.514794556182, 16395.754063689055, 649478.0, 717710.0, 717714.0, 718439.0, 718813.0, 57929.84140317254, 58240.83518329694, 58825.52936176544, 58877.0, 58880.0, 1373.8282714660668, 1378.4692893236177, 1397.7064816388672, 1400.0129908414544, 1400.2578633324558, 26937.0, 29658.406831863675, 30328.775960894447, 30714.692853071185, 31085.844570777, 52268.95462090661, 52402.47597524129, 52471.21293180682, 52589.47410525846, 52659.47340526546, 622957.0, 627727.0, 629878.9542365995, 631913.0, 632341.0, 26486.675666216997, 27120.32199195036, 27494.72505275002, 27578.44843103167, 27702.168934931986, 41804.58195418007, 46864.82837929079, 48314.75842620764, 48403.0, 48739.0, 39727.80136099301, 39770.0, 40162.598374015884, 40241.0, 41224.587754122076, 39382.803085984386, 40406.401014022165, 40416.79791601023, 40470.0, 40891.795541022104, 30813.383732325678, 36098.819505902306, 37214.69748558787, 38876.41685374778, 39083.413748793224, 26868.05961791328, 28487.002954896478, 28890.855545722978, 29305.56041659334, 30481.695183048774, 22363.66454503151, 26241.606375903993, 26630.334241644116, 26691.19926402211, 26977.325566860985], "value": 18616.392380762925, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.9157710572356, 357.93020361029596, 375.13905586678555, 389.82263070303014, 404.9713727133082, 19457.31899383522, 20301.0864511097, 20717.171313147493, 21068.367948961535, 21256.4685882853, 11803.468843902023, 11982.340971246578, 12208.962238209762, 12220.816687749691, 12236.694082647939, 4664.766761661912, 5553.0, 5560.082586373243, 5567.638103523258, 5572.749226284806, 3393.898183054512, 4156.147989662112, 5426.0, 5916.733746981375, 6237.719302631393, 6212.87574248517, 6222.5644204905675, 6248.96875515624, 6250.437460628543, 6251.281102673182, 5799.971000145015, 6369.235691717, 6769.864602707943, 6807.659617019179, 6822.181338239393, 5161.864389834231, 5705.144228365737, 6026.728797204137, 7375.409967202664, 7838.255365740246, 22373.888130559404, 28421.0, 28661.85669071662, 29092.709072909212, 29212.123636290944, 2369.5260947810507, 2454.619533972237, 2458.0659349447096, 2545.9363515912064, 3218.1793642621215, 14386.496472623408, 14971.850281497154, 15246.009009414463, 15721.685566288725, 16459.753103703453, 1703.2505697493186, 1959.3632069577302, 2030.1067530286628, 2080.147139672727, 2127.9893600532055, 116045.0, 127924.08113878299, 135421.3228933859, 148622.7706584413, 154799.0, 19201.135948882333, 21823.781762182494, 22775.772242277697, 22969.0, 23205.53588928212, 35210.0, 35307.29385412277, 36036.819815901275, 36112.458313125324, 36171.819140904125, 7707.845843083107, 8989.10108989109, 9199.586018629177, 9426.010268921664, 9546.0, 7433.702651893864, 7512.361449276764, 7605.6957721691615, 7671.884921726179, 7674.040744906887, 9616.855747163798, 9691.806163876683, 9754.902450975542, 9855.605775769032, 9966.501674916226, 1569.5526774869336, 1690.7463880418036, 1694.2883988724766, 3881.514810648669, 3891.900518155382, 373.86727711662513, 381.8563402609203, 392.78200598668013, 838.5513750143766, 897.6723495923941, 11802.0, 11878.762424751456, 11915.165938384403, 11943.462544185533, 12027.879721202851, 433.22452809470695, 433.22452809471326, 438.7257963772642, 457.22043915125295, 459.104745745797, 5020.899582008339, 6038.275406951107, 6098.14625952367, 6148.1699970504305, 6216.191895053614, 635153.0, 642260.0, 648345.0, 657284.0, 663097.0, 139131.30434347966, 144854.2757286228, 147496.0, 148504.25747871192, 151014.0, 827.185222555782, 940.8965013848472, 973.1776648731952, 977.3695966101825, 978.5792109393029, 19284.13221405068, 19718.90140549288, 19898.60202795965, 19903.900480497505, 19994.400167994983, 56161.0, 56456.0, 56931.43068569261, 57321.0, 57778.422215777304, 83351.5832420834, 84441.73337399821, 85261.57369213115, 85437.57281213554, 86115.56942215249, 6860.936554834008, 7524.887126693214, 7897.723579674684, 7949.8410031800195, 8148.511089334659, 9347.672831450867, 11386.373749443528, 12136.453859576517, 12369.567065152676, 12413.75172496563, 9046.954765226132, 10423.478826058818, 10428.374297542172, 10950.616728414467, 11020.0, 10497.685069447623, 10683.626073087406, 10837.0, 10932.398718070264, 11097.945695158947, 9990.0, 10462.372257664565, 10854.67435976922, 11071.003609675168, 11292.717682058013, 7804.609769511615, 8039.995000624922, 8113.553754543556, 8140.75577732669, 8196.237808871121, 6484.837879053061, 7697.923020769945, 8399.370047246359, 10588.311759735901, 10791.244612877023], "value": 9674.772984115978, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.292339676955, 1516.6587517808493, 1555.929983150758, 1672.9832701672979, 1802.2790883646533, 8041.396895232851, 8428.620712067956, 8543.188397102282, 9079.682211122612, 9145.725628231155, 8566.528840913747, 8845.778855528599, 8886.688965886195, 8979.506127163004, 8988.235999940012, 1977.9901100494478, 2423.5879900416885, 2430.890609922558, 2433.148398060682, 2437.609982402816, 2028.4624574487773, 2396.2571602803187, 2414.263649586875, 2416.8429052111646, 2434.659147719312, 2406.626972819216, 2417.782399584037, 2421.0436877433403, 2437.5862000040024, 2448.400141965221, 2419.2863105383954, 2422.1401402502124, 2423.3578101803037, 2429.392651837041, 2432.89051992659, 2405.2784164750506, 2417.4528301886808, 2418.1657328221913, 2420.9394765130837, 2425.34515680767, 9024.909750902472, 9086.591103400362, 9088.772780680536, 9100.180983711498, 9105.590248438835, 5281.867953301198, 5363.54409875161, 5451.209574611698, 5461.317335333083, 5472.097103977839, 3546.4680297955256, 3572.517710109154, 3712.1090938174643, 3719.6094410087094, 3761.1161377076364, 964.4888209249109, 982.4400091947592, 993.8757655293089, 1112.1992165640727, 1115.7712668902855, 11821.763564728742, 11940.164188506807, 11973.521059157623, 11975.88024119765, 11992.28046317215, 4745.074710431501, 4802.255650374198, 4822.228443449031, 4857.392825896763, 4921.753912304371, 10036.598536058622, 10114.848277275847, 10125.392476451436, 10128.797424051625, 10153.289269751047, 5383.300170977748, 5397.59518036141, 5398.379186393615, 5418.810341638024, 5425.945740542544, 4040.5555388907196, 4428.092241090569, 4593.793279302439, 4934.629902757236, 4971.030649023478, 4026.134381108076, 4037.1723796621623, 4121.567235440296, 4152.397902304149, 4173.874783756492, 1310.1811367895066, 1310.8689131086815, 1321.9206847589176, 1325.993370033163, 1329.7207586406769, 801.2988634944423, 904.6381447421085, 906.6600024990629, 921.8386782313069, 936.1060187520901, 5704.458076482728, 5730.942690573124, 5814.534837213013, 6032.969835150796, 6071.058985857199, 448.74197336531626, 450.0279396503537, 458.00841178847423, 976.6679329028022, 1046.4558429616557, 2829.7311755383207, 3415.6584341565645, 3732.64539868712, 4128.0, 4211.705180637326, 10615.1507879371, 10783.46082695862, 10810.945945270223, 11008.449577521093, 11014.44927753609, 10864.619738309122, 11000.779984400267, 11026.338419694683, 11046.723831904106, 11069.280496767684, 8105.55419451924, 8312.0, 8333.0, 8377.078521362646, 8400.159984001673, 6023.855467461169, 6053.545984051126, 6062.909056364247, 6128.32588415265, 6146.631202127886, 9969.30214884951, 10026.749331266778, 10209.33639313472, 10277.229207809294, 10299.124574411258, 10187.08316251541, 10472.266941314036, 10481.895181048092, 10487.265891387835, 10488.94755526248, 6318.27339855904, 6726.932730672631, 7249.818754530968, 7654.2345765423015, 7768.223177682186, 7386.96306518464, 8486.448380855225, 8490.872636910575, 8502.702405415781, 8626.698065567674, 7577.469577129548, 7687.028822628511, 7710.7686769397005, 7812.335951444191, 7830.4518683691595, 7332.670029848777, 7449.664765085476, 7552.39580833543, 7596.886046709194, 7638.312551870358, 6370.299267080525, 7198.100237470317, 7222.927770722225, 7228.277172282729, 7247.9637601811655, 4896.36347274852, 4932.457429682804, 4998.550130488274, 5023.648344615988, 5080.7205603692155, 4966.726830024383, 5000.749962501933, 5063.417706963599, 5105.157648987875, 5112.948870511396], "value": 4597.39092490216, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.6628792608317, 300.92176034231096, 308.4863701936277, 309.66865453964266, 312.199209028841, 5331.067063263923, 5490.313710786152, 5503.09198982168, 5582.581306402021, 5634.971825140874, 4592.08158368326, 4743.383360163182, 4879.463259041511, 4991.675541089836, 5357.785688572462, 3987.872551908775, 4123.855665051731, 4173.603507666767, 4177.764895780758, 4188.057687020427, 3936.350502167139, 3948.6574564648013, 3987.840486380556, 4143.7513749175, 4185.865208743532, 3590.263995880838, 3834.94247586285, 4054.432379466877, 4085.836566537335, 4097.8770636880945, 3600.3339382214244, 4119.752814831105, 4122.196171746511, 4129.483814523184, 4146.481689788777, 3170.936581268385, 3603.837827297778, 3606.0790759484903, 3610.656987586175, 3614.8734794282336, 5025.597952163818, 5229.450907654679, 5296.788128474856, 5316.9202461963105, 5339.225812257239, 4702.31816386622, 4706.811727530895, 4729.148753224418, 4748.287756836467, 4758.595519380857, 5040.521150490697, 5463.289772329572, 5698.572607054446, 5744.109663002241, 5779.653220806723, 3251.8536665850093, 3488.494168345601, 3717.925641487155, 3781.4516895050338, 3873.4770805941403, 5961.582689211757, 5997.870755881643, 6059.515238780887, 6097.72560234786, 6111.113888486145, 3499.177693242086, 3925.784081875467, 3932.587078356731, 3939.955911683406, 3955.4857868476915, 3737.7383583149463, 3752.1932784451474, 3983.7410568312966, 3990.6408423242046, 3998.980260033673, 3946.960530394717, 4668.696534725232, 4685.8594242172785, 4713.34013238147, 4876.780544875489, 5842.0, 5875.23621929155, 5894.440028197314, 5901.40985901415, 5918.964181268261, 1158.692946369213, 1228.4717571444364, 1262.722201115753, 1369.657585603599, 1375.7523645743663, 810.8905297784723, 828.2131974624131, 837.3426859914938, 837.7989282572139, 839.7816567692444, 4054.675625949917, 4215.536291007987, 4614.7461889595725, 4641.582257596832, 4646.62826973848, 4015.477987861559, 4394.472663280427, 4680.765961701902, 4746.97939942907, 4857.8299759508955, 4004.3192657248337, 4161.875143745692, 4472.463304403427, 4584.33527138563, 4597.678162528591, 2339.7660233976467, 2604.8119579553268, 2751.5184842652457, 3158.6209654841564, 3203.19920019995, 5979.970100149559, 6030.5778595497895, 6254.34329395416, 6317.515383884784, 6326.2724786649205, 5514.36584792754, 5779.768809247583, 5999.580029397987, 6167.321594624587, 6259.119346005506, 4728.361671174347, 5385.676859388371, 5791.82624521265, 6002.879942401128, 6056.818295451144, 5036.028743041623, 5146.408163061146, 6109.694515274307, 6140.5701600887505, 6167.136600875791, 4999.800007999785, 5181.896362072662, 5711.942880571141, 5955.255593050869, 6030.7889223876955, 6251.093066833229, 6302.779402720883, 6323.292710967921, 6345.841353966188, 6354.904676429765, 3846.1346197105427, 3849.538055433366, 3902.570717221047, 3974.7813870237414, 4003.3994900763955, 5072.847814565569, 5312.070387682063, 5970.283565972111, 6059.87892239937, 6165.93441197204, 4896.877578060577, 5645.322561292671, 5728.770849165987, 5818.854528636818, 5874.471297583067, 4960.652754307164, 5392.732707813582, 5459.617826752248, 5613.522850557585, 5913.172155898092, 5305.522502974751, 5442.537384322219, 5757.913631295618, 5810.883782324415, 5834.474897259267, 5858.0, 5969.432903874125, 5970.223870896755, 5971.790987315597, 5988.8802223956145, 5554.944450555605, 5738.626989245686, 5821.155932389865, 5849.824505264849, 5881.529477641864], "value": 4118.5686193259535, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.8194954690176, 734.0933946575981, 735.9411247100229, 766.9539827610344, 791.3945831438947, 14971.925140374296, 15676.451324203656, 15701.921490392531, 15705.764413533778, 15724.842751572494, 14069.71860562788, 14126.293685315719, 14129.293535323244, 14156.71686566268, 14158.716825663481, 672.6065251827687, 692.7609974558794, 827.0365024746163, 834.2825170353491, 850.9191626795445, 709.5175280809048, 842.5366048673236, 849.5327569836596, 850.6554845287668, 853.0190281176634, 737.9815504612374, 909.2498688581946, 916.4821875640242, 921.3412410126758, 925.0656836595053, 894.369469523984, 904.5296445848122, 909.2180724576858, 913.3332667152982, 915.6108653822165, 672.8856094463904, 676.2730065179951, 677.200902934537, 678.6131904814258, 680.4454369688688, 14588.197649129293, 14725.779113313309, 14751.631209219748, 14808.407663693439, 14833.25833708321, 13276.336183190802, 13424.664383390396, 14459.71080578393, 14515.709685806225, 14762.630934226623, 11586.594469193538, 11606.187566870323, 11741.530338786439, 11987.700307492296, 12200.938995304967, 3746.5635824095248, 3830.9042273943096, 3864.188520410717, 3881.8835434936996, 3983.5418926823495, 113943.86056139415, 116808.0, 117528.0, 118002.81997180004, 118670.0, 10855.402952837512, 11180.105591552656, 11195.4962026709, 11263.26788758728, 11629.77887321836, 22589.77410225877, 22628.094876205098, 22696.092156313895, 23013.654795178085, 23029.0, 8121.066077401175, 8141.348692104618, 8179.0594081681365, 8183.549904755177, 8227.71203007892, 4396.538363471854, 4509.6392288616835, 4585.9770701146945, 4605.930911036337, 4628.907421851544, 3561.1097225693575, 3679.9080022999105, 3680.595134535199, 3680.7975561344383, 3686.576043754949, 655.8786624474487, 661.5270081891471, 662.8900814947345, 682.6723172877047, 686.7905288886838, 488.6188772757255, 596.314238625584, 631.1006815288196, 644.577801539992, 683.6581709145428, 6725.932740672531, 8681.233027012759, 9353.39202951806, 9547.42715437076, 9625.229981601455, 451.0415367344393, 521.9665063174859, 527.9366476022902, 540.1276937745513, 603.474976770204, 4400.185965596375, 4650.325702773079, 4661.580457758818, 4670.439547254351, 4761.0001899601475, 96944.0, 142994.0, 144365.27817361057, 166340.3365966325, 169136.0, 145512.0, 146066.0, 147620.26189868982, 148414.0, 151552.2422387881, 119444.0, 121295.78704213022, 122770.0, 123326.38336808438, 124303.37848310881, 8082.515049097073, 8270.669173233004, 8905.51019693923, 9015.55751079824, 9144.451332920045, 66023.33976660365, 66073.33926660864, 67949.32050679627, 68171.65914170397, 68243.65878170577, 103509.0, 105643.0, 106185.46907265414, 107443.46278268559, 108108.0, 11469.254498457574, 11699.532018719156, 11887.16789824704, 12010.219335743148, 12013.63959081194, 12968.157069790434, 13012.544560940321, 13146.868531314565, 13224.272665003517, 13471.393787279792, 12028.819567706316, 12033.939830300793, 12188.57339993096, 12493.562725304571, 12687.11190216676, 12004.39978001079, 12047.75904481923, 12178.756424871275, 12265.38673066361, 12536.937315313366, 11039.39283339424, 11423.0, 11737.589184378507, 12088.274703517816, 12299.385030748248, 9859.92341421779, 10274.691759247235, 10788.352698838095, 11017.173711971795, 11235.66293011211, 8974.461532308082, 9578.760530986781, 9610.615575376907, 9709.757256068655, 9735.865966292358], "value": 7701.706086877686, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 119.0, 118.0, 118.0, 119.0, 119.0, 117.0, 117.0, 119.0], "value": 117.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 112.0, 109.0, 144.0, 101.0, 140.0, 143.0, 145.0, 130.0, 146.0], "value": 131.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [225.0, 215.0, 197.0, 198.0, 192.0, 216.0, 200.0, 191.0, 282.0, 257.0], "value": 217.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 58.0, 79.0, 60.0, 61.0, 58.0, 59.0, 76.0, 58.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 70.0, 76.0, 84.0, 100.0, 104.0, 116.0, 69.0, 70.0, 118.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 75.0, 134.0, 131.0, 89.0, 94.0, 91.0, 90.0, 121.0, 88.0], "value": 100.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 151.0, 113.0, 96.0, 96.0, 97.0, 97.0, 111.0, 124.0, 97.0], "value": 109.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 142.0, 143.0, 91.0, 91.0, 89.0, 96.0, 139.0, 148.0], "value": 112.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 55.0, 57.0, 60.0, 62.0, 60.0, 61.0, 60.0, 61.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 74.0, 76.0, 75.0, 71.0, 70.0, 69.0, 96.0, 108.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 105.0, 105.0, 80.0, 85.0, 84.0, 86.0, 87.0, 87.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 142.0, 142.0, 140.0, 140.0, 141.0, 142.0, 164.0, 198.0, 155.0], "value": 150.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 229.0, 165.0, 169.0, 165.0, 168.0, 165.0, 168.0, 165.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 75.0, 78.0, 88.0, 67.0, 58.0, 83.0, 88.0, 89.0], "value": 76.3, "unit": "score"}]}]} 16:36:40 INFO - Return code: 0 16:36:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:36:40 ERROR - # TBPL SUCCESS # 16:36:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:36:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:36:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:36:40 INFO - 2016-11-05 16:36:40.139 screenresolution[1684:16935] starting screenresolution argv=screenresolution get 16:36:40 INFO - 2016-11-05 16:36:40.142 screenresolution[1684:16935] Display 0: 1600x1200x32@60 16:36:40 INFO - 2016-11-05 16:36:40.148 screenresolution[1685:16938] starting screenresolution argv=screenresolution list 16:36:40 INFO - Available Modes on Display 0 16:36:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:36:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:36:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:36:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:36:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:36:40 INFO - Intel Iris: 16:36:40 INFO - Chipset Model: Intel Iris 16:36:40 INFO - Type: GPU 16:36:40 INFO - Bus: Built-In 16:36:40 INFO - VRAM (Dynamic, Max): 1536 MB 16:36:40 INFO - Vendor: Intel (0x8086) 16:36:40 INFO - Device ID: 0x0a2e 16:36:40 INFO - Revision ID: 0x0009 16:36:40 INFO - Displays: 16:36:40 INFO - Display: 16:36:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:36:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:36:40 INFO - Display Serial Number: 1600x1200 60 16:36:40 INFO - Main Display: Yes 16:36:40 INFO - Mirror: Off 16:36:40 INFO - Online: Yes 16:36:40 INFO - Rotation: Supported 16:36:40 INFO - Return code: 0 16:36:40 INFO - Running post-action listener: _resource_record_post_action 16:36:40 INFO - [mozharness: 2016-11-05 23:36:40.385046Z] Finished run-tests step (success) 16:36:40 INFO - Running post-run listener: _resource_record_post_run 16:36:40 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 31865856; Write bytes: 666842624; Read time: 194; Write time: 1912 16:36:40 INFO - TinderboxPrint: CPU usage
54.3% 16:36:40 INFO - TinderboxPrint: I/O read bytes / time
31,865,856 / 194 16:36:40 INFO - TinderboxPrint: I/O write bytes / time
666,842,624 / 1,912 16:36:40 INFO - TinderboxPrint: CPU idle
2,210.8 (45.7%) 16:36:40 INFO - TinderboxPrint: CPU system
978.4 (20.2%) 16:36:40 INFO - TinderboxPrint: CPU user
1,644.5 (34.0%) 16:36:40 INFO - TinderboxPrint: Swap in / out
391,561,216 / 0 16:36:40 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 364530176; Write bytes: 365569536; Read time: 27794; Write time: 771 16:36:40 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 28777472; Write bytes: 299958272; Read time: 172; Write time: 1133 16:36:40 INFO - Running post-run listener: _upload_blobber_files 16:36:40 INFO - Blob upload gear active. 16:36:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:36:40 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 16:36:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:36:41 INFO - (blobuploader) - INFO - Open directory for files ... 16:36:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:36:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:36:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:42 INFO - (blobuploader) - INFO - Done attempting. 16:36:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:36:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:36:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:43 INFO - (blobuploader) - INFO - Done attempting. 16:36:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:36:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:36:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:45 INFO - (blobuploader) - INFO - Done attempting. 16:36:45 INFO - (blobuploader) - INFO - Iteration through files over. 16:36:45 INFO - Return code: 0 16:36:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:36:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:36:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7f64b66064e58811946f17df638d92897088709168b0ef99a9a266224648e207ddccb9a17d904a295a0436082b340e9af280d156381b4987664ef81e295d01d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c69770f2adcd183230c2c8c21781721d103595355f081f5797b57c1428759810a5f2c502d14c167793228c288f52fa23c69af5b033e049a17970ac743b28dfac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0e83cd56eda0c0bdecd1ae596d4d0dc9598f65ca98e7f0b57d11cfb2c45254384398b76dcee121a64d0a60b29a3189af90ca5941c38c671aace0bd38abb3824"} 16:36:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:36:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:36:45 INFO - Contents: 16:36:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7f64b66064e58811946f17df638d92897088709168b0ef99a9a266224648e207ddccb9a17d904a295a0436082b340e9af280d156381b4987664ef81e295d01d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c69770f2adcd183230c2c8c21781721d103595355f081f5797b57c1428759810a5f2c502d14c167793228c288f52fa23c69af5b033e049a17970ac743b28dfac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0e83cd56eda0c0bdecd1ae596d4d0dc9598f65ca98e7f0b57d11cfb2c45254384398b76dcee121a64d0a60b29a3189af90ca5941c38c671aace0bd38abb3824"} 16:36:45 INFO - Running post-run listener: copy_logs_to_upload_dir 16:36:45 INFO - Copying logs to upload dir... 16:36:45 INFO - mkdir: /builds/slave/test/build/upload/logs 16:36:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.136333 ========= master_lag: 2.22 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-05 16:36:48.005888) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 16:36:48.012116) ========= 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.1VE3BMzdrK/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.jB5ISD47Uq/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7f64b66064e58811946f17df638d92897088709168b0ef99a9a266224648e207ddccb9a17d904a295a0436082b340e9af280d156381b4987664ef81e295d01d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c69770f2adcd183230c2c8c21781721d103595355f081f5797b57c1428759810a5f2c502d14c167793228c288f52fa23c69af5b033e049a17970ac743b28dfac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0e83cd56eda0c0bdecd1ae596d4d0dc9598f65ca98e7f0b57d11cfb2c45254384398b76dcee121a64d0a60b29a3189af90ca5941c38c671aace0bd38abb3824"} build_url:https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010898 build_url: 'https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7f64b66064e58811946f17df638d92897088709168b0ef99a9a266224648e207ddccb9a17d904a295a0436082b340e9af280d156381b4987664ef81e295d01d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c69770f2adcd183230c2c8c21781721d103595355f081f5797b57c1428759810a5f2c502d14c167793228c288f52fa23c69af5b033e049a17970ac743b28dfac", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a0e83cd56eda0c0bdecd1ae596d4d0dc9598f65ca98e7f0b57d11cfb2c45254384398b76dcee121a64d0a60b29a3189af90ca5941c38c671aace0bd38abb3824"}' ========= master_lag: 0.41 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 16:36:48.429648) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:36:48.430005) ========= 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.1VE3BMzdrK/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.jB5ISD47Uq/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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.005254 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:36:48.491417) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 16:36:48.491738) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 16:36:48.497209) ========= ========= Total master_lag: 2.76 =========