builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0273 starttime: 1479102670.33 results: success (0) buildid: 20161113194020 builduid: c8e1726c50924e4fa0c868eec9bbadc1 revision: 4e97dee28c6941a78f5ec342fbe95ce5e6a012b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-13 21:51:10.328484) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-13 21:51:10.328904) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-13 21:51:10.329205) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-13 21:51:10.357166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 21:51:10.357529) ========= 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.5Ko7TlTT1R/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.GsdVVZniEb/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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-13 21:51:10-- 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% 18.9M=0.001s 2016-11-13 21:51:10 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127675 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 21:51:10.507705) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 21:51:10.508056) ========= 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.5Ko7TlTT1R/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.GsdVVZniEb/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.024022 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 21:51:10.560847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-11-13 21:51:10.563290) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4e97dee28c6941a78f5ec342fbe95ce5e6a012b1 --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 4e97dee28c6941a78f5ec342fbe95ce5e6a012b1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5Ko7TlTT1R/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.GsdVVZniEb/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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-13 21:51:10,646 truncating revision to first 12 chars 2016-11-13 21:51:10,646 Setting DEBUG logging. 2016-11-13 21:51:10,646 attempt 1/10 2016-11-13 21:51:10,646 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4e97dee28c69?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-13 21:51:12,267 unpacking tar archive at: mozilla-aurora-4e97dee28c69/testing/mozharness/ program finished with exit code 0 elapsedTime=1.888673 ========= master_lag: 1.83 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-11-13 21:51:14.277285) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-13 21:51:14.277636) ========= script_repo_revision: 4e97dee28c6941a78f5ec342fbe95ce5e6a012b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-13 21:51:14.278234) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-13 21:51:14.278537) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-13 21:51:14.388536) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-11-13 21:51:14.389007) ========= /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.5Ko7TlTT1R/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.GsdVVZniEb/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:51:14 INFO - MultiFileLogger online at 20161113 21:51:14 in /builds/slave/test 21:51:14 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 21:51:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:51:14 INFO - {'append_to_log': False, 21:51:14 INFO - 'base_work_dir': '/builds/slave/test', 21:51:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:51:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:51:14 INFO - 'branch': 'Mozilla-Aurora', 21:51:14 INFO - 'buildbot_json_path': 'buildprops.json', 21:51:14 INFO - 'config_files': ('talos/mac_config.py',), 21:51:14 INFO - 'default_actions': ('clobber', 21:51:14 INFO - 'read-buildbot-config', 21:51:14 INFO - 'download-and-extract', 21:51:14 INFO - 'populate-webroot', 21:51:14 INFO - 'create-virtualenv', 21:51:14 INFO - 'install', 21:51:14 INFO - 'run-tests'), 21:51:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:51:14 INFO - 'download_minidump_stackwalk': True, 21:51:14 INFO - 'download_symbols': 'ondemand', 21:51:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:51:14 INFO - 'tooltool.py': '/tools/tooltool.py', 21:51:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:51:14 INFO - '/tools/misc-python/virtualenv.py')}, 21:51:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:51:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:51:14 INFO - 'installer_path': 'installer.exe', 21:51:14 INFO - 'log_level': 'info', 21:51:14 INFO - 'log_name': 'talos', 21:51:14 INFO - 'log_to_console': True, 21:51:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:51:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:51:14 INFO - 'opt_config_files': (), 21:51:14 INFO - 'pip_index': False, 21:51:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:51:14 INFO - 'cmd': ('bash', 21:51:14 INFO - '-c', 21:51:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:51:14 INFO - 'enabled': True, 21:51:14 INFO - 'halt_on_failure': False, 21:51:14 INFO - 'name': 'check_screen_resolution'},), 21:51:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:51:14 INFO - 'cmd': ('bash', 21:51:14 INFO - '-c', 21:51:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:51:14 INFO - 'enabled': True, 21:51:14 INFO - 'halt_on_failure': False, 21:51:14 INFO - 'name': 'check_screen_resolution'},), 21:51:14 INFO - 'run_cmd_checks_enabled': True, 21:51:14 INFO - 'sps_profile': False, 21:51:14 INFO - 'sps_profile_interval': 0, 21:51:14 INFO - 'suite': 'dromaeojs-e10s', 21:51:14 INFO - 'system_bits': '32', 21:51:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:51:14 INFO - 'title': 't-yosemite-r7-0273', 21:51:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:51:14 INFO - 'use_talos_json': True, 21:51:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:51:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:51:14 INFO - 'work_dir': 'build'} 21:51:14 INFO - [mozharness: 2016-11-14 05:51:14.585757Z] Running clobber step. 21:51:14 INFO - Running pre-action listener: _resource_record_pre_action 21:51:14 INFO - Running main action method: clobber 21:51:14 INFO - rmtree: /builds/slave/test/build 21:51:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:51:16 INFO - Running post-action listener: _resource_record_post_action 21:51:16 INFO - [mozharness: 2016-11-14 05:51:16.927513Z] Finished clobber step (success) 21:51:16 INFO - [mozharness: 2016-11-14 05:51:16.927647Z] Running read-buildbot-config step. 21:51:16 INFO - Running pre-action listener: _resource_record_pre_action 21:51:16 INFO - Running main action method: read_buildbot_config 21:51:16 INFO - Using buildbot properties: 21:51:16 INFO - { 21:51:16 INFO - "project": "", 21:51:16 INFO - "product": "firefox", 21:51:16 INFO - "script_repo_revision": "production", 21:51:16 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 21:51:16 INFO - "repository": "", 21:51:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 21:51:16 INFO - "buildid": "20161113194020", 21:51:16 INFO - "pgo_build": "False", 21:51:16 INFO - "basedir": "/builds/slave/test", 21:51:16 INFO - "buildnumber": 21, 21:51:16 INFO - "slavename": "t-yosemite-r7-0273", 21:51:16 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 21:51:16 INFO - "platform": "yosemite_r7", 21:51:16 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 21:51:16 INFO - "branch": "mozilla-aurora", 21:51:16 INFO - "repo_path": "releases/mozilla-aurora", 21:51:16 INFO - "revision": "4e97dee28c6941a78f5ec342fbe95ce5e6a012b1", 21:51:16 INFO - "stage_platform": "macosx64", 21:51:16 INFO - "builduid": "c8e1726c50924e4fa0c868eec9bbadc1", 21:51:16 INFO - "slavebuilddir": "test" 21:51:16 INFO - } 21:51:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 21:51:16 INFO - Running post-action listener: _resource_record_post_action 21:51:16 INFO - [mozharness: 2016-11-14 05:51:16.930940Z] Finished read-buildbot-config step (success) 21:51:16 INFO - [mozharness: 2016-11-14 05:51:16.931046Z] Running download-and-extract step. 21:51:16 INFO - Running pre-action listener: _resource_record_pre_action 21:51:16 INFO - Running main action method: download_and_extract 21:51:16 INFO - mkdir: /builds/slave/test/build/tests 21:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:16 INFO - trying https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 21:51:16 INFO - Downloading https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/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 21:51:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/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 21:51:18 INFO - Downloaded 1199 bytes. 21:51:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:51:18 INFO - Using the following test package requirements: 21:51:18 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:51:18 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:51:18 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 21:51:18 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:51:18 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 21:51:18 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:51:18 INFO - u'jsshell-mac.zip'], 21:51:18 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:51:18 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 21:51:18 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:51:18 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:51:18 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 21:51:18 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:51:18 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 21:51:18 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:51:18 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 21:51:18 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:51:18 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 21:51:18 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 21:51:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:51:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:51:18 INFO - Fetch https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:51:18 INFO - Expected file size: 16423831 21:51:25 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 21:51:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:51:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:51:25 INFO - Fetch https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:51:26 INFO - Expected file size: 16423831 21:51:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 21:51:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 21:51:32 INFO - Fetch https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 21:51:33 INFO - Expected file size: 14414089 21:51:34 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')]} 21:51:34 INFO - trying https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:51:34 INFO - Downloading https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 21:51:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/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 21:51:37 INFO - Downloaded 115561410 bytes. 21:51:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:51:37 INFO - mkdir: /builds/slave/test/properties 21:51:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:51:37 INFO - Writing to file /builds/slave/test/properties/build_url 21:51:37 INFO - Contents: 21:51:37 INFO - build_url:https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:51:37 INFO - Running post-action listener: _resource_record_post_action 21:51:37 INFO - Running post-action listener: set_extra_try_arguments 21:51:37 INFO - [mozharness: 2016-11-14 05:51:37.903259Z] Finished download-and-extract step (success) 21:51:37 INFO - [mozharness: 2016-11-14 05:51:37.903373Z] Running populate-webroot step. 21:51:37 INFO - Running pre-action listener: _resource_record_pre_action 21:51:37 INFO - Running main action method: populate_webroot 21:51:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:51:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:51:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:51:37 INFO - '--tppagecycles', 21:51:37 INFO - '7'], 21:51:37 INFO - 'tests': ['tsvgm']}}, 21:51:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:51:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:51:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:51:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:51:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:51:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:51:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:37 INFO - 'talos_options': ['--disable-e10s'], 21:51:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:51:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:51:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:37 INFO - 'talos_options': ['--disable-e10s'], 21:51:37 INFO - 'tests': ['damp', 'tps']}, 21:51:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:37 INFO - 'tests': ['damp', 'tps']}, 21:51:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:51:37 INFO - 'tests': ['dromaeo_dom']}, 21:51:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:51:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:51:37 INFO - 'tests': ['basic_compositor_video']}, 21:51:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:51:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:51:37 INFO - 'tests': ['a11yr', 21:51:37 INFO - 'ts_paint', 21:51:37 INFO - 'tpaint', 21:51:37 INFO - 'sessionrestore', 21:51:37 INFO - 'sessionrestore_no_auto_restore', 21:51:37 INFO - 'tabpaint']}, 21:51:37 INFO - 'other-e10s': {'tests': ['a11yr', 21:51:37 INFO - 'ts_paint', 21:51:37 INFO - 'tpaint', 21:51:37 INFO - 'sessionrestore', 21:51:37 INFO - 'sessionrestore_no_auto_restore', 21:51:37 INFO - 'tabpaint']}, 21:51:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:51:37 INFO - 'ts_paint', 21:51:37 INFO - 'tpaint', 21:51:37 INFO - 'sessionrestore', 21:51:37 INFO - 'sessionrestore_no_auto_restore', 21:51:37 INFO - 'tabpaint']}, 21:51:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:51:37 INFO - 'ts_paint', 21:51:37 INFO - 'tpaint', 21:51:37 INFO - 'sessionrestore', 21:51:37 INFO - 'sessionrestore_no_auto_restore', 21:51:37 INFO - 'tabpaint']}, 21:51:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:51:37 INFO - 'tests': ['a11yr', 21:51:37 INFO - 'ts_paint', 21:51:37 INFO - 'tpaint', 21:51:37 INFO - 'sessionrestore', 21:51:37 INFO - 'sessionrestore_no_auto_restore', 21:51:37 INFO - 'tabpaint']}, 21:51:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:51:37 INFO - 'tests': ['a11yr', 21:51:37 INFO - 'ts_paint', 21:51:37 INFO - 'tpaint', 21:51:37 INFO - 'sessionrestore', 21:51:37 INFO - 'sessionrestore_no_auto_restore', 21:51:37 INFO - 'tabpaint']}, 21:51:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:51:37 INFO - 'tests': ['tsvgx', 21:51:37 INFO - 'tsvgr_opacity', 21:51:37 INFO - 'tart', 21:51:37 INFO - 'tscrollx', 21:51:37 INFO - 'cart']}, 21:51:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:51:37 INFO - 'tsvgr_opacity', 21:51:37 INFO - 'tart', 21:51:37 INFO - 'tscrollx', 21:51:37 INFO - 'cart']}, 21:51:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:37 INFO - 'talos_options': ['--disable-e10s'], 21:51:37 INFO - 'tests': ['tp5o']}, 21:51:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:37 INFO - 'tests': ['tp5o']}, 21:51:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:37 INFO - 'talos_options': ['--disable-e10s', 21:51:37 INFO - '--xperf_path', 21:51:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:51:37 INFO - 'tests': ['tp5n']}, 21:51:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:51:37 INFO - 'talos_options': ['--xperf_path', 21:51:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:51:37 INFO - 'tests': ['tp5n']}}, 21:51:37 INFO - 'talos.zip': {'path': '', 21:51:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:51:37 INFO - Running post-action listener: _resource_record_post_action 21:51:37 INFO - [mozharness: 2016-11-14 05:51:37.921811Z] Finished populate-webroot step (success) 21:51:37 INFO - [mozharness: 2016-11-14 05:51:37.921939Z] Running create-virtualenv step. 21:51:37 INFO - Running pre-action listener: _resource_record_pre_action 21:51:37 INFO - Running main action method: create_virtualenv 21:51:37 INFO - Creating virtualenv /builds/slave/test/build/venv 21:51:37 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 21:51:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:51:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:51:38 INFO - Using real prefix '/tools/python27' 21:51:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:51:38 INFO - Installing distribute.............................................................................................................................................................................................done. 21:51:41 INFO - Installing pip.................done. 21:51:41 INFO - Return code: 0 21:51:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:41 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 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963579b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.5Ko7TlTT1R/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.GsdVVZniEb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:51:41 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 21:51:41 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 21:51:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Ko7TlTT1R/Render', 21:51:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:41 INFO - 'HOME': '/Users/cltbld', 21:51:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:41 INFO - 'LOGNAME': 'cltbld', 21:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:41 INFO - 'MOZ_NO_REMOTE': '1', 21:51:41 INFO - 'NO_EM_RESTART': '1', 21:51:41 INFO - 'PAGER': '/bin/cat', 21:51:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:41 INFO - 'PWD': '/builds/slave/test', 21:51:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:41 INFO - 'SHELL': '/bin/bash', 21:51:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsdVVZniEb/Listeners', 21:51:41 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:51:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:41 INFO - 'USER': 'cltbld', 21:51:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:41 INFO - 'XPC_FLAGS': '0x0', 21:51:41 INFO - 'XPC_SERVICE_NAME': '0', 21:51:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:41 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 21:51:41 INFO - Cleaning up... 21:51:41 INFO - Return code: 0 21:51:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:41 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 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963579b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.5Ko7TlTT1R/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.GsdVVZniEb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:51:41 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 21:51:41 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 21:51:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Ko7TlTT1R/Render', 21:51:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:41 INFO - 'HOME': '/Users/cltbld', 21:51:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:41 INFO - 'LOGNAME': 'cltbld', 21:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:41 INFO - 'MOZ_NO_REMOTE': '1', 21:51:41 INFO - 'NO_EM_RESTART': '1', 21:51:41 INFO - 'PAGER': '/bin/cat', 21:51:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:41 INFO - 'PWD': '/builds/slave/test', 21:51:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:41 INFO - 'SHELL': '/bin/bash', 21:51:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsdVVZniEb/Listeners', 21:51:41 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:51:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:41 INFO - 'USER': 'cltbld', 21:51:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:41 INFO - 'XPC_FLAGS': '0x0', 21:51:41 INFO - 'XPC_SERVICE_NAME': '0', 21:51:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:42 INFO - Downloading/unpacking psutil>=3.1.1 21:51:42 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 21:51:42 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 21:51:42 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 21:51:42 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 21:51:42 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 21:51:42 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 21:51:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:51:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:51:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:51:45 INFO - Installing collected packages: psutil 21:51:45 INFO - Running setup.py install for psutil 21:51:45 INFO - building 'psutil._psutil_osx' extension 21:51:45 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 21:51:46 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 21:51:46 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 21:51:46 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 21:51:46 INFO - building 'psutil._psutil_posix' extension 21:51:46 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 21:51:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:51:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:51:46 INFO - ^ 21:51:46 INFO - 1 warning generated. 21:51:46 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 21:51:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:51:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:51:46 INFO - Successfully installed psutil 21:51:46 INFO - Cleaning up... 21:51:46 INFO - Return code: 0 21:51:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:46 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 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963579b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.5Ko7TlTT1R/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.GsdVVZniEb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:51:46 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 21:51:46 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 21:51:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Ko7TlTT1R/Render', 21:51:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:46 INFO - 'HOME': '/Users/cltbld', 21:51:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:46 INFO - 'LOGNAME': 'cltbld', 21:51:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:46 INFO - 'MOZ_NO_REMOTE': '1', 21:51:46 INFO - 'NO_EM_RESTART': '1', 21:51:46 INFO - 'PAGER': '/bin/cat', 21:51:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:46 INFO - 'PWD': '/builds/slave/test', 21:51:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:46 INFO - 'SHELL': '/bin/bash', 21:51:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsdVVZniEb/Listeners', 21:51:46 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:51:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:46 INFO - 'USER': 'cltbld', 21:51:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:46 INFO - 'XPC_FLAGS': '0x0', 21:51:46 INFO - 'XPC_SERVICE_NAME': '0', 21:51:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:51:46 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 21:51:46 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 21:51:46 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 21:51:46 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 21:51:46 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 21:51:46 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 21:51:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:51:49 INFO - Installing collected packages: mozsystemmonitor 21:51:49 INFO - Running setup.py install for mozsystemmonitor 21:51:49 INFO - Successfully installed mozsystemmonitor 21:51:49 INFO - Cleaning up... 21:51:49 INFO - Return code: 0 21:51:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:51:49 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')]} 21:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:49 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')]} 21:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:49 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 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963579b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.5Ko7TlTT1R/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.GsdVVZniEb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:51:49 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 21:51:49 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 21:51:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Ko7TlTT1R/Render', 21:51:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:49 INFO - 'HOME': '/Users/cltbld', 21:51:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:49 INFO - 'LOGNAME': 'cltbld', 21:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:49 INFO - 'MOZ_NO_REMOTE': '1', 21:51:49 INFO - 'NO_EM_RESTART': '1', 21:51:49 INFO - 'PAGER': '/bin/cat', 21:51:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:49 INFO - 'PWD': '/builds/slave/test', 21:51:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:49 INFO - 'SHELL': '/bin/bash', 21:51:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsdVVZniEb/Listeners', 21:51:49 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:51:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:49 INFO - 'USER': 'cltbld', 21:51:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:49 INFO - 'XPC_FLAGS': '0x0', 21:51:49 INFO - 'XPC_SERVICE_NAME': '0', 21:51:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:49 INFO - Downloading/unpacking jsonschema==2.5.1 21:51:49 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 21:51:49 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 21:51:49 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 21:51:49 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 21:51:49 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 21:51:49 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 21:51:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:51:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:52 INFO - Downloading functools32-3.2.3-2.tar.gz 21:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:51:52 INFO - warning: no files found matching '*.txt' 21:51:52 INFO - no previously-included directories found matching 'build' 21:51:52 INFO - no previously-included directories found matching 'dist' 21:51:52 INFO - no previously-included directories found matching '.git*' 21:51:52 INFO - Installing collected packages: jsonschema, functools32 21:51:52 INFO - Running setup.py install for functools32 21:51:53 INFO - warning: no files found matching '*.txt' 21:51:53 INFO - no previously-included directories found matching 'build' 21:51:53 INFO - no previously-included directories found matching 'dist' 21:51:53 INFO - no previously-included directories found matching '.git*' 21:51:53 INFO - Successfully installed jsonschema functools32 21:51:53 INFO - Cleaning up... 21:51:53 INFO - Return code: 0 21:51:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963579b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.5Ko7TlTT1R/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.GsdVVZniEb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:51:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:51:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Ko7TlTT1R/Render', 21:51:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:53 INFO - 'HOME': '/Users/cltbld', 21:51:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:53 INFO - 'LOGNAME': 'cltbld', 21:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:53 INFO - 'MOZ_NO_REMOTE': '1', 21:51:53 INFO - 'NO_EM_RESTART': '1', 21:51:53 INFO - 'PAGER': '/bin/cat', 21:51:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:53 INFO - 'PWD': '/builds/slave/test', 21:51:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:53 INFO - 'SHELL': '/bin/bash', 21:51:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsdVVZniEb/Listeners', 21:51:53 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:51:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:53 INFO - 'USER': 'cltbld', 21:51:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:53 INFO - 'XPC_FLAGS': '0x0', 21:51:53 INFO - 'XPC_SERVICE_NAME': '0', 21:51:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:51:53 INFO - Cleaning up... 21:51:53 INFO - Return code: 0 21:51:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963579b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.5Ko7TlTT1R/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.GsdVVZniEb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:51:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:51:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Ko7TlTT1R/Render', 21:51:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:53 INFO - 'HOME': '/Users/cltbld', 21:51:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:53 INFO - 'LOGNAME': 'cltbld', 21:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:53 INFO - 'MOZ_NO_REMOTE': '1', 21:51:53 INFO - 'NO_EM_RESTART': '1', 21:51:53 INFO - 'PAGER': '/bin/cat', 21:51:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:53 INFO - 'PWD': '/builds/slave/test', 21:51:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:53 INFO - 'SHELL': '/bin/bash', 21:51:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsdVVZniEb/Listeners', 21:51:53 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:51:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:53 INFO - 'USER': 'cltbld', 21:51:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:53 INFO - 'XPC_FLAGS': '0x0', 21:51:53 INFO - 'XPC_SERVICE_NAME': '0', 21:51:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:53 INFO - Downloading/unpacking blobuploader==1.2.4 21:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:56 INFO - Downloading blobuploader-1.2.4.tar.gz 21:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:51:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:51:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:51:57 INFO - Downloading docopt-0.6.1.tar.gz 21:51:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:51:57 INFO - Installing collected packages: blobuploader, requests, docopt 21:51:57 INFO - Running setup.py install for blobuploader 21:51:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:51:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:51:57 INFO - Running setup.py install for requests 21:51:58 INFO - Running setup.py install for docopt 21:51:58 INFO - Successfully installed blobuploader requests docopt 21:51:58 INFO - Cleaning up... 21:51:58 INFO - Return code: 0 21:51:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:51:58 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 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963579b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.5Ko7TlTT1R/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.GsdVVZniEb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:51:58 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 21:51:58 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 21:51:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Ko7TlTT1R/Render', 21:51:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:51:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:51:58 INFO - 'HOME': '/Users/cltbld', 21:51:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:51:58 INFO - 'LOGNAME': 'cltbld', 21:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:51:58 INFO - 'MOZ_NO_REMOTE': '1', 21:51:58 INFO - 'NO_EM_RESTART': '1', 21:51:58 INFO - 'PAGER': '/bin/cat', 21:51:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:51:58 INFO - 'PWD': '/builds/slave/test', 21:51:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:51:58 INFO - 'SHELL': '/bin/bash', 21:51:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsdVVZniEb/Listeners', 21:51:58 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:51:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:51:58 INFO - 'USER': 'cltbld', 21:51:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:51:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:51:58 INFO - 'XPC_FLAGS': '0x0', 21:51:58 INFO - 'XPC_SERVICE_NAME': '0', 21:51:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:51:58 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-d4CpdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:51:58 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-h8WQLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:51:58 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-tPC0OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:51:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:51:58 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-1QhVYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:51:59 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-QSBd4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:51:59 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-aCF2Db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:51:59 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-vZo9rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:51:59 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-wJ1btR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:51:59 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-_zRYjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:51:59 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-ZmiyHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:51:59 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-inO8cR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:51:59 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-Y9Sm5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:51:59 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-hc5rBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:51:59 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-zWsCqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:52:00 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-DAyCQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:52:00 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-TqX7SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:52:00 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-2Lci92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:52:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:52:00 INFO - Running setup.py install for manifestparser 21:52:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:52:00 INFO - Running setup.py install for mozcrash 21:52:00 INFO - Running setup.py install for mozdebug 21:52:00 INFO - Running setup.py install for mozdevice 21:52:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:52:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:52:00 INFO - Running setup.py install for mozfile 21:52:01 INFO - Running setup.py install for mozhttpd 21:52:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:52:01 INFO - Running setup.py install for mozinfo 21:52:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:52:01 INFO - Running setup.py install for mozInstall 21:52:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:52:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:52:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:52:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:52:01 INFO - Running setup.py install for mozleak 21:52:01 INFO - Running setup.py install for mozlog 21:52:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:52:01 INFO - Running setup.py install for moznetwork 21:52:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:52:01 INFO - Running setup.py install for mozprocess 21:52:02 INFO - Running setup.py install for mozprofile 21:52:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:52:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:52:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:52:02 INFO - Running setup.py install for mozrunner 21:52:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:52:02 INFO - Running setup.py install for mozscreenshot 21:52:02 INFO - Running setup.py install for moztest 21:52:02 INFO - Running setup.py install for mozversion 21:52:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:52:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:52:02 INFO - Cleaning up... 21:52:02 INFO - Return code: 0 21:52:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:52: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')]} 21:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52: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')]} 21:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:02 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 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963579b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.5Ko7TlTT1R/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.GsdVVZniEb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:52:02 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 21:52:02 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 21:52:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Ko7TlTT1R/Render', 21:52:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:52:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:52:02 INFO - 'HOME': '/Users/cltbld', 21:52:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:52:02 INFO - 'LOGNAME': 'cltbld', 21:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:02 INFO - 'MOZ_NO_REMOTE': '1', 21:52:02 INFO - 'NO_EM_RESTART': '1', 21:52:02 INFO - 'PAGER': '/bin/cat', 21:52:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:52:02 INFO - 'PWD': '/builds/slave/test', 21:52:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:52:02 INFO - 'SHELL': '/bin/bash', 21:52:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsdVVZniEb/Listeners', 21:52:02 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:52:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:52:02 INFO - 'USER': 'cltbld', 21:52:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:52:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:02 INFO - 'XPC_FLAGS': '0x0', 21:52:02 INFO - 'XPC_SERVICE_NAME': '0', 21:52:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:52:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-TtYbu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:52:03 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)) 21:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:52:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-dkyRyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:52:03 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)) 21:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:52:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-TclaG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:52:03 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)) 21:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:52:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-9Gd9gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:52:03 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)) 21:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:52:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-7xTWH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:52:03 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)) 21:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:52:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-HLqUPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:52:03 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)) 21:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:52:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-fbWkpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:52:03 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)) 21:52:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:52:03 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-GRkSGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:52:04 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)) 21:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:52:04 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-vuoMNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:52:04 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)) 21:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:52:04 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-u73yDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:52:04 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)) 21:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:52:04 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-HQsKDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:52:04 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)) 21:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:52:04 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-SBLO8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:52:04 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)) 21:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:52:04 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-xtJraC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:52:04 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)) 21:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:52:04 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-Xb7Kfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:52:04 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)) 21:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:52:04 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-pz_JTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:52:04 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)) 21:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:52:04 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-WLu2x6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:52:04 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)) 21:52:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:52:04 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-uk0_kU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:52:05 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)) 21:52:05 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)) 21:52:05 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)) 21:52:05 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)) 21:52:05 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)) 21:52:05 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)) 21:52:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:52:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:52:07 INFO - Downloading blessings-1.6.tar.gz 21:52:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:52:08 INFO - Installing collected packages: blessings 21:52:08 INFO - Running setup.py install for blessings 21:52:08 INFO - Successfully installed blessings 21:52:08 INFO - Cleaning up... 21:52:08 INFO - Return code: 0 21:52:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:52:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:52:08 INFO - Reading from file tmpfile_stdout 21:52:08 INFO - Current package versions: 21:52:08 INFO - blessings == 1.6 21:52:08 INFO - blobuploader == 1.2.4 21:52:08 INFO - docopt == 0.6.1 21:52:08 INFO - functools32 == 3.2.3-2 21:52:08 INFO - jsonschema == 2.5.1 21:52:08 INFO - manifestparser == 1.1 21:52:08 INFO - mozInstall == 1.12 21:52:08 INFO - mozcrash == 0.17 21:52:08 INFO - mozdebug == 0.1 21:52:08 INFO - mozdevice == 0.48 21:52:08 INFO - mozfile == 1.2 21:52:08 INFO - mozhttpd == 0.7 21:52:08 INFO - mozinfo == 0.9 21:52:08 INFO - mozleak == 0.1 21:52:08 INFO - mozlog == 3.4 21:52:08 INFO - moznetwork == 0.27 21:52:08 INFO - mozprocess == 0.23 21:52:08 INFO - mozprofile == 0.28 21:52:08 INFO - mozrunner == 6.12 21:52:08 INFO - mozscreenshot == 0.1 21:52:08 INFO - mozsystemmonitor == 0.3 21:52:08 INFO - moztest == 0.7 21:52:08 INFO - mozversion == 1.4 21:52:08 INFO - psutil == 3.1.1 21:52:08 INFO - requests == 1.2.3 21:52:08 INFO - wsgiref == 0.1.2 21:52:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:08 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 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963579b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.5Ko7TlTT1R/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.GsdVVZniEb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:52:08 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 21:52:08 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 21:52:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Ko7TlTT1R/Render', 21:52:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:52:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:52:08 INFO - 'HOME': '/Users/cltbld', 21:52:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:52:08 INFO - 'LOGNAME': 'cltbld', 21:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:08 INFO - 'MOZ_NO_REMOTE': '1', 21:52:08 INFO - 'NO_EM_RESTART': '1', 21:52:08 INFO - 'PAGER': '/bin/cat', 21:52:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:52:08 INFO - 'PWD': '/builds/slave/test', 21:52:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:52:08 INFO - 'SHELL': '/bin/bash', 21:52:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsdVVZniEb/Listeners', 21:52:08 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:52:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:52:08 INFO - 'USER': 'cltbld', 21:52:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:52:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:08 INFO - 'XPC_FLAGS': '0x0', 21:52:08 INFO - 'XPC_SERVICE_NAME': '0', 21:52:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:08 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)) 21:52:08 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)) 21:52:08 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)) 21:52:08 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)) 21:52:08 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)) 21:52:08 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)) 21:52:08 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)) 21:52:08 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)) 21:52:08 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)) 21:52:08 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)) 21:52:08 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)) 21:52:08 INFO - Cleaning up... 21:52:08 INFO - Return code: 0 21:52:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:52:08 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 0x11067a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105f0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8963579b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11048ed30>, '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 0x1102f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, '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.5Ko7TlTT1R/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.GsdVVZniEb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 21:52:08 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 21:52:08 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 21:52:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Ko7TlTT1R/Render', 21:52:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:52:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:52:08 INFO - 'HOME': '/Users/cltbld', 21:52:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:52:08 INFO - 'LOGNAME': 'cltbld', 21:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:08 INFO - 'MOZ_NO_REMOTE': '1', 21:52:08 INFO - 'NO_EM_RESTART': '1', 21:52:08 INFO - 'PAGER': '/bin/cat', 21:52:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:52:08 INFO - 'PWD': '/builds/slave/test', 21:52:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:52:08 INFO - 'SHELL': '/bin/bash', 21:52:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsdVVZniEb/Listeners', 21:52:08 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:52:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:52:08 INFO - 'USER': 'cltbld', 21:52:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:52:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:08 INFO - 'XPC_FLAGS': '0x0', 21:52:08 INFO - 'XPC_SERVICE_NAME': '0', 21:52:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:52:09 INFO - Cleaning up... 21:52:09 INFO - Return code: 0 21:52:09 INFO - Running post-action listener: _resource_record_post_action 21:52:09 INFO - Running post-action listener: _start_resource_monitoring 21:52:09 INFO - Starting resource monitoring. 21:52:09 INFO - [mozharness: 2016-11-14 05:52:09.191153Z] Finished create-virtualenv step (success) 21:52:09 INFO - [mozharness: 2016-11-14 05:52:09.192107Z] Running install step. 21:52:09 INFO - Running pre-action listener: _resource_record_pre_action 21:52:09 INFO - Running main action method: install 21:52:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:52:09 INFO - Reading from file tmpfile_stdout 21:52:09 INFO - Detecting whether we're running mozinstall >=1.0... 21:52:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:52:09 INFO - Reading from file tmpfile_stdout 21:52:09 INFO - Output received: 21:52:09 INFO - Usage: mozinstall [options] installer 21:52:09 INFO - Options: 21:52:09 INFO - -h, --help show this help message and exit 21:52:09 INFO - -d DEST, --destination=DEST 21:52:09 INFO - Directory to install application into. [default: 21:52:09 INFO - "/builds/slave/test"] 21:52:09 INFO - --app=APP Application being installed. [default: firefox] 21:52:09 INFO - mkdir: /builds/slave/test/build/application 21:52:09 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'] 21:52:09 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 21:52:41 INFO - Reading from file tmpfile_stdout 21:52:41 INFO - Output received: 21:52:41 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 21:52:41 INFO - Running post-action listener: _resource_record_post_action 21:52:41 INFO - [mozharness: 2016-11-14 05:52:41.863193Z] Finished install step (success) 21:52:41 INFO - [mozharness: 2016-11-14 05:52:41.863333Z] Running run-tests step. 21:52:41 INFO - Running pre-action listener: _resource_record_pre_action 21:52:41 INFO - Running main action method: run_tests 21:52:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:52:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:52:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:52:41 INFO - 2016-11-13 21:52:41.877 screenresolution[1645:7532] starting screenresolution argv=screenresolution get 21:52:41 INFO - 2016-11-13 21:52:41.880 screenresolution[1645:7532] Display 0: 1600x1200x32@60 21:52:41 INFO - 2016-11-13 21:52:41.886 screenresolution[1646:7534] starting screenresolution argv=screenresolution list 21:52:41 INFO - Available Modes on Display 0 21:52:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:52:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:52:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:52:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:52:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:52:42 INFO - Intel Iris: 21:52:42 INFO - Chipset Model: Intel Iris 21:52:42 INFO - Type: GPU 21:52:42 INFO - Bus: Built-In 21:52:42 INFO - VRAM (Dynamic, Max): 1536 MB 21:52:42 INFO - Vendor: Intel (0x8086) 21:52:42 INFO - Device ID: 0x0a2e 21:52:42 INFO - Revision ID: 0x0009 21:52:42 INFO - Displays: 21:52:42 INFO - Display: 21:52:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:52:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:52:42 INFO - Display Serial Number: 1600x1200 60 21:52:42 INFO - Main Display: Yes 21:52:42 INFO - Mirror: Off 21:52:42 INFO - Online: Yes 21:52:42 INFO - Rotation: Supported 21:52:42 INFO - Return code: 0 21:52:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:52:42 INFO - Python 2.7.3 21:52:42 INFO - Return code: 0 21:52:42 INFO - grabbing minidump binary from tooltool 21:52:42 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')]} 21:52:42 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 0x11048ed30>, '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 0x1102f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110486b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:52:42 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 21:52:42 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 21:52:42 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 21:52:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:52:42 INFO - Return code: 0 21:52:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:52:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:52:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:52:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:52:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:52:42 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/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--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 21:52:42 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/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0273 --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 21:52:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5Ko7TlTT1R/Render', 21:52:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:52:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:52:42 INFO - 'HOME': '/Users/cltbld', 21:52:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:52:42 INFO - 'LOGNAME': 'cltbld', 21:52:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:52:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:52:42 INFO - 'MOZ_NO_REMOTE': '1', 21:52:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:52:42 INFO - 'NO_EM_RESTART': '1', 21:52:42 INFO - 'PAGER': '/bin/cat', 21:52:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:52:42 INFO - 'PWD': '/builds/slave/test', 21:52:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:52:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:52:42 INFO - 'SHELL': '/bin/bash', 21:52:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GsdVVZniEb/Listeners', 21:52:42 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 21:52:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:52:42 INFO - 'USER': 'cltbld', 21:52:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:52:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:52:42 INFO - 'XPC_FLAGS': '0x0', 21:52:42 INFO - 'XPC_SERVICE_NAME': '0', 21:52:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:52:42 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/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--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 21:52:42 INFO - mozversion application_buildid: 20161113194020 21:52:42 INFO - mozversion application_changeset: 4e97dee28c6941a78f5ec342fbe95ce5e6a012b1 21:52:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:52:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:52:42 INFO - mozversion application_name: Firefox 21:52:42 INFO - mozversion application_remotingname: firefox-dev 21:52:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:52:42 INFO - mozversion application_vendor: Mozilla 21:52:42 INFO - mozversion application_version: 51.0a2 21:52:42 INFO - mozversion platform_buildid: 20161113194020 21:52:42 INFO - mozversion platform_changeset: 4e97dee28c6941a78f5ec342fbe95ce5e6a012b1 21:52:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:52:42 INFO - mozversion platform_version: 51.0a2 21:52:42 INFO - using testdate: 1479102762 21:52:42 INFO - actual date: 1479102762 21:52:42 INFO - starting webserver on 'localhost:49278' 21:52:42 INFO - SUITE-START | Running 2 tests 21:52:42 INFO - TEST-START | dromaeo_css 21:52:42 INFO - operating with platform_type : mac_ 21:52:42 INFO - Initialising browser for dromaeo_css test... 21:52:42 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpi88M4l/profile http://localhost:49278/getInfo.html) 21:52:45 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 21:52:45 INFO - PROCESS | 1656 | colorDepth:24 21:52:45 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 21:52:45 INFO - PROCESS | 1656 | __metrics 21:52:45 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 21:52:46 INFO - TEST-INFO | 1656: exit 0 21:52:46 INFO - Browser initialized. 21:52:46 INFO - Running cycle 1/1 for dromaeo_css test... 21:52:46 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpi88M4l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:52:58 INFO - PROCESS | 1659 | RSS: Main: 225521664 21:52:58 INFO - PROCESS | 1659 | 21:53:47 INFO - PROCESS | 1659 | 1479102827675 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] 21:56:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 21:56:01 INFO - PROCESS | 1659 | RSS: Main: 237641728 21:56:01 INFO - PROCESS | 1659 | 21:59:04 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 21:59:04 INFO - PROCESS | 1659 | RSS: Main: 248659968 21:59:04 INFO - PROCESS | 1659 | 22:02:06 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 22:02:07 INFO - PROCESS | 1659 | RSS: Main: 251514880 22:02:07 INFO - PROCESS | 1659 | 22:05:09 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 22:05:09 INFO - PROCESS | 1659 | RSS: Main: 251867136 22:05:09 INFO - PROCESS | 1659 | 22:08:12 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 22:08:13 INFO - PROCESS | 1659 | RSS: Main: 256532480 22:08:13 INFO - PROCESS | 1659 | 22:11:15 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 22:11:16 INFO - PROCESS | 1659 | RSS: Main: 258019328 22:11:16 INFO - PROCESS | 1659 | 22:11:16 INFO - PROCESS | 1659 | __start_tp_report 22:11:16 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 22:11:16 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 22:11:16 INFO - PROCESS | 1659 | |i|pagename|runs| 22:11:16 INFO - PROCESS | 1659 | |0;dojo.html;3113.2683819302465;3437.570303712036;3462.878799242027;3482.6169121396642;3497.527833742444;5759.45285197906;5772.711364431777;5852.531797456204;5864.091065884784;5864.706764661761;5805.854853628651;5888.852778680524;5890.941090589093;5908.556858235639;5910.793122240722;5281.577473802096;5399.595030372738;5431.4840090191365;5441.156620723775;5445.646033007862;5395.352557693062;5412.404635490093;5417.052015897222;5440.510354068133;5444.128939369702;5292.285541451894;5296.09966305727;5426.457354264581;5433.891322173554;5471.425500322469;4222.746635201883;4559.612432943204;5374.731263436813;5416.593755468316;5484.643498172606;5242.266082748418;5349.037173308803;5378.542823859977;5386.622936394454;5462.617616766828;5680.091185410356;5868.48362539216;5906.26171728534;5973.701314934279;5978.8505287367725;6069.787557435468;6137.622145771035;6173.074038894157;6248.187735594389;6261.87476250477;5259.631825772198;6251.468625166866;6272.5922815016875;6320.336364681688;6331.2719037310835;6023.548233882477;6036.849078772978;6045.879082418371;6055.7274922628585;6057.7879774207695;6244.438000579969;6288.591241569284;6289.496840252768;6289.55973081889;6292.653904035322;6257.311695713468;6269.467095296951;6274.1843560336865;6277.2781130170615;6279.937200628026;6220.315765265817;6310.905336419957;6329.113924050636;6343.460805831556;6346.873062538723;6121.57491608479;6219.595726277777;6230.158928544589;6247.75008999644;6254.312025677172;6214.627122372672;6239.500839932794;6265.71804268809;6276.6547839869245;6286.214223222098;5019.7490125494305;5049.747512624354;5050.545450909436;5055.51972562606;5063.468335824759;3783.640554147407;4220.388043733703;4447.510773814878;4450.287953927356;4549.545045495424;4847.612191024709;4949.356583644103;5014.774335154927;6055.909161362583;6086.178365920633;6293.653849038347;6324.177856878577;6335.081413195153;6343.651099189497;6354.586951848115;5856.882862342814;5917.822465325961;5949.286085669747;6008.068749343859;6031.336552979169;5499.202615620713;5525.060739674265;5531.032069387841;5539.529140023144;5557.972210139004;6293.716782744787;6350.65071421067;6439.678016099177;6521.608703477807;6529.412352888263;6330.841728956813;6343.0485427186295;6347.333529979285;6347.90478142819;6363.427291543783;5689.288838895138;6296.307406185224;6349.952257877399;6556.147700799056;6567.605943643397;6019.157317975574;6220;6231.906521402092;6251.843703907439;6308.621482711052;6317.684115794284;6350;6351;6359.268684101203;6362.491000720024;6045.395460453919;6169.796889606484;6275.466585340115;6292.339304372975;6300.936990630035;6138.539609529393;6139.26328840542;6165.167702360303;6172.537059720449;6243.656598887105;6018.707601581906;6170.259568851767;6178.41305076017;6195.2255968004;6216.751329946752;6222.937770622236;6254.843628909131;6270.2475702915945;6292.559520833498;6310.905336419865;5904.940950590439;5987;6075.058365953284;6080.90878636812;6099.878002440015 22:11:16 INFO - PROCESS | 1659 | |1;ext.html;477.41755058828227;478.99281510777325;503.9392079672292;532.7975369359644;536.9194620806876;39781.60218397815;41298;41484.792576037114;43428.56571434285;43672.56327436725;43646.127077458514;43930.56069439305;44065.559344406625;44097;44294.335584966255;9867.75330616735;9949.801003979916;10027.89972100277;10075.143612792885;10076.596936122547;9869.555869985832;9996.200303975664;10019.44893030883;10025.44860032698;10043.89956100437;9886.950565247163;10008.549615267331;10038.849417258747;10070.899291007107;10111.443870587114;9969.1526220271;10025.999999999964;10030.949845250727;10044.196464282913;10053.79892402148;9873.963233860484;9957.0540798624;9970.002999699973;9976.600935962553;9992.750181245454;40946.38580421296;41491.7925410374;41908.37137442941;42016.579834201875;42112.78943605293;3373.3590617782543;3391.491276308549;3421.0934102462866;3421.5038819371302;3451.7928924264625;29095;29112.272193195127;29401.41197176066;29798.70201297981;29962.101136965706;3173.1591128350774;3248.1554795753036;3284.211789170582;3337.0155804037868;3353.96646033539;512876;517373;519433;519851.40074299765;520815;59252.40747592555;59289;59468.40531594715;59496;59533.40466595279;34861.65138348635;35298.470522942174;35364.115897102776;36353.81823090868;63399.68300158469;16236.837631623532;16372.181390930406;16412.917935410485;16429.753553696704;16461.83538164627;10470.214733894989;12676.556320528738;12691.428885700165;12725.918296944677;12741.617751467471;19256;19416.315084255286;19466.70799938002;19573.727707698956;19722.30971915976;7556.921846492259;8136.389770767216;8302.335813134934;8353.037036296466;8405.915940840636;890.875277461156;990.6136606723384;1022.0750221049962;1043.5669197283044;1078.7788503356794;21693;22444.438889027904;26719.46561068768;28590.999315023873;28622.425766582623;807.9394045446616;1036.8185567525652;1076.8976947190004;1110.228391268077;1133.8299255111635;12178.147529672839;13624.841888439396;13726.931365343109;14190.716185676436;15574.143422111893;180854;182389;183205;184248.07875960536;184442;55760.72119639376;57449;58225.70887145622;58671.706641467375;60040.399596004354;1355.8440779310308;1360.9183448993092;1379.0553470872485;1386.2098603795941;1386.8266466691664;21882.562348753254;23887.880560597085;29949.550756739103;30945.226369340045;31132.22169445782;50793.746031269606;51190;51445;51534.74232628813;51586.74206628943;611516;615602;616443;619927;621285;26794;26849.86575067112;27007.32481687895;27186.91252349884;27666.446671066064;47709.5229047719;47922.76038619924;48235.517644824504;48430.273545897544;48892.75553622209;39585;39594.45778827608;40041.399379008755;40959.79520102381;41300.38049429321;39700;39736.60263397329;39968.20063598653;40660.3900941492;41068.794656026526;30868.53697194499;32862.671373285964;33470.4979425304;37874.62125378711;39075.80462097671;32668.67331326656;35675.64324356723;36137.63862361448;36254;36271.09322266859;25733.871330643226;26027.869860650575;26260.868695657166;26466.338341541614;26509.469810604067 22:11:16 INFO - PROCESS | 1659 | |2;jquery.html;367.74074277634264;373.7327810615411;375.4537148449007;383.98080095995226;391.49106161989425;15155.696886062273;20555.280565180223;20709.378718638465;21361.145554177834;21424.464388390297;19973.700394494095;20285.290014849485;20531.486712832186;20855.85292808895;20872.269470568495;5336.67979921204;5840.240768700063;5980.491658209057;6021.397860213965;6082.665453400061;5989.191459153024;5999.790007349722;6107.236595425572;6109.694515274241;6114.541409394291;5815.62198457101;6023.879522409549;6136.9079463808075;6162.7534898604;6204.81385558434;5054.848354549369;6113.7860174893885;6189.473894718954;6192;6362;5930.762769489258;5985.610935289193;5987.820365389001;6037.54718396122;6041.093835924603;13138.934305328412;13610.659733506642;13626.93186534061;15846.890717649769;20102.396928092036;2363.2555744940287;2400.4958958618713;2436.4639779248537;2457.69278840145;2692.8788204530842;9506.239500839916;9834.754131146707;10208.693739187836;10375.481225938749;10463.05832475081;1551.5422950229597;1632.8243664561496;1838.7701537307837;1951.063489525036;2001.3995801259564;106054.96900450398;107921;108444;110215;114529;11398.290256461598;11473.885261147449;11518.30890146577;11565.496485456837;11810;13955.581332559836;13980.930095349458;14093.590640936029;14128.434862605587;14129.081609695337;8442.831143377098;8508.617112229964;8622.913770862337;8677.21905028538;8685.565721713889;8694.304455643532;8760.123987601317;8768.868466972874;8857.955710221408;8910.910890891138;4221.303484924953;4363.560025191679;4385.802638881258;4398.274284743045;4475.641948644101;1696.635223426969;1924.509250141205;1945.0760888577813;1953.5506833428392;1965.3416105604497;839.941204115706;863.6890719341033;907.5371560504191;949.8480243161061;967.7483854197959;20716.482087947923;21319;21399.144034238456;21628.67556986615;21644.783552164277;916.4248461822301;942.4580866002076;994.3487016004528;1001.6861050972277;1022.9795404091876;8423.915760842436;8663.653453861902;9458.385204961656;9868.950655246821;11098.001179893687;598943;617831;630497;630980;631939;118348;125304;130872.3456382712;130895.34552327177;145231;930.6975233049286;972.9902700973041;1006.9093781559549;1011.6661501704419;1013.4881884648353;19875.60248794987;20221.090050948038;20239.4940126498;20526.486837829172;20655.690164647243;55933.440665592825;56861;57909;59304.813903720824;61940.76118477695;73788.63105684437;79541.60229198817;82925.9268518292;84409.5779521123;89069;8065.717699880476;8217.630206640835;8233.135520770233;8255.133211012757;8269.46248493846;12506.499740010662;12571;13249.13880597758;13370.465181392636;13775.931120344334;11218.597675290588;11469.713257168638;11535.250208736405;11584.015358694605;11632.651020469399;10116.342437741523;10647.680569582924;11258.718532036764;11346.716332091764;11470.369129697947;5926.792562260473;11171.944140279571;11760.556033047902;11765.235259708092;11791.823122652995;8269.46248493846;8295.95852020736;8350.20673036085;8375.12061233586;8457.196566326189;9380.390274632127;10393.792124157626;10478.63777708893;11325.490352933974;11642.01042911362 22:11:16 INFO - PROCESS | 1659 | |3;mootools.html;1516.742153833848;1550.6278493161642;1742.99777627864;1803.6302557975616;1857.9256829726812;8089.757307280776;8342;8621.870671939925;9192.586333614978;9206.447613143217;8652.783680407993;8924.821503569941;8943.95528022359;8968.955155224216;9035.819283614324;2358.5282943411303;2366.6450032495177;2404.735479097307;2405.1822380390663;2416.8549887006834;2395.8442701224453;2418.8185886058527;2431.768981946721;2438.207582535674;2439.3901524618846;2401.2076014915037;2411.240459255329;2418.8064954803663;2441.645961335605;2443.767842055002;2386.8209884258663;2393.6050551658955;2398.136670798511;2399.4841109161525;2427.490227052321;2369.869657168855;2371.727251366098;2380.297812145404;2386.248331775485;2388.665586817847;9000.369974101815;9055.003949565542;9061.275097992146;9067.229285510673;9077.68228112013;5361.329833770778;5421.512063914227;5511.5039646432015;5514.751836167382;5515.944840551583;3641.799701016443;3650.1604630934767;3668.779873207616;3682.4660424238605;3714.851405943759;1092.8743194532651;1101.0860985382114;1101.091599430473;1118.0775859915602;1125.3697929159614;11609.361485118316;11866.991305738937;11922.344271065089;11960.940195298968;11969.521219151224;4721.126591580569;4752.6696943660245;4784.976075119672;4857.222844344888;4917.606591472745;10043.995600439897;10138.23963202748;10154.492275386348;10174.643887463903;10186.08325250731;4605.424321959755;5419.132938729785;5423.105187643994;5434.293541839615;5451.64564303319;4440.600345968878;4582.106489234568;4757.191277482836;4907.6564640475535;4958.256261560795;3959.3862951242604;4022.4770779798437;4058.8579399721457;4080.2451546464;4091.5908409158847;1118.4631376939114;1289.9935500322438;1331.1613683379603;1342.1074985134971;1345.5156143788229;773.7291947818219;887.1616322575234;910.6721580231111;911.9726408207764;918.2745630951607;5715.342735585461;5977.3126090500145;6036.456718895321;6105.542084343603;6362.809115726535;841.5287439034038;934.3412893909777;973.2603221551531;977.6871401151564;983.4296108257194;3794.2221844521805;3941.0541470046983;3953.4267531207815;3958.4062390641056;4075.1238483726142;9282.860757088649;10422.635207767691;10988.395638239974;11029.669109926715;11034;9307.488088155216;10280.485975701185;10967.067799237155;10970.725731856608;10975.780484390267;8208.09710931797;8384.329253659693;8411.70559030431;8424.83150337002;8424.957875210708;4337.1976184405985;5834.679092649945;5856.677882716321;5879.382664820303;5901.104530015275;10088.69733907984;10091.949540252252;10112.949435252776;10225.9488702559;10289.176865850864;9540.85688714656;10299.588016479556;10476.790464190826;10540.420276884844;10604;7104.502684812013;7306.890396643948;7512.924870751222;7516.774496765106;7703.8074048147;8424.915750842412;8427.83144337122;8442.240198382175;8593.742187734379;8602.39783215169;7449.851002980018;7450.552966822008;7567.810804729926;7612.3148916597775;7666.731664391719;6398.5521013528605;7346.33882950537;7515.398768098648;7541.698332066656;7643.235676432312;7047.541909775849;7051.083359163276;7114.683783500069;7136.250693677297;7137.250588688113;4926.162552366035;4931.309616653743;5028;5053.7473126344275;5091.9490805092955;4228.344606585984;4932.506749325183;4943.65394422387;4954.306397104337;5137.794488220578 22:11:16 INFO - PROCESS | 1659 | |4;prototype.html;269.58214767110985;298.28411811652035;307.48342784122667;309.8977337478631;311.87057371190957;5505.29335905869;5567.3040869891265;5584.301962254718;5585.547757583027;5604.663720176787;5455.2815863003225;5468.945310546894;5486.8203336282695;5554.222408862763;5555.472230138131;3265.3632541654447;4102.353981681814;4129.421880936671;4185.707000509966;4189.183109293689;4147.854825081123;4152.584741525853;4159.9376009359885;4197.958020419787;4244.660427165834;3259.315543735818;4156.97921510392;4159.272127377697;4186.42534841072;4217.346311321735;4060.7360521566;4091.4272001919753;4124.628783409477;4149.356849688304;4193.385546564564;3177.855971850132;3467.739919506047;3587.7488575799703;3594.730395220369;3656.3491468684992;4375.956240437618;5277.656952298088;5300.655457395257;5301.575873930076;5330.840074797762;4181.6236538711355;4423.137488189805;4584.426946631671;4755.690880092783;4873.244647079709;5015.871428928498;5047.369078865142;5122.513361230677;5466.262054622614;5668.433156684298;3229.337985712923;3297.4888892221743;3739.2334571413066;4009.919801603981;4025.3156963316305;5264.131048578534;5322.92015619766;5706;5997.530605001759;6143.754249830046;3214.6624604416666;3886.242182774332;3941.842326306973;3942.5466071402157;3954.3870700040966;3948.58539853317;3952.960470395317;3968.1666849961252;3987.670295303454;4036.414719865603;4657.208274593328;4675.95324046762;4677.719336839732;4678.742669153229;4691.3432119503295;4817.421909370828;5418.241446197536;5812.941870581325;5828.930729591019;5850.385709500526;1167.1129941244546;1339.5666636698834;1371.1704418826666;1371.7736573465265;1376.9793453098011;785.3991696352296;801.9679212831538;828.0394742099136;839.7942504086537;844.8437039147777;4674.158651442705;4824.831130910401;5459.344878614592;5503.330884521004;5515.758954235345;4868.318435419044;5364.436734142859;5555.777728899636;6146.815595532141;6192.256929168439;4047.741568037758;5437.945620543823;5515.641483303572;5544.500994910478;5576.386597474275;2390.7250666173613;3144.484412470015;3155.9269848251706;3195.984020079885;3202.9359412811614;5412.972935135378;5795.39148389413;6100.071965456517;6114.667506209126;6364.886144924712;5383.78464861409;5898.410158984153;5939.020061689859;6060.727267272983;6145.293291271471;5334.413214546396;6301.369863013662;6314.463270621956;6351.5871468355335;6354.777582784765;5772.855678608068;5848.912266315923;6084.448465641233;6085.391460853879;6097.176881120992;5055.7219352935945;5866.927729799808;5947.464728174485;5960.940390596212;6041.365656606169;5181.5077567631015;5908.2275317405465;5960.433758792908;6101.288582559149;6258.092576576462;3973.523177218752;4033.495813023372;4056;4089.26393249218;4091.5703851095204;5257.502686224013;5868.738221282445;5960.509872531867;6055.182550355646;6060.212172417558;5547.278853748987;5664.518515926027;5837.591368604327;5880.059970014992;5915.733791979457;4736.342280201902;5452.863678408072;5764.308283005898;5787.594868359174;5905.320888097924;5220.504052115043;5701.258836351248;5715.514181294637;5766.365699773106;5771.538276937918;4459.197344478025;5457.107732901569;5731.19763233156;5735.541156707537;5782.335031471434;4768.403949506312;5432.266644003167;5608.42963970089;5697.524510048784;5714.971305165111 22:11:16 INFO - PROCESS | 1659 | |5;yui.html;618.9164462797522;686.9690863911123;694.2848865668361;710.4458522352567;758.9392848572115;12248.02015838733;13951.720965580682;16128.193590320496;16148.919255403722;16201.513954581367;12634.936825315861;14110.365033573487;14655.560333190022;14659.267036648178;14699.044562103456;658.2265837640776;685.1504134872747;821.0844907927648;826.7313123234927;852.1648784191497;817.7669364231195;854.7393045121236;858.9699360522383;859.0078459379396;865.3380164174412;908.1055160666738;912.6486302773446;915.5696822493418;915.6703586708779;916.4363916191561;647.3106141958799;695.3637421759084;747.6355650937035;891.0332289465937;906.3247880329164;635.9046143078575;666.3736088077192;667.3226674924955;669.768929719251;672.2571558427965;15074.09555426678;15173.772393414107;15193.848061519353;15214.467493637669;15249.008814427027;11589.36258505782;14755.77866332006;14780.926095369454;14936;15028.699426011528;10965.122790176767;11544.480498377508;11568.363739994296;12030.63908082759;12157.878421215763;3866.3040652682507;3872.3610604250266;3902;4002.139539998885;4025.63769260765;100285.4985725074;125641;127111;128444.71555284421;134746;10611.946940265248;10901.563937442572;10985.890141098487;11178.608748693756;11358.920902514248;21239.78760212409;21277.46806329854;21441.249556265768;21470.57058858814;21511.247106351202;8002.279794818378;8118.675252989932;8290.378221633402;8381.203785640355;8509.361797865186;3698.5561732591723;4062.654674352654;4582.1293954148605;4585.380973568593;4615.815367385267;3654.2326111516877;3782;3791.976166435047;3795.8291876865605;3801.752886062397;665.7703092433103;681.7273090763636;681.7954613615896;682.1405029662661;691.1982100763191;584.4739734239133;650.9023646452976;661.8809109780113;668.1114118222752;684.6200358800813;7662.693492260359;8220.260176584135;8613.440126391764;9589.664361747306;9613.807723845484;614.7418084404561;627.9497640188865;668.7796515568267;676.0839063069568;688.9207741109736;4316.41015390763;4458.197524445566;4669.089527542164;4674.6026587740425;4684.672072954861;127698.36150819187;132646.33676831555;140406;146311;168310;102698.43253918563;122245;126978.09532857014;136230;136265.318673406;86764;111032.4448377753;112900.87826858464;118341.40829295799;118725.8127418732;9750.902490974999;10250.846237306298;10273.02406271403;10283.280170388001;10326.173906087644;60184.69907650609;60195;61710;63174.05238921512;63225.36774632195;73276;87254.5637271835;97863.51068244613;99661.50507742245;100020.49989750005;12914.612561623166;13200.801987969997;13422.664433389244;13484;13723.656908576966;14325.78511322352;14951.850481495047;15420.691586168437;15774.05355678663;15867.920660396625;11549.307041577533;13197.076204665582;13936.442542298195;14170.149791012573;14207.431702731776;12983;13914.582562523141;14233.288335583387;14471.565853024425;14778.63053423673;13154;13462.124961877447;14123;14165.575032749033;14579.854201458274;11081.27971681838;11211.66365009051;11651.359175245443;11806.232594881305;12183.756324873275;9823.705288841345;9976.957028106497;10415.84376234342;11030.834537481784;11835.11236657237 22:11:16 INFO - PROCESS | 1659 | __end_tp_report 22:11:16 INFO - PROCESS | 1659 | __start_cc_report 22:11:16 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,374 22:11:16 INFO - PROCESS | 1659 | __end_cc_report 22:11:16 INFO - PROCESS | 1659 | __startTimestamp1479103876062__endTimestamp 22:11:16 INFO - PROCESS | 1659 | 22:11:16 INFO - PROCESS | 1659 | ------- Summary: start ------- 22:11:16 INFO - PROCESS | 1659 | Number of tests: 6 22:11:16 INFO - PROCESS | 1659 | 22:11:16 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5824.69 Median:6075.06 stddev:675.50 (11.1%) stddev-sans-first:643.22 22:11:16 INFO - PROCESS | 1659 | Values: 3113.3 3437.6 3462.9 3482.6 3497.5 5759.5 5772.7 5852.5 5864.1 5864.7 5805.9 5888.9 5890.9 5908.6 5910.8 5281.6 5399.6 5431.5 5441.2 5445.6 5395.4 5412.4 5417.1 5440.5 5444.1 5292.3 5296.1 5426.5 5433.9 5471.4 4222.7 4559.6 5374.7 5416.6 5484.6 5242.3 5349.0 5378.5 5386.6 5462.6 5680.1 5868.5 5906.3 5973.7 5978.9 6069.8 6137.6 6173.1 6248.2 6261.9 5259.6 6251.5 6272.6 6320.3 6331.3 6023.5 6036.8 6045.9 6055.7 6057.8 6244.4 6288.6 6289.5 6289.6 6292.7 6257.3 6269.5 6274.2 6277.3 6279.9 6220.3 6310.9 6329.1 6343.5 6346.9 6121.6 6219.6 6230.2 6247.8 6254.3 6214.6 6239.5 6265.7 6276.7 6286.2 5019.7 5049.7 5050.5 5055.5 5063.5 3783.6 4220.4 4447.5 4450.3 4549.5 4847.6 4949.4 5014.8 6055.9 6086.2 6293.7 6324.2 6335.1 6343.7 6354.6 5856.9 5917.8 5949.3 6008.1 6031.3 5499.2 5525.1 5531.0 5539.5 5558.0 6293.7 6350.7 6439.7 6521.6 6529.4 6330.8 6343.0 6347.3 6347.9 6363.4 5689.3 6296.3 6350.0 6556.1 6567.6 6019.2 6220.0 6231.9 6251.8 6308.6 6317.7 6350.0 6351.0 6359.3 6362.5 6045.4 6169.8 6275.5 6292.3 6300.9 6138.5 6139.3 6165.2 6172.5 6243.7 6018.7 6170.3 6178.4 6195.2 6216.8 6222.9 6254.8 6270.2 6292.6 6310.9 5904.9 5987.0 6075.1 6080.9 6099.9 22:11:16 INFO - PROCESS | 1659 | 22:11:16 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:58921.49 Median:35080.06 stddev:128126.62 (365.2%) stddev-sans-first:128410.91 22:11:16 INFO - PROCESS | 1659 | Values: 477.4 479.0 503.9 532.8 536.9 39781.6 41298.0 41484.8 43428.6 43672.6 43646.1 43930.6 44065.6 44097.0 44294.3 9867.8 9949.8 10027.9 10075.1 10076.6 9869.6 9996.2 10019.4 10025.4 10043.9 9887.0 10008.5 10038.8 10070.9 10111.4 9969.2 10026.0 10030.9 10044.2 10053.8 9874.0 9957.1 9970.0 9976.6 9992.8 40946.4 41491.8 41908.4 42016.6 42112.8 3373.4 3391.5 3421.1 3421.5 3451.8 29095.0 29112.3 29401.4 29798.7 29962.1 3173.2 3248.2 3284.2 3337.0 3354.0 512876.0 517373.0 519433.0 519851.4 520815.0 59252.4 59289.0 59468.4 59496.0 59533.4 34861.7 35298.5 35364.1 36353.8 63399.7 16236.8 16372.2 16412.9 16429.8 16461.8 10470.2 12676.6 12691.4 12725.9 12741.6 19256.0 19416.3 19466.7 19573.7 19722.3 7556.9 8136.4 8302.3 8353.0 8405.9 890.9 990.6 1022.1 1043.6 1078.8 21693.0 22444.4 26719.5 28591.0 28622.4 807.9 1036.8 1076.9 1110.2 1133.8 12178.1 13624.8 13726.9 14190.7 15574.1 180854.0 182389.0 183205.0 184248.1 184442.0 55760.7 57449.0 58225.7 58671.7 60040.4 1355.8 1360.9 1379.1 1386.2 1386.8 21882.6 23887.9 29949.6 30945.2 31132.2 50793.7 51190.0 51445.0 51534.7 51586.7 611516.0 615602.0 616443.0 619927.0 621285.0 26794.0 26849.9 27007.3 27186.9 27666.4 47709.5 47922.8 48235.5 48430.3 48892.8 39585.0 39594.5 40041.4 40959.8 41300.4 39700.0 39736.6 39968.2 40660.4 41068.8 30868.5 32862.7 33470.5 37874.6 39075.8 32668.7 35675.6 36137.6 36254.0 36271.1 25733.9 26027.9 26260.9 26466.3 26509.5 22:11:16 INFO - PROCESS | 1659 | 22:11:16 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:35520.78 Median:2575.29 stddev:103625.38 (4023.8%) stddev-sans-first:103882.46 22:11:16 INFO - PROCESS | 1659 | Values: 367.7 373.7 375.5 384.0 391.5 15155.7 20555.3 20709.4 21361.1 21424.5 19973.7 20285.3 20531.5 20855.9 20872.3 5336.7 5840.2 5980.5 6021.4 6082.7 5989.2 5999.8 6107.2 6109.7 6114.5 5815.6 6023.9 6136.9 6162.8 6204.8 5054.8 6113.8 6189.5 6192.0 6362.0 5930.8 5985.6 5987.8 6037.5 6041.1 13138.9 13610.7 13626.9 15846.9 20102.4 2363.3 2400.5 2436.5 2457.7 2692.9 9506.2 9834.8 10208.7 10375.5 10463.1 1551.5 1632.8 1838.8 1951.1 2001.4 106055.0 107921.0 108444.0 110215.0 114529.0 11398.3 11473.9 11518.3 11565.5 11810.0 13955.6 13980.9 14093.6 14128.4 14129.1 8442.8 8508.6 8622.9 8677.2 8685.6 8694.3 8760.1 8768.9 8858.0 8910.9 4221.3 4363.6 4385.8 4398.3 4475.6 1696.6 1924.5 1945.1 1953.6 1965.3 839.9 863.7 907.5 949.8 967.7 20716.5 21319.0 21399.1 21628.7 21644.8 916.4 942.5 994.3 1001.7 1023.0 8423.9 8663.7 9458.4 9869.0 11098.0 598943.0 617831.0 630497.0 630980.0 631939.0 118348.0 125304.0 130872.3 130895.3 145231.0 930.7 973.0 1006.9 1011.7 1013.5 19875.6 20221.1 20239.5 20526.5 20655.7 55933.4 56861.0 57909.0 59304.8 61940.8 73788.6 79541.6 82925.9 84409.6 89069.0 8065.7 8217.6 8233.1 8255.1 8269.5 12506.5 12571.0 13249.1 13370.5 13775.9 11218.6 11469.7 11535.3 11584.0 11632.7 10116.3 10647.7 11258.7 11346.7 11470.4 5926.8 11171.9 11760.6 11765.2 11791.8 8269.5 8296.0 8350.2 8375.1 8457.2 9380.4 10393.8 10478.6 11325.5 11642.0 22:11:16 INFO - PROCESS | 1659 | 22:11:16 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5769.31 Median:4821.10 stddev:3231.35 (67.0%) stddev-sans-first:3224.62 22:11:16 INFO - PROCESS | 1659 | Values: 1516.7 1550.6 1743.0 1803.6 1857.9 8089.8 8342.0 8621.9 9192.6 9206.4 8652.8 8924.8 8944.0 8969.0 9035.8 2358.5 2366.6 2404.7 2405.2 2416.9 2395.8 2418.8 2431.8 2438.2 2439.4 2401.2 2411.2 2418.8 2441.6 2443.8 2386.8 2393.6 2398.1 2399.5 2427.5 2369.9 2371.7 2380.3 2386.2 2388.7 9000.4 9055.0 9061.3 9067.2 9077.7 5361.3 5421.5 5511.5 5514.8 5515.9 3641.8 3650.2 3668.8 3682.5 3714.9 1092.9 1101.1 1101.1 1118.1 1125.4 11609.4 11867.0 11922.3 11960.9 11969.5 4721.1 4752.7 4785.0 4857.2 4917.6 10044.0 10138.2 10154.5 10174.6 10186.1 4605.4 5419.1 5423.1 5434.3 5451.6 4440.6 4582.1 4757.2 4907.7 4958.3 3959.4 4022.5 4058.9 4080.2 4091.6 1118.5 1290.0 1331.2 1342.1 1345.5 773.7 887.2 910.7 912.0 918.3 5715.3 5977.3 6036.5 6105.5 6362.8 841.5 934.3 973.3 977.7 983.4 3794.2 3941.1 3953.4 3958.4 4075.1 9282.9 10422.6 10988.4 11029.7 11034.0 9307.5 10280.5 10967.1 10970.7 10975.8 8208.1 8384.3 8411.7 8424.8 8425.0 4337.2 5834.7 5856.7 5879.4 5901.1 10088.7 10091.9 10112.9 10225.9 10289.2 9540.9 10299.6 10476.8 10540.4 10604.0 7104.5 7306.9 7512.9 7516.8 7703.8 8424.9 8427.8 8442.2 8593.7 8602.4 7449.9 7450.6 7567.8 7612.3 7666.7 6398.6 7346.3 7515.4 7541.7 7643.2 7047.5 7051.1 7114.7 7136.3 7137.3 4926.2 4931.3 5028.0 5053.7 5091.9 4228.3 4932.5 4943.7 4954.3 5137.8 22:11:16 INFO - PROCESS | 1659 | 22:11:16 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4665.07 Median:5326.88 stddev:1466.90 (27.5%) stddev-sans-first:1433.43 22:11:16 INFO - PROCESS | 1659 | Values: 269.6 298.3 307.5 309.9 311.9 5505.3 5567.3 5584.3 5585.5 5604.7 5455.3 5468.9 5486.8 5554.2 5555.5 3265.4 4102.4 4129.4 4185.7 4189.2 4147.9 4152.6 4159.9 4198.0 4244.7 3259.3 4157.0 4159.3 4186.4 4217.3 4060.7 4091.4 4124.6 4149.4 4193.4 3177.9 3467.7 3587.7 3594.7 3656.3 4376.0 5277.7 5300.7 5301.6 5330.8 4181.6 4423.1 4584.4 4755.7 4873.2 5015.9 5047.4 5122.5 5466.3 5668.4 3229.3 3297.5 3739.2 4009.9 4025.3 5264.1 5322.9 5706.0 5997.5 6143.8 3214.7 3886.2 3941.8 3942.5 3954.4 3948.6 3953.0 3968.2 3987.7 4036.4 4657.2 4676.0 4677.7 4678.7 4691.3 4817.4 5418.2 5812.9 5828.9 5850.4 1167.1 1339.6 1371.2 1371.8 1377.0 785.4 802.0 828.0 839.8 844.8 4674.2 4824.8 5459.3 5503.3 5515.8 4868.3 5364.4 5555.8 6146.8 6192.3 4047.7 5437.9 5515.6 5544.5 5576.4 2390.7 3144.5 3155.9 3196.0 3202.9 5413.0 5795.4 6100.1 6114.7 6364.9 5383.8 5898.4 5939.0 6060.7 6145.3 5334.4 6301.4 6314.5 6351.6 6354.8 5772.9 5848.9 6084.4 6085.4 6097.2 5055.7 5866.9 5947.5 5960.9 6041.4 5181.5 5908.2 5960.4 6101.3 6258.1 3973.5 4033.5 4056.0 4089.3 4091.6 5257.5 5868.7 5960.5 6055.2 6060.2 5547.3 5664.5 5837.6 5880.1 5915.7 4736.3 5452.9 5764.3 5787.6 5905.3 5220.5 5701.3 5715.5 5766.4 5771.5 4459.2 5457.1 5731.2 5735.5 5782.3 4768.4 5432.3 5608.4 5697.5 5715.0 22:11:16 INFO - PROCESS | 1659 | 22:11:16 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:24978.03 Median:21490.91 stddev:39855.89 (185.5%) stddev-sans-first:39925.73 22:11:16 INFO - PROCESS | 1659 | Values: 618.9 687.0 694.3 710.4 758.9 12248.0 13951.7 16128.2 16148.9 16201.5 12634.9 14110.4 14655.6 14659.3 14699.0 658.2 685.2 821.1 826.7 852.2 817.8 854.7 859.0 859.0 865.3 908.1 912.6 915.6 915.7 916.4 647.3 695.4 747.6 891.0 906.3 635.9 666.4 667.3 669.8 672.3 15074.1 15173.8 15193.8 15214.5 15249.0 11589.4 14755.8 14780.9 14936.0 15028.7 10965.1 11544.5 11568.4 12030.6 12157.9 3866.3 3872.4 3902.0 4002.1 4025.6 100285.5 125641.0 127111.0 128444.7 134746.0 10611.9 10901.6 10985.9 11178.6 11358.9 21239.8 21277.5 21441.2 21470.6 21511.2 8002.3 8118.7 8290.4 8381.2 8509.4 3698.6 4062.7 4582.1 4585.4 4615.8 3654.2 3782.0 3792.0 3795.8 3801.8 665.8 681.7 681.8 682.1 691.2 584.5 650.9 661.9 668.1 684.6 7662.7 8220.3 8613.4 9589.7 9613.8 614.7 627.9 668.8 676.1 688.9 4316.4 4458.2 4669.1 4674.6 4684.7 127698.4 132646.3 140406.0 146311.0 168310.0 102698.4 122245.0 126978.1 136230.0 136265.3 86764.0 111032.4 112900.9 118341.4 118725.8 9750.9 10250.8 10273.0 10283.3 10326.2 60184.7 60195.0 61710.0 63174.1 63225.4 73276.0 87254.6 97863.5 99661.5 100020.5 12914.6 13200.8 13422.7 13484.0 13723.7 14325.8 14951.9 15420.7 15774.1 15867.9 11549.3 13197.1 13936.4 14170.1 14207.4 12983.0 13914.6 14233.3 14471.6 14778.6 13154.0 13462.1 14123.0 14165.6 14579.9 11081.3 11211.7 11651.4 11806.2 12183.8 9823.7 9977.0 10415.8 11030.8 11835.1 22:11:16 INFO - PROCESS | 1659 | -------- Summary: end -------- 22:11:16 INFO - PROCESS | 1659 | 22:11:16 INFO - TEST-INFO | 1659: exit 0 22:11:16 INFO - TEST-OK | dromaeo_css | took 1114271ms 22:11:16 INFO - TEST-START | kraken 22:11:16 INFO - operating with platform_type : mac_ 22:11:16 INFO - Initialising browser for kraken test... 22:11:16 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpc85ISv/profile http://localhost:49278/getInfo.html) 22:11:19 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 22:11:19 INFO - PROCESS | 1671 | colorDepth:24 22:11:19 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 22:11:19 INFO - PROCESS | 1671 | __metrics 22:11:19 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 22:11:20 INFO - TEST-INFO | 1671: exit 0 22:11:20 INFO - Browser initialized. 22:11:20 INFO - Running cycle 1/1 for kraken test... 22:11:20 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpc85ISv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:11:32 INFO - PROCESS | 1673 | RSS: Main: 225697792 22:11:32 INFO - PROCESS | 1673 | 22:11:35 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 22:11:36 INFO - PROCESS | 1673 | RSS: Main: 238387200 22:11:36 INFO - PROCESS | 1673 | 22:11:38 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 22:11:39 INFO - PROCESS | 1673 | RSS: Main: 247037952 22:11:39 INFO - PROCESS | 1673 | 22:11:42 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 22:11:43 INFO - PROCESS | 1673 | RSS: Main: 249917440 22:11:43 INFO - PROCESS | 1673 | 22:11:44 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 22:11:45 INFO - PROCESS | 1673 | RSS: Main: 251334656 22:11:45 INFO - PROCESS | 1673 | 22:11:47 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:11:48 INFO - PROCESS | 1673 | RSS: Main: 251265024 22:11:48 INFO - PROCESS | 1673 | 22:11:51 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 22:11:51 INFO - PROCESS | 1673 | RSS: Main: 251760640 22:11:51 INFO - PROCESS | 1673 | 22:11:55 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 22:11:55 INFO - PROCESS | 1673 | RSS: Main: 251666432 22:11:55 INFO - PROCESS | 1673 | 22:11:58 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 22:11:59 INFO - PROCESS | 1673 | RSS: Main: 252092416 22:11:59 INFO - PROCESS | 1673 | 22:12:00 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:12:01 INFO - PROCESS | 1673 | RSS: Main: 251592704 22:12:01 INFO - PROCESS | 1673 | 22:12:03 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:12:04 INFO - PROCESS | 1673 | RSS: Main: 251662336 22:12:04 INFO - PROCESS | 1673 | 22:12:06 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:12:07 INFO - PROCESS | 1673 | RSS: Main: 251752448 22:12:07 INFO - PROCESS | 1673 | 22:12:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:12:10 INFO - PROCESS | 1673 | RSS: Main: 252133376 22:12:10 INFO - PROCESS | 1673 | 22:12:14 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:12:14 INFO - PROCESS | 1673 | RSS: Main: 251846656 22:12:14 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 22:12:16 INFO - PROCESS | 1673 | RSS: Main: 253321216 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | __start_tp_report 22:12:16 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 22:12:16 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 22:12:16 INFO - PROCESS | 1673 | |i|pagename|runs| 22:12:16 INFO - PROCESS | 1673 | |0;ai-astar;109;120;118;120;114;118;117;119;120;118 22:12:16 INFO - PROCESS | 1673 | |1;audio-beat-detection;136;109;127;179;140;111;112;112;139;108 22:12:16 INFO - PROCESS | 1673 | |2;audio-dft;192;205;199;197;196;192;194;193;204;194 22:12:16 INFO - PROCESS | 1673 | |3;audio-fft;82;60;59;85;60;61;60;60;79;66 22:12:16 INFO - PROCESS | 1673 | |4;audio-oscillator;89;70;91;73;69;69;88;99;94;87 22:12:16 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;133;89;91;127;90;86;107;109;136;110 22:12:16 INFO - PROCESS | 1673 | |6;imaging-darkroom;121;131;151;152;95;95;94;96;120;131 22:12:16 INFO - PROCESS | 1673 | |7;imaging-desaturate;97;129;98;95;139;150;93;91;76;154 22:12:16 INFO - PROCESS | 1673 | |8;json-parse-financial;56;56;68;74;58;59;58;59;59;58 22:12:16 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;68;76;85;121;122;114;92;72;71;63 22:12:16 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;86;86;86;83;95;111;112;107;110;100 22:12:16 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;142;171;158;154;129;154;152;160;164;143 22:12:16 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;166;239;213;169;166;168;189;229;232;233 22:12:16 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;69;69;68;67;68;68;66;66;68;67 22:12:16 INFO - PROCESS | 1673 | __end_tp_report 22:12:16 INFO - PROCESS | 1673 | __start_cc_report 22:12:16 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,957 22:12:16 INFO - PROCESS | 1673 | __end_cc_report 22:12:16 INFO - PROCESS | 1673 | __startTimestamp1479103936657__endTimestamp 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | ------- Summary: start ------- 22:12:16 INFO - PROCESS | 1673 | Number of tests: 14 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:117.30 Median:118.50 stddev:3.43 (2.9%) stddev-sans-first:1.92 22:12:16 INFO - PROCESS | 1673 | Values: 109.0 120.0 118.0 120.0 114.0 118.0 117.0 119.0 120.0 118.0 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:131.50 stddev:22.33 (17.0%) stddev-sans-first:23.46 22:12:16 INFO - PROCESS | 1673 | Values: 136.0 109.0 127.0 179.0 140.0 111.0 112.0 112.0 139.0 108.0 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:196.60 Median:196.50 stddev:4.72 (2.4%) stddev-sans-first:4.70 22:12:16 INFO - PROCESS | 1673 | Values: 192.0 205.0 199.0 197.0 196.0 192.0 194.0 193.0 204.0 194.0 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:67.20 Median:63.50 stddev:10.49 (16.5%) stddev-sans-first:9.66 22:12:16 INFO - PROCESS | 1673 | Values: 82.0 60.0 59.0 85.0 60.0 61.0 60.0 60.0 79.0 66.0 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:82.90 Median:88.50 stddev:11.45 (12.9%) stddev-sans-first:11.92 22:12:16 INFO - PROCESS | 1673 | Values: 89.0 70.0 91.0 73.0 69.0 69.0 88.0 99.0 94.0 87.0 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:107.80 Median:111.00 stddev:18.95 (17.1%) stddev-sans-first:17.78 22:12:16 INFO - PROCESS | 1673 | Values: 133.0 89.0 91.0 127.0 90.0 86.0 107.0 109.0 136.0 110.0 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:118.60 Median:123.00 stddev:22.88 (18.6%) stddev-sans-first:24.25 22:12:16 INFO - PROCESS | 1673 | Values: 121.0 131.0 151.0 152.0 95.0 95.0 94.0 96.0 120.0 131.0 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:112.20 Median:92.00 stddev:27.96 (30.4%) stddev-sans-first:29.11 22:12:16 INFO - PROCESS | 1673 | Values: 97.0 129.0 98.0 95.0 139.0 150.0 93.0 91.0 76.0 154.0 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:59.00 stddev:5.82 (9.9%) stddev-sans-first:5.94 22:12:16 INFO - PROCESS | 1673 | Values: 56.0 56.0 68.0 74.0 58.0 59.0 58.0 59.0 59.0 58.0 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:88.40 Median:71.50 stddev:22.75 (31.8%) stddev-sans-first:22.90 22:12:16 INFO - PROCESS | 1673 | Values: 68.0 76.0 85.0 121.0 122.0 114.0 92.0 72.0 71.0 63.0 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:97.60 Median:84.50 stddev:11.82 (14.0%) stddev-sans-first:11.77 22:12:16 INFO - PROCESS | 1673 | Values: 86.0 86.0 86.0 83.0 95.0 111.0 112.0 107.0 110.0 100.0 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:152.70 Median:156.00 stddev:12.10 (7.8%) stddev-sans-first:12.20 22:12:16 INFO - PROCESS | 1673 | Values: 142.0 171.0 158.0 154.0 129.0 154.0 152.0 160.0 164.0 143.0 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.40 Median:221.00 stddev:31.73 (14.4%) stddev-sans-first:31.12 22:12:16 INFO - PROCESS | 1673 | Values: 166.0 239.0 213.0 169.0 166.0 168.0 189.0 229.0 232.0 233.0 22:12:16 INFO - PROCESS | 1673 | 22:12:16 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.07 (1.6%) stddev-sans-first:1.01 22:12:16 INFO - PROCESS | 1673 | Values: 69.0 69.0 68.0 67.0 68.0 68.0 66.0 66.0 68.0 67.0 22:12:16 INFO - PROCESS | 1673 | -------- Summary: end -------- 22:12:16 INFO - PROCESS | 1673 | 22:12:17 INFO - TEST-INFO | 1673: exit 0 22:12:17 INFO - TEST-OK | kraken | took 60721ms 22:12:17 INFO - SUITE-END | took 1174s 22:12:17 INFO - Completed test suite (00:19:35) 22:12:17 INFO - javascript benchmark 22:12:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7374.109771477545, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.2683819302465, 3437.570303712036, 3462.878799242027, 3482.6169121396642, 3497.527833742444, 5759.45285197906, 5772.711364431777, 5852.531797456204, 5864.091065884784, 5864.706764661761, 5805.854853628651, 5888.852778680524, 5890.941090589093, 5908.556858235639, 5910.793122240722, 5281.577473802096, 5399.595030372738, 5431.4840090191365, 5441.156620723775, 5445.646033007862, 5395.352557693062, 5412.404635490093, 5417.052015897222, 5440.510354068133, 5444.128939369702, 5292.285541451894, 5296.09966305727, 5426.457354264581, 5433.891322173554, 5471.425500322469, 4222.746635201883, 4559.612432943204, 5374.731263436813, 5416.593755468316, 5484.643498172606, 5242.266082748418, 5349.037173308803, 5378.542823859977, 5386.622936394454, 5462.617616766828, 5680.091185410356, 5868.48362539216, 5906.26171728534, 5973.701314934279, 5978.8505287367725, 6069.787557435468, 6137.622145771035, 6173.074038894157, 6248.187735594389, 6261.87476250477, 5259.631825772198, 6251.468625166866, 6272.5922815016875, 6320.336364681688, 6331.2719037310835, 6023.548233882477, 6036.849078772978, 6045.879082418371, 6055.7274922628585, 6057.7879774207695, 6244.438000579969, 6288.591241569284, 6289.496840252768, 6289.55973081889, 6292.653904035322, 6257.311695713468, 6269.467095296951, 6274.1843560336865, 6277.2781130170615, 6279.937200628026, 6220.315765265817, 6310.905336419957, 6329.113924050636, 6343.460805831556, 6346.873062538723, 6121.57491608479, 6219.595726277777, 6230.158928544589, 6247.75008999644, 6254.312025677172, 6214.627122372672, 6239.500839932794, 6265.71804268809, 6276.6547839869245, 6286.214223222098, 5019.7490125494305, 5049.747512624354, 5050.545450909436, 5055.51972562606, 5063.468335824759, 3783.640554147407, 4220.388043733703, 4447.510773814878, 4450.287953927356, 4549.545045495424, 4847.612191024709, 4949.356583644103, 5014.774335154927, 6055.909161362583, 6086.178365920633, 6293.653849038347, 6324.177856878577, 6335.081413195153, 6343.651099189497, 6354.586951848115, 5856.882862342814, 5917.822465325961, 5949.286085669747, 6008.068749343859, 6031.336552979169, 5499.202615620713, 5525.060739674265, 5531.032069387841, 5539.529140023144, 5557.972210139004, 6293.716782744787, 6350.65071421067, 6439.678016099177, 6521.608703477807, 6529.412352888263, 6330.841728956813, 6343.0485427186295, 6347.333529979285, 6347.90478142819, 6363.427291543783, 5689.288838895138, 6296.307406185224, 6349.952257877399, 6556.147700799056, 6567.605943643397, 6019.157317975574, 6220.0, 6231.906521402092, 6251.843703907439, 6308.621482711052, 6317.684115794284, 6350.0, 6351.0, 6359.268684101203, 6362.491000720024, 6045.395460453919, 6169.796889606484, 6275.466585340115, 6292.339304372975, 6300.936990630035, 6138.539609529393, 6139.26328840542, 6165.167702360303, 6172.537059720449, 6243.656598887105, 6018.707601581906, 6170.259568851767, 6178.41305076017, 6195.2255968004, 6216.751329946752, 6222.937770622236, 6254.843628909131, 6270.2475702915945, 6292.559520833498, 6310.905336419865, 5904.940950590439, 5987.0, 6075.058365953284, 6080.90878636812, 6099.878002440015], "value": 5780.989125878401, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.41755058828227, 478.99281510777325, 503.9392079672292, 532.7975369359644, 536.9194620806876, 39781.60218397815, 41298.0, 41484.792576037114, 43428.56571434285, 43672.56327436725, 43646.127077458514, 43930.56069439305, 44065.559344406625, 44097.0, 44294.335584966255, 9867.75330616735, 9949.801003979916, 10027.89972100277, 10075.143612792885, 10076.596936122547, 9869.555869985832, 9996.200303975664, 10019.44893030883, 10025.44860032698, 10043.89956100437, 9886.950565247163, 10008.549615267331, 10038.849417258747, 10070.899291007107, 10111.443870587114, 9969.1526220271, 10025.999999999964, 10030.949845250727, 10044.196464282913, 10053.79892402148, 9873.963233860484, 9957.0540798624, 9970.002999699973, 9976.600935962553, 9992.750181245454, 40946.38580421296, 41491.7925410374, 41908.37137442941, 42016.579834201875, 42112.78943605293, 3373.3590617782543, 3391.491276308549, 3421.0934102462866, 3421.5038819371302, 3451.7928924264625, 29095.0, 29112.272193195127, 29401.41197176066, 29798.70201297981, 29962.101136965706, 3173.1591128350774, 3248.1554795753036, 3284.211789170582, 3337.0155804037868, 3353.96646033539, 512876.0, 517373.0, 519433.0, 519851.40074299765, 520815.0, 59252.40747592555, 59289.0, 59468.40531594715, 59496.0, 59533.40466595279, 34861.65138348635, 35298.470522942174, 35364.115897102776, 36353.81823090868, 63399.68300158469, 16236.837631623532, 16372.181390930406, 16412.917935410485, 16429.753553696704, 16461.83538164627, 10470.214733894989, 12676.556320528738, 12691.428885700165, 12725.918296944677, 12741.617751467471, 19256.0, 19416.315084255286, 19466.70799938002, 19573.727707698956, 19722.30971915976, 7556.921846492259, 8136.389770767216, 8302.335813134934, 8353.037036296466, 8405.915940840636, 890.875277461156, 990.6136606723384, 1022.0750221049962, 1043.5669197283044, 1078.7788503356794, 21693.0, 22444.438889027904, 26719.46561068768, 28590.999315023873, 28622.425766582623, 807.9394045446616, 1036.8185567525652, 1076.8976947190004, 1110.228391268077, 1133.8299255111635, 12178.147529672839, 13624.841888439396, 13726.931365343109, 14190.716185676436, 15574.143422111893, 180854.0, 182389.0, 183205.0, 184248.07875960536, 184442.0, 55760.72119639376, 57449.0, 58225.70887145622, 58671.706641467375, 60040.399596004354, 1355.8440779310308, 1360.9183448993092, 1379.0553470872485, 1386.2098603795941, 1386.8266466691664, 21882.562348753254, 23887.880560597085, 29949.550756739103, 30945.226369340045, 31132.22169445782, 50793.746031269606, 51190.0, 51445.0, 51534.74232628813, 51586.74206628943, 611516.0, 615602.0, 616443.0, 619927.0, 621285.0, 26794.0, 26849.86575067112, 27007.32481687895, 27186.91252349884, 27666.446671066064, 47709.5229047719, 47922.76038619924, 48235.517644824504, 48430.273545897544, 48892.75553622209, 39585.0, 39594.45778827608, 40041.399379008755, 40959.79520102381, 41300.38049429321, 39700.0, 39736.60263397329, 39968.20063598653, 40660.3900941492, 41068.794656026526, 30868.53697194499, 32862.671373285964, 33470.4979425304, 37874.62125378711, 39075.80462097671, 32668.67331326656, 35675.64324356723, 36137.63862361448, 36254.0, 36271.09322266859, 25733.871330643226, 26027.869860650575, 26260.868695657166, 26466.338341541614, 26509.469810604067], "value": 19229.18005138199, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.74074277634264, 373.7327810615411, 375.4537148449007, 383.98080095995226, 391.49106161989425, 15155.696886062273, 20555.280565180223, 20709.378718638465, 21361.145554177834, 21424.464388390297, 19973.700394494095, 20285.290014849485, 20531.486712832186, 20855.85292808895, 20872.269470568495, 5336.67979921204, 5840.240768700063, 5980.491658209057, 6021.397860213965, 6082.665453400061, 5989.191459153024, 5999.790007349722, 6107.236595425572, 6109.694515274241, 6114.541409394291, 5815.62198457101, 6023.879522409549, 6136.9079463808075, 6162.7534898604, 6204.81385558434, 5054.848354549369, 6113.7860174893885, 6189.473894718954, 6192.0, 6362.0, 5930.762769489258, 5985.610935289193, 5987.820365389001, 6037.54718396122, 6041.093835924603, 13138.934305328412, 13610.659733506642, 13626.93186534061, 15846.890717649769, 20102.396928092036, 2363.2555744940287, 2400.4958958618713, 2436.4639779248537, 2457.69278840145, 2692.8788204530842, 9506.239500839916, 9834.754131146707, 10208.693739187836, 10375.481225938749, 10463.05832475081, 1551.5422950229597, 1632.8243664561496, 1838.7701537307837, 1951.063489525036, 2001.3995801259564, 106054.96900450398, 107921.0, 108444.0, 110215.0, 114529.0, 11398.290256461598, 11473.885261147449, 11518.30890146577, 11565.496485456837, 11810.0, 13955.581332559836, 13980.930095349458, 14093.590640936029, 14128.434862605587, 14129.081609695337, 8442.831143377098, 8508.617112229964, 8622.913770862337, 8677.21905028538, 8685.565721713889, 8694.304455643532, 8760.123987601317, 8768.868466972874, 8857.955710221408, 8910.910890891138, 4221.303484924953, 4363.560025191679, 4385.802638881258, 4398.274284743045, 4475.641948644101, 1696.635223426969, 1924.509250141205, 1945.0760888577813, 1953.5506833428392, 1965.3416105604497, 839.941204115706, 863.6890719341033, 907.5371560504191, 949.8480243161061, 967.7483854197959, 20716.482087947923, 21319.0, 21399.144034238456, 21628.67556986615, 21644.783552164277, 916.4248461822301, 942.4580866002076, 994.3487016004528, 1001.6861050972277, 1022.9795404091876, 8423.915760842436, 8663.653453861902, 9458.385204961656, 9868.950655246821, 11098.001179893687, 598943.0, 617831.0, 630497.0, 630980.0, 631939.0, 118348.0, 125304.0, 130872.3456382712, 130895.34552327177, 145231.0, 930.6975233049286, 972.9902700973041, 1006.9093781559549, 1011.6661501704419, 1013.4881884648353, 19875.60248794987, 20221.090050948038, 20239.4940126498, 20526.486837829172, 20655.690164647243, 55933.440665592825, 56861.0, 57909.0, 59304.813903720824, 61940.76118477695, 73788.63105684437, 79541.60229198817, 82925.9268518292, 84409.5779521123, 89069.0, 8065.717699880476, 8217.630206640835, 8233.135520770233, 8255.133211012757, 8269.46248493846, 12506.499740010662, 12571.0, 13249.13880597758, 13370.465181392636, 13775.931120344334, 11218.597675290588, 11469.713257168638, 11535.250208736405, 11584.015358694605, 11632.651020469399, 10116.342437741523, 10647.680569582924, 11258.718532036764, 11346.716332091764, 11470.369129697947, 5926.792562260473, 11171.944140279571, 11760.556033047902, 11765.235259708092, 11791.823122652995, 8269.46248493846, 8295.95852020736, 8350.20673036085, 8375.12061233586, 8457.196566326189, 9380.390274632127, 10393.792124157626, 10478.63777708893, 11325.490352933974, 11642.01042911362], "value": 9502.873125091088, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1516.742153833848, 1550.6278493161642, 1742.99777627864, 1803.6302557975616, 1857.9256829726812, 8089.757307280776, 8342.0, 8621.870671939925, 9192.586333614978, 9206.447613143217, 8652.783680407993, 8924.821503569941, 8943.95528022359, 8968.955155224216, 9035.819283614324, 2358.5282943411303, 2366.6450032495177, 2404.735479097307, 2405.1822380390663, 2416.8549887006834, 2395.8442701224453, 2418.8185886058527, 2431.768981946721, 2438.207582535674, 2439.3901524618846, 2401.2076014915037, 2411.240459255329, 2418.8064954803663, 2441.645961335605, 2443.767842055002, 2386.8209884258663, 2393.6050551658955, 2398.136670798511, 2399.4841109161525, 2427.490227052321, 2369.869657168855, 2371.727251366098, 2380.297812145404, 2386.248331775485, 2388.665586817847, 9000.369974101815, 9055.003949565542, 9061.275097992146, 9067.229285510673, 9077.68228112013, 5361.329833770778, 5421.512063914227, 5511.5039646432015, 5514.751836167382, 5515.944840551583, 3641.799701016443, 3650.1604630934767, 3668.779873207616, 3682.4660424238605, 3714.851405943759, 1092.8743194532651, 1101.0860985382114, 1101.091599430473, 1118.0775859915602, 1125.3697929159614, 11609.361485118316, 11866.991305738937, 11922.344271065089, 11960.940195298968, 11969.521219151224, 4721.126591580569, 4752.6696943660245, 4784.976075119672, 4857.222844344888, 4917.606591472745, 10043.995600439897, 10138.23963202748, 10154.492275386348, 10174.643887463903, 10186.08325250731, 4605.424321959755, 5419.132938729785, 5423.105187643994, 5434.293541839615, 5451.64564303319, 4440.600345968878, 4582.106489234568, 4757.191277482836, 4907.6564640475535, 4958.256261560795, 3959.3862951242604, 4022.4770779798437, 4058.8579399721457, 4080.2451546464, 4091.5908409158847, 1118.4631376939114, 1289.9935500322438, 1331.1613683379603, 1342.1074985134971, 1345.5156143788229, 773.7291947818219, 887.1616322575234, 910.6721580231111, 911.9726408207764, 918.2745630951607, 5715.342735585461, 5977.3126090500145, 6036.456718895321, 6105.542084343603, 6362.809115726535, 841.5287439034038, 934.3412893909777, 973.2603221551531, 977.6871401151564, 983.4296108257194, 3794.2221844521805, 3941.0541470046983, 3953.4267531207815, 3958.4062390641056, 4075.1238483726142, 9282.860757088649, 10422.635207767691, 10988.395638239974, 11029.669109926715, 11034.0, 9307.488088155216, 10280.485975701185, 10967.067799237155, 10970.725731856608, 10975.780484390267, 8208.09710931797, 8384.329253659693, 8411.70559030431, 8424.83150337002, 8424.957875210708, 4337.1976184405985, 5834.679092649945, 5856.677882716321, 5879.382664820303, 5901.104530015275, 10088.69733907984, 10091.949540252252, 10112.949435252776, 10225.9488702559, 10289.176865850864, 9540.85688714656, 10299.588016479556, 10476.790464190826, 10540.420276884844, 10604.0, 7104.502684812013, 7306.890396643948, 7512.924870751222, 7516.774496765106, 7703.8074048147, 8424.915750842412, 8427.83144337122, 8442.240198382175, 8593.742187734379, 8602.39783215169, 7449.851002980018, 7450.552966822008, 7567.810804729926, 7612.3148916597775, 7666.731664391719, 6398.5521013528605, 7346.33882950537, 7515.398768098648, 7541.698332066656, 7643.235676432312, 7047.541909775849, 7051.083359163276, 7114.683783500069, 7136.250693677297, 7137.250588688113, 4926.162552366035, 4931.309616653743, 5028.0, 5053.7473126344275, 5091.9490805092955, 4228.344606585984, 4932.506749325183, 4943.65394422387, 4954.306397104337, 5137.794488220578], "value": 4643.107046738148, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [269.58214767110985, 298.28411811652035, 307.48342784122667, 309.8977337478631, 311.87057371190957, 5505.29335905869, 5567.3040869891265, 5584.301962254718, 5585.547757583027, 5604.663720176787, 5455.2815863003225, 5468.945310546894, 5486.8203336282695, 5554.222408862763, 5555.472230138131, 3265.3632541654447, 4102.353981681814, 4129.421880936671, 4185.707000509966, 4189.183109293689, 4147.854825081123, 4152.584741525853, 4159.9376009359885, 4197.958020419787, 4244.660427165834, 3259.315543735818, 4156.97921510392, 4159.272127377697, 4186.42534841072, 4217.346311321735, 4060.7360521566, 4091.4272001919753, 4124.628783409477, 4149.356849688304, 4193.385546564564, 3177.855971850132, 3467.739919506047, 3587.7488575799703, 3594.730395220369, 3656.3491468684992, 4375.956240437618, 5277.656952298088, 5300.655457395257, 5301.575873930076, 5330.840074797762, 4181.6236538711355, 4423.137488189805, 4584.426946631671, 4755.690880092783, 4873.244647079709, 5015.871428928498, 5047.369078865142, 5122.513361230677, 5466.262054622614, 5668.433156684298, 3229.337985712923, 3297.4888892221743, 3739.2334571413066, 4009.919801603981, 4025.3156963316305, 5264.131048578534, 5322.92015619766, 5706.0, 5997.530605001759, 6143.754249830046, 3214.6624604416666, 3886.242182774332, 3941.842326306973, 3942.5466071402157, 3954.3870700040966, 3948.58539853317, 3952.960470395317, 3968.1666849961252, 3987.670295303454, 4036.414719865603, 4657.208274593328, 4675.95324046762, 4677.719336839732, 4678.742669153229, 4691.3432119503295, 4817.421909370828, 5418.241446197536, 5812.941870581325, 5828.930729591019, 5850.385709500526, 1167.1129941244546, 1339.5666636698834, 1371.1704418826666, 1371.7736573465265, 1376.9793453098011, 785.3991696352296, 801.9679212831538, 828.0394742099136, 839.7942504086537, 844.8437039147777, 4674.158651442705, 4824.831130910401, 5459.344878614592, 5503.330884521004, 5515.758954235345, 4868.318435419044, 5364.436734142859, 5555.777728899636, 6146.815595532141, 6192.256929168439, 4047.741568037758, 5437.945620543823, 5515.641483303572, 5544.500994910478, 5576.386597474275, 2390.7250666173613, 3144.484412470015, 3155.9269848251706, 3195.984020079885, 3202.9359412811614, 5412.972935135378, 5795.39148389413, 6100.071965456517, 6114.667506209126, 6364.886144924712, 5383.78464861409, 5898.410158984153, 5939.020061689859, 6060.727267272983, 6145.293291271471, 5334.413214546396, 6301.369863013662, 6314.463270621956, 6351.5871468355335, 6354.777582784765, 5772.855678608068, 5848.912266315923, 6084.448465641233, 6085.391460853879, 6097.176881120992, 5055.7219352935945, 5866.927729799808, 5947.464728174485, 5960.940390596212, 6041.365656606169, 5181.5077567631015, 5908.2275317405465, 5960.433758792908, 6101.288582559149, 6258.092576576462, 3973.523177218752, 4033.495813023372, 4056.0, 4089.26393249218, 4091.5703851095204, 5257.502686224013, 5868.738221282445, 5960.509872531867, 6055.182550355646, 6060.212172417558, 5547.278853748987, 5664.518515926027, 5837.591368604327, 5880.059970014992, 5915.733791979457, 4736.342280201902, 5452.863678408072, 5764.308283005898, 5787.594868359174, 5905.320888097924, 5220.504052115043, 5701.258836351248, 5715.514181294637, 5766.365699773106, 5771.538276937918, 4459.197344478025, 5457.107732901569, 5731.19763233156, 5735.541156707537, 5782.335031471434, 4768.403949506312, 5432.266644003167, 5608.42963970089, 5697.524510048784, 5714.971305165111], "value": 4185.9461137969365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.9164462797522, 686.9690863911123, 694.2848865668361, 710.4458522352567, 758.9392848572115, 12248.02015838733, 13951.720965580682, 16128.193590320496, 16148.919255403722, 16201.513954581367, 12634.936825315861, 14110.365033573487, 14655.560333190022, 14659.267036648178, 14699.044562103456, 658.2265837640776, 685.1504134872747, 821.0844907927648, 826.7313123234927, 852.1648784191497, 817.7669364231195, 854.7393045121236, 858.9699360522383, 859.0078459379396, 865.3380164174412, 908.1055160666738, 912.6486302773446, 915.5696822493418, 915.6703586708779, 916.4363916191561, 647.3106141958799, 695.3637421759084, 747.6355650937035, 891.0332289465937, 906.3247880329164, 635.9046143078575, 666.3736088077192, 667.3226674924955, 669.768929719251, 672.2571558427965, 15074.09555426678, 15173.772393414107, 15193.848061519353, 15214.467493637669, 15249.008814427027, 11589.36258505782, 14755.77866332006, 14780.926095369454, 14936.0, 15028.699426011528, 10965.122790176767, 11544.480498377508, 11568.363739994296, 12030.63908082759, 12157.878421215763, 3866.3040652682507, 3872.3610604250266, 3902.0, 4002.139539998885, 4025.63769260765, 100285.4985725074, 125641.0, 127111.0, 128444.71555284421, 134746.0, 10611.946940265248, 10901.563937442572, 10985.890141098487, 11178.608748693756, 11358.920902514248, 21239.78760212409, 21277.46806329854, 21441.249556265768, 21470.57058858814, 21511.247106351202, 8002.279794818378, 8118.675252989932, 8290.378221633402, 8381.203785640355, 8509.361797865186, 3698.5561732591723, 4062.654674352654, 4582.1293954148605, 4585.380973568593, 4615.815367385267, 3654.2326111516877, 3782.0, 3791.976166435047, 3795.8291876865605, 3801.752886062397, 665.7703092433103, 681.7273090763636, 681.7954613615896, 682.1405029662661, 691.1982100763191, 584.4739734239133, 650.9023646452976, 661.8809109780113, 668.1114118222752, 684.6200358800813, 7662.693492260359, 8220.260176584135, 8613.440126391764, 9589.664361747306, 9613.807723845484, 614.7418084404561, 627.9497640188865, 668.7796515568267, 676.0839063069568, 688.9207741109736, 4316.41015390763, 4458.197524445566, 4669.089527542164, 4674.6026587740425, 4684.672072954861, 127698.36150819187, 132646.33676831555, 140406.0, 146311.0, 168310.0, 102698.43253918563, 122245.0, 126978.09532857014, 136230.0, 136265.318673406, 86764.0, 111032.4448377753, 112900.87826858464, 118341.40829295799, 118725.8127418732, 9750.902490974999, 10250.846237306298, 10273.02406271403, 10283.280170388001, 10326.173906087644, 60184.69907650609, 60195.0, 61710.0, 63174.05238921512, 63225.36774632195, 73276.0, 87254.5637271835, 97863.51068244613, 99661.50507742245, 100020.49989750005, 12914.612561623166, 13200.801987969997, 13422.664433389244, 13484.0, 13723.656908576966, 14325.78511322352, 14951.850481495047, 15420.691586168437, 15774.05355678663, 15867.920660396625, 11549.307041577533, 13197.076204665582, 13936.442542298195, 14170.149791012573, 14207.431702731776, 12983.0, 13914.582562523141, 14233.288335583387, 14471.565853024425, 14778.63053423673, 13154.0, 13462.124961877447, 14123.0, 14165.575032749033, 14579.854201458274, 11081.27971681838, 11211.66365009051, 11651.359175245443, 11806.232594881305, 12183.756324873275, 9823.705288841345, 9976.957028106497, 10415.84376234342, 11030.834537481784, 11835.11236657237], "value": 7830.592617174185, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1597.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 120.0, 118.0, 120.0, 114.0, 118.0, 117.0, 119.0, 120.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 109.0, 127.0, 179.0, 140.0, 111.0, 112.0, 112.0, 139.0, 108.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 205.0, 199.0, 197.0, 196.0, 192.0, 194.0, 193.0, 204.0, 194.0], "value": 196.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 59.0, 85.0, 60.0, 61.0, 60.0, 60.0, 79.0, 66.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 91.0, 73.0, 69.0, 69.0, 88.0, 99.0, 94.0, 87.0], "value": 82.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 89.0, 91.0, 127.0, 90.0, 86.0, 107.0, 109.0, 136.0, 110.0], "value": 107.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 131.0, 151.0, 152.0, 95.0, 95.0, 94.0, 96.0, 120.0, 131.0], "value": 118.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 129.0, 98.0, 95.0, 139.0, 150.0, 93.0, 91.0, 76.0, 154.0], "value": 112.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 68.0, 74.0, 58.0, 59.0, 58.0, 59.0, 59.0, 58.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 85.0, 121.0, 122.0, 114.0, 92.0, 72.0, 71.0, 63.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 83.0, 95.0, 111.0, 112.0, 107.0, 110.0, 100.0], "value": 97.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 171.0, 158.0, 154.0, 129.0, 154.0, 152.0, 160.0, 164.0, 143.0], "value": 152.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 239.0, 213.0, 169.0, 166.0, 168.0, 189.0, 229.0, 232.0, 233.0], "value": 200.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 67.0, 68.0, 68.0, 66.0, 66.0, 68.0, 67.0], "value": 67.6, "unit": "score"}]}]} 22:12:17 INFO - Return code: 0 22:12:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:12:17 ERROR - # TBPL SUCCESS # 22:12:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:12:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:12:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:12:17 INFO - 2016-11-13 22:12:17.973 screenresolution[1678:10762] starting screenresolution argv=screenresolution get 22:12:17 INFO - 2016-11-13 22:12:17.975 screenresolution[1678:10762] Display 0: 1600x1200x32@60 22:12:17 INFO - 2016-11-13 22:12:17.981 screenresolution[1679:10765] starting screenresolution argv=screenresolution list 22:12:17 INFO - Available Modes on Display 0 22:12:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:12:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:12:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:12:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:12:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:12:18 INFO - Intel Iris: 22:12:18 INFO - Chipset Model: Intel Iris 22:12:18 INFO - Type: GPU 22:12:18 INFO - Bus: Built-In 22:12:18 INFO - VRAM (Dynamic, Max): 1536 MB 22:12:18 INFO - Vendor: Intel (0x8086) 22:12:18 INFO - Device ID: 0x0a2e 22:12:18 INFO - Revision ID: 0x0009 22:12:18 INFO - Displays: 22:12:18 INFO - Display: 22:12:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:12:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:12:18 INFO - Display Serial Number: 1600x1200 60 22:12:18 INFO - Main Display: Yes 22:12:18 INFO - Mirror: Off 22:12:18 INFO - Online: Yes 22:12:18 INFO - Rotation: Supported 22:12:18 INFO - Return code: 0 22:12:18 INFO - Running post-action listener: _resource_record_post_action 22:12:18 INFO - [mozharness: 2016-11-14 06:12:18.217451Z] Finished run-tests step (success) 22:12:18 INFO - Running post-run listener: _resource_record_post_run 22:12:18 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 37499904; Write bytes: 667399680; Read time: 242; Write time: 1954 22:12:18 INFO - TinderboxPrint: CPU usage
54.2% 22:12:18 INFO - TinderboxPrint: I/O read bytes / time
37,499,904 / 242 22:12:18 INFO - TinderboxPrint: I/O write bytes / time
667,399,680 / 1,954 22:12:18 INFO - TinderboxPrint: CPU idle
2,213.1 (45.8%) 22:12:18 INFO - TinderboxPrint: CPU system
974.1 (20.2%) 22:12:18 INFO - TinderboxPrint: CPU user
1,646.6 (34.1%) 22:12:18 INFO - TinderboxPrint: Swap in / out
401,268,736 / 0 22:12:18 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356729344; Write bytes: 356780032; Read time: 27610; Write time: 769 22:12:18 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35705856; Write bytes: 299621888; Read time: 227; Write time: 1147 22:12:18 INFO - Running post-run listener: _upload_blobber_files 22:12:18 INFO - Blob upload gear active. 22:12:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:12:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:12:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:12:19 INFO - (blobuploader) - INFO - Open directory for files ... 22:12:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:12:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:12:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:12:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:12:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:12:20 INFO - (blobuploader) - INFO - Done attempting. 22:12:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:12:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:12:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:12:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:12:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:12:21 INFO - (blobuploader) - INFO - Done attempting. 22:12:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:12:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:12:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:12:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:12:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:12:23 INFO - (blobuploader) - INFO - Done attempting. 22:12:23 INFO - (blobuploader) - INFO - Iteration through files over. 22:12:23 INFO - Return code: 0 22:12:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:12:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:12:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/464077fe8fcf41a501c0bd81ced2a9e692c2d86f0a7b13606767e2512dd7e1eb2a38ecb2bb41622104e1d8df8a836243e00a173c7c6930a1616813b84f3133e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cd5eecda826ae55d53e723847325ed93585dc50de6d2097c7f91c600724514d609d0fe1389beb807f304f70cd97eb30c6db7fdeeb946e6aa545f461423996c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b95c5d0ce6f4758d6911399eab5bfccc5aa9bdfa6debdf738e92e1cbf327f0e6fff1848bc996a65b366f6019f773fa702242e1d333277fd285e15e98abc9f266"} 22:12:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:12:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:12:23 INFO - Contents: 22:12:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/464077fe8fcf41a501c0bd81ced2a9e692c2d86f0a7b13606767e2512dd7e1eb2a38ecb2bb41622104e1d8df8a836243e00a173c7c6930a1616813b84f3133e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cd5eecda826ae55d53e723847325ed93585dc50de6d2097c7f91c600724514d609d0fe1389beb807f304f70cd97eb30c6db7fdeeb946e6aa545f461423996c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b95c5d0ce6f4758d6911399eab5bfccc5aa9bdfa6debdf738e92e1cbf327f0e6fff1848bc996a65b366f6019f773fa702242e1d333277fd285e15e98abc9f266"} 22:12:23 INFO - Running post-run listener: copy_logs_to_upload_dir 22:12:23 INFO - Copying logs to upload dir... 22:12:23 INFO - mkdir: /builds/slave/test/build/upload/logs 22:12:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.926523 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-11-13 22:12:23.353723) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-13 22:12:23.357360) ========= 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.5Ko7TlTT1R/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.GsdVVZniEb/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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/464077fe8fcf41a501c0bd81ced2a9e692c2d86f0a7b13606767e2512dd7e1eb2a38ecb2bb41622104e1d8df8a836243e00a173c7c6930a1616813b84f3133e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cd5eecda826ae55d53e723847325ed93585dc50de6d2097c7f91c600724514d609d0fe1389beb807f304f70cd97eb30c6db7fdeeb946e6aa545f461423996c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b95c5d0ce6f4758d6911399eab5bfccc5aa9bdfa6debdf738e92e1cbf327f0e6fff1848bc996a65b366f6019f773fa702242e1d333277fd285e15e98abc9f266"} build_url:https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010987 build_url: 'https://queue.taskcluster.net/v1/task/bI40XmK8TM2stW3x6wVp_w/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/464077fe8fcf41a501c0bd81ced2a9e692c2d86f0a7b13606767e2512dd7e1eb2a38ecb2bb41622104e1d8df8a836243e00a173c7c6930a1616813b84f3133e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cd5eecda826ae55d53e723847325ed93585dc50de6d2097c7f91c600724514d609d0fe1389beb807f304f70cd97eb30c6db7fdeeb946e6aa545f461423996c0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b95c5d0ce6f4758d6911399eab5bfccc5aa9bdfa6debdf738e92e1cbf327f0e6fff1848bc996a65b366f6019f773fa702242e1d333277fd285e15e98abc9f266"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-13 22:12:23.391602) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 22:12:23.391984) ========= 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.5Ko7TlTT1R/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.GsdVVZniEb/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.005128 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-13 22:12:23.444990) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-13 22:12:23.445323) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-13 22:12:23.445673) ========= ========= Total master_lag: 1.99 =========