builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0240 starttime: 1478387733.28 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.281334) ========= 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.281725) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.282006) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.348587) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:33.348913) ========= 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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.3M=0.001s 2016-11-05 16:15:34 (19.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.643283 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:34.022947) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:34.023231) ========= 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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.028100 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:34.077446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:34.077797) ========= 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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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,164 truncating revision to first 12 chars 2016-11-05 16:15:34,164 Setting DEBUG logging. 2016-11-05 16:15:34,164 attempt 1/10 2016-11-05 16:15:34,164 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:34,797 unpacking tar archive at: mozilla-aurora-070cf059bb70/testing/mozharness/ program finished with exit code 0 elapsedTime=0.903519 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:35.003357) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:35.003676) ========= script_repo_revision: 070cf059bb70aa991d50b4d266987adf26685915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:35.007160) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:35.007428) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-05 16:15:35.026594) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-11-05 16:15:35.026988) ========= /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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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-0240', 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.237315Z] 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:37 INFO - Running post-action listener: _resource_record_post_action 16:15:37 INFO - [mozharness: 2016-11-05 23:15:37.665242Z] Finished clobber step (success) 16:15:37 INFO - [mozharness: 2016-11-05 23:15:37.665389Z] Running read-buildbot-config step. 16:15:37 INFO - Running pre-action listener: _resource_record_pre_action 16:15:37 INFO - Running main action method: read_buildbot_config 16:15:37 INFO - Using buildbot properties: 16:15:37 INFO - { 16:15:37 INFO - "project": "", 16:15:37 INFO - "product": "firefox", 16:15:37 INFO - "script_repo_revision": "production", 16:15:37 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 16:15:37 INFO - "repository": "", 16:15:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 16:15:37 INFO - "buildid": "20161105060620", 16:15:37 INFO - "pgo_build": "False", 16:15:37 INFO - "basedir": "/builds/slave/test", 16:15:37 INFO - "buildnumber": 6, 16:15:37 INFO - "slavename": "t-yosemite-r7-0240", 16:15:37 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 16:15:37 INFO - "platform": "yosemite_r7", 16:15:37 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:15:37 INFO - "branch": "mozilla-aurora", 16:15:37 INFO - "repo_path": "releases/mozilla-aurora", 16:15:37 INFO - "revision": "070cf059bb70aa991d50b4d266987adf26685915", 16:15:37 INFO - "stage_platform": "macosx64", 16:15:37 INFO - "builduid": "b916449ac61a4df986f58c0f4ee2b98e", 16:15:37 INFO - "slavebuilddir": "test" 16:15:37 INFO - } 16:15:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 16:15:37 INFO - Running post-action listener: _resource_record_post_action 16:15:37 INFO - [mozharness: 2016-11-05 23:15:37.668785Z] Finished read-buildbot-config step (success) 16:15:37 INFO - [mozharness: 2016-11-05 23:15:37.668921Z] Running download-and-extract step. 16:15:37 INFO - Running pre-action listener: _resource_record_pre_action 16:15:37 INFO - Running main action method: download_and_extract 16:15:37 INFO - mkdir: /builds/slave/test/build/tests 16:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:15:37 INFO - trying https://queue.taskcluster.net/v1/task/a33Nu30jQACbK3wn41gmlA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 16:15:37 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:37 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:54 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:58 INFO - Running post-action listener: _resource_record_post_action 16:15:58 INFO - Running post-action listener: set_extra_try_arguments 16:15:58 INFO - [mozharness: 2016-11-05 23:15:58.736595Z] Finished download-and-extract step (success) 16:15:58 INFO - [mozharness: 2016-11-05 23:15:58.736714Z] Running populate-webroot step. 16:15:58 INFO - Running pre-action listener: _resource_record_pre_action 16:15:58 INFO - Running main action method: populate_webroot 16:15:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:15:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:15:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:15:58 INFO - '--tppagecycles', 16:15:58 INFO - '7'], 16:15:58 INFO - 'tests': ['tsvgm']}}, 16:15:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:15:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:15:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:15:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:15:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:15:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:15:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:58 INFO - 'talos_options': ['--disable-e10s'], 16:15:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:15:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:58 INFO - 'talos_options': ['--disable-e10s'], 16:15:58 INFO - 'tests': ['damp', 'tps']}, 16:15:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:58 INFO - 'tests': ['damp', 'tps']}, 16:15:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:15:58 INFO - 'tests': ['dromaeo_dom']}, 16:15:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:15:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:15:58 INFO - 'tests': ['basic_compositor_video']}, 16:15:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:15:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:15:58 INFO - 'tests': ['a11yr', 16:15:58 INFO - 'ts_paint', 16:15:58 INFO - 'tpaint', 16:15:58 INFO - 'sessionrestore', 16:15:58 INFO - 'sessionrestore_no_auto_restore', 16:15:58 INFO - 'tabpaint']}, 16:15:58 INFO - 'other-e10s': {'tests': ['a11yr', 16:15:58 INFO - 'ts_paint', 16:15:58 INFO - 'tpaint', 16:15:58 INFO - 'sessionrestore', 16:15:58 INFO - 'sessionrestore_no_auto_restore', 16:15:58 INFO - 'tabpaint']}, 16:15:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:15:58 INFO - 'ts_paint', 16:15:58 INFO - 'tpaint', 16:15:58 INFO - 'sessionrestore', 16:15:58 INFO - 'sessionrestore_no_auto_restore', 16:15:58 INFO - 'tabpaint']}, 16:15:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:15:58 INFO - 'ts_paint', 16:15:58 INFO - 'tpaint', 16:15:58 INFO - 'sessionrestore', 16:15:58 INFO - 'sessionrestore_no_auto_restore', 16:15:58 INFO - 'tabpaint']}, 16:15:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:15:58 INFO - 'tests': ['a11yr', 16:15:58 INFO - 'ts_paint', 16:15:58 INFO - 'tpaint', 16:15:58 INFO - 'sessionrestore', 16:15:58 INFO - 'sessionrestore_no_auto_restore', 16:15:58 INFO - 'tabpaint']}, 16:15:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:15:58 INFO - 'tests': ['a11yr', 16:15:58 INFO - 'ts_paint', 16:15:58 INFO - 'tpaint', 16:15:58 INFO - 'sessionrestore', 16:15:58 INFO - 'sessionrestore_no_auto_restore', 16:15:58 INFO - 'tabpaint']}, 16:15:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:15:58 INFO - 'tests': ['tsvgx', 16:15:58 INFO - 'tsvgr_opacity', 16:15:58 INFO - 'tart', 16:15:58 INFO - 'tscrollx', 16:15:58 INFO - 'cart']}, 16:15:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:15:58 INFO - 'tsvgr_opacity', 16:15:58 INFO - 'tart', 16:15:58 INFO - 'tscrollx', 16:15:58 INFO - 'cart']}, 16:15:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:58 INFO - 'talos_options': ['--disable-e10s'], 16:15:58 INFO - 'tests': ['tp5o']}, 16:15:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:58 INFO - 'tests': ['tp5o']}, 16:15:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:58 INFO - 'talos_options': ['--disable-e10s', 16:15:58 INFO - '--xperf_path', 16:15:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:58 INFO - 'tests': ['tp5n']}, 16:15:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:15:58 INFO - 'talos_options': ['--xperf_path', 16:15:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:15:58 INFO - 'tests': ['tp5n']}}, 16:15:58 INFO - 'talos.zip': {'path': '', 16:15:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:15:58 INFO - Running post-action listener: _resource_record_post_action 16:15:58 INFO - [mozharness: 2016-11-05 23:15:58.755479Z] Finished populate-webroot step (success) 16:15:58 INFO - [mozharness: 2016-11-05 23:15:58.755575Z] Running create-virtualenv step. 16:15:58 INFO - Running pre-action listener: _resource_record_pre_action 16:15:58 INFO - Running main action method: create_virtualenv 16:15:58 INFO - Creating virtualenv /builds/slave/test/build/venv 16:15:58 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:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:15:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:15:58 INFO - Using real prefix '/tools/python27' 16:15:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:15:59 INFO - Installing distribute.............................................................................................................................................................................................done. 16:16:02 INFO - Installing pip.................done. 16:16:02 INFO - Return code: 0 16:16:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:02 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 0x10e904490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e87a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f3959d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e718d30>, '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 0x10e57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e710b20>, '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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:02 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:02 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:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1CdJD1FFfz/Render', 16:16:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:02 INFO - 'HOME': '/Users/cltbld', 16:16:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:02 INFO - 'LOGNAME': 'cltbld', 16:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:02 INFO - 'MOZ_NO_REMOTE': '1', 16:16:02 INFO - 'NO_EM_RESTART': '1', 16:16:02 INFO - 'PAGER': '/bin/cat', 16:16:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:02 INFO - 'PWD': '/builds/slave/test', 16:16:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:02 INFO - 'SHELL': '/bin/bash', 16:16:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aWQrrM1gQ3/Listeners', 16:16:02 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 16:16:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:02 INFO - 'USER': 'cltbld', 16:16:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:02 INFO - 'XPC_FLAGS': '0x0', 16:16:02 INFO - 'XPC_SERVICE_NAME': '0', 16:16:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:02 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:02 INFO - Cleaning up... 16:16:02 INFO - Return code: 0 16:16:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:02 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 0x10e904490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e87a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f3959d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e718d30>, '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 0x10e57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e710b20>, '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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:02 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:02 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:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1CdJD1FFfz/Render', 16:16:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:02 INFO - 'HOME': '/Users/cltbld', 16:16:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:02 INFO - 'LOGNAME': 'cltbld', 16:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:02 INFO - 'MOZ_NO_REMOTE': '1', 16:16:02 INFO - 'NO_EM_RESTART': '1', 16:16:02 INFO - 'PAGER': '/bin/cat', 16:16:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:02 INFO - 'PWD': '/builds/slave/test', 16:16:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:02 INFO - 'SHELL': '/bin/bash', 16:16:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aWQrrM1gQ3/Listeners', 16:16:02 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 16:16:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:02 INFO - 'USER': 'cltbld', 16:16:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:02 INFO - 'XPC_FLAGS': '0x0', 16:16:02 INFO - 'XPC_SERVICE_NAME': '0', 16:16:02 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 0x10e904490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e87a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f3959d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e718d30>, '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 0x10e57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e710b20>, '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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners', 16:16:07 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:16:10 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:10 INFO - Installing collected packages: mozsystemmonitor 16:16:10 INFO - Running setup.py install for mozsystemmonitor 16:16:10 INFO - Successfully installed mozsystemmonitor 16:16:10 INFO - Cleaning up... 16:16:10 INFO - Return code: 0 16:16:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:10 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 0x10e904490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e87a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f3959d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e718d30>, '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 0x10e57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e710b20>, '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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:10 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:10 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:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1CdJD1FFfz/Render', 16:16:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:10 INFO - 'HOME': '/Users/cltbld', 16:16:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:10 INFO - 'LOGNAME': 'cltbld', 16:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:10 INFO - 'MOZ_NO_REMOTE': '1', 16:16:10 INFO - 'NO_EM_RESTART': '1', 16:16:10 INFO - 'PAGER': '/bin/cat', 16:16:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:10 INFO - 'PWD': '/builds/slave/test', 16:16:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:10 INFO - 'SHELL': '/bin/bash', 16:16:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aWQrrM1gQ3/Listeners', 16:16:10 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 16:16:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:10 INFO - 'USER': 'cltbld', 16:16:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:10 INFO - 'XPC_FLAGS': '0x0', 16:16:10 INFO - 'XPC_SERVICE_NAME': '0', 16:16:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:11 INFO - Downloading/unpacking jsonschema==2.5.1 16:16:11 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:11 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 - 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:11 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:11 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:11 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:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:16:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:16:13 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:13 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:13 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:13 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:13 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:13 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 functools32-3.2.3-2.tar.gz 16:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:16:14 INFO - warning: no files found matching '*.txt' 16:16:14 INFO - no previously-included directories found matching 'build' 16:16:14 INFO - no previously-included directories found matching 'dist' 16:16:14 INFO - no previously-included directories found matching '.git*' 16:16:14 INFO - Installing collected packages: jsonschema, functools32 16:16:14 INFO - Running setup.py install for functools32 16:16:14 INFO - warning: no files found matching '*.txt' 16:16:14 INFO - no previously-included directories found matching 'build' 16:16:14 INFO - no previously-included directories found matching 'dist' 16:16:14 INFO - no previously-included directories found matching '.git*' 16:16:14 INFO - Successfully installed jsonschema functools32 16:16:14 INFO - Cleaning up... 16:16:14 INFO - Return code: 0 16:16:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e904490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e87a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f3959d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e718d30>, '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 0x10e57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e710b20>, '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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:16:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1CdJD1FFfz/Render', 16:16:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:14 INFO - 'HOME': '/Users/cltbld', 16:16:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:14 INFO - 'LOGNAME': 'cltbld', 16:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:14 INFO - 'MOZ_NO_REMOTE': '1', 16:16:14 INFO - 'NO_EM_RESTART': '1', 16:16:14 INFO - 'PAGER': '/bin/cat', 16:16:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:14 INFO - 'PWD': '/builds/slave/test', 16:16:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:14 INFO - 'SHELL': '/bin/bash', 16:16:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aWQrrM1gQ3/Listeners', 16:16:14 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 16:16:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:14 INFO - 'USER': 'cltbld', 16:16:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:14 INFO - 'XPC_FLAGS': '0x0', 16:16:14 INFO - 'XPC_SERVICE_NAME': '0', 16:16:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:16:14 INFO - Cleaning up... 16:16:14 INFO - Return code: 0 16:16:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e904490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e87a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f3959d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e718d30>, '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 0x10e57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e710b20>, '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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:16:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1CdJD1FFfz/Render', 16:16:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:14 INFO - 'HOME': '/Users/cltbld', 16:16:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:14 INFO - 'LOGNAME': 'cltbld', 16:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:14 INFO - 'MOZ_NO_REMOTE': '1', 16:16:14 INFO - 'NO_EM_RESTART': '1', 16:16:14 INFO - 'PAGER': '/bin/cat', 16:16:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:14 INFO - 'PWD': '/builds/slave/test', 16:16:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:14 INFO - 'SHELL': '/bin/bash', 16:16:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aWQrrM1gQ3/Listeners', 16:16:14 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 16:16:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:14 INFO - 'USER': 'cltbld', 16:16:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:14 INFO - 'XPC_FLAGS': '0x0', 16:16:14 INFO - 'XPC_SERVICE_NAME': '0', 16:16:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:14 INFO - Downloading/unpacking blobuploader==1.2.4 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:17 INFO - Downloading blobuploader-1.2.4.tar.gz 16:16:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:16:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:16:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:16:18 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:18 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 - 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:18 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:18 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:18 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 docopt-0.6.1.tar.gz 16:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:16:18 INFO - Installing collected packages: blobuploader, requests, docopt 16:16:18 INFO - Running setup.py install for blobuploader 16:16:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:16:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:16:19 INFO - Running setup.py install for requests 16:16:19 INFO - Running setup.py install for docopt 16:16:19 INFO - Successfully installed blobuploader requests docopt 16:16:19 INFO - Cleaning up... 16:16:19 INFO - Return code: 0 16:16:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:16:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:19 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 0x10e904490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e87a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f3959d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e718d30>, '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 0x10e57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e710b20>, '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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:19 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:19 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:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1CdJD1FFfz/Render', 16:16:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:19 INFO - 'HOME': '/Users/cltbld', 16:16:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:19 INFO - 'LOGNAME': 'cltbld', 16:16:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:19 INFO - 'MOZ_NO_REMOTE': '1', 16:16:19 INFO - 'NO_EM_RESTART': '1', 16:16:19 INFO - 'PAGER': '/bin/cat', 16:16:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:19 INFO - 'PWD': '/builds/slave/test', 16:16:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:19 INFO - 'SHELL': '/bin/bash', 16:16:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aWQrrM1gQ3/Listeners', 16:16:19 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 16:16:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:19 INFO - 'USER': 'cltbld', 16:16:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:19 INFO - 'XPC_FLAGS': '0x0', 16:16:19 INFO - 'XPC_SERVICE_NAME': '0', 16:16:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:20 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-5syns3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:20 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-4e0vgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:20 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-CvzkXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:20 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-pW99qI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:20 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-NSKr5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:20 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-Dpq1kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:20 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-jJBWk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:20 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-f3Bc3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:20 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-uvJLAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:21 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-YuWW3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:21 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-eA81Tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:21 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-0FYNRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:21 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-Ei7i2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:21 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-TDashf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:21 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-nNXCU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:21 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-tXy6r7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:21 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-6PIhsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:16:21 INFO - Running setup.py install for manifestparser 16:16:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:16:22 INFO - Running setup.py install for mozcrash 16:16:22 INFO - Running setup.py install for mozdebug 16:16:22 INFO - Running setup.py install for mozdevice 16:16:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:16:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:16:22 INFO - Running setup.py install for mozfile 16:16:22 INFO - Running setup.py install for mozhttpd 16:16:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:16:22 INFO - Running setup.py install for mozinfo 16:16:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:16:22 INFO - Running setup.py install for mozInstall 16:16:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Running setup.py install for mozleak 16:16:23 INFO - Running setup.py install for mozlog 16:16:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Running setup.py install for moznetwork 16:16:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Running setup.py install for mozprocess 16:16:23 INFO - Running setup.py install for mozprofile 16:16:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:16:23 INFO - Running setup.py install for mozrunner 16:16:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Running setup.py install for mozscreenshot 16:16:24 INFO - Running setup.py install for moztest 16:16:24 INFO - Running setup.py install for mozversion 16:16:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:16:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:16:24 INFO - Cleaning up... 16:16:24 INFO - Return code: 0 16:16:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:24 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:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:24 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:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:24 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 0x10e904490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e87a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f3959d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e718d30>, '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 0x10e57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e710b20>, '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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:24 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:24 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:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1CdJD1FFfz/Render', 16:16:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:24 INFO - 'HOME': '/Users/cltbld', 16:16:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:24 INFO - 'LOGNAME': 'cltbld', 16:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:24 INFO - 'MOZ_NO_REMOTE': '1', 16:16:24 INFO - 'NO_EM_RESTART': '1', 16:16:24 INFO - 'PAGER': '/bin/cat', 16:16:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:24 INFO - 'PWD': '/builds/slave/test', 16:16:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:24 INFO - 'SHELL': '/bin/bash', 16:16:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aWQrrM1gQ3/Listeners', 16:16:24 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 16:16:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:24 INFO - 'USER': 'cltbld', 16:16:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:24 INFO - 'XPC_FLAGS': '0x0', 16:16:24 INFO - 'XPC_SERVICE_NAME': '0', 16:16:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:24 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-nceNbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:24 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-e_an2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:24 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:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:24 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-idK1F8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:25 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-dBRwBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:25 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-xaY4wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:25 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-4g_OGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:25 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-KZ2uTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:25 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-mKLmZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:25 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-Pggtm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:25 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-s__1Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:25 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-oc1op3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:25 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:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:25 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-xFt7Ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:26 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-1G1tn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:26 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-QFAyOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:26 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-4WnWlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:26 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-VGGwl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:26 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:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:26 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-JO90mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:26 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:26 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:26 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:26 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:26 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:26 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:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:16:26 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:26 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:26 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:26 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:26 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:26 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:28 INFO - Downloading blessings-1.6.tar.gz 16:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:16:29 INFO - Installing collected packages: blessings 16:16:29 INFO - Running setup.py install for blessings 16:16:29 INFO - Successfully installed blessings 16:16:29 INFO - Cleaning up... 16:16:29 INFO - Return code: 0 16:16:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:16:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:29 INFO - Reading from file tmpfile_stdout 16:16:29 INFO - Current package versions: 16:16:29 INFO - blessings == 1.6 16:16:29 INFO - blobuploader == 1.2.4 16:16:29 INFO - docopt == 0.6.1 16:16:29 INFO - functools32 == 3.2.3-2 16:16:29 INFO - jsonschema == 2.5.1 16:16:29 INFO - manifestparser == 1.1 16:16:29 INFO - mozInstall == 1.12 16:16:29 INFO - mozcrash == 0.17 16:16:29 INFO - mozdebug == 0.1 16:16:29 INFO - mozdevice == 0.48 16:16:29 INFO - mozfile == 1.2 16:16:29 INFO - mozhttpd == 0.7 16:16:29 INFO - mozinfo == 0.9 16:16:29 INFO - mozleak == 0.1 16:16:29 INFO - mozlog == 3.4 16:16:29 INFO - moznetwork == 0.27 16:16:29 INFO - mozprocess == 0.23 16:16:29 INFO - mozprofile == 0.28 16:16:29 INFO - mozrunner == 6.12 16:16:29 INFO - mozscreenshot == 0.1 16:16:29 INFO - mozsystemmonitor == 0.3 16:16:29 INFO - moztest == 0.7 16:16:29 INFO - mozversion == 1.4 16:16:29 INFO - psutil == 3.1.1 16:16:29 INFO - requests == 1.2.3 16:16:29 INFO - wsgiref == 0.1.2 16:16:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:29 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:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:29 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:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:29 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 0x10e904490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e87a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f3959d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e718d30>, '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 0x10e57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e710b20>, '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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:29 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:29 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:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1CdJD1FFfz/Render', 16:16:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:29 INFO - 'HOME': '/Users/cltbld', 16:16:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:29 INFO - 'LOGNAME': 'cltbld', 16:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:29 INFO - 'MOZ_NO_REMOTE': '1', 16:16:29 INFO - 'NO_EM_RESTART': '1', 16:16:29 INFO - 'PAGER': '/bin/cat', 16:16:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:29 INFO - 'PWD': '/builds/slave/test', 16:16:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:29 INFO - 'SHELL': '/bin/bash', 16:16:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aWQrrM1gQ3/Listeners', 16:16:29 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 16:16:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:29 INFO - 'USER': 'cltbld', 16:16:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:29 INFO - 'XPC_FLAGS': '0x0', 16:16:29 INFO - 'XPC_SERVICE_NAME': '0', 16:16:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:29 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:29 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:29 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:29 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:29 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:29 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:29 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:29 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:29 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:29 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:29 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:29 INFO - Cleaning up... 16:16:29 INFO - Return code: 0 16:16:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:16:29 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:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:29 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:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:29 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 0x10e904490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e87a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f3959d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e718d30>, '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 0x10e57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e710b20>, '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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:29 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:29 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:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1CdJD1FFfz/Render', 16:16:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:29 INFO - 'HOME': '/Users/cltbld', 16:16:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:29 INFO - 'LOGNAME': 'cltbld', 16:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:29 INFO - 'MOZ_NO_REMOTE': '1', 16:16:29 INFO - 'NO_EM_RESTART': '1', 16:16:29 INFO - 'PAGER': '/bin/cat', 16:16:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:29 INFO - 'PWD': '/builds/slave/test', 16:16:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:29 INFO - 'SHELL': '/bin/bash', 16:16:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aWQrrM1gQ3/Listeners', 16:16:29 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 16:16:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:29 INFO - 'USER': 'cltbld', 16:16:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:29 INFO - 'XPC_FLAGS': '0x0', 16:16:29 INFO - 'XPC_SERVICE_NAME': '0', 16:16:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:16:30 INFO - Cleaning up... 16:16:30 INFO - Return code: 0 16:16:30 INFO - Running post-action listener: _resource_record_post_action 16:16:30 INFO - Running post-action listener: _start_resource_monitoring 16:16:30 INFO - Starting resource monitoring. 16:16:30 INFO - [mozharness: 2016-11-05 23:16:30.209477Z] Finished create-virtualenv step (success) 16:16:30 INFO - [mozharness: 2016-11-05 23:16:30.210417Z] Running install step. 16:16:30 INFO - Running pre-action listener: _resource_record_pre_action 16:16:30 INFO - Running main action method: install 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 - Detecting whether we're running mozinstall >=1.0... 16:16:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:16:30 INFO - Reading from file tmpfile_stdout 16:16:30 INFO - Output received: 16:16:30 INFO - Usage: mozinstall [options] installer 16:16:30 INFO - Options: 16:16:30 INFO - -h, --help show this help message and exit 16:16:30 INFO - -d DEST, --destination=DEST 16:16:30 INFO - Directory to install application into. [default: 16:16:30 INFO - "/builds/slave/test"] 16:16:30 INFO - --app=APP Application being installed. [default: firefox] 16:16:30 INFO - mkdir: /builds/slave/test/build/application 16:16:30 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:30 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:02 INFO - Reading from file tmpfile_stdout 16:17:02 INFO - Output received: 16:17:02 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:17:02 INFO - Running post-action listener: _resource_record_post_action 16:17:02 INFO - [mozharness: 2016-11-05 23:17:02.684062Z] Finished install step (success) 16:17:02 INFO - [mozharness: 2016-11-05 23:17:02.684248Z] Running run-tests step. 16:17:02 INFO - Running pre-action listener: _resource_record_pre_action 16:17:02 INFO - Running main action method: run_tests 16:17:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:17:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:17:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:17:02 INFO - 2016-11-05 16:17:02.698 screenresolution[1657:13442] starting screenresolution argv=screenresolution get 16:17:02 INFO - 2016-11-05 16:17:02.701 screenresolution[1657:13442] Display 0: 1600x1200x32@60 16:17:02 INFO - 2016-11-05 16:17:02.706 screenresolution[1658:13444] starting screenresolution argv=screenresolution list 16:17:02 INFO - Available Modes on Display 0 16:17:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:17:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:17:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:17:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:17:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:17:02 INFO - Intel Iris: 16:17:02 INFO - Chipset Model: Intel Iris 16:17:02 INFO - Type: GPU 16:17:02 INFO - Bus: Built-In 16:17:02 INFO - VRAM (Dynamic, Max): 1536 MB 16:17:02 INFO - Vendor: Intel (0x8086) 16:17:02 INFO - Device ID: 0x0a2e 16:17:02 INFO - Revision ID: 0x0009 16:17:02 INFO - Displays: 16:17:02 INFO - Display: 16:17:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:17:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:17:02 INFO - Display Serial Number: 1600x1200 60 16:17:02 INFO - Main Display: Yes 16:17:02 INFO - Mirror: Off 16:17:02 INFO - Online: Yes 16:17:02 INFO - Rotation: Supported 16:17:02 INFO - Return code: 0 16:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:17:02 INFO - Python 2.7.3 16:17:02 INFO - Return code: 0 16:17:02 INFO - grabbing minidump binary from tooltool 16:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:17:02 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 0x10e718d30>, '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 0x10e57edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e710b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:17:02 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:02 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:02 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:03 INFO - Return code: 0 16:17:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:17:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:17:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:17:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:17:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:17:03 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-0240', '--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:03 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-0240 --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:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1CdJD1FFfz/Render', 16:17:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:17:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:17:03 INFO - 'HOME': '/Users/cltbld', 16:17:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:17:03 INFO - 'LOGNAME': 'cltbld', 16:17:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:17:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:03 INFO - 'MOZ_NO_REMOTE': '1', 16:17:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:17:03 INFO - 'NO_EM_RESTART': '1', 16:17:03 INFO - 'PAGER': '/bin/cat', 16:17:03 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:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:03 INFO - 'PWD': '/builds/slave/test', 16:17:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:17:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:17:03 INFO - 'SHELL': '/bin/bash', 16:17:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aWQrrM1gQ3/Listeners', 16:17:03 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 16:17:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:17:03 INFO - 'USER': 'cltbld', 16:17:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:17:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:03 INFO - 'XPC_FLAGS': '0x0', 16:17:03 INFO - 'XPC_SERVICE_NAME': '0', 16:17:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:17:03 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-0240', '--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:03 INFO - mozversion application_buildid: 20161105060620 16:17:03 INFO - mozversion application_changeset: 070cf059bb70aa991d50b4d266987adf26685915 16:17:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:17:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:17:03 INFO - mozversion application_name: Firefox 16:17:03 INFO - mozversion application_remotingname: firefox-dev 16:17:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:17:03 INFO - mozversion application_vendor: Mozilla 16:17:03 INFO - mozversion application_version: 51.0a2 16:17:03 INFO - mozversion platform_buildid: 20161105060620 16:17:03 INFO - mozversion platform_changeset: 070cf059bb70aa991d50b4d266987adf26685915 16:17:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:17:03 INFO - mozversion platform_version: 51.0a2 16:17:03 INFO - using testdate: 1478387823 16:17:03 INFO - actual date: 1478387823 16:17:03 INFO - starting webserver on 'localhost:49281' 16:17:03 INFO - SUITE-START | Running 2 tests 16:17:03 INFO - TEST-START | dromaeo_css 16:17:03 INFO - operating with platform_type : mac_ 16:17:03 INFO - Initialising browser for dromaeo_css test... 16:17:03 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpvISyr6/profile http://localhost:49281/getInfo.html) 16:17:05 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 16:17:05 INFO - PROCESS | 1668 | colorDepth:24 16:17:05 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 16:17:05 INFO - PROCESS | 1668 | __metrics 16:17:06 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 16:17:06 INFO - TEST-INFO | 1668: exit 0 16:17:06 INFO - Browser initialized. 16:17:06 INFO - Running cycle 1/1 for dromaeo_css test... 16:17:06 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpvISyr6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:17:18 INFO - PROCESS | 1672 | RSS: Main: 225492992 16:17:18 INFO - PROCESS | 1672 | 16:18:08 INFO - PROCESS | 1672 | 1478387888349 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:20 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49281/tests/dromaeo/cssquery-ext.html) 16:20:22 INFO - PROCESS | 1672 | RSS: Main: 238161920 16:20:22 INFO - PROCESS | 1672 | 16:23:24 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-ext.html (next: http://localhost:49281/tests/dromaeo/cssquery-jquery.html) 16:23:24 INFO - PROCESS | 1672 | RSS: Main: 247500800 16:23:24 INFO - PROCESS | 1672 | 16:26:26 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49281/tests/dromaeo/cssquery-mootools.html) 16:26:27 INFO - PROCESS | 1672 | RSS: Main: 251604992 16:26:27 INFO - PROCESS | 1672 | 16:29:29 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49281/tests/dromaeo/cssquery-prototype.html) 16:29:29 INFO - PROCESS | 1672 | RSS: Main: 252874752 16:29:29 INFO - PROCESS | 1672 | 16:32:32 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49281/tests/dromaeo/cssquery-yui.html) 16:32:33 INFO - PROCESS | 1672 | RSS: Main: 257429504 16:32:33 INFO - PROCESS | 1672 | 16:35:36 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-yui.html (next: http://localhost:49281/tests/dromaeo/cssquery-dojo.html) 16:35:36 INFO - PROCESS | 1672 | RSS: Main: 259416064 16:35:36 INFO - PROCESS | 1672 | 16:35:36 INFO - PROCESS | 1672 | __start_tp_report 16:35:36 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 16:35:36 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 16:35:36 INFO - PROCESS | 1672 | |i|pagename|runs| 16:35:36 INFO - PROCESS | 1672 | |0;dojo.html;3263.2494526258965;3300.290437555925;3346.196912740943;3357.7481688873327;3386.966130338699;5555.527780138688;5570.721463926808;5636.7181640918;5639;5675.9999999999945;5580.525655319292;5636.887262254762;5660.518855897254;5662.490375866171;5678.43215678432;5123.923141152885;5189.636725429222;5207.531322181003;5221.138512145491;5271.551918086967;5227.503387178212;5248.107821670306;5256.92114618281;5258.894822103555;5272.420033796279;5160.277561141444;5161.251618515313;5220.738963051851;5270.472952704718;5273.604479664022;5177.818776342848;5228.372595288571;5255.237990491396;5289.814856480005;5337.519623233928;5132.5124113209185;5247.632665713401;5251.002309561171;5255.264263003182;5319.468053194688;5513.917291240595;5681.659100453986;5714.828460165656;5785.218995435646;5816.680082595455;5037.596992240612;5960.344362120163;6105.755769769204;6114.816555503342;6133;5477.4248703886315;6103.389661033905;6139.570230083896;6161.876762464771;6181.165542651729;5801.7099145042575;5818.912716309216;5827.125931110368;5838.737256823453;5856.882862342729;6125.877482450326;6128.724207410677;6136.917362303815;6140.907886381708;6153.769246150699;6072.908906366408;6082.635041897501;6092.421219984094;6095.542834287357;6098.908516372258;6107.633541987495;6129.96935015331;6147.754089836357;6152.692365381713;6155.292141403706;4502.144592527409;5437.34751829783;5914.970425147847;6063.090536419572;6125.785597504066;5075.543201111917;6113.052476866093;6131.693415329216;6148.538859585549;6160.815175544741;4601.493835678073;4811.398575178103;4878.926816097762;4881.096997055556;4898.90202195954;4284.993026638737;4347.65218782503;4392.714473559208;4394.692371534026;4426.468823741107;5640.238567793377;5671.716414179275;5743.62666426681;5794.101914203221;5810.88378232433;6160.661163635953;6162.753489860445;6174.289956655042;6208.2239720034995;6213.782517611952;4795.808167673324;5629.746661400247;5704.087346024616;5726.312842458931;5732.283464566929;5326.840194794085;5340.49265319794;5358.54452371545;5359.678419294854;5372.946270537244;6217.222847144107;6253.405926437073;6260.123582698335;6272.655003974825;6301.117843501914;6085.391460853879;6111.786087486917;6127.84680382994;6129.02260737745;6194.101855231056;5311.840644780663;6192.752289908533;6219.968900155471;6233.470155036873;6255.812325630239;6139.631622102688;6143.600665956698;6154.661493617894;6165.938340616536;6175.62946223228;4980.900381992412;5985.820425387245;6107.786227482017;6146.907796382969;6225.28409232944;6011.21854158974;6109.860177052684;6129.908988904127;6136.386361364007;6145.0782382642965;6070.089486576872;6071.666058366833;6092.8781424372155;6107.54193435503;6111.327753946974;5728.770849165987;5766.596338256281;5866.823995280149;5891.293044834647;5977.790777322773;4764.595009424099;5996.8800623988145;6045.6070355426755;6056.90914636272;6117.96941015292;5903.321118071477;5945.732442040205;5946.970265148647;5948.048312270016;5983.760649573968 16:35:36 INFO - PROCESS | 1672 | |1;ext.html;470.91052699987;479.94720580736134;483.4295531273099;533.3493138371185;538.927534206928;39972.8008159755;41483.79258103709;41559.37660935081;41670.58329416705;41673.58326416735;43325.350119748226;43917.560824391745;43949.12101757963;43961.34057989133;43994.78002609983;9859.60561577538;9990.900090999106;10031.799364012715;10051.497425128751;10060.245481588874;9791.461469619167;9881.851772223386;9899.059589339036;9929.602815887356;9931.702048938543;9803.705888823346;9891.752706182331;9903.207743380512;9918.40489570628;9940.801183976317;9816;9841.70474885751;9880.209583233323;9897.059779321025;9897.307188496809;9792.412455252708;9861;9876;9889.456079915602;9893.961134080962;36364;41214.1757164858;41743.582564174576;42063.369049463974;42162;2900.8694608742658;3195.760317976161;3398.9830050849587;3608.0799396154075;3915.569287378386;29463.116106516838;29790.70209297901;29896.8505157475;29910.55134172989;30502.389952201054;3241.2221066944;3293.3413317336626;3439.7420193485336;3455.6889879910927;3476.878309259164;464126.9999999966;478384;499596;504966;505499;65275;65695.34304656892;65777.01334479987;65920.6703966477;66488.00267995887;66145.01564953059;70264.29735702577;70564;70742.2925770746;71123.6443817788;17050;17224.827751722572;17228.655426891393;17454.56363590895;17470.38853640142;12990.610281691565;13160.934195329153;13292.534761283308;13336.599902002956;13482.93258533701;20030.49923751918;20340.89829550843;20569.89715051445;20724.792752072586;20726.274580389916;8378.737740809947;8499.490030598185;8563.559385575205;8582.785430364165;8630.5253211074;853.7737499562621;898.4339865884451;960.1934375124929;1104.8342748587615;1123.6685177872548;29607.555886661718;29909.40181196364;30588;30638.693613063584;30899.227519312197;899.7165892743765;1012.2104758288547;1062.2723434447428;1066.0938202527943;1124.9437528123724;15861.841381586037;15898.841011589737;15994.200289985454;16024;16173.919130404509;718008;726622;726701;728208;731027;59707.701461493285;59928;60082.69958650179;60147.39852601506;60512.697436513416;1162.3316592958913;1239.9708242159168;1354.6588877011884;1380.151207007683;1381.88944884409;27271.454570908867;30554.777808888284;30704.232394190323;30796.846015769777;31201;41308.58691413168;52345.47654523406;52421.21368179404;52475.950480989406;52611.47388526066;673302;675614;678295.6085219543;680108;683592;26162;27812.30469238285;28048.29879253035;28049.439011219252;28077.57883631706;47959.04081918412;48674;49383.25925111198;49454.75272623614;49635.503644964534;36396.27207455889;38945.610543894196;39506.60493395029;40450.98872528093;41356.79321603373;33118.834405827816;39859.40210896897;41476.79261603673;41504.377434337905;41752;34468.48297275593;38476;39263.803680981415;39906;40829;29859.104226873227;34366.48450273298;35570.82214589014;36065.459018115274;36218.45672314864;26350.4729905397;26546.070887519618;26554.336141596614;26823.105050886064;26844.194674159808 16:35:36 INFO - PROCESS | 1672 | |2;jquery.html;367.2837965966365;367.9245754620303;372.09395122875816;374.52061361457334;392.6878131885151;19481.610367792655;19679.606407871834;20076.799232007714;20465.079071441804;20605.793942060576;11957.940210298959;12134.878651213507;18570.721439178422;20079.799202008013;20695.275665351717;5099.107656160176;5353.1167357386175;5353.544948679367;5354.330708661418;5359.517643412092;5228.816991405301;5947.732352044169;5988.970055149718;6008;6035.969820150915;5616.887662246773;5925.644461332312;5950.434708702666;5966.940330596682;5990.490808281302;5257.211418287268;5284.048871203182;5387.326584176978;5387.838364849061;5407.270018547505;4228.365745138223;4909.0672772173175;5024.748762561857;5244.921326180111;5254;9783.559739811726;11477.680066792342;12760.234385936781;12767.936160319232;12776.233425994376;1978.5350442645968;2175.3908905506482;2268.795808377254;2276.9886150569305;2753.8347699138117;8574.871376929352;10075.748106297327;10202.9489852551;10295.742606434898;10479.68560943173;1748.7202047672438;1833.2208811255164;1866.188208129468;1871.9344822931132;1875.1280654495724;120700.79299207071;120723;123334.76665233323;125636;126206;9787.608495660237;11142.554297827995;11499.252548584314;11525.596604118815;11733.4719937603;14578.271086445635;14705.117692938458;14717.116972981656;14747;14757.852421475647;8494.74515764528;8602.61288242018;8720.084391138838;8829.64681412749;8894.4663320201;6697.928331466942;8704.956475217583;8789.956050219707;8935.731928042169;8947.686830961014;4466.821327146943;4547.795349209227;4553.521880202531;4608.216603177468;4625.1443482955765;1912.0210582047514;1945.6400565895071;1949.6100779843805;1975.74315339005;1982.464734521671;827.7020272701823;875.9956200219085;921.2307723051327;921.5254144115786;973.1339108193713;20402.795972040385;20885.68671469929;20929.790702093087;21098.894505527373;21243.36269911905;740.2338579570227;899.9280057595377;904.2630256341192;904.7692838326185;967.4823969176457;8374.623141958626;9127.26981841451;9230.86153707695;11017.44912754359;11172;466161;599274;606512;619224;620382;110751;113057;126191.36904315419;131486;131682.68317316705;842.5534466732641;851.6337974670827;973.2700474644017;988.9159421449258;991.504247876062;18547;19237.941913194907;19249.711254331476;19271.22915083437;19393.0303484828;51311.74344128255;55574.72212638911;57045.85908281728;57634;58571.4142858566;79509;85020;86941.13058869583;87497;88639;6400.775972840928;7097.503174777716;7399.075115610549;7931.881021784793;8065.233802788725;11873.632904186032;12665.936670316589;12732.618021459371;12988.285644289655;12997.805032924703;10723.892761072602;11010.50452729645;11045.116390688887;11222.438878056228;11352.602658906899;10658.573657053632;10830;10831.512581933674;10844.240903136704;11066.833997490205;11173.162012849232;11298.265612735146;11351.545938162712;11425.828612570984;11486.483108259981;7394.482386232912;7490.962545187239;7515;7568.3945284378215;7775.066991961001;8409.906712127384;9193.678221262224;10583.31208471447;11039.337639741641;11419 16:35:36 INFO - PROCESS | 1672 | |3;mootools.html;1471.4702707025472;1495.4242616592612;1686.4350442601728;1813.247502286552;1830.4234166237643;8108.594570271478;8390.790230244247;8522.275606573441;9096.0903909609;9111;8661.783455413617;8967.551622418885;8989.415687980292;9066.592003359849;9089.22741566966;2387.570237357275;2411.6382542618658;2414.1912459326145;2417.5044115956275;2425.442148305882;2398.0527691561824;2410.252821625293;2411.0837881604966;2437.061731233479;2446.6085426331792;2296.334063121693;2302.2747834432103;2307.1348244408346;2309.5334462616192;2311.3643747969277;2386.069432921162;2397.3646983549374;2401;2407.217654262363;2417.347316224618;2376.512814872947;2400.111958575321;2404.4349577849193;2404.483036147237;2407.831451798375;9023.27813774903;9072.00207977122;9087.954560227223;9163.175314221751;9183.357164998453;5251.10731175701;5362.544183744387;5407.080796264605;5411.648242864201;5429.077056900336;3583.5341405617105;3626.3110009098186;3644.963550364489;3662.487251784752;3673.797941113238;1088.2545456362418;1101.9063379612742;1106.6569363497342;1119.865616126062;1123.6966019174859;11802.40987950599;11867.64397068098;11891.524339026428;11936.58221962227;11960;3822.7515211511163;3900.31744444721;4325.437693099877;4777.498362671939;4788.640851936118;8512.616932238065;9253.213476854542;10020.549075291483;10078.496075196212;10081.395116292899;4704.788284527204;5360.624756267024;5367.624266301322;5369.40936496985;5472.2338872557875;4371.672124590605;4464.196444639996;4626.074785043005;4789.95210047902;4996.5003499650475;3952.9209415811524;3975.840966361371;4077.347624380144;4092.570280120604;4112.91774164515;1113.33200079953;1303.4590644882458;1306.301128896036;1316.4470922212693;1319.848217455005;774.8450309938034;791.7308115240846;861.5606040919051;891.0955380289012;915.3683958068912;5842.620229685057;5885.911711324334;6161.4146656067605;6212.378762123752;6232.3144454110015;931.3620170183447;955.6798472511787;956.1012648110892;959.5633986536109;969.2682025071026;3780.2628487444686;3800.8669696560487;4007.1384652299894;4091.5294741105154;4144.046869220097;10864.837027444595;11139.498722557504;11236.269642473213;11239.269447485887;11272.943635281936;10741.194410419093;11180.664580062612;11185.440727963569;11202.047825934724;11239.381833999209;8173.182681731898;8427.367947403969;8517.872231916526;8519.829603407898;8539.487630742175;5936.614120082354;5970.910436343545;5993.430624090704;6084.69576521181;6167.475764560063;9622.470764107762;9977;9999.3000489965;10161.949190254001;10422.843657344994;10545.472726363498;10557.260991730505;10558.630447934593;10567.577296908037;10602.992715691997;6650.83372915681;6872.553284036521;6922.480813939075;7017;7315.817104572216;8451;8538.78653033679;8541;8624.266937310147;8701.738947831574;7492.700291988477;7599.938138878254;7674.501157424749;7750.031246094239;7791.220877912164;7430;7544.547327160388;7563.9621801890635;7567.545947243183;7605.923940760522;7078.539894906815;7205.71177152908;7208.098987626547;7208.171060328129;7235.384992275715;4970.304157418037;5056.7471626419265;5064.898702026013;5143.691378517301;5307.814226502054;5086.440491545853;5157.149070403491;5210.635255532076;5262.552683021986;5284.101702710472 16:35:36 INFO - PROCESS | 1672 | |4;prototype.html;302.58243623799154;310.06824492400347;310.3451716877389;313.41860848126726;316.4651738561832;5467.835964921053;5560.331041100274;5594.86012849679;5651;5657.830265092049;5149.433562308143;5419.566434685225;5426.158945363465;5463.808766693167;5495.642783219088;3926.3521518949337;4038.2125485530332;4039.4142849286836;4097.119119389331;4125.051238215212;3035.969640303591;3483.303339332131;3811.504504414422;4073.124278280169;4164.146349998243;3422.8117453540044;4111.938320925188;4142.275101857178;4154.376843473488;4299.968007678151;3950.3679411294343;4095.4266402703647;4127.545969943304;4137.8758637240935;4161.833526658945;3052.1767365187334;3195.3769015042076;3393.355262500117;3543.6633519815578;3558.946615800765;4423.402840616508;5299.284596579451;5300.01949639318;5323.574114070865;5350.411454739976;4317.330813723878;4527.008116428761;4749.762511874393;4761.8095276188915;4763;5590.329160500766;5634.4365563443735;5636.688957527435;5677.914831277534;5773.884522309572;3428.9142771430666;3678.834452449646;3883.5339759229073;3889.8994542947057;3900.9857437066566;5216.478352164791;5710.286214223263;5827.736467578127;6043.516518678495;6069.514438844926;3571.8035508046787;3895.7272990890933;3921.5294164700417;3987.461692671452;4001.9599804001587;3988.262171498282;4003.619656132663;4009.7393669411395;4022.738521996061;4045.2516284487465;3948.8943095933187;4377.387165796791;4510.323451482238;4729.148753224453;4738.31294462308;4685.882852928636;5542.891421715673;5787.450192231731;5798.825440459827;5915.7633694652595;1324.7218084202232;1334.8865346445662;1365.627544317954;1368.548379034916;1373.3133433283358;738.972827769401;788.5820515126992;793.7023616143946;837.2213841127809;838.9764487325454;4845.0067736114015;5087.516685914832;5131.358580177478;5371.274877891513;5401.837944861661;4829.975850120797;5943.910841337383;5954.345022047572;5968.403159683997;6057.818265452043;5136.476304032741;5425.701586412706;5426.972865135649;5432;5442.428545002796;2862.942741145207;2950.1973125530403;2994.4310580989977;3048.6830009193172;3156.4949608062598;5340.118880384771;5432.266644003088;5519.69641669712;5847.26909136358;6184.042212983694;5744.798932037359;6100.450959413674;6112.847178820565;6141.815745527552;6173.900873702963;4880.389951256093;5126.92309615356;5274.604404669665;6258.499320054476;6262.937370626418;4778.641601879804;5771.884562308815;6038.849028774316;6074.119252708244;6091;4801.375821143229;5173.982146962612;5709.54323654115;5950;5970.731317090655;6163.84590385244;6182.381761823782;6242.845073661387;6259.530535209787;6290.465310448663;3535.911602209965;3854.8843534694006;3993.2612466693754;4052.959470405376;4077.857274995361;5819.9815032368315;5927.733252003584;5932.584719069796;6034.607750496204;6034.818955431344;4904.435989861069;5210.6613070150315;5796.391378905154;5839.416058394127;5887.587868849139;5370.436104209002;5786.161006654096;5802.912956305743;5815.476607105381;5855.691534283116;5021.372328458942;5286.603504737083;5719.256496655408;5750.913736293875;5804.448577385142;5492.231087647652;5632.690202038763;5693.807883964786;5791.075506869004;5887.882242355215;4778.04439112172;5395.973020134874;5657.801976930952;5736.569757268138;5758.1362795579325 16:35:36 INFO - PROCESS | 1672 | |5;yui.html;690.2097098821849;703.750168690115;756.5838788666232;777.576220959577;805.3476683886053;15608.453704120358;15721.213939303047;15896.364145434169;15904.045757254558;15931;12277.631671049861;14319.78520322196;14348;14361.640958976004;14433.20617366047;685.568092101975;709.1808960650457;831.8544254755424;843.9746807595782;861.6036623153326;824.9958750206241;854.9953804279977;869.8608222684372;871.8822958900531;874.9956250218772;877.1579283887444;926.7173512078813;929.5816882402912;930.692871352452;934.065934065934;874.5802015032788;919.2508105893709;921.424109931293;924.9953750231273;926.7683079230226;648.5589798936721;674.8009337245525;686.7767975408012;687.295522089857;688.3082502085422;15133.697326053418;15141.924290378587;15163.241837908061;15169.848301516953;15207.771883421758;14693.412263509554;14745.852541474555;14759;14830.925845370812;14842.480513181987;11338.886611133948;11730.12024098196;11840.526378944833;11890.227135236182;12461.190022648589;4430.778461076933;4567.132244873464;4609.078184363141;4611.1930412177735;4632.513586073447;80556;98056;105144.99999999923;110271.44864275708;125164.37417812944;10435.94782026085;10881.020708136306;11008.229423940247;11066.889331106748;11325.886741132648;20473.89763051175;20643.896780516003;20839.79160208409;20860.37418877436;21193;6734.292899245606;7799.220077992155;7809.297163255334;7845.843083138306;7922.445428819928;4376.627986621109;4406.49325327585;4440.33394990754;4460.286354183315;4546.386237857913;3080.183751305906;3090.3973725123833;3103.898116168773;3440.9655903440644;3578.5347904772734;587.8859561131717;653.9378759017885;662.192125606759;674.8110529051874;686.8179932317939;577.2755192233719;601.2814686449651;620.8385819686823;623.5510432488601;628.924529056507;8263.774196908194;9193.034731353246;9332.486713230837;9405.67080152205;9568.282378821616;587.5593305021234;618.9257289125334;634.0267689097213;641.0768493369533;664.51158398577;3776.8489260429824;4352.325389564622;4510.503844577094;4534.9319760203625;4623.190941585209;104446;126689.09966350513;170247.1487642554;179772;186837.06581467006;124795;145032;147828.26085869502;149777;151055;105808.47095764626;107923.46038269758;115289.4235528817;130751;135769;8166.550839703873;9667.854982175413;9945.403275803475;10012.599496020077;10366.792664146826;61202.081968771396;63959.36040639534;64064.67967660132;65114.34885651083;65380.673096634215;73026;79285.414291715;79878;86058;89064.5546772262;10933.125349971824;12563.309018003732;12856.164349317265;13149.34253287351;13730.51943181984;14715.043522171025;14834.629134271298;15308.31112599958;15504.953937076398;15719.607009824846;13902.026858119834;14153.510078442972;14425.773809226333;14780.48268310604;14913.478028268959;14144.575662730134;14227.573172804832;14245.287735613385;14450.37841493358;14964.251787410803;12829.973602111622;13076.346182691017;13810.447582096604;13866.376013079234;14033.789493157406;11470.254433461798;11698.70753231176;11751.647450576496;11874.7797427892;11885.28688278706;11760.294382337088;11887.821682674594;11924.67366572183;11935.34355610415;12033.977111945582 16:35:36 INFO - PROCESS | 1672 | __end_tp_report 16:35:36 INFO - PROCESS | 1672 | __start_cc_report 16:35:36 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,375 16:35:36 INFO - PROCESS | 1672 | __end_cc_report 16:35:36 INFO - PROCESS | 1672 | __startTimestamp1478388936309__endTimestamp 16:35:36 INFO - PROCESS | 1672 | 16:35:36 INFO - PROCESS | 1672 | ------- Summary: start ------- 16:35:36 INFO - PROCESS | 1672 | Number of tests: 6 16:35:36 INFO - PROCESS | 1672 | 16:35:36 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5645.70 Median:5827.13 stddev:633.56 (10.9%) stddev-sans-first:607.31 16:35:36 INFO - PROCESS | 1672 | Values: 3263.2 3300.3 3346.2 3357.7 3387.0 5555.5 5570.7 5636.7 5639.0 5676.0 5580.5 5636.9 5660.5 5662.5 5678.4 5123.9 5189.6 5207.5 5221.1 5271.6 5227.5 5248.1 5256.9 5258.9 5272.4 5160.3 5161.3 5220.7 5270.5 5273.6 5177.8 5228.4 5255.2 5289.8 5337.5 5132.5 5247.6 5251.0 5255.3 5319.5 5513.9 5681.7 5714.8 5785.2 5816.7 5037.6 5960.3 6105.8 6114.8 6133.0 5477.4 6103.4 6139.6 6161.9 6181.2 5801.7 5818.9 5827.1 5838.7 5856.9 6125.9 6128.7 6136.9 6140.9 6153.8 6072.9 6082.6 6092.4 6095.5 6098.9 6107.6 6130.0 6147.8 6152.7 6155.3 4502.1 5437.3 5915.0 6063.1 6125.8 5075.5 6113.1 6131.7 6148.5 6160.8 4601.5 4811.4 4878.9 4881.1 4898.9 4285.0 4347.7 4392.7 4394.7 4426.5 5640.2 5671.7 5743.6 5794.1 5810.9 6160.7 6162.8 6174.3 6208.2 6213.8 4795.8 5629.7 5704.1 5726.3 5732.3 5326.8 5340.5 5358.5 5359.7 5372.9 6217.2 6253.4 6260.1 6272.7 6301.1 6085.4 6111.8 6127.8 6129.0 6194.1 5311.8 6192.8 6220.0 6233.5 6255.8 6139.6 6143.6 6154.7 6165.9 6175.6 4980.9 5985.8 6107.8 6146.9 6225.3 6011.2 6109.9 6129.9 6136.4 6145.1 6070.1 6071.7 6092.9 6107.5 6111.3 5728.8 5766.6 5866.8 5891.3 5977.8 4764.6 5996.9 6045.6 6056.9 6118.0 5903.3 5945.7 5947.0 5948.0 5983.8 16:35:36 INFO - PROCESS | 1672 | 16:35:36 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:76324.57 Median:41480.29 stddev:171516.03 (413.5%) stddev-sans-first:171902.63 16:35:36 INFO - PROCESS | 1672 | Values: 470.9 479.9 483.4 533.3 538.9 39972.8 41483.8 41559.4 41670.6 41673.6 43325.4 43917.6 43949.1 43961.3 43994.8 9859.6 9990.9 10031.8 10051.5 10060.2 9791.5 9881.9 9899.1 9929.6 9931.7 9803.7 9891.8 9903.2 9918.4 9940.8 9816.0 9841.7 9880.2 9897.1 9897.3 9792.4 9861.0 9876.0 9889.5 9894.0 36364.0 41214.2 41743.6 42063.4 42162.0 2900.9 3195.8 3399.0 3608.1 3915.6 29463.1 29790.7 29896.9 29910.6 30502.4 3241.2 3293.3 3439.7 3455.7 3476.9 464127.0 478384.0 499596.0 504966.0 505499.0 65275.0 65695.3 65777.0 65920.7 66488.0 66145.0 70264.3 70564.0 70742.3 71123.6 17050.0 17224.8 17228.7 17454.6 17470.4 12990.6 13160.9 13292.5 13336.6 13482.9 20030.5 20340.9 20569.9 20724.8 20726.3 8378.7 8499.5 8563.6 8582.8 8630.5 853.8 898.4 960.2 1104.8 1123.7 29607.6 29909.4 30588.0 30638.7 30899.2 899.7 1012.2 1062.3 1066.1 1124.9 15861.8 15898.8 15994.2 16024.0 16173.9 718008.0 726622.0 726701.0 728208.0 731027.0 59707.7 59928.0 60082.7 60147.4 60512.7 1162.3 1240.0 1354.7 1380.2 1381.9 27271.5 30554.8 30704.2 30796.8 31201.0 41308.6 52345.5 52421.2 52476.0 52611.5 673302.0 675614.0 678295.6 680108.0 683592.0 26162.0 27812.3 28048.3 28049.4 28077.6 47959.0 48674.0 49383.3 49454.8 49635.5 36396.3 38945.6 39506.6 40451.0 41356.8 33118.8 39859.4 41476.8 41504.4 41752.0 34468.5 38476.0 39263.8 39906.0 40829.0 29859.1 34366.5 35570.8 36065.5 36218.5 26350.5 26546.1 26554.3 26823.1 26844.2 16:35:36 INFO - PROCESS | 1672 | 16:35:36 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:34256.12 Median:383.60 stddev:98073.21 (25566.2%) stddev-sans-first:98315.32 16:35:36 INFO - PROCESS | 1672 | Values: 367.3 367.9 372.1 374.5 392.7 19481.6 19679.6 20076.8 20465.1 20605.8 11957.9 12134.9 18570.7 20079.8 20695.3 5099.1 5353.1 5353.5 5354.3 5359.5 5228.8 5947.7 5989.0 6008.0 6036.0 5616.9 5925.6 5950.4 5966.9 5990.5 5257.2 5284.0 5387.3 5387.8 5407.3 4228.4 4909.1 5024.7 5244.9 5254.0 9783.6 11477.7 12760.2 12767.9 12776.2 1978.5 2175.4 2268.8 2277.0 2753.8 8574.9 10075.7 10202.9 10295.7 10479.7 1748.7 1833.2 1866.2 1871.9 1875.1 120700.8 120723.0 123334.8 125636.0 126206.0 9787.6 11142.6 11499.3 11525.6 11733.5 14578.3 14705.1 14717.1 14747.0 14757.9 8494.7 8602.6 8720.1 8829.6 8894.5 6697.9 8705.0 8790.0 8935.7 8947.7 4466.8 4547.8 4553.5 4608.2 4625.1 1912.0 1945.6 1949.6 1975.7 1982.5 827.7 876.0 921.2 921.5 973.1 20402.8 20885.7 20929.8 21098.9 21243.4 740.2 899.9 904.3 904.8 967.5 8374.6 9127.3 9230.9 11017.4 11172.0 466161.0 599274.0 606512.0 619224.0 620382.0 110751.0 113057.0 126191.4 131486.0 131682.7 842.6 851.6 973.3 988.9 991.5 18547.0 19237.9 19249.7 19271.2 19393.0 51311.7 55574.7 57045.9 57634.0 58571.4 79509.0 85020.0 86941.1 87497.0 88639.0 6400.8 7097.5 7399.1 7931.9 8065.2 11873.6 12665.9 12732.6 12988.3 12997.8 10723.9 11010.5 11045.1 11222.4 11352.6 10658.6 10830.0 10831.5 10844.2 11066.8 11173.2 11298.3 11351.5 11425.8 11486.5 7394.5 7491.0 7515.0 7568.4 7775.1 8409.9 9193.7 10583.3 11039.3 11419.0 16:35:36 INFO - PROCESS | 1672 | 16:35:36 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:5800.96 Median:4983.40 stddev:3281.58 (65.9%) stddev-sans-first:3274.65 16:35:36 INFO - PROCESS | 1672 | Values: 1471.5 1495.4 1686.4 1813.2 1830.4 8108.6 8390.8 8522.3 9096.1 9111.0 8661.8 8967.6 8989.4 9066.6 9089.2 2387.6 2411.6 2414.2 2417.5 2425.4 2398.1 2410.3 2411.1 2437.1 2446.6 2296.3 2302.3 2307.1 2309.5 2311.4 2386.1 2397.4 2401.0 2407.2 2417.3 2376.5 2400.1 2404.4 2404.5 2407.8 9023.3 9072.0 9088.0 9163.2 9183.4 5251.1 5362.5 5407.1 5411.6 5429.1 3583.5 3626.3 3645.0 3662.5 3673.8 1088.3 1101.9 1106.7 1119.9 1123.7 11802.4 11867.6 11891.5 11936.6 11960.0 3822.8 3900.3 4325.4 4777.5 4788.6 8512.6 9253.2 10020.5 10078.5 10081.4 4704.8 5360.6 5367.6 5369.4 5472.2 4371.7 4464.2 4626.1 4790.0 4996.5 3952.9 3975.8 4077.3 4092.6 4112.9 1113.3 1303.5 1306.3 1316.4 1319.8 774.8 791.7 861.6 891.1 915.4 5842.6 5885.9 6161.4 6212.4 6232.3 931.4 955.7 956.1 959.6 969.3 3780.3 3800.9 4007.1 4091.5 4144.0 10864.8 11139.5 11236.3 11239.3 11272.9 10741.2 11180.7 11185.4 11202.0 11239.4 8173.2 8427.4 8517.9 8519.8 8539.5 5936.6 5970.9 5993.4 6084.7 6167.5 9622.5 9977.0 9999.3 10161.9 10422.8 10545.5 10557.3 10558.6 10567.6 10603.0 6650.8 6872.6 6922.5 7017.0 7315.8 8451.0 8538.8 8541.0 8624.3 8701.7 7492.7 7599.9 7674.5 7750.0 7791.2 7430.0 7544.5 7564.0 7567.5 7605.9 7078.5 7205.7 7208.1 7208.2 7235.4 4970.3 5056.7 5064.9 5143.7 5307.8 5086.4 5157.1 5210.6 5262.6 5284.1 16:35:36 INFO - PROCESS | 1672 | 16:35:36 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:4649.53 Median:5299.65 stddev:1467.39 (27.7%) stddev-sans-first:1434.77 16:35:36 INFO - PROCESS | 1672 | Values: 302.6 310.1 310.3 313.4 316.5 5467.8 5560.3 5594.9 5651.0 5657.8 5149.4 5419.6 5426.2 5463.8 5495.6 3926.4 4038.2 4039.4 4097.1 4125.1 3036.0 3483.3 3811.5 4073.1 4164.1 3422.8 4111.9 4142.3 4154.4 4300.0 3950.4 4095.4 4127.5 4137.9 4161.8 3052.2 3195.4 3393.4 3543.7 3558.9 4423.4 5299.3 5300.0 5323.6 5350.4 4317.3 4527.0 4749.8 4761.8 4763.0 5590.3 5634.4 5636.7 5677.9 5773.9 3428.9 3678.8 3883.5 3889.9 3901.0 5216.5 5710.3 5827.7 6043.5 6069.5 3571.8 3895.7 3921.5 3987.5 4002.0 3988.3 4003.6 4009.7 4022.7 4045.3 3948.9 4377.4 4510.3 4729.1 4738.3 4685.9 5542.9 5787.5 5798.8 5915.8 1324.7 1334.9 1365.6 1368.5 1373.3 739.0 788.6 793.7 837.2 839.0 4845.0 5087.5 5131.4 5371.3 5401.8 4830.0 5943.9 5954.3 5968.4 6057.8 5136.5 5425.7 5427.0 5432.0 5442.4 2862.9 2950.2 2994.4 3048.7 3156.5 5340.1 5432.3 5519.7 5847.3 6184.0 5744.8 6100.5 6112.8 6141.8 6173.9 4880.4 5126.9 5274.6 6258.5 6262.9 4778.6 5771.9 6038.8 6074.1 6091.0 4801.4 5174.0 5709.5 5950.0 5970.7 6163.8 6182.4 6242.8 6259.5 6290.5 3535.9 3854.9 3993.3 4053.0 4077.9 5820.0 5927.7 5932.6 6034.6 6034.8 4904.4 5210.7 5796.4 5839.4 5887.6 5370.4 5786.2 5802.9 5815.5 5855.7 5021.4 5286.6 5719.3 5750.9 5804.4 5492.2 5632.7 5693.8 5791.1 5887.9 4778.0 5396.0 5657.8 5736.6 5758.1 16:35:36 INFO - PROCESS | 1672 | 16:35:36 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:25351.50 Median:3085.29 stddev:41446.27 (1343.4%) stddev-sans-first:41521.18 16:35:36 INFO - PROCESS | 1672 | Values: 690.2 703.8 756.6 777.6 805.3 15608.5 15721.2 15896.4 15904.0 15931.0 12277.6 14319.8 14348.0 14361.6 14433.2 685.6 709.2 831.9 844.0 861.6 825.0 855.0 869.9 871.9 875.0 877.2 926.7 929.6 930.7 934.1 874.6 919.3 921.4 925.0 926.8 648.6 674.8 686.8 687.3 688.3 15133.7 15141.9 15163.2 15169.8 15207.8 14693.4 14745.9 14759.0 14830.9 14842.5 11338.9 11730.1 11840.5 11890.2 12461.2 4430.8 4567.1 4609.1 4611.2 4632.5 80556.0 98056.0 105145.0 110271.4 125164.4 10435.9 10881.0 11008.2 11066.9 11325.9 20473.9 20643.9 20839.8 20860.4 21193.0 6734.3 7799.2 7809.3 7845.8 7922.4 4376.6 4406.5 4440.3 4460.3 4546.4 3080.2 3090.4 3103.9 3441.0 3578.5 587.9 653.9 662.2 674.8 686.8 577.3 601.3 620.8 623.6 628.9 8263.8 9193.0 9332.5 9405.7 9568.3 587.6 618.9 634.0 641.1 664.5 3776.8 4352.3 4510.5 4534.9 4623.2 104446.0 126689.1 170247.1 179772.0 186837.1 124795.0 145032.0 147828.3 149777.0 151055.0 105808.5 107923.5 115289.4 130751.0 135769.0 8166.6 9667.9 9945.4 10012.6 10366.8 61202.1 63959.4 64064.7 65114.3 65380.7 73026.0 79285.4 79878.0 86058.0 89064.6 10933.1 12563.3 12856.2 13149.3 13730.5 14715.0 14834.6 15308.3 15505.0 15719.6 13902.0 14153.5 14425.8 14780.5 14913.5 14144.6 14227.6 14245.3 14450.4 14964.3 12830.0 13076.3 13810.4 13866.4 14033.8 11470.3 11698.7 11751.6 11874.8 11885.3 11760.3 11887.8 11924.7 11935.3 12034.0 16:35:36 INFO - PROCESS | 1672 | -------- Summary: end -------- 16:35:36 INFO - PROCESS | 1672 | 16:35:36 INFO - TEST-INFO | 1672: exit 0 16:35:36 INFO - TEST-OK | dromaeo_css | took 1113709ms 16:35:36 INFO - TEST-START | kraken 16:35:36 INFO - operating with platform_type : mac_ 16:35:36 INFO - Initialising browser for kraken test... 16:35:37 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmp2HsDa6/profile http://localhost:49281/getInfo.html) 16:35:39 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 16:35:39 INFO - PROCESS | 1681 | colorDepth:24 16:35:39 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 16:35:39 INFO - PROCESS | 1681 | __metrics 16:35:39 ERROR - PROCESS | 1681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 16:35:40 INFO - TEST-INFO | 1681: exit 0 16:35:40 INFO - Browser initialized. 16:35:40 INFO - Running cycle 1/1 for kraken test... 16:35:40 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmp2HsDa6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:35:52 INFO - PROCESS | 1683 | RSS: Main: 225173504 16:35:52 INFO - PROCESS | 1683 | 16:35:55 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection) 16:35:56 INFO - PROCESS | 1683 | RSS: Main: 237617152 16:35:56 INFO - PROCESS | 1683 | 16:35:58 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-dft) 16:35:59 INFO - PROCESS | 1683 | RSS: Main: 245043200 16:35:59 INFO - PROCESS | 1683 | 16:36:02 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-fft) 16:36:03 INFO - PROCESS | 1683 | RSS: Main: 248737792 16:36:03 INFO - PROCESS | 1683 | 16:36:04 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator) 16:36:05 INFO - PROCESS | 1683 | RSS: Main: 250155008 16:36:05 INFO - PROCESS | 1683 | 16:36:07 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:36:08 INFO - PROCESS | 1683 | RSS: Main: 250339328 16:36:08 INFO - PROCESS | 1683 | 16:36:10 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom) 16:36:11 INFO - PROCESS | 1683 | RSS: Main: 251269120 16:36:11 INFO - PROCESS | 1683 | 16:36:14 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate) 16:36:15 INFO - PROCESS | 1683 | RSS: Main: 251322368 16:36:15 INFO - PROCESS | 1683 | 16:36:18 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial) 16:36:18 INFO - PROCESS | 1683 | RSS: Main: 251736064 16:36:18 INFO - PROCESS | 1683 | 16:36:20 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:36:21 INFO - PROCESS | 1683 | RSS: Main: 250880000 16:36:21 INFO - PROCESS | 1683 | 16:36:23 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:36:23 INFO - PROCESS | 1683 | RSS: Main: 250961920 16:36:23 INFO - PROCESS | 1683 | 16:36:25 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:36:26 INFO - PROCESS | 1683 | RSS: Main: 250978304 16:36:26 INFO - PROCESS | 1683 | 16:36:29 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:36:30 INFO - PROCESS | 1683 | RSS: Main: 250966016 16:36:30 INFO - PROCESS | 1683 | 16:36:33 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:36:33 INFO - PROCESS | 1683 | RSS: Main: 251293696 16:36:33 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49281/tests/kraken/driver.html?testName=ai-astar) 16:36:35 INFO - PROCESS | 1683 | RSS: Main: 253014016 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | __start_tp_report 16:36:35 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 16:36:35 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 16:36:35 INFO - PROCESS | 1683 | |i|pagename|runs| 16:36:35 INFO - PROCESS | 1683 | |0;ai-astar;108;117;117;118;118;118;116;116;162;177 16:36:35 INFO - PROCESS | 1683 | |1;audio-beat-detection;143;111;109;139;107;110;110;108;134;110 16:36:35 INFO - PROCESS | 1683 | |2;audio-dft;191;201;197;195;195;192;194;198;197;195 16:36:35 INFO - PROCESS | 1683 | |3;audio-fft;84;59;58;82;58;59;59;59;78;51 16:36:35 INFO - PROCESS | 1683 | |4;audio-oscillator;85;70;88;73;69;70;87;70;70;87 16:36:35 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;89;108;137;104;89;85;90;97;85;75 16:36:35 INFO - PROCESS | 1683 | |6;imaging-darkroom;93;108;141;154;153;153;95;94;96;95 16:36:35 INFO - PROCESS | 1683 | |7;imaging-desaturate;90;92;91;92;92;90;136;91;74;124 16:36:35 INFO - PROCESS | 1683 | |8;json-parse-financial;57;57;57;58;62;83;93;91;61;69 16:36:35 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;69;73;75;81;81;100;101;62;92;61 16:36:35 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;83;84;83;83;84;86;86;83;75;89 16:36:35 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;142;139;136;129;149;144;140;151;205;174 16:36:35 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;167;168;167;166;170;167;221;161;234;213 16:36:35 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;68;69;64;63;67;67;65;68;68;67 16:36:35 INFO - PROCESS | 1683 | __end_tp_report 16:36:35 INFO - PROCESS | 1683 | __start_cc_report 16:36:35 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,955 16:36:35 INFO - PROCESS | 1683 | __end_cc_report 16:36:35 INFO - PROCESS | 1683 | __startTimestamp1478388995815__endTimestamp 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | ------- Summary: start ------- 16:36:35 INFO - PROCESS | 1683 | Number of tests: 14 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:126.70 Median:118.00 stddev:23.02 (19.5%) stddev-sans-first:23.40 16:36:35 INFO - PROCESS | 1683 | Values: 108.0 117.0 117.0 118.0 118.0 118.0 116.0 116.0 162.0 177.0 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:118.10 Median:110.50 stddev:14.39 (13.0%) stddev-sans-first:12.12 16:36:35 INFO - PROCESS | 1683 | Values: 143.0 111.0 109.0 139.0 107.0 110.0 110.0 108.0 134.0 110.0 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:195.50 Median:196.00 stddev:2.92 (1.5%) stddev-sans-first:2.60 16:36:35 INFO - PROCESS | 1683 | Values: 191.0 201.0 197.0 195.0 195.0 192.0 194.0 198.0 197.0 195.0 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:64.70 Median:59.00 stddev:11.81 (20.0%) stddev-sans-first:10.26 16:36:35 INFO - PROCESS | 1683 | Values: 84.0 59.0 58.0 82.0 58.0 59.0 59.0 59.0 78.0 51.0 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:79.00 stddev:8.57 (10.8%) stddev-sans-first:8.57 16:36:35 INFO - PROCESS | 1683 | Values: 85.0 70.0 88.0 73.0 69.0 70.0 87.0 70.0 70.0 87.0 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:95.90 Median:87.00 stddev:17.34 (19.9%) stddev-sans-first:18.21 16:36:35 INFO - PROCESS | 1683 | Values: 89.0 108.0 137.0 104.0 89.0 85.0 90.0 97.0 85.0 75.0 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:118.20 Median:93.50 stddev:28.12 (30.1%) stddev-sans-first:28.31 16:36:35 INFO - PROCESS | 1683 | Values: 93.0 108.0 141.0 154.0 153.0 153.0 95.0 94.0 96.0 95.0 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:91.00 stddev:18.33 (20.1%) stddev-sans-first:19.25 16:36:35 INFO - PROCESS | 1683 | Values: 90.0 92.0 91.0 92.0 92.0 90.0 136.0 91.0 74.0 124.0 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:65.50 stddev:14.61 (22.3%) stddev-sans-first:14.86 16:36:35 INFO - PROCESS | 1683 | Values: 57.0 57.0 57.0 58.0 62.0 83.0 93.0 91.0 61.0 69.0 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:79.50 Median:74.00 stddev:14.39 (19.5%) stddev-sans-first:14.76 16:36:35 INFO - PROCESS | 1683 | Values: 69.0 73.0 75.0 81.0 81.0 100.0 101.0 62.0 92.0 61.0 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:3.60 (4.3%) stddev-sans-first:3.81 16:36:35 INFO - PROCESS | 1683 | Values: 83.0 84.0 83.0 83.0 84.0 86.0 86.0 83.0 75.0 89.0 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:150.90 Median:146.50 stddev:22.49 (15.4%) stddev-sans-first:23.62 16:36:35 INFO - PROCESS | 1683 | Values: 142.0 139.0 136.0 129.0 149.0 144.0 140.0 151.0 205.0 174.0 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.40 Median:169.00 stddev:27.65 (16.4%) stddev-sans-first:28.68 16:36:35 INFO - PROCESS | 1683 | Values: 167.0 168.0 167.0 166.0 170.0 167.0 221.0 161.0 234.0 213.0 16:36:35 INFO - PROCESS | 1683 | 16:36:35 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.50 stddev:1.96 (2.9%) stddev-sans-first:2.01 16:36:35 INFO - PROCESS | 1683 | Values: 68.0 69.0 64.0 63.0 67.0 67.0 65.0 68.0 68.0 67.0 16:36:35 INFO - PROCESS | 1683 | -------- Summary: end -------- 16:36:35 INFO - PROCESS | 1683 | 16:36:36 INFO - TEST-INFO | 1683: exit 0 16:36:36 INFO - TEST-OK | kraken | took 59617ms 16:36:36 INFO - SUITE-END | took 1173s 16:36:36 INFO - Completed test suite (00:19:33) 16:36:36 INFO - javascript benchmark 16:36:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7386.05256160341, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3263.2494526258965, 3300.290437555925, 3346.196912740943, 3357.7481688873327, 3386.966130338699, 5555.527780138688, 5570.721463926808, 5636.7181640918, 5639.0, 5675.9999999999945, 5580.525655319292, 5636.887262254762, 5660.518855897254, 5662.490375866171, 5678.43215678432, 5123.923141152885, 5189.636725429222, 5207.531322181003, 5221.138512145491, 5271.551918086967, 5227.503387178212, 5248.107821670306, 5256.92114618281, 5258.894822103555, 5272.420033796279, 5160.277561141444, 5161.251618515313, 5220.738963051851, 5270.472952704718, 5273.604479664022, 5177.818776342848, 5228.372595288571, 5255.237990491396, 5289.814856480005, 5337.519623233928, 5132.5124113209185, 5247.632665713401, 5251.002309561171, 5255.264263003182, 5319.468053194688, 5513.917291240595, 5681.659100453986, 5714.828460165656, 5785.218995435646, 5816.680082595455, 5037.596992240612, 5960.344362120163, 6105.755769769204, 6114.816555503342, 6133.0, 5477.4248703886315, 6103.389661033905, 6139.570230083896, 6161.876762464771, 6181.165542651729, 5801.7099145042575, 5818.912716309216, 5827.125931110368, 5838.737256823453, 5856.882862342729, 6125.877482450326, 6128.724207410677, 6136.917362303815, 6140.907886381708, 6153.769246150699, 6072.908906366408, 6082.635041897501, 6092.421219984094, 6095.542834287357, 6098.908516372258, 6107.633541987495, 6129.96935015331, 6147.754089836357, 6152.692365381713, 6155.292141403706, 4502.144592527409, 5437.34751829783, 5914.970425147847, 6063.090536419572, 6125.785597504066, 5075.543201111917, 6113.052476866093, 6131.693415329216, 6148.538859585549, 6160.815175544741, 4601.493835678073, 4811.398575178103, 4878.926816097762, 4881.096997055556, 4898.90202195954, 4284.993026638737, 4347.65218782503, 4392.714473559208, 4394.692371534026, 4426.468823741107, 5640.238567793377, 5671.716414179275, 5743.62666426681, 5794.101914203221, 5810.88378232433, 6160.661163635953, 6162.753489860445, 6174.289956655042, 6208.2239720034995, 6213.782517611952, 4795.808167673324, 5629.746661400247, 5704.087346024616, 5726.312842458931, 5732.283464566929, 5326.840194794085, 5340.49265319794, 5358.54452371545, 5359.678419294854, 5372.946270537244, 6217.222847144107, 6253.405926437073, 6260.123582698335, 6272.655003974825, 6301.117843501914, 6085.391460853879, 6111.786087486917, 6127.84680382994, 6129.02260737745, 6194.101855231056, 5311.840644780663, 6192.752289908533, 6219.968900155471, 6233.470155036873, 6255.812325630239, 6139.631622102688, 6143.600665956698, 6154.661493617894, 6165.938340616536, 6175.62946223228, 4980.900381992412, 5985.820425387245, 6107.786227482017, 6146.907796382969, 6225.28409232944, 6011.21854158974, 6109.860177052684, 6129.908988904127, 6136.386361364007, 6145.0782382642965, 6070.089486576872, 6071.666058366833, 6092.8781424372155, 6107.54193435503, 6111.327753946974, 5728.770849165987, 5766.596338256281, 5866.823995280149, 5891.293044834647, 5977.790777322773, 4764.595009424099, 5996.8800623988145, 6045.6070355426755, 6056.90914636272, 6117.96941015292, 5903.321118071477, 5945.732442040205, 5946.970265148647, 5948.048312270016, 5983.760649573968], "value": 5608.328507856727, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.91052699987, 479.94720580736134, 483.4295531273099, 533.3493138371185, 538.927534206928, 39972.8008159755, 41483.79258103709, 41559.37660935081, 41670.58329416705, 41673.58326416735, 43325.350119748226, 43917.560824391745, 43949.12101757963, 43961.34057989133, 43994.78002609983, 9859.60561577538, 9990.900090999106, 10031.799364012715, 10051.497425128751, 10060.245481588874, 9791.461469619167, 9881.851772223386, 9899.059589339036, 9929.602815887356, 9931.702048938543, 9803.705888823346, 9891.752706182331, 9903.207743380512, 9918.40489570628, 9940.801183976317, 9816.0, 9841.70474885751, 9880.209583233323, 9897.059779321025, 9897.307188496809, 9792.412455252708, 9861.0, 9876.0, 9889.456079915602, 9893.961134080962, 36364.0, 41214.1757164858, 41743.582564174576, 42063.369049463974, 42162.0, 2900.8694608742658, 3195.760317976161, 3398.9830050849587, 3608.0799396154075, 3915.569287378386, 29463.116106516838, 29790.70209297901, 29896.8505157475, 29910.55134172989, 30502.389952201054, 3241.2221066944, 3293.3413317336626, 3439.7420193485336, 3455.6889879910927, 3476.878309259164, 464126.9999999966, 478384.0, 499596.0, 504966.0, 505499.0, 65275.0, 65695.34304656892, 65777.01334479987, 65920.6703966477, 66488.00267995887, 66145.01564953059, 70264.29735702577, 70564.0, 70742.2925770746, 71123.6443817788, 17050.0, 17224.827751722572, 17228.655426891393, 17454.56363590895, 17470.38853640142, 12990.610281691565, 13160.934195329153, 13292.534761283308, 13336.599902002956, 13482.93258533701, 20030.49923751918, 20340.89829550843, 20569.89715051445, 20724.792752072586, 20726.274580389916, 8378.737740809947, 8499.490030598185, 8563.559385575205, 8582.785430364165, 8630.5253211074, 853.7737499562621, 898.4339865884451, 960.1934375124929, 1104.8342748587615, 1123.6685177872548, 29607.555886661718, 29909.40181196364, 30588.0, 30638.693613063584, 30899.227519312197, 899.7165892743765, 1012.2104758288547, 1062.2723434447428, 1066.0938202527943, 1124.9437528123724, 15861.841381586037, 15898.841011589737, 15994.200289985454, 16024.0, 16173.919130404509, 718008.0, 726622.0, 726701.0, 728208.0, 731027.0, 59707.701461493285, 59928.0, 60082.69958650179, 60147.39852601506, 60512.697436513416, 1162.3316592958913, 1239.9708242159168, 1354.6588877011884, 1380.151207007683, 1381.88944884409, 27271.454570908867, 30554.777808888284, 30704.232394190323, 30796.846015769777, 31201.0, 41308.58691413168, 52345.47654523406, 52421.21368179404, 52475.950480989406, 52611.47388526066, 673302.0, 675614.0, 678295.6085219543, 680108.0, 683592.0, 26162.0, 27812.30469238285, 28048.29879253035, 28049.439011219252, 28077.57883631706, 47959.04081918412, 48674.0, 49383.25925111198, 49454.75272623614, 49635.503644964534, 36396.27207455889, 38945.610543894196, 39506.60493395029, 40450.98872528093, 41356.79321603373, 33118.834405827816, 39859.40210896897, 41476.79261603673, 41504.377434337905, 41752.0, 34468.48297275593, 38476.0, 39263.803680981415, 39906.0, 40829.0, 29859.104226873227, 34366.48450273298, 35570.82214589014, 36065.459018115274, 36218.45672314864, 26350.4729905397, 26546.070887519618, 26554.336141596614, 26823.105050886064, 26844.194674159808], "value": 20696.567892198753, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.2837965966365, 367.9245754620303, 372.09395122875816, 374.52061361457334, 392.6878131885151, 19481.610367792655, 19679.606407871834, 20076.799232007714, 20465.079071441804, 20605.793942060576, 11957.940210298959, 12134.878651213507, 18570.721439178422, 20079.799202008013, 20695.275665351717, 5099.107656160176, 5353.1167357386175, 5353.544948679367, 5354.330708661418, 5359.517643412092, 5228.816991405301, 5947.732352044169, 5988.970055149718, 6008.0, 6035.969820150915, 5616.887662246773, 5925.644461332312, 5950.434708702666, 5966.940330596682, 5990.490808281302, 5257.211418287268, 5284.048871203182, 5387.326584176978, 5387.838364849061, 5407.270018547505, 4228.365745138223, 4909.0672772173175, 5024.748762561857, 5244.921326180111, 5254.0, 9783.559739811726, 11477.680066792342, 12760.234385936781, 12767.936160319232, 12776.233425994376, 1978.5350442645968, 2175.3908905506482, 2268.795808377254, 2276.9886150569305, 2753.8347699138117, 8574.871376929352, 10075.748106297327, 10202.9489852551, 10295.742606434898, 10479.68560943173, 1748.7202047672438, 1833.2208811255164, 1866.188208129468, 1871.9344822931132, 1875.1280654495724, 120700.79299207071, 120723.0, 123334.76665233323, 125636.0, 126206.0, 9787.608495660237, 11142.554297827995, 11499.252548584314, 11525.596604118815, 11733.4719937603, 14578.271086445635, 14705.117692938458, 14717.116972981656, 14747.0, 14757.852421475647, 8494.74515764528, 8602.61288242018, 8720.084391138838, 8829.64681412749, 8894.4663320201, 6697.928331466942, 8704.956475217583, 8789.956050219707, 8935.731928042169, 8947.686830961014, 4466.821327146943, 4547.795349209227, 4553.521880202531, 4608.216603177468, 4625.1443482955765, 1912.0210582047514, 1945.6400565895071, 1949.6100779843805, 1975.74315339005, 1982.464734521671, 827.7020272701823, 875.9956200219085, 921.2307723051327, 921.5254144115786, 973.1339108193713, 20402.795972040385, 20885.68671469929, 20929.790702093087, 21098.894505527373, 21243.36269911905, 740.2338579570227, 899.9280057595377, 904.2630256341192, 904.7692838326185, 967.4823969176457, 8374.623141958626, 9127.26981841451, 9230.86153707695, 11017.44912754359, 11172.0, 466161.0, 599274.0, 606512.0, 619224.0, 620382.0, 110751.0, 113057.0, 126191.36904315419, 131486.0, 131682.68317316705, 842.5534466732641, 851.6337974670827, 973.2700474644017, 988.9159421449258, 991.504247876062, 18547.0, 19237.941913194907, 19249.711254331476, 19271.22915083437, 19393.0303484828, 51311.74344128255, 55574.72212638911, 57045.85908281728, 57634.0, 58571.4142858566, 79509.0, 85020.0, 86941.13058869583, 87497.0, 88639.0, 6400.775972840928, 7097.503174777716, 7399.075115610549, 7931.881021784793, 8065.233802788725, 11873.632904186032, 12665.936670316589, 12732.618021459371, 12988.285644289655, 12997.805032924703, 10723.892761072602, 11010.50452729645, 11045.116390688887, 11222.438878056228, 11352.602658906899, 10658.573657053632, 10830.0, 10831.512581933674, 10844.240903136704, 11066.833997490205, 11173.162012849232, 11298.265612735146, 11351.545938162712, 11425.828612570984, 11486.483108259981, 7394.482386232912, 7490.962545187239, 7515.0, 7568.3945284378215, 7775.066991961001, 8409.906712127384, 9193.678221262224, 10583.31208471447, 11039.337639741641, 11419.0], "value": 9135.578111582345, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.4702707025472, 1495.4242616592612, 1686.4350442601728, 1813.247502286552, 1830.4234166237643, 8108.594570271478, 8390.790230244247, 8522.275606573441, 9096.0903909609, 9111.0, 8661.783455413617, 8967.551622418885, 8989.415687980292, 9066.592003359849, 9089.22741566966, 2387.570237357275, 2411.6382542618658, 2414.1912459326145, 2417.5044115956275, 2425.442148305882, 2398.0527691561824, 2410.252821625293, 2411.0837881604966, 2437.061731233479, 2446.6085426331792, 2296.334063121693, 2302.2747834432103, 2307.1348244408346, 2309.5334462616192, 2311.3643747969277, 2386.069432921162, 2397.3646983549374, 2401.0, 2407.217654262363, 2417.347316224618, 2376.512814872947, 2400.111958575321, 2404.4349577849193, 2404.483036147237, 2407.831451798375, 9023.27813774903, 9072.00207977122, 9087.954560227223, 9163.175314221751, 9183.357164998453, 5251.10731175701, 5362.544183744387, 5407.080796264605, 5411.648242864201, 5429.077056900336, 3583.5341405617105, 3626.3110009098186, 3644.963550364489, 3662.487251784752, 3673.797941113238, 1088.2545456362418, 1101.9063379612742, 1106.6569363497342, 1119.865616126062, 1123.6966019174859, 11802.40987950599, 11867.64397068098, 11891.524339026428, 11936.58221962227, 11960.0, 3822.7515211511163, 3900.31744444721, 4325.437693099877, 4777.498362671939, 4788.640851936118, 8512.616932238065, 9253.213476854542, 10020.549075291483, 10078.496075196212, 10081.395116292899, 4704.788284527204, 5360.624756267024, 5367.624266301322, 5369.40936496985, 5472.2338872557875, 4371.672124590605, 4464.196444639996, 4626.074785043005, 4789.95210047902, 4996.5003499650475, 3952.9209415811524, 3975.840966361371, 4077.347624380144, 4092.570280120604, 4112.91774164515, 1113.33200079953, 1303.4590644882458, 1306.301128896036, 1316.4470922212693, 1319.848217455005, 774.8450309938034, 791.7308115240846, 861.5606040919051, 891.0955380289012, 915.3683958068912, 5842.620229685057, 5885.911711324334, 6161.4146656067605, 6212.378762123752, 6232.3144454110015, 931.3620170183447, 955.6798472511787, 956.1012648110892, 959.5633986536109, 969.2682025071026, 3780.2628487444686, 3800.8669696560487, 4007.1384652299894, 4091.5294741105154, 4144.046869220097, 10864.837027444595, 11139.498722557504, 11236.269642473213, 11239.269447485887, 11272.943635281936, 10741.194410419093, 11180.664580062612, 11185.440727963569, 11202.047825934724, 11239.381833999209, 8173.182681731898, 8427.367947403969, 8517.872231916526, 8519.829603407898, 8539.487630742175, 5936.614120082354, 5970.910436343545, 5993.430624090704, 6084.69576521181, 6167.475764560063, 9622.470764107762, 9977.0, 9999.3000489965, 10161.949190254001, 10422.843657344994, 10545.472726363498, 10557.260991730505, 10558.630447934593, 10567.577296908037, 10602.992715691997, 6650.83372915681, 6872.553284036521, 6922.480813939075, 7017.0, 7315.817104572216, 8451.0, 8538.78653033679, 8541.0, 8624.266937310147, 8701.738947831574, 7492.700291988477, 7599.938138878254, 7674.501157424749, 7750.031246094239, 7791.220877912164, 7430.0, 7544.547327160388, 7563.9621801890635, 7567.545947243183, 7605.923940760522, 7078.539894906815, 7205.71177152908, 7208.098987626547, 7208.171060328129, 7235.384992275715, 4970.304157418037, 5056.7471626419265, 5064.898702026013, 5143.691378517301, 5307.814226502054, 5086.440491545853, 5157.149070403491, 5210.635255532076, 5262.552683021986, 5284.101702710472], "value": 4646.979875724949, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.58243623799154, 310.06824492400347, 310.3451716877389, 313.41860848126726, 316.4651738561832, 5467.835964921053, 5560.331041100274, 5594.86012849679, 5651.0, 5657.830265092049, 5149.433562308143, 5419.566434685225, 5426.158945363465, 5463.808766693167, 5495.642783219088, 3926.3521518949337, 4038.2125485530332, 4039.4142849286836, 4097.119119389331, 4125.051238215212, 3035.969640303591, 3483.303339332131, 3811.504504414422, 4073.124278280169, 4164.146349998243, 3422.8117453540044, 4111.938320925188, 4142.275101857178, 4154.376843473488, 4299.968007678151, 3950.3679411294343, 4095.4266402703647, 4127.545969943304, 4137.8758637240935, 4161.833526658945, 3052.1767365187334, 3195.3769015042076, 3393.355262500117, 3543.6633519815578, 3558.946615800765, 4423.402840616508, 5299.284596579451, 5300.01949639318, 5323.574114070865, 5350.411454739976, 4317.330813723878, 4527.008116428761, 4749.762511874393, 4761.8095276188915, 4763.0, 5590.329160500766, 5634.4365563443735, 5636.688957527435, 5677.914831277534, 5773.884522309572, 3428.9142771430666, 3678.834452449646, 3883.5339759229073, 3889.8994542947057, 3900.9857437066566, 5216.478352164791, 5710.286214223263, 5827.736467578127, 6043.516518678495, 6069.514438844926, 3571.8035508046787, 3895.7272990890933, 3921.5294164700417, 3987.461692671452, 4001.9599804001587, 3988.262171498282, 4003.619656132663, 4009.7393669411395, 4022.738521996061, 4045.2516284487465, 3948.8943095933187, 4377.387165796791, 4510.323451482238, 4729.148753224453, 4738.31294462308, 4685.882852928636, 5542.891421715673, 5787.450192231731, 5798.825440459827, 5915.7633694652595, 1324.7218084202232, 1334.8865346445662, 1365.627544317954, 1368.548379034916, 1373.3133433283358, 738.972827769401, 788.5820515126992, 793.7023616143946, 837.2213841127809, 838.9764487325454, 4845.0067736114015, 5087.516685914832, 5131.358580177478, 5371.274877891513, 5401.837944861661, 4829.975850120797, 5943.910841337383, 5954.345022047572, 5968.403159683997, 6057.818265452043, 5136.476304032741, 5425.701586412706, 5426.972865135649, 5432.0, 5442.428545002796, 2862.942741145207, 2950.1973125530403, 2994.4310580989977, 3048.6830009193172, 3156.4949608062598, 5340.118880384771, 5432.266644003088, 5519.69641669712, 5847.26909136358, 6184.042212983694, 5744.798932037359, 6100.450959413674, 6112.847178820565, 6141.815745527552, 6173.900873702963, 4880.389951256093, 5126.92309615356, 5274.604404669665, 6258.499320054476, 6262.937370626418, 4778.641601879804, 5771.884562308815, 6038.849028774316, 6074.119252708244, 6091.0, 4801.375821143229, 5173.982146962612, 5709.54323654115, 5950.0, 5970.731317090655, 6163.84590385244, 6182.381761823782, 6242.845073661387, 6259.530535209787, 6290.465310448663, 3535.911602209965, 3854.8843534694006, 3993.2612466693754, 4052.959470405376, 4077.857274995361, 5819.9815032368315, 5927.733252003584, 5932.584719069796, 6034.607750496204, 6034.818955431344, 4904.435989861069, 5210.6613070150315, 5796.391378905154, 5839.416058394127, 5887.587868849139, 5370.436104209002, 5786.161006654096, 5802.912956305743, 5815.476607105381, 5855.691534283116, 5021.372328458942, 5286.603504737083, 5719.256496655408, 5750.913736293875, 5804.448577385142, 5492.231087647652, 5632.690202038763, 5693.807883964786, 5791.075506869004, 5887.882242355215, 4778.04439112172, 5395.973020134874, 5657.801976930952, 5736.569757268138, 5758.1362795579325], "value": 4172.566332594247, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.2097098821849, 703.750168690115, 756.5838788666232, 777.576220959577, 805.3476683886053, 15608.453704120358, 15721.213939303047, 15896.364145434169, 15904.045757254558, 15931.0, 12277.631671049861, 14319.78520322196, 14348.0, 14361.640958976004, 14433.20617366047, 685.568092101975, 709.1808960650457, 831.8544254755424, 843.9746807595782, 861.6036623153326, 824.9958750206241, 854.9953804279977, 869.8608222684372, 871.8822958900531, 874.9956250218772, 877.1579283887444, 926.7173512078813, 929.5816882402912, 930.692871352452, 934.065934065934, 874.5802015032788, 919.2508105893709, 921.424109931293, 924.9953750231273, 926.7683079230226, 648.5589798936721, 674.8009337245525, 686.7767975408012, 687.295522089857, 688.3082502085422, 15133.697326053418, 15141.924290378587, 15163.241837908061, 15169.848301516953, 15207.771883421758, 14693.412263509554, 14745.852541474555, 14759.0, 14830.925845370812, 14842.480513181987, 11338.886611133948, 11730.12024098196, 11840.526378944833, 11890.227135236182, 12461.190022648589, 4430.778461076933, 4567.132244873464, 4609.078184363141, 4611.1930412177735, 4632.513586073447, 80556.0, 98056.0, 105144.99999999923, 110271.44864275708, 125164.37417812944, 10435.94782026085, 10881.020708136306, 11008.229423940247, 11066.889331106748, 11325.886741132648, 20473.89763051175, 20643.896780516003, 20839.79160208409, 20860.37418877436, 21193.0, 6734.292899245606, 7799.220077992155, 7809.297163255334, 7845.843083138306, 7922.445428819928, 4376.627986621109, 4406.49325327585, 4440.33394990754, 4460.286354183315, 4546.386237857913, 3080.183751305906, 3090.3973725123833, 3103.898116168773, 3440.9655903440644, 3578.5347904772734, 587.8859561131717, 653.9378759017885, 662.192125606759, 674.8110529051874, 686.8179932317939, 577.2755192233719, 601.2814686449651, 620.8385819686823, 623.5510432488601, 628.924529056507, 8263.774196908194, 9193.034731353246, 9332.486713230837, 9405.67080152205, 9568.282378821616, 587.5593305021234, 618.9257289125334, 634.0267689097213, 641.0768493369533, 664.51158398577, 3776.8489260429824, 4352.325389564622, 4510.503844577094, 4534.9319760203625, 4623.190941585209, 104446.0, 126689.09966350513, 170247.1487642554, 179772.0, 186837.06581467006, 124795.0, 145032.0, 147828.26085869502, 149777.0, 151055.0, 105808.47095764626, 107923.46038269758, 115289.4235528817, 130751.0, 135769.0, 8166.550839703873, 9667.854982175413, 9945.403275803475, 10012.599496020077, 10366.792664146826, 61202.081968771396, 63959.36040639534, 64064.67967660132, 65114.34885651083, 65380.673096634215, 73026.0, 79285.414291715, 79878.0, 86058.0, 89064.5546772262, 10933.125349971824, 12563.309018003732, 12856.164349317265, 13149.34253287351, 13730.51943181984, 14715.043522171025, 14834.629134271298, 15308.31112599958, 15504.953937076398, 15719.607009824846, 13902.026858119834, 14153.510078442972, 14425.773809226333, 14780.48268310604, 14913.478028268959, 14144.575662730134, 14227.573172804832, 14245.287735613385, 14450.37841493358, 14964.251787410803, 12829.973602111622, 13076.346182691017, 13810.447582096604, 13866.376013079234, 14033.789493157406, 11470.254433461798, 11698.70753231176, 11751.647450576496, 11874.7797427892, 11885.28688278706, 11760.294382337088, 11887.821682674594, 11924.67366572183, 11935.34355610415, 12033.977111945582], "value": 7895.630436539706, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 117.0, 117.0, 118.0, 118.0, 118.0, 116.0, 116.0, 162.0, 177.0], "value": 126.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 111.0, 109.0, 139.0, 107.0, 110.0, 110.0, 108.0, 134.0, 110.0], "value": 118.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 201.0, 197.0, 195.0, 195.0, 192.0, 194.0, 198.0, 197.0, 195.0], "value": 195.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 58.0, 82.0, 58.0, 59.0, 59.0, 59.0, 78.0, 51.0], "value": 64.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 88.0, 73.0, 69.0, 70.0, 87.0, 70.0, 70.0, 87.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 108.0, 137.0, 104.0, 89.0, 85.0, 90.0, 97.0, 85.0, 75.0], "value": 95.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 108.0, 141.0, 154.0, 153.0, 153.0, 95.0, 94.0, 96.0, 95.0], "value": 118.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 91.0, 92.0, 92.0, 90.0, 136.0, 91.0, 74.0, 124.0], "value": 97.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 58.0, 62.0, 83.0, 93.0, 91.0, 61.0, 69.0], "value": 68.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 75.0, 81.0, 81.0, 100.0, 101.0, 62.0, 92.0, 61.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 83.0, 84.0, 86.0, 86.0, 83.0, 75.0, 89.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 136.0, 129.0, 149.0, 144.0, 140.0, 151.0, 205.0, 174.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 167.0, 166.0, 170.0, 167.0, 221.0, 161.0, 234.0, 213.0], "value": 183.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 64.0, 63.0, 67.0, 67.0, 65.0, 68.0, 68.0, 67.0], "value": 66.6, "unit": "score"}]}]} 16:36:37 INFO - Return code: 0 16:36:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:36:37 ERROR - # TBPL SUCCESS # 16:36:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:36:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:36:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:36:37 INFO - 2016-11-05 16:36:37.132 screenresolution[1688:16526] starting screenresolution argv=screenresolution get 16:36:37 INFO - 2016-11-05 16:36:37.134 screenresolution[1688:16526] Display 0: 1600x1200x32@60 16:36:37 INFO - 2016-11-05 16:36:37.140 screenresolution[1689:16529] starting screenresolution argv=screenresolution list 16:36:37 INFO - Available Modes on Display 0 16:36:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:36:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:36:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:36:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:36:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:36:37 INFO - Intel Iris: 16:36:37 INFO - Chipset Model: Intel Iris 16:36:37 INFO - Type: GPU 16:36:37 INFO - Bus: Built-In 16:36:37 INFO - VRAM (Dynamic, Max): 1536 MB 16:36:37 INFO - Vendor: Intel (0x8086) 16:36:37 INFO - Device ID: 0x0a2e 16:36:37 INFO - Revision ID: 0x0009 16:36:37 INFO - Displays: 16:36:37 INFO - Display: 16:36:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:36:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:36:37 INFO - Display Serial Number: 1600x1200 60 16:36:37 INFO - Main Display: Yes 16:36:37 INFO - Mirror: Off 16:36:37 INFO - Online: Yes 16:36:37 INFO - Rotation: Supported 16:36:37 INFO - Return code: 0 16:36:37 INFO - Running post-action listener: _resource_record_post_action 16:36:37 INFO - [mozharness: 2016-11-05 23:36:37.379425Z] Finished run-tests step (success) 16:36:37 INFO - Running post-run listener: _resource_record_post_run 16:36:37 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 31939584; Write bytes: 669301248; Read time: 193; Write time: 1937 16:36:37 INFO - TinderboxPrint: CPU usage
54.3% 16:36:37 INFO - TinderboxPrint: I/O read bytes / time
31,939,584 / 193 16:36:37 INFO - TinderboxPrint: I/O write bytes / time
669,301,248 / 1,937 16:36:37 INFO - TinderboxPrint: CPU idle
2,207.2 (45.7%) 16:36:37 INFO - TinderboxPrint: CPU system
976.1 (20.2%) 16:36:37 INFO - TinderboxPrint: CPU user
1,642.5 (34.0%) 16:36:37 INFO - TinderboxPrint: Swap in / out
391,507,968 / 0 16:36:37 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 358777344; Write bytes: 357468160; Read time: 27571; Write time: 729 16:36:37 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 29899776; Write bytes: 300773888; Read time: 175; Write time: 1171 16:36:37 INFO - Running post-run listener: _upload_blobber_files 16:36:37 INFO - Blob upload gear active. 16:36:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:36:37 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:37 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:37 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:38 INFO - (blobuploader) - INFO - Open directory for files ... 16:36:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:36:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:36:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:39 INFO - (blobuploader) - INFO - Done attempting. 16:36:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:36:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:36:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:36:40 INFO - (blobuploader) - INFO - Done attempting. 16:36:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:36:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:36:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:36:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: 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 - Iteration through files over. 16:36:42 INFO - Return code: 0 16:36:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:36:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:36:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3c18dee73b047cd747b313b05fb43a8a0aa5556dfc61f69d4364c61f3b7a95c716c1b97f3520cf6af27815f71b15c81c6a812e57e62a41c8d4f112b9f5628e4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aee1f9003d2fc7bec926b298683c6a954057169e34ae378e9feca41017a84fc2b50b090ab30cd626ec329851033492ace2f46cff42104aa473082946fe91839e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5af46065a023807f032cae228f9162d88980ed23991cab2da1ecaa4cb6111c1836da4796e45f92f030f1bbf41519d701a09302609f1f692d2f8fd162bcf5e1bb"} 16:36:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:36:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:36:42 INFO - Contents: 16:36:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3c18dee73b047cd747b313b05fb43a8a0aa5556dfc61f69d4364c61f3b7a95c716c1b97f3520cf6af27815f71b15c81c6a812e57e62a41c8d4f112b9f5628e4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aee1f9003d2fc7bec926b298683c6a954057169e34ae378e9feca41017a84fc2b50b090ab30cd626ec329851033492ace2f46cff42104aa473082946fe91839e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5af46065a023807f032cae228f9162d88980ed23991cab2da1ecaa4cb6111c1836da4796e45f92f030f1bbf41519d701a09302609f1f692d2f8fd162bcf5e1bb"} 16:36:42 INFO - Running post-run listener: copy_logs_to_upload_dir 16:36:42 INFO - Copying logs to upload dir... 16:36:42 INFO - mkdir: /builds/slave/test/build/upload/logs 16:36:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.774124 ========= master_lag: 1.51 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-11-05 16:36:44.307535) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 16:36:44.312130) ========= 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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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/3c18dee73b047cd747b313b05fb43a8a0aa5556dfc61f69d4364c61f3b7a95c716c1b97f3520cf6af27815f71b15c81c6a812e57e62a41c8d4f112b9f5628e4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aee1f9003d2fc7bec926b298683c6a954057169e34ae378e9feca41017a84fc2b50b090ab30cd626ec329851033492ace2f46cff42104aa473082946fe91839e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5af46065a023807f032cae228f9162d88980ed23991cab2da1ecaa4cb6111c1836da4796e45f92f030f1bbf41519d701a09302609f1f692d2f8fd162bcf5e1bb"} 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.011073 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/3c18dee73b047cd747b313b05fb43a8a0aa5556dfc61f69d4364c61f3b7a95c716c1b97f3520cf6af27815f71b15c81c6a812e57e62a41c8d4f112b9f5628e4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aee1f9003d2fc7bec926b298683c6a954057169e34ae378e9feca41017a84fc2b50b090ab30cd626ec329851033492ace2f46cff42104aa473082946fe91839e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5af46065a023807f032cae228f9162d88980ed23991cab2da1ecaa4cb6111c1836da4796e45f92f030f1bbf41519d701a09302609f1f692d2f8fd162bcf5e1bb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-05 16:36:44.354046) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:36:44.354376) ========= 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.1CdJD1FFfz/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.aWQrrM1gQ3/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.005041 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-05 16:36:44.402542) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 16:36:44.405920) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-05 16:36:44.406235) ========= ========= Total master_lag: 1.66 =========