builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0066 starttime: 1482299930.05 results: success (0) buildid: 20161220201353 builduid: 856c8a10b3e24fb69d4abe6b477e9266 revision: 20774bffb62a3c1fecf98ed8ad9ee1a861bcd9b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:50.048341) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:50.048789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:50.049062) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:50.072912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:50.073279) ========= 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.I9K67pyzFJ/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.EboKBxntCq/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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-12-20 21:58:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 78.5M=0s 2016-12-20 21:58:50 (78.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.191715 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:50.289088) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:50.289400) ========= 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.I9K67pyzFJ/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.EboKBxntCq/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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.026373 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:50.337994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-20 21:58:50.338394) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 20774bffb62a3c1fecf98ed8ad9ee1a861bcd9b7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 20774bffb62a3c1fecf98ed8ad9ee1a861bcd9b7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.I9K67pyzFJ/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.EboKBxntCq/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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-12-20 21:58:50,442 truncating revision to first 12 chars 2016-12-20 21:58:50,442 Setting DEBUG logging. 2016-12-20 21:58:50,442 attempt 1/10 2016-12-20 21:58:50,442 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/20774bffb62a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-20 21:58:52,090 unpacking tar archive at: mozilla-central-20774bffb62a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.910401 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-20 21:58:52.275725) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:52.276262) ========= script_repo_revision: 20774bffb62a3c1fecf98ed8ad9ee1a861bcd9b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:52.277080) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:52.277639) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-20 21:58:52.298282) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-12-20 21:58:52.298948) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.I9K67pyzFJ/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.EboKBxntCq/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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:58:52 INFO - MultiFileLogger online at 20161220 21:58:52 in /builds/slave/test 21:58:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:58:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:58:52 INFO - {'append_to_log': False, 21:58:52 INFO - 'base_work_dir': '/builds/slave/test', 21:58:52 INFO - 'blob_upload_branch': 'Firefox', 21:58:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:58:52 INFO - 'branch': 'Firefox', 21:58:52 INFO - 'buildbot_json_path': 'buildprops.json', 21:58:52 INFO - 'config_files': ('talos/mac_config.py',), 21:58:52 INFO - 'default_actions': ('clobber', 21:58:52 INFO - 'read-buildbot-config', 21:58:52 INFO - 'download-and-extract', 21:58:52 INFO - 'populate-webroot', 21:58:52 INFO - 'create-virtualenv', 21:58:52 INFO - 'install', 21:58:52 INFO - 'run-tests'), 21:58:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:58:52 INFO - 'download_minidump_stackwalk': True, 21:58:52 INFO - 'download_symbols': 'ondemand', 21:58:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:58:52 INFO - 'tooltool.py': '/tools/tooltool.py', 21:58:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:58:52 INFO - '/tools/misc-python/virtualenv.py')}, 21:58:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:58:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:58:52 INFO - 'installer_path': 'installer.exe', 21:58:52 INFO - 'log_level': 'info', 21:58:52 INFO - 'log_name': 'talos', 21:58:52 INFO - 'log_to_console': True, 21:58:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:58:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:58:52 INFO - 'opt_config_files': (), 21:58:52 INFO - 'pip_index': False, 21:58:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:58:52 INFO - 'cmd': ('bash', 21:58:52 INFO - '-c', 21:58:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:58:52 INFO - 'enabled': True, 21:58:52 INFO - 'halt_on_failure': False, 21:58:52 INFO - 'name': 'check_screen_resolution'},), 21:58:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:58:52 INFO - 'cmd': ('bash', 21:58:52 INFO - '-c', 21:58:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:58:52 INFO - 'enabled': True, 21:58:52 INFO - 'halt_on_failure': False, 21:58:52 INFO - 'name': 'check_screen_resolution'},), 21:58:52 INFO - 'run_cmd_checks_enabled': True, 21:58:52 INFO - 'sps_profile': False, 21:58:52 INFO - 'sps_profile_interval': 0, 21:58:52 INFO - 'suite': 'dromaeojs-e10s', 21:58:52 INFO - 'system_bits': '32', 21:58:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:58:52 INFO - 'title': 't-yosemite-r7-0066', 21:58:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:58:52 INFO - 'use_talos_json': True, 21:58:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:58:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:58:52 INFO - 'work_dir': 'build'} 21:58:52 INFO - [mozharness: 2016-12-21 05:58:52.514858Z] Running clobber step. 21:58:52 INFO - Running pre-action listener: _resource_record_pre_action 21:58:52 INFO - Running main action method: clobber 21:58:52 INFO - rmtree: /builds/slave/test/build 21:58:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:58:54 INFO - Running post-action listener: _resource_record_post_action 21:58:54 INFO - [mozharness: 2016-12-21 05:58:54.913411Z] Finished clobber step (success) 21:58:54 INFO - [mozharness: 2016-12-21 05:58:54.913567Z] Running read-buildbot-config step. 21:58:54 INFO - Running pre-action listener: _resource_record_pre_action 21:58:54 INFO - Running main action method: read_buildbot_config 21:58:54 INFO - Using buildbot properties: 21:58:54 INFO - { 21:58:54 INFO - "project": "", 21:58:54 INFO - "product": "firefox", 21:58:54 INFO - "script_repo_revision": "production", 21:58:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 21:58:54 INFO - "repository": "", 21:58:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 21:58:54 INFO - "buildid": "20161220201353", 21:58:54 INFO - "pgo_build": "False", 21:58:54 INFO - "basedir": "/builds/slave/test", 21:58:54 INFO - "buildnumber": 37, 21:58:54 INFO - "slavename": "t-yosemite-r7-0066", 21:58:54 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 21:58:54 INFO - "platform": "yosemite_r7", 21:58:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:58:54 INFO - "branch": "mozilla-central", 21:58:54 INFO - "repo_path": "mozilla-central", 21:58:54 INFO - "revision": "20774bffb62a3c1fecf98ed8ad9ee1a861bcd9b7", 21:58:54 INFO - "stage_platform": "macosx64", 21:58:54 INFO - "builduid": "856c8a10b3e24fb69d4abe6b477e9266", 21:58:54 INFO - "slavebuilddir": "test" 21:58:54 INFO - } 21:58:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 21:58:54 INFO - Running post-action listener: _resource_record_post_action 21:58:54 INFO - [mozharness: 2016-12-21 05:58:54.916822Z] Finished read-buildbot-config step (success) 21:58:54 INFO - [mozharness: 2016-12-21 05:58:54.916971Z] Running download-and-extract step. 21:58:54 INFO - Running pre-action listener: _resource_record_pre_action 21:58:54 INFO - Running main action method: download_and_extract 21:58:54 INFO - mkdir: /builds/slave/test/build/tests 21:58:54 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:58:54 INFO - trying https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 21:58:54 INFO - Downloading https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:58:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 21:58:56 INFO - Downloaded 1199 bytes. 21:58:56 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 21:58:56 INFO - Using the following test package requirements: 21:58:56 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:58:56 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:56 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 21:58:56 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:56 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 21:58:56 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:56 INFO - u'jsshell-mac.zip'], 21:58:56 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:56 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 21:58:56 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 21:58:56 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:56 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 21:58:56 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:56 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 21:58:56 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:56 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 21:58:56 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 21:58:56 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 21:58:56 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:58:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:58:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:58:56 INFO - Fetch https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:58:57 INFO - Expected file size: 16277718 21:58:57 INFO - Obtained file size: 16277718 21:59:04 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:59:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 21:59:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:59:04 INFO - Fetch https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 21:59:05 INFO - Expected file size: 16277718 21:59:05 INFO - Obtained file size: 16277718 21:59:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 21:59:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:59:11 INFO - Fetch https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 21:59:13 INFO - Expected file size: 14409734 21:59:13 INFO - Obtained file size: 14409734 21:59:13 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:59:13 INFO - trying https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:59:13 INFO - Downloading https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 21:59:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 21:59:15 INFO - Downloaded 69609572 bytes. 21:59:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:59:15 INFO - mkdir: /builds/slave/test/properties 21:59:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:59:15 INFO - Writing to file /builds/slave/test/properties/build_url 21:59:15 INFO - Contents: 21:59:15 INFO - build_url:https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 21:59:16 INFO - Running post-action listener: _resource_record_post_action 21:59:16 INFO - Running post-action listener: set_extra_try_arguments 21:59:16 INFO - [mozharness: 2016-12-21 05:59:16.650303Z] Finished download-and-extract step (success) 21:59:16 INFO - [mozharness: 2016-12-21 05:59:16.650449Z] Running populate-webroot step. 21:59:16 INFO - Running pre-action listener: _resource_record_pre_action 21:59:16 INFO - Running main action method: populate_webroot 21:59:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:16 INFO - '--tppagecycles', 21:59:16 INFO - '7'], 21:59:16 INFO - 'tests': ['tsvgm']}}, 21:59:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:59:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:59:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:59:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:59:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:59:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:59:16 INFO - 'talos_options': ['--disable-e10s'], 21:59:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:59:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:59:16 INFO - 'talos_options': ['--disable-e10s'], 21:59:16 INFO - 'tests': ['damp', 'tps']}, 21:59:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:59:16 INFO - 'tests': ['damp', 'tps']}, 21:59:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:59:16 INFO - 'tests': ['dromaeo_dom']}, 21:59:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:59:16 INFO - 'tests': ['basic_compositor_video']}, 21:59:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:59:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:59:16 INFO - 'tests': ['a11yr', 21:59:16 INFO - 'ts_paint', 21:59:16 INFO - 'tpaint', 21:59:16 INFO - 'sessionrestore', 21:59:16 INFO - 'sessionrestore_no_auto_restore', 21:59:16 INFO - 'tabpaint']}, 21:59:16 INFO - 'other-e10s': {'tests': ['a11yr', 21:59:16 INFO - 'ts_paint', 21:59:16 INFO - 'tpaint', 21:59:16 INFO - 'sessionrestore', 21:59:16 INFO - 'sessionrestore_no_auto_restore', 21:59:16 INFO - 'tabpaint']}, 21:59:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:59:16 INFO - 'ts_paint', 21:59:16 INFO - 'tpaint', 21:59:16 INFO - 'sessionrestore', 21:59:16 INFO - 'sessionrestore_no_auto_restore', 21:59:16 INFO - 'tabpaint']}, 21:59:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:59:16 INFO - 'ts_paint', 21:59:16 INFO - 'tpaint', 21:59:16 INFO - 'sessionrestore', 21:59:16 INFO - 'sessionrestore_no_auto_restore', 21:59:16 INFO - 'tabpaint']}, 21:59:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:59:16 INFO - 'tests': ['a11yr', 21:59:16 INFO - 'ts_paint', 21:59:16 INFO - 'tpaint', 21:59:16 INFO - 'sessionrestore', 21:59:16 INFO - 'sessionrestore_no_auto_restore', 21:59:16 INFO - 'tabpaint']}, 21:59:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:59:16 INFO - 'tests': ['a11yr', 21:59:16 INFO - 'ts_paint', 21:59:16 INFO - 'tpaint', 21:59:16 INFO - 'sessionrestore', 21:59:16 INFO - 'sessionrestore_no_auto_restore', 21:59:16 INFO - 'tabpaint']}, 21:59:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:59:16 INFO - 'tests': ['tsvgx', 21:59:16 INFO - 'tsvgr_opacity', 21:59:16 INFO - 'tart', 21:59:16 INFO - 'tscrollx', 21:59:16 INFO - 'cart', 21:59:16 INFO - 'tsvg_static']}, 21:59:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:59:16 INFO - 'tsvgr_opacity', 21:59:16 INFO - 'tart', 21:59:16 INFO - 'tscrollx', 21:59:16 INFO - 'cart', 21:59:16 INFO - 'tsvg_static']}, 21:59:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:59:16 INFO - 'talos_options': ['--disable-e10s'], 21:59:16 INFO - 'tests': ['tp5o']}, 21:59:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:59:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:59:16 INFO - 'talos_options': ['--disable-e10s', 21:59:16 INFO - '--xperf_path', 21:59:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:16 INFO - 'tests': ['tp5n']}, 21:59:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:59:16 INFO - 'talos_options': ['--xperf_path', 21:59:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:16 INFO - 'tests': ['tp5n']}}, 21:59:16 INFO - 'talos.zip': {'path': '', 21:59:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:16 INFO - Running post-action listener: _resource_record_post_action 21:59:16 INFO - [mozharness: 2016-12-21 05:59:16.669587Z] Finished populate-webroot step (success) 21:59:16 INFO - [mozharness: 2016-12-21 05:59:16.669719Z] Running create-virtualenv step. 21:59:16 INFO - Running pre-action listener: _resource_record_pre_action 21:59:16 INFO - Running main action method: create_virtualenv 21:59:16 INFO - Creating virtualenv /builds/slave/test/build/venv 21:59:16 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:59:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:59:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:16 INFO - Using real prefix '/tools/python27' 21:59:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:59:17 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:20 INFO - Installing pip.................done. 21:59:20 INFO - Return code: 0 21:59:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:59:20 INFO - Reading from file tmpfile_stdout 21:59:20 INFO - Output received: 21:59:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:59:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10492bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9c0c75e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104709d30>, '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 0x104630db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046febe8>, '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.I9K67pyzFJ/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.EboKBxntCq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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:59:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:59:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9K67pyzFJ/Render', 21:59:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:20 INFO - 'HOME': '/Users/cltbld', 21:59:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:20 INFO - 'LOGNAME': 'cltbld', 21:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:20 INFO - 'MOZ_NO_REMOTE': '1', 21:59:20 INFO - 'NO_EM_RESTART': '1', 21:59:20 INFO - 'PAGER': '/bin/cat', 21:59:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:20 INFO - 'PWD': '/builds/slave/test', 21:59:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:20 INFO - 'SHELL': '/bin/bash', 21:59:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EboKBxntCq/Listeners', 21:59:20 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 21:59:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:20 INFO - 'USER': 'cltbld', 21:59:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:20 INFO - 'XPC_FLAGS': '0x0', 21:59:20 INFO - 'XPC_SERVICE_NAME': '0', 21:59:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:20 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:59:20 INFO - Cleaning up... 21:59:20 INFO - Return code: 0 21:59:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10492bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9c0c75e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104709d30>, '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 0x104630db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046febe8>, '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.I9K67pyzFJ/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.EboKBxntCq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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:59:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:59:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9K67pyzFJ/Render', 21:59:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:20 INFO - 'HOME': '/Users/cltbld', 21:59:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:20 INFO - 'LOGNAME': 'cltbld', 21:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:20 INFO - 'MOZ_NO_REMOTE': '1', 21:59:20 INFO - 'NO_EM_RESTART': '1', 21:59:20 INFO - 'PAGER': '/bin/cat', 21:59:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:20 INFO - 'PWD': '/builds/slave/test', 21:59:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:20 INFO - 'SHELL': '/bin/bash', 21:59:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EboKBxntCq/Listeners', 21:59:20 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 21:59:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:20 INFO - 'USER': 'cltbld', 21:59:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:20 INFO - 'XPC_FLAGS': '0x0', 21:59:20 INFO - 'XPC_SERVICE_NAME': '0', 21:59:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:21 INFO - Downloading/unpacking psutil>=3.1.1 21:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:59:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:24 INFO - Installing collected packages: psutil 21:59:24 INFO - Running setup.py install for psutil 21:59:24 INFO - building 'psutil._psutil_osx' extension 21:59:24 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:59:25 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:59:25 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:59:25 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:59:25 INFO - building 'psutil._psutil_posix' extension 21:59:25 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:59:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:59:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:59:25 INFO - ^ 21:59:25 INFO - 1 warning generated. 21:59:25 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:59:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:25 INFO - Successfully installed psutil 21:59:25 INFO - Cleaning up... 21:59:25 INFO - Return code: 0 21:59:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:25 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 0x10492bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9c0c75e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104709d30>, '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 0x104630db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046febe8>, '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.I9K67pyzFJ/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.EboKBxntCq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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:59:25 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:59:25 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:59:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9K67pyzFJ/Render', 21:59:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:25 INFO - 'HOME': '/Users/cltbld', 21:59:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:25 INFO - 'LOGNAME': 'cltbld', 21:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:25 INFO - 'MOZ_NO_REMOTE': '1', 21:59:25 INFO - 'NO_EM_RESTART': '1', 21:59:25 INFO - 'PAGER': '/bin/cat', 21:59:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:25 INFO - 'PWD': '/builds/slave/test', 21:59:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:25 INFO - 'SHELL': '/bin/bash', 21:59:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EboKBxntCq/Listeners', 21:59:25 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 21:59:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:25 INFO - 'USER': 'cltbld', 21:59:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:25 INFO - 'XPC_FLAGS': '0x0', 21:59:25 INFO - 'XPC_SERVICE_NAME': '0', 21:59:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:59:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:59:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:59:28 INFO - Installing collected packages: mozsystemmonitor 21:59:28 INFO - Running setup.py install for mozsystemmonitor 21:59:29 INFO - Successfully installed mozsystemmonitor 21:59:29 INFO - Cleaning up... 21:59:29 INFO - Return code: 0 21:59:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10492bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9c0c75e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104709d30>, '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 0x104630db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046febe8>, '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.I9K67pyzFJ/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.EboKBxntCq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:59:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9K67pyzFJ/Render', 21:59:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:29 INFO - 'HOME': '/Users/cltbld', 21:59:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:29 INFO - 'LOGNAME': 'cltbld', 21:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:29 INFO - 'MOZ_NO_REMOTE': '1', 21:59:29 INFO - 'NO_EM_RESTART': '1', 21:59:29 INFO - 'PAGER': '/bin/cat', 21:59:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:29 INFO - 'PWD': '/builds/slave/test', 21:59:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:29 INFO - 'SHELL': '/bin/bash', 21:59:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EboKBxntCq/Listeners', 21:59:29 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 21:59:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:29 INFO - 'USER': 'cltbld', 21:59:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:29 INFO - 'XPC_FLAGS': '0x0', 21:59:29 INFO - 'XPC_SERVICE_NAME': '0', 21:59:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:29 INFO - Downloading/unpacking jsonschema==2.5.1 21:59:29 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:59:29 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:59:29 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:59:29 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:59:29 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:59:29 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:59:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:59:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:32 INFO - Downloading functools32-3.2.3-2.tar.gz 21:59:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:59:32 INFO - warning: no files found matching '*.txt' 21:59:32 INFO - no previously-included directories found matching 'build' 21:59:32 INFO - no previously-included directories found matching 'dist' 21:59:32 INFO - no previously-included directories found matching '.git*' 21:59:32 INFO - Installing collected packages: jsonschema, functools32 21:59:32 INFO - Running setup.py install for functools32 21:59:32 INFO - warning: no files found matching '*.txt' 21:59:32 INFO - no previously-included directories found matching 'build' 21:59:32 INFO - no previously-included directories found matching 'dist' 21:59:32 INFO - no previously-included directories found matching '.git*' 21:59:32 INFO - Successfully installed jsonschema functools32 21:59:32 INFO - Cleaning up... 21:59:32 INFO - Return code: 0 21:59:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:59:32 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:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:32 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:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:32 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 0x10492bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9c0c75e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104709d30>, '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 0x104630db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046febe8>, '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.I9K67pyzFJ/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.EboKBxntCq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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:59:32 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:59:32 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:59:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9K67pyzFJ/Render', 21:59:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:32 INFO - 'HOME': '/Users/cltbld', 21:59:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:32 INFO - 'LOGNAME': 'cltbld', 21:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:32 INFO - 'MOZ_NO_REMOTE': '1', 21:59:32 INFO - 'NO_EM_RESTART': '1', 21:59:32 INFO - 'PAGER': '/bin/cat', 21:59:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:32 INFO - 'PWD': '/builds/slave/test', 21:59:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:32 INFO - 'SHELL': '/bin/bash', 21:59:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EboKBxntCq/Listeners', 21:59:32 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 21:59:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:32 INFO - 'USER': 'cltbld', 21:59:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:32 INFO - 'XPC_FLAGS': '0x0', 21:59:32 INFO - 'XPC_SERVICE_NAME': '0', 21:59:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:59:33 INFO - Cleaning up... 21:59:33 INFO - Return code: 0 21:59:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:59:33 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:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:33 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:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:33 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 0x10492bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9c0c75e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104709d30>, '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 0x104630db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046febe8>, '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.I9K67pyzFJ/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.EboKBxntCq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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:59:33 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:59:33 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:59:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9K67pyzFJ/Render', 21:59:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:33 INFO - 'HOME': '/Users/cltbld', 21:59:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:33 INFO - 'LOGNAME': 'cltbld', 21:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:33 INFO - 'MOZ_NO_REMOTE': '1', 21:59:33 INFO - 'NO_EM_RESTART': '1', 21:59:33 INFO - 'PAGER': '/bin/cat', 21:59:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:33 INFO - 'PWD': '/builds/slave/test', 21:59:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:33 INFO - 'SHELL': '/bin/bash', 21:59:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EboKBxntCq/Listeners', 21:59:33 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 21:59:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:33 INFO - 'USER': 'cltbld', 21:59:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:33 INFO - 'XPC_FLAGS': '0x0', 21:59:33 INFO - 'XPC_SERVICE_NAME': '0', 21:59:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:33 INFO - Downloading/unpacking blobuploader==1.2.4 21:59:33 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:59:33 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:59:33 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:59:33 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:59:33 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:59:33 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:59:36 INFO - Downloading blobuploader-1.2.4.tar.gz 21:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:59:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 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:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:59:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:59:37 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:59:37 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:59:37 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:59:37 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:59:37 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:59:37 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:59:37 INFO - Downloading docopt-0.6.1.tar.gz 21:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:59:37 INFO - Installing collected packages: blobuploader, requests, docopt 21:59:37 INFO - Running setup.py install for blobuploader 21:59:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:59:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:59:37 INFO - Running setup.py install for requests 21:59:38 INFO - Running setup.py install for docopt 21:59:38 INFO - Successfully installed blobuploader requests docopt 21:59:38 INFO - Cleaning up... 21:59:38 INFO - Return code: 0 21:59:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:38 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 0x10492bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9c0c75e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104709d30>, '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 0x104630db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046febe8>, '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.I9K67pyzFJ/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.EboKBxntCq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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:59:38 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:59:38 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:59:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9K67pyzFJ/Render', 21:59:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:38 INFO - 'HOME': '/Users/cltbld', 21:59:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:38 INFO - 'LOGNAME': 'cltbld', 21:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:38 INFO - 'MOZ_NO_REMOTE': '1', 21:59:38 INFO - 'NO_EM_RESTART': '1', 21:59:38 INFO - 'PAGER': '/bin/cat', 21:59:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:38 INFO - 'PWD': '/builds/slave/test', 21:59:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:38 INFO - 'SHELL': '/bin/bash', 21:59:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EboKBxntCq/Listeners', 21:59:38 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 21:59:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:38 INFO - 'USER': 'cltbld', 21:59:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:38 INFO - 'XPC_FLAGS': '0x0', 21:59:38 INFO - 'XPC_SERVICE_NAME': '0', 21:59:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:59:38 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-u88YsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:59:38 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-2jpbT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:59:38 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-DyFos9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:59:39 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-9ZgOmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:59:39 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-lWaxNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:59:39 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-NPlKqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:59:39 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-g7aHmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:59:39 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-_zNipu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:59:39 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-IdJ8Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:59:39 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-OpnmZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:59:39 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-frL2Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:59:39 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-nqVyTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:59:40 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-UWLLJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:59:40 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-6WTC3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:40 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-mTKqQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:59:40 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-biAtea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:59:40 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-Z1syh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:59:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:59:40 INFO - Running setup.py install for manifestparser 21:59:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:59:40 INFO - Running setup.py install for mozcrash 21:59:40 INFO - Running setup.py install for mozdebug 21:59:40 INFO - Running setup.py install for mozdevice 21:59:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:59:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:59:41 INFO - Running setup.py install for mozfile 21:59:41 INFO - Running setup.py install for mozhttpd 21:59:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:59:41 INFO - Running setup.py install for mozinfo 21:59:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:59:41 INFO - Running setup.py install for mozInstall 21:59:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:59:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:59:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:59:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:59:41 INFO - Running setup.py install for mozleak 21:59:41 INFO - Running setup.py install for mozlog 21:59:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Running setup.py install for moznetwork 21:59:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Running setup.py install for mozprocess 21:59:42 INFO - Running setup.py install for mozprofile 21:59:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Running setup.py install for mozrunner 21:59:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:59:42 INFO - Running setup.py install for mozscreenshot 21:59:42 INFO - Running setup.py install for moztest 21:59:42 INFO - Running setup.py install for mozversion 21:59:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:59:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:59:43 INFO - Cleaning up... 21:59:43 INFO - Return code: 0 21:59:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:43 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 0x10492bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9c0c75e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104709d30>, '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 0x104630db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046febe8>, '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.I9K67pyzFJ/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.EboKBxntCq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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:59:43 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:59:43 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:59:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9K67pyzFJ/Render', 21:59:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:43 INFO - 'HOME': '/Users/cltbld', 21:59:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:43 INFO - 'LOGNAME': 'cltbld', 21:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:43 INFO - 'MOZ_NO_REMOTE': '1', 21:59:43 INFO - 'NO_EM_RESTART': '1', 21:59:43 INFO - 'PAGER': '/bin/cat', 21:59:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:43 INFO - 'PWD': '/builds/slave/test', 21:59:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:43 INFO - 'SHELL': '/bin/bash', 21:59:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EboKBxntCq/Listeners', 21:59:43 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 21:59:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:43 INFO - 'USER': 'cltbld', 21:59:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:43 INFO - 'XPC_FLAGS': '0x0', 21:59:43 INFO - 'XPC_SERVICE_NAME': '0', 21:59:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:59:43 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-w2U9tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:59:43 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:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:59:43 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-rxwVNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:59:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:59:43 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-mbj_0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:59:43 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:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:59:43 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-wgS_7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:59:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:59:43 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-qLl3IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:59:43 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:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:59:43 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-S5nRcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:59:44 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:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:59:44 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-yPnQhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:59:44 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:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:59:44 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-E69uXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:59:44 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:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:59:44 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-WXxOVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:59:44 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:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:59:44 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-ZNDEy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:59:44 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:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:59:44 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-CRfA4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:59:44 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:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:59:44 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-eTkjDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:59:44 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:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:59:44 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-8PQkWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:59:44 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:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:59:44 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-tWjDLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:44 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-1Eoi8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:45 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:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:59:45 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-bI59qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:59:45 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:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:59:45 INFO - Running setup.py (path:/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/pip-V3nAFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:59:45 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:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:59:45 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:59:45 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:59:45 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:59:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:59:45 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:59:45 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:59:45 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:59:45 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:59:45 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:59:45 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:59:47 INFO - Downloading blessings-1.6.tar.gz 21:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:59:47 INFO - Installing collected packages: blessings 21:59:47 INFO - Running setup.py install for blessings 21:59:48 INFO - Successfully installed blessings 21:59:48 INFO - Cleaning up... 21:59:48 INFO - Return code: 0 21:59:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:59:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:59:48 INFO - Reading from file tmpfile_stdout 21:59:48 INFO - Current package versions: 21:59:48 INFO - blessings == 1.6 21:59:48 INFO - blobuploader == 1.2.4 21:59:48 INFO - docopt == 0.6.1 21:59:48 INFO - functools32 == 3.2.3-2 21:59:48 INFO - jsonschema == 2.5.1 21:59:48 INFO - manifestparser == 1.1 21:59:48 INFO - mozInstall == 1.12 21:59:48 INFO - mozcrash == 1.0 21:59:48 INFO - mozdebug == 0.1 21:59:48 INFO - mozdevice == 0.49 21:59:48 INFO - mozfile == 1.2 21:59:48 INFO - mozhttpd == 0.7 21:59:48 INFO - mozinfo == 0.9 21:59:48 INFO - mozleak == 0.1 21:59:48 INFO - mozlog == 3.4 21:59:48 INFO - moznetwork == 0.27 21:59:48 INFO - mozprocess == 0.23 21:59:48 INFO - mozprofile == 0.28 21:59:48 INFO - mozrunner == 6.13 21:59:48 INFO - mozscreenshot == 0.1 21:59:48 INFO - mozsystemmonitor == 0.3 21:59:48 INFO - moztest == 0.7 21:59:48 INFO - mozversion == 1.4 21:59:48 INFO - psutil == 3.1.1 21:59:48 INFO - requests == 1.2.3 21:59:48 INFO - wsgiref == 0.1.2 21:59:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59:48 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:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:48 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:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:49 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 0x10492bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9c0c75e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104709d30>, '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 0x104630db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046febe8>, '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.I9K67pyzFJ/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.EboKBxntCq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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:59:49 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:59:49 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:59:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9K67pyzFJ/Render', 21:59:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:49 INFO - 'HOME': '/Users/cltbld', 21:59:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:49 INFO - 'LOGNAME': 'cltbld', 21:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:49 INFO - 'MOZ_NO_REMOTE': '1', 21:59:49 INFO - 'NO_EM_RESTART': '1', 21:59:49 INFO - 'PAGER': '/bin/cat', 21:59:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:49 INFO - 'PWD': '/builds/slave/test', 21:59:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:49 INFO - 'SHELL': '/bin/bash', 21:59:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EboKBxntCq/Listeners', 21:59:49 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 21:59:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:49 INFO - 'USER': 'cltbld', 21:59:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:49 INFO - 'XPC_FLAGS': '0x0', 21:59:49 INFO - 'XPC_SERVICE_NAME': '0', 21:59:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:49 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:59:49 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:59:49 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:59:49 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:59:49 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:59:49 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:59:49 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:59:49 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:59:49 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:59:49 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:59:49 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:59:49 INFO - Cleaning up... 21:59:49 INFO - Return code: 0 21:59:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:59: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:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10492bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10492e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9c0c75e60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104709d30>, '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 0x104630db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046febe8>, '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.I9K67pyzFJ/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.EboKBxntCq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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:59: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'] in /builds/slave/test/build 21:59: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 21:59:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9K67pyzFJ/Render', 21:59:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:49 INFO - 'HOME': '/Users/cltbld', 21:59:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:49 INFO - 'LOGNAME': 'cltbld', 21:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:49 INFO - 'MOZ_NO_REMOTE': '1', 21:59:49 INFO - 'NO_EM_RESTART': '1', 21:59:49 INFO - 'PAGER': '/bin/cat', 21:59:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:49 INFO - 'PWD': '/builds/slave/test', 21:59:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:49 INFO - 'SHELL': '/bin/bash', 21:59:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EboKBxntCq/Listeners', 21:59:49 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 21:59:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:49 INFO - 'USER': 'cltbld', 21:59:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:49 INFO - 'XPC_FLAGS': '0x0', 21:59:49 INFO - 'XPC_SERVICE_NAME': '0', 21:59:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:59:50 INFO - Cleaning up... 21:59:50 INFO - Return code: 0 21:59:50 INFO - Running post-action listener: _resource_record_post_action 21:59:50 INFO - Running post-action listener: _start_resource_monitoring 21:59:50 INFO - Starting resource monitoring. 21:59:50 INFO - [mozharness: 2016-12-21 05:59:50.180909Z] Finished create-virtualenv step (success) 21:59:50 INFO - [mozharness: 2016-12-21 05:59:50.181882Z] Running install step. 21:59:50 INFO - Running pre-action listener: _resource_record_pre_action 21:59:50 INFO - Running main action method: install 21:59:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:59:50 INFO - Reading from file tmpfile_stdout 21:59:50 INFO - Detecting whether we're running mozinstall >=1.0... 21:59:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:59:50 INFO - Reading from file tmpfile_stdout 21:59:50 INFO - Output received: 21:59:50 INFO - Usage: mozinstall [options] installer 21:59:50 INFO - Options: 21:59:50 INFO - -h, --help show this help message and exit 21:59:50 INFO - -d DEST, --destination=DEST 21:59:50 INFO - Directory to install application into. [default: 21:59:50 INFO - "/builds/slave/test"] 21:59:50 INFO - --app=APP Application being installed. [default: firefox] 21:59:50 INFO - mkdir: /builds/slave/test/build/application 21:59:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:59:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 22:00:12 INFO - Reading from file tmpfile_stdout 22:00:12 INFO - Output received: 22:00:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:00:12 INFO - Running post-action listener: _resource_record_post_action 22:00:12 INFO - [mozharness: 2016-12-21 06:00:12.537100Z] Finished install step (success) 22:00:12 INFO - [mozharness: 2016-12-21 06:00:12.537291Z] Running run-tests step. 22:00:12 INFO - Running pre-action listener: _resource_record_pre_action 22:00:12 INFO - Running main action method: run_tests 22:00:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:00:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:00:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:00:12 INFO - 2016-12-20 22:00:12.552 screenresolution[1627:7403] starting screenresolution argv=screenresolution get 22:00:12 INFO - 2016-12-20 22:00:12.555 screenresolution[1627:7403] Display 0: 1600x1200x32@60 22:00:12 INFO - 2016-12-20 22:00:12.561 screenresolution[1628:7406] starting screenresolution argv=screenresolution list 22:00:12 INFO - Available Modes on Display 0 22:00:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:00:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:00:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:00:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:00:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:00:12 INFO - Intel Iris: 22:00:12 INFO - Chipset Model: Intel Iris 22:00:12 INFO - Type: GPU 22:00:12 INFO - Bus: Built-In 22:00:12 INFO - VRAM (Dynamic, Max): 1536 MB 22:00:12 INFO - Vendor: Intel (0x8086) 22:00:12 INFO - Device ID: 0x0a2e 22:00:12 INFO - Revision ID: 0x0009 22:00:12 INFO - Displays: 22:00:12 INFO - Display: 22:00:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:00:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:00:12 INFO - Display Serial Number: 1600x1200 60 22:00:12 INFO - Main Display: Yes 22:00:12 INFO - Mirror: Off 22:00:12 INFO - Online: Yes 22:00:12 INFO - Rotation: Supported 22:00:12 INFO - Return code: 0 22:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:00:12 INFO - Python 2.7.3 22:00:12 INFO - Return code: 0 22:00:12 INFO - grabbing minidump binary from tooltool 22:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:12 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 0x104709d30>, '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 0x104630db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1046febe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:00:12 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 22:00:12 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 22:00:12 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 22:00:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:12 INFO - Return code: 0 22:00:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:00:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:00:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:00:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:00:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 22:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0066 --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 22:00:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.I9K67pyzFJ/Render', 22:00:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:12 INFO - 'HOME': '/Users/cltbld', 22:00:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:12 INFO - 'LOGNAME': 'cltbld', 22:00:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:00:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:12 INFO - 'MOZ_NO_REMOTE': '1', 22:00:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:00:12 INFO - 'NO_EM_RESTART': '1', 22:00:12 INFO - 'PAGER': '/bin/cat', 22:00:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:12 INFO - 'PWD': '/builds/slave/test', 22:00:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:00:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:12 INFO - 'SHELL': '/bin/bash', 22:00:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EboKBxntCq/Listeners', 22:00:12 INFO - 'TMPDIR': '/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/', 22:00:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:12 INFO - 'USER': 'cltbld', 22:00:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:12 INFO - 'XPC_FLAGS': '0x0', 22:00:12 INFO - 'XPC_SERVICE_NAME': '0', 22:00:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0066', '--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 22:00:13 INFO - mozversion application_buildid: 20161220201353 22:00:13 INFO - mozversion application_changeset: 20774bffb62a3c1fecf98ed8ad9ee1a861bcd9b7 22:00:13 INFO - mozversion application_display_name: Nightly 22:00:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:13 INFO - mozversion application_name: Firefox 22:00:13 INFO - mozversion application_remotingname: firefox 22:00:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:00:13 INFO - mozversion application_vendor: Mozilla 22:00:13 INFO - mozversion application_version: 53.0a1 22:00:13 INFO - mozversion platform_buildid: 20161220201353 22:00:13 INFO - mozversion platform_changeset: 20774bffb62a3c1fecf98ed8ad9ee1a861bcd9b7 22:00:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:00:13 INFO - mozversion platform_version: 53.0a1 22:00:13 INFO - using testdate: 1482300013 22:00:13 INFO - actual date: 1482300013 22:00:13 INFO - starting webserver on 'localhost:49242' 22:00:13 INFO - SUITE-START | Running 2 tests 22:00:13 INFO - TEST-START | dromaeo_css 22:00:13 INFO - operating with platform_type : mac_ 22:00:13 INFO - Initialising browser for dromaeo_css test... 22:00:13 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmp69cu1L/profile http://localhost:49242/getInfo.html) 22:00:16 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 22:00:16 INFO - PROCESS | 1638 | colorDepth:24 22:00:16 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 22:00:16 INFO - PROCESS | 1638 | __metrics 22:00:16 INFO - PROCESS | 1638 | 2016-12-20 22:00:16.129 plugin-container[1640:7576] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e33, name = 'com.apple.tsm.portname' 22:00:16 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:00:16 INFO - PROCESS | 1638 | 2016-12-20 22:00:16.132 plugin-container[1640:7576] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b1f, name = 'com.apple.CFPasteboardClient' 22:00:16 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:00:16 INFO - PROCESS | 1638 | 2016-12-20 22:00:16.132 plugin-container[1640:7576] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:00:16 ERROR - PROCESS | 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3232: TypeError: this.tabs is undefined 22:00:16 INFO - TEST-INFO | 1638: exit 0 22:00:16 INFO - Browser initialized. 22:00:16 INFO - Running cycle 1/1 for dromaeo_css test... 22:00:16 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmp69cu1L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:19 INFO - PROCESS | 1641 | 2016-12-20 22:00:19.558 plugin-container[1642:7689] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433f, name = 'com.apple.tsm.portname' 22:00:19 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:00:19 INFO - PROCESS | 1641 | 2016-12-20 22:00:19.559 plugin-container[1642:7689] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 22:00:19 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:00:19 INFO - PROCESS | 1641 | 2016-12-20 22:00:19.559 plugin-container[1642:7689] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:00:29 INFO - PROCESS | 1641 | RSS: Main: 234651648 22:00:29 INFO - PROCESS | 1641 | 22:01:18 INFO - PROCESS | 1641 | 1482300078850 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] 22:03:32 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 22:03:34 INFO - PROCESS | 1641 | RSS: Main: 253640704 22:03:34 INFO - PROCESS | 1641 | 22:06:36 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 22:06:37 INFO - PROCESS | 1641 | RSS: Main: 265699328 22:06:37 INFO - PROCESS | 1641 | 22:09:39 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 22:09:40 INFO - PROCESS | 1641 | RSS: Main: 270966784 22:09:40 INFO - PROCESS | 1641 | 22:12:42 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 22:12:42 INFO - PROCESS | 1641 | RSS: Main: 269578240 22:12:42 INFO - PROCESS | 1641 | 22:15:45 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 22:15:46 INFO - PROCESS | 1641 | RSS: Main: 274206720 22:15:46 INFO - PROCESS | 1641 | 22:18:49 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 22:18:49 INFO - PROCESS | 1641 | RSS: Main: 277733376 22:18:49 INFO - PROCESS | 1641 | 22:18:49 INFO - PROCESS | 1641 | __start_tp_report 22:18:49 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 22:18:49 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 22:18:49 INFO - PROCESS | 1641 | |i|pagename|runs| 22:18:49 INFO - PROCESS | 1641 | |0;dojo.html;3399.5580574525306;3406.8466918988643;3426.280481098969;3441.5698037745283;3452.6202117767048;5050.646454748169;5081.1108056090125;5581.916271255935;5667.404922483137;5692.117721753125;5621.662700237978;5713.514351280146;5775.480206781399;5810.331811841629;5837.79567715129;4568.748718820463;4925.162722337212;5210.869728256786;5277.234800953878;5306.204069389584;5195.480451954812;5299.655522391032;5316.5215130638235;5324.574034077284;5377.220303056055;5121.462246464105;5165.509276618753;5266.683998960075;5287.550558202557;5295.338082739658;4195.8741237762915;5132;5248.160294352885;5284.81503147388;5313.1764576490705;5143.02282566315;5151.484851514856;5164.561012313958;5204.68771873685;5214.009338225763;4735.550122738335;5545.334559852803;5723.914141287884;5752.395998420147;5752.798652047159;6078.574499785017;6102.943731970943;6126.785562505335;6157.7536898524;6172.7530898764;6224.9688751556405;6252.937470625281;6257.342978987186;6262.906056409158;6274.278457977345;5794.5074668653215;5832.445917637818;5833.0375488044;5842.444967728059;5874.9412505874825;6120.660465672121;6202.844928876724;6204.906926396107;6221.408966148299;6246.6876656167005;5651.576131790132;6106.786754545499;6141.393954534099;6142.345304543789;6148.938510614926;4537.069900670354;5181.300524429229;5253.001929633434;5967.940320596826;6105.64170830808;6103.938960610426;6104.359042300494;6111.348653136725;6127.479164270998;6189;4871.464138944713;5939.584229103922;6163.96918015407;6208.906866397007;6221.844453888689;4816.470188279286;4908.386451693538;4911.238757992517;4918.5819205367225;4919.7540122993705;4264.658827293809;4371.9725864421835;4398.516163222043;4412.051408947092;4443;5773.047447171254;5821.650700957956;5866.6480011199465;5876.794312199053;5903.645781253139;6193.84515387119;6251.624902505864;6254.655993920378;6259.7496100156395;6281.968590157111;5450.618456708072;5792.594518383757;5798.159266906359;5801.564882633819;5825.766969321265;5211.687298762086;5259.710715910662;5263.394709608444;5320.467953204726;5334.813281535127;6279.529035322369;6284.057391391237;6299.527535434952;6300.0234963580715;6302.779402720883;6211.534134939988;6256.31180570146;6277.717502712298;6298.275698294755;6298.307186209605;6172.259328880563;6214.40963108504;6255.937440625536;6288.5283603728985;6302.684865756785;6113.385090541831;6184.690765461799;6186.164867742978;6221.564490485623;6229.53278504123;6233.127362169391;6234.345393733593;6248.12526246335;6253.656048917172;6287.74849006053;5782.971085144547;5892.204552385373;6068.4538391544975;6080.69596520181;6143.815685529441;5937.198478205387;5949.494292984971;6072.483838873745;6082.513398928164;6117.265928088658;5309.893802124013;5808.21589085485;6014.458698717136;6024.307204671519;6038.728257228523;5841.824745257649;6035.969820151046;6102.542309326729;6105.206323178136;6116.3883611638485;6011.338752737108;6030.939690603213;6032.366601506954;6068.605540639845;6109.266887973472 22:18:49 INFO - PROCESS | 1641 | |1;ext.html;448.53128480737627;465.7554783738538;482.08163448630347;488.09702051205255;570.6718636783847;35072.824635876816;37605.623943760555;37612;37716;37717.868463946055;31821.68178318216;37898.81050594743;38529.61470385295;38648.42027369592;38731.225375492475;8403.033651130107;8658.696945606906;8893.110688931103;9236.815263694722;10870.18473614482;10870.782584348308;11120.55517779288;11122.666320010372;11134.99785019348;11166.720831979224;11092.33445993239;11106.389148596823;11123.110151187926;11160.832587511193;11163.944180279128;11035.72410689735;11085.390303533302;11156.442177891155;11159;11178.329300242012;8609.870851937227;9572;10947.178961577834;11027.83458248127;11070.833937490945;35508.644913550794;37491.8125409374;37727;37772.81113594415;37778.811105944296;3233.4341490239112;3556.2354093869685;3572.7141828653644;3623.420252759572;3693.8522459101605;21447.46381340479;26544.336391590172;26631.600525992126;27274.5908811368;27492.45015099707;3149.937001259962;3190.7766456348063;3204.5834041574444;3205.6313523944814;3206.2144774530157;488619;494110;495932;500622;500940;42183.578164218576;51555.968880622175;51933.740331298104;51970.70073248199;52118.69703257373;54247;54683.72658136684;54962.45037549653;55043.17435238475;55064;14621.78067328991;14999.850001500063;15111.093334399971;15118.319675614624;15120.54638360851;10640.521176547074;10897.182711296684;11512.712182195344;11738.471768770425;11801.232919860182;16543.007419554626;16603.750943735853;16692.41576544815;16732.24704888283;17030.403935862185;7374.188839227681;7490.925090749131;7522.285382888617;7533.510321829063;7587.203343648947;808.2604416958535;887.3730288173142;951.9857202141974;1030.5447519013026;1053.115383078218;24611.753882461304;25461.745382545938;27519.036833710725;28821.423571528452;29210.7078929208;1006.1648831469862;1018.1294992781213;1047.1936608811172;1071.6945670483874;1127.9266847654876;11571.76856462866;14719.852801472063;14941.925290373696;15226.695466090838;15291;639098;643532;646094;647046;648142;54254.45745542494;54467;54792.45207547953;54868.17697734537;54869.45130548644;1327.774278372679;1375.8417781955204;1390.1172755300456;1391.2139641102947;1391.6660001599746;28413.715862841105;28700.712992869805;28731.5690264642;29229.97695080662;29432.852835735684;46189.76905115453;46642;46684;46708.299375510076;46761;546299;549969;550574;550859;551769;24282.878585607665;24978.125765598117;25038.62442063334;25077.74922250754;25671.17617062159;40078.398824018244;40115.398269025405;40303;40764.98087547835;40859.79570102131;33564.99305020853;33864.3227135451;34435.82782086074;34827.651723483454;34916;31423.528647069856;31436.842815785774;33082.5037624431;33817.49273760945;34243.31513369769;32984.505232422016;33559.83220083982;33574.83212584019;33588.49617255792;33984.830075849466;29491;29840.80636774505;30184.5472317911;30431.391372172875;30521.389572208875;17943.371981980566;20748.06633701457;23170.304890853302;23644.645330320403;23793.881030594737 22:18:49 INFO - PROCESS | 1641 | |2;jquery.html;292.64882141430286;371.27415901911746;372.9216864458464;386.07534953785665;402.5069290119602;18564.907175464137;18892.90553547232;19634.410967670956;19799.40601781947;19854.106565204565;17082;19459.708104378446;20183.899080504576;20536.8973155134;20554;5561;5597.776088956437;5828.912566311487;5829.242198514187;5844.094165404348;5613.550915926737;5717.399673034334;5749.741261643236;5756.625819321752;5760.308762948431;5579.609427340088;5615.736459296666;5686.943130568683;5706.486416222539;5730.742116604742;5550.250716153308;5651.886962260732;5669.348024977139;5671.7164141792955;5701.714914254312;4907.9263811042865;4941.061198372334;4960.280759289883;4987.202047672391;4999.925001124986;21456.356309310744;21609.67585486219;22238.88880555603;24767.752322476725;24839.62740558893;2215.423989762657;2259.3109101723967;2382.54731600997;2651.602259661047;2660.175345642838;14789.482368117064;15678.372865085383;15703.057816531045;15861.206939653086;16206.108664023473;1726.6891959447294;1789.9463016109537;1835.779706435223;1887.546589126365;1910.3122875764714;93340.06659933382;93747;94145;97759;99355.50322248414;10543.683689489328;10893;10911.83632245517;10940.890591093987;11153.888461115448;13628.454861805416;13778.173309601456;13785.379657915419;13785.793213101811;13794.517191898236;7756.224377562312;8088.757337279891;8365.330773538102;8486.19381158789;8583.871241931376;7498.587577683171;8285.212904774036;8328.8334233315;8342.499450033018;8379.287760540301;6631.653907779969;6753.898691519631;6767.526273160832;6825.726970921207;6886;1548.3342162869849;1730.7144321186863;1834.7981722010568;1875.8780679255806;1878.4083013850593;767.4167632599265;885.9589981771393;918.5499105438287;946.6450081219542;1005.8189525885265;15984.488589592382;17936.641267174582;18309.084545772657;20984.580308393746;21436.356909292746;809.7408829174608;946.2855544064188;993.2717072294156;998.8401855703053;1022.2077889635443;8541.871871921927;11261.268017578832;11436.771264574661;11504.827427588592;11515.754427886483;470151.6492417516;552453.2377338088;563571;568584;570242;119227;134252;137847;140759;141816;993.0615568288043;1026.1175389165312;1045.5086109528509;1045.628801775374;1047.9782212343057;15074.321655525748;18314.633707326044;19547.315843945395;19551.08978204393;19648.508787280432;36036.63963360333;37118;41418.37872431856;50473.49526504688;52492.47507524876;70727;74116;76917.23082769325;79296.60351698204;84186.57906710428;7866.646000929857;7950.204979502004;8074.3540516759695;8104.230098140667;8287.461315014505;11950.581729639422;12330.81503777462;12387.690307742017;12721.872781272068;12752.74494510123;10425.801032881012;10434.321769084985;10569.365838049742;10875.456227188452;11066;9470.384425012353;10264;10347.793044139225;10500.842487362543;10775.353478791298;8849.926325033179;9253.352265341362;10534.157267418741;10627.09669678086;10960.835587466036;7808.336291415293;7873.566953817595;8090.919090809017;8240.381971352292;8255;7977.282044616012;8807;9502.667406640734;10907.78184436291;10934.781304374028 22:18:49 INFO - PROCESS | 1641 | |3;mootools.html;1465.8754005909498;1498.5354540092571;1716.622343084521;1746.5109769264611;1871.2234422714582;7539.547627142375;7793.727219547317;7968.840623187532;8402.369822263325;8431.66273349066;7950.761477155695;8263.21499457552;8293.668253269861;8386.20331068549;8403.621837017334;2260.4461906832807;2297.655351697242;2300.5513924784673;2302.0561569756405;2310.9884450577724;2323.8954247058923;2359.7876191142796;2366.994027538289;2379.524095180962;2380.4048987753063;1896.80083591223;1900.8499857586169;2217.667349897512;2240.361496973363;2246.3710161154822;1882.5481884347726;2264.445210923318;2271.3299576624936;2272.3183045086407;2278.715160604924;2256.8758718270487;2281.406834223114;2284.234781348234;2284.7601001894727;2331;7596.442729240493;7860.449768516149;8384.83230335396;8401.201885820838;8420.621072051712;5028.673136246132;5187.144121219994;5194.428612852583;5196.376434827845;5205.9219111713355;3185.3629274145264;3270.100722301386;3425.4861770734587;3431.3823511767873;3433.416319225713;1010.1211945607295;1041.4740556019162;1045.4406892312577;1049.643121338741;1060.5174645536263;10768.192385571114;10774.138068954464;10802.13582913373;10901.672949811518;10962.068224200952;3731.6828069613844;4644.326572646947;4710.52894710533;4749.501302363271;4752.1921273383605;9320.06799320076;9399.10708482693;9418.858717119248;9430.90569094314;9435.292353073546;5164.767585458663;5193.870153246199;5194.584433245332;5198.2202669599865;5258.5267325940085;4240.809163587646;4293.441852559147;4689.859304220879;4737.786799594027;4775.641826863;3770.698344132463;3844.3272427325664;3889.9611003890163;3907.6873850091924;3920.9805450583053;1233.5497543396596;1267;1278.6164150754737;1283.8202651628778;1298.2470167302943;828.747232094205;890.5369208011798;902.4946030222965;923.5890028937193;949.838527450335;5412.458754124556;5823.650580965155;5828.94171058284;5846.853828654318;5872.559558033165;875.6322344615149;888.5868071346855;889;918.701422037827;920.889493260813;3829.215010922754;3848.6728628066926;3855.6529912307465;3951.7431366961055;4006.419069234945;9796.167325777245;10130.088292053602;10173;10173.694789156189;10212.642557510451;10019.549120289605;10128.442935638463;10140.340877843064;10168.33905796121;10189.337693049929;7045.542039767399;7412.888806667905;7440.255974402517;7724.0731112266885;7859.960700196462;4799.928001079917;5739.5695322850115;5909.704514774158;5952.226210592596;5988.730507127103;9067.727968160965;9270.675526356545;9278.582463789011;9401.52992350366;9419.293552983416;9382.48396338208;9431.669891553762;9435.811283774423;9442.15020648145;9564.282678798978;4788.545088216614;6203.689815509116;6823.93176068233;7007.283215612208;7289.052423184952;7833.529988200727;8000.359971202406;8008.519488830689;8013.799655008672;8055.798605034921;6152.569320147547;7073.929260707327;7177.641117944187;7255.600941948243;7262.491625586158;5692.516136128475;6101.755929762938;6754.696038678369;7001.649917504206;7020.087388639648;6605.47156227491;6656.201255849329;6667.066610674607;6721.395074443128;6743.325667433218;4790.281457781221;4833.564979151894;4874.634402419903;4901;5007.023630392038;4103.343465045578;4845;4998.950010499994;5002.324686167321;5006.49935006511 22:18:49 INFO - PROCESS | 1641 | |4;prototype.html;319.84807216572125;357.7924803613904;365.2785748147411;373.9027852758282;378.5759948857279;4597.5402459754005;4858.153901517428;4930.8767280818;5321.547668448182;5332.813351532697;4473.351364052219;5005.124103281929;5063.974680126595;5319.882824606828;5462.153366228241;4062.6546743526837;4263.189993901165;4288.914221715564;4302.182585308797;4304.548022457644;3691.3724666806575;4037.7375470594466;4291.313389857623;4302.26861433557;4319.308910574308;3906.4921560197135;3928.6464218220353;4068.6338229559333;4070.8982275443204;4072.470578824749;4094.5905409459115;4104.0970986382945;4117.485314335708;4120.608542188487;4149.502059752849;3424.195314101184;3527.5414196154593;3553.8578456861696;3565.0552603560077;3586.228960773446;4261.403403523509;4452.732836029849;5327.893442131136;5337.119375303109;5418.672425255798;4471.2398892188085;4683.531646835289;4714.292856071583;4722;4751.7624118794265;4836.564709176191;5095.363079615048;5559.385709860806;5725.828225153252;5809.970950145264;3172.476541370671;3603.1532589841368;3709.9426663401073;3848.2495913296916;3877.4571559981623;4964.478729733398;5324.760385782649;5435.456454354572;5639.238702775114;6102.9694851525455;3213.694699003591;3838.9232215356096;3956.4065390191126;3987.940180897289;3988.581198974124;3785.848566057382;3807.7715337079308;3968.6428221460205;3983.661388781928;4005.5593884673244;4434.645228381722;4501.257292546693;4646.442426908792;4654.394928659252;4747.715137091785;5022.744313921519;5240.4759524047295;5819.25730529617;5918.733656985446;5944.970275148597;1221.578555398404;1261.5143169879661;1273.7452509498137;1308.9672758180932;1309.508934149694;852.5098068610574;881.4314766975265;881.5151666583354;890.3900827932887;890.8552510024717;4509.977450112794;4848;4892.633052521075;5196.298499702491;5215.478452154754;5083.669561478492;5085.804835863569;5179.778480538349;5339.839804805862;5699.658020518699;4010.8903663661663;4365.257906155961;5041.571466425322;5052.747362631853;5107.416700822757;2576.2224065395194;2632.2364016109254;2795.888164473439;2842.7725781937397;2869.613855650311;5388.868337649137;5780.653160810365;5898.911516327258;5909.168157871074;5947.702614869239;4636.976815115971;5077.796888124508;5547.861303467445;5710.885782284331;5874.823755287348;5631.4087020863035;5796.681182535001;5805.796797112081;5882.264716910387;5968.791092311835;5166.870828229325;5265.420803711512;5451.3458384994055;5619.606627536034;5719.48524632785;4805.399325084364;5257.921131182959;5521.558275337883;5556.777728890799;5631.493165615114;5180.430152683127;5873.4126587340925;5884.676342801015;5907.3797251288;5963.70181490915;3113.7041981011766;3295.868165273362;3630.5659264589813;3782.508273924482;3789.696824253998;4524.742185626344;5247.55395791362;5629.943700563106;5668.178114173505;5713.400092990176;4836.613070954386;4922.901541969069;4981.850544483671;5648.519875810603;5864.706764661664;5454.945450545444;5807.647902599285;5812.244408226903;5884.882302353843;5887.970560147343;5361.169018802092;5668.886622267614;5673.5461163107675;5704.229928959538;5802.709864506842;5499.670019798825;5850.899023517542;5894.764209431574;5909.5863289569315;5936.5844390892225;5145.485451454824;5366.329208848894;5539.590278228983;5742.684152371659;5843.181954526284 22:18:49 INFO - PROCESS | 1641 | |5;yui.html;612.8069658057709;724.7173602295104;758.0335072782202;763.1910175214269;812.719611733952;14605.488807891727;14902.701945961087;15293.84706152938;15441.150736709476;15637.139957302357;13123.475060997549;13171.93414032931;13190;14993.925030374832;15520.844791552081;876.4697358098371;900.8063266397756;904.5567671840784;906.6554709210491;909.4361495872536;699.8915168148919;717.5909731453074;812.7724237213561;892.5314210039717;896.3501461440436;910.0990019880304;933.7712260496188;935.550935550936;935.9719208423725;936.442816524167;927.8747369105185;929.5677509957834;930.2511478259999;932.0912110692021;935.3546053223288;687.2543290529732;691.629977961788;695.2317688953734;696.6412297666706;697.5465947134403;14481.131132132;14897.627559310995;14910.329035193334;14912;14947.626309342244;13664;13911.79132313016;13928.51250206238;14027;14075.085119467201;11755.88244117565;11763.35301558414;11839.940800295943;11866.52533898643;12268.631941041784;3091.9536206956914;3518.683318501347;3692.8892133236045;3697.334479793636;3799.0692280391204;99216;105605.47197264041;106406;107431.31421714442;112412.4379378098;9495.192908602847;10402.427866467266;10570.577176912837;10597.470126493645;10737.463126843626;20854.792989180245;21451.892740536197;21457.570848582942;21531.78468215329;21560.78439215619;7706.190849960785;7754.069511658637;7834.686612535549;7904.841903161904;7913.248241417056;3711.7958512281543;4230.323148296257;4333.5016473106;4371.23503386906;4377.934330985037;3054.4501989641635;3452.7583069184916;3524.665156810099;3528.5236493073107;3550.55618047744;598.775459202799;616.0666590115978;620.3294815817857;624.9718762655691;630.8738252349549;572.8539222498237;585.689584520205;662.466390306439;663.9668016599247;677.9932200678029;8317.459365141247;8678.739637810875;8834.381593288408;9132.771680708036;9314;647.9449246814073;666.1306994372391;676.681959479044;683.4327508168209;690.1821341709989;4259.339802330644;4325.567443255649;4566.437928883343;4570.451545814523;4638.5593368629925;81617.77573336405;88882;97520;98488;99162;83080.58459707662;85937.14062859291;86769.56615216883;87641.12358876457;89518;65531.344686552526;75599.62200189073;77613;78989.81515277276;79139.60430197812;8703;8724.389292749447;8753.64985400577;8757.605907734294;8819.162179592928;49307.50692493029;49474;50821.74589127031;51257.286261336405;51464.742676287875;63377.36622633899;65620.67189664021;69555.65222174059;70367.29632703608;71050.93423598753;11440.199186056896;11571.537138514364;11675.474603642686;11715.472803723682;11759.118066145244;12599.811002834782;12674.302913339854;12802.679933001376;12863.807042894552;13216.839395043278;9957.950210248902;9981.750456238362;10598.735031624272;11839;12329.321887296284;9300.674476393293;10618.52216650268;11834.940825295818;12189.51241950312;12213.206141600767;9844.409335439897;10164.18686505063;11665.533378664759;12299.323537205539;12341.3829308536;8382.874256886274;8565.828683426422;10249.436281004617;10490.31812932157;10585.153187744809;7985.760427186961;8952.23905968;10212.285140040125;10340.224483163642;10343.741406464898 22:18:49 INFO - PROCESS | 1641 | __end_tp_report 22:18:49 INFO - PROCESS | 1641 | __start_cc_report 22:18:49 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,374 22:18:49 INFO - PROCESS | 1641 | __end_cc_report 22:18:49 INFO - PROCESS | 1641 | __startTimestamp1482301129593__endTimestamp 22:18:49 INFO - PROCESS | 1641 | 22:18:49 INFO - PROCESS | 1641 | ------- Summary: start ------- 22:18:49 INFO - PROCESS | 1641 | Number of tests: 6 22:18:49 INFO - PROCESS | 1641 | 22:18:49 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5677.21 Median:5876.79 stddev:656.19 (11.2%) stddev-sans-first:633.41 22:18:49 INFO - PROCESS | 1641 | Values: 3399.6 3406.8 3426.3 3441.6 3452.6 5050.6 5081.1 5581.9 5667.4 5692.1 5621.7 5713.5 5775.5 5810.3 5837.8 4568.7 4925.2 5210.9 5277.2 5306.2 5195.5 5299.7 5316.5 5324.6 5377.2 5121.5 5165.5 5266.7 5287.6 5295.3 4195.9 5132.0 5248.2 5284.8 5313.2 5143.0 5151.5 5164.6 5204.7 5214.0 4735.6 5545.3 5723.9 5752.4 5752.8 6078.6 6102.9 6126.8 6157.8 6172.8 6225.0 6252.9 6257.3 6262.9 6274.3 5794.5 5832.4 5833.0 5842.4 5874.9 6120.7 6202.8 6204.9 6221.4 6246.7 5651.6 6106.8 6141.4 6142.3 6148.9 4537.1 5181.3 5253.0 5967.9 6105.6 6103.9 6104.4 6111.3 6127.5 6189.0 4871.5 5939.6 6164.0 6208.9 6221.8 4816.5 4908.4 4911.2 4918.6 4919.8 4264.7 4372.0 4398.5 4412.1 4443.0 5773.0 5821.7 5866.6 5876.8 5903.6 6193.8 6251.6 6254.7 6259.7 6282.0 5450.6 5792.6 5798.2 5801.6 5825.8 5211.7 5259.7 5263.4 5320.5 5334.8 6279.5 6284.1 6299.5 6300.0 6302.8 6211.5 6256.3 6277.7 6298.3 6298.3 6172.3 6214.4 6255.9 6288.5 6302.7 6113.4 6184.7 6186.2 6221.6 6229.5 6233.1 6234.3 6248.1 6253.7 6287.7 5783.0 5892.2 6068.5 6080.7 6143.8 5937.2 5949.5 6072.5 6082.5 6117.3 5309.9 5808.2 6014.5 6024.3 6038.7 5841.8 6036.0 6102.5 6105.2 6116.4 6011.3 6030.9 6032.4 6068.6 6109.3 22:18:49 INFO - PROCESS | 1641 | 22:18:49 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:67679.82 Median:33033.50 stddev:151796.82 (459.5%) stddev-sans-first:152138.72 22:18:49 INFO - PROCESS | 1641 | Values: 448.5 465.8 482.1 488.1 570.7 35072.8 37605.6 37612.0 37716.0 37717.9 31821.7 37898.8 38529.6 38648.4 38731.2 8403.0 8658.7 8893.1 9236.8 10870.2 10870.8 11120.6 11122.7 11135.0 11166.7 11092.3 11106.4 11123.1 11160.8 11163.9 11035.7 11085.4 11156.4 11159.0 11178.3 8609.9 9572.0 10947.2 11027.8 11070.8 35508.6 37491.8 37727.0 37772.8 37778.8 3233.4 3556.2 3572.7 3623.4 3693.9 21447.5 26544.3 26631.6 27274.6 27492.5 3149.9 3190.8 3204.6 3205.6 3206.2 488619.0 494110.0 495932.0 500622.0 500940.0 42183.6 51556.0 51933.7 51970.7 52118.7 54247.0 54683.7 54962.5 55043.2 55064.0 14621.8 14999.9 15111.1 15118.3 15120.5 10640.5 10897.2 11512.7 11738.5 11801.2 16543.0 16603.8 16692.4 16732.2 17030.4 7374.2 7490.9 7522.3 7533.5 7587.2 808.3 887.4 952.0 1030.5 1053.1 24611.8 25461.7 27519.0 28821.4 29210.7 1006.2 1018.1 1047.2 1071.7 1127.9 11571.8 14719.9 14941.9 15226.7 15291.0 639098.0 643532.0 646094.0 647046.0 648142.0 54254.5 54467.0 54792.5 54868.2 54869.5 1327.8 1375.8 1390.1 1391.2 1391.7 28413.7 28700.7 28731.6 29230.0 29432.9 46189.8 46642.0 46684.0 46708.3 46761.0 546299.0 549969.0 550574.0 550859.0 551769.0 24282.9 24978.1 25038.6 25077.7 25671.2 40078.4 40115.4 40303.0 40765.0 40859.8 33565.0 33864.3 34435.8 34827.7 34916.0 31423.5 31436.8 33082.5 33817.5 34243.3 32984.5 33559.8 33574.8 33588.5 33984.8 29491.0 29840.8 30184.5 30431.4 30521.4 17943.4 20748.1 23170.3 23644.6 23793.9 22:18:49 INFO - PROCESS | 1641 | 22:18:49 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:32660.29 Median:18203.96 stddev:91399.49 (502.1%) stddev-sans-first:91623.58 22:18:49 INFO - PROCESS | 1641 | Values: 292.6 371.3 372.9 386.1 402.5 18564.9 18892.9 19634.4 19799.4 19854.1 17082.0 19459.7 20183.9 20536.9 20554.0 5561.0 5597.8 5828.9 5829.2 5844.1 5613.6 5717.4 5749.7 5756.6 5760.3 5579.6 5615.7 5686.9 5706.5 5730.7 5550.3 5651.9 5669.3 5671.7 5701.7 4907.9 4941.1 4960.3 4987.2 4999.9 21456.4 21609.7 22238.9 24767.8 24839.6 2215.4 2259.3 2382.5 2651.6 2660.2 14789.5 15678.4 15703.1 15861.2 16206.1 1726.7 1789.9 1835.8 1887.5 1910.3 93340.1 93747.0 94145.0 97759.0 99355.5 10543.7 10893.0 10911.8 10940.9 11153.9 13628.5 13778.2 13785.4 13785.8 13794.5 7756.2 8088.8 8365.3 8486.2 8583.9 7498.6 8285.2 8328.8 8342.5 8379.3 6631.7 6753.9 6767.5 6825.7 6886.0 1548.3 1730.7 1834.8 1875.9 1878.4 767.4 886.0 918.5 946.6 1005.8 15984.5 17936.6 18309.1 20984.6 21436.4 809.7 946.3 993.3 998.8 1022.2 8541.9 11261.3 11436.8 11504.8 11515.8 470151.6 552453.2 563571.0 568584.0 570242.0 119227.0 134252.0 137847.0 140759.0 141816.0 993.1 1026.1 1045.5 1045.6 1048.0 15074.3 18314.6 19547.3 19551.1 19648.5 36036.6 37118.0 41418.4 50473.5 52492.5 70727.0 74116.0 76917.2 79296.6 84186.6 7866.6 7950.2 8074.4 8104.2 8287.5 11950.6 12330.8 12387.7 12721.9 12752.7 10425.8 10434.3 10569.4 10875.5 11066.0 9470.4 10264.0 10347.8 10500.8 10775.4 8849.9 9253.4 10534.2 10627.1 10960.8 7808.3 7873.6 8090.9 8240.4 8255.0 7977.3 8807.0 9502.7 10907.8 10934.8 22:18:49 INFO - PROCESS | 1641 | 22:18:49 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5399.07 Median:5017.85 stddev:2968.51 (59.2%) stddev-sans-first:2962.12 22:18:49 INFO - PROCESS | 1641 | Values: 1465.9 1498.5 1716.6 1746.5 1871.2 7539.5 7793.7 7968.8 8402.4 8431.7 7950.8 8263.2 8293.7 8386.2 8403.6 2260.4 2297.7 2300.6 2302.1 2311.0 2323.9 2359.8 2367.0 2379.5 2380.4 1896.8 1900.8 2217.7 2240.4 2246.4 1882.5 2264.4 2271.3 2272.3 2278.7 2256.9 2281.4 2284.2 2284.8 2331.0 7596.4 7860.4 8384.8 8401.2 8420.6 5028.7 5187.1 5194.4 5196.4 5205.9 3185.4 3270.1 3425.5 3431.4 3433.4 1010.1 1041.5 1045.4 1049.6 1060.5 10768.2 10774.1 10802.1 10901.7 10962.1 3731.7 4644.3 4710.5 4749.5 4752.2 9320.1 9399.1 9418.9 9430.9 9435.3 5164.8 5193.9 5194.6 5198.2 5258.5 4240.8 4293.4 4689.9 4737.8 4775.6 3770.7 3844.3 3890.0 3907.7 3921.0 1233.5 1267.0 1278.6 1283.8 1298.2 828.7 890.5 902.5 923.6 949.8 5412.5 5823.7 5828.9 5846.9 5872.6 875.6 888.6 889.0 918.7 920.9 3829.2 3848.7 3855.7 3951.7 4006.4 9796.2 10130.1 10173.0 10173.7 10212.6 10019.5 10128.4 10140.3 10168.3 10189.3 7045.5 7412.9 7440.3 7724.1 7860.0 4799.9 5739.6 5909.7 5952.2 5988.7 9067.7 9270.7 9278.6 9401.5 9419.3 9382.5 9431.7 9435.8 9442.2 9564.3 4788.5 6203.7 6823.9 7007.3 7289.1 7833.5 8000.4 8008.5 8013.8 8055.8 6152.6 7073.9 7177.6 7255.6 7262.5 5692.5 6101.8 6754.7 7001.6 7020.1 6605.5 6656.2 6667.1 6721.4 6743.3 4790.3 4833.6 4874.6 4901.0 5007.0 4103.3 4845.0 4999.0 5002.3 5006.5 22:18:49 INFO - PROCESS | 1641 | 22:18:49 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4521.38 Median:5032.16 stddev:1391.78 (27.7%) stddev-sans-first:1359.49 22:18:49 INFO - PROCESS | 1641 | Values: 319.8 357.8 365.3 373.9 378.6 4597.5 4858.2 4930.9 5321.5 5332.8 4473.4 5005.1 5064.0 5319.9 5462.2 4062.7 4263.2 4288.9 4302.2 4304.5 3691.4 4037.7 4291.3 4302.3 4319.3 3906.5 3928.6 4068.6 4070.9 4072.5 4094.6 4104.1 4117.5 4120.6 4149.5 3424.2 3527.5 3553.9 3565.1 3586.2 4261.4 4452.7 5327.9 5337.1 5418.7 4471.2 4683.5 4714.3 4722.0 4751.8 4836.6 5095.4 5559.4 5725.8 5810.0 3172.5 3603.2 3709.9 3848.2 3877.5 4964.5 5324.8 5435.5 5639.2 6103.0 3213.7 3838.9 3956.4 3987.9 3988.6 3785.8 3807.8 3968.6 3983.7 4005.6 4434.6 4501.3 4646.4 4654.4 4747.7 5022.7 5240.5 5819.3 5918.7 5945.0 1221.6 1261.5 1273.7 1309.0 1309.5 852.5 881.4 881.5 890.4 890.9 4510.0 4848.0 4892.6 5196.3 5215.5 5083.7 5085.8 5179.8 5339.8 5699.7 4010.9 4365.3 5041.6 5052.7 5107.4 2576.2 2632.2 2795.9 2842.8 2869.6 5388.9 5780.7 5898.9 5909.2 5947.7 4637.0 5077.8 5547.9 5710.9 5874.8 5631.4 5796.7 5805.8 5882.3 5968.8 5166.9 5265.4 5451.3 5619.6 5719.5 4805.4 5257.9 5521.6 5556.8 5631.5 5180.4 5873.4 5884.7 5907.4 5963.7 3113.7 3295.9 3630.6 3782.5 3789.7 4524.7 5247.6 5629.9 5668.2 5713.4 4836.6 4922.9 4981.9 5648.5 5864.7 5454.9 5807.6 5812.2 5884.9 5888.0 5361.2 5668.9 5673.5 5704.2 5802.7 5499.7 5850.9 5894.8 5909.6 5936.6 5145.5 5366.3 5539.6 5742.7 5843.2 22:18:49 INFO - PROCESS | 1641 | 22:18:49 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:19623.78 Median:579.27 stddev:28578.96 (4933.6%) stddev-sans-first:28623.48 22:18:49 INFO - PROCESS | 1641 | Values: 612.8 724.7 758.0 763.2 812.7 14605.5 14902.7 15293.8 15441.2 15637.1 13123.5 13171.9 13190.0 14993.9 15520.8 876.5 900.8 904.6 906.7 909.4 699.9 717.6 812.8 892.5 896.4 910.1 933.8 935.6 936.0 936.4 927.9 929.6 930.3 932.1 935.4 687.3 691.6 695.2 696.6 697.5 14481.1 14897.6 14910.3 14912.0 14947.6 13664.0 13911.8 13928.5 14027.0 14075.1 11755.9 11763.4 11839.9 11866.5 12268.6 3092.0 3518.7 3692.9 3697.3 3799.1 99216.0 105605.5 106406.0 107431.3 112412.4 9495.2 10402.4 10570.6 10597.5 10737.5 20854.8 21451.9 21457.6 21531.8 21560.8 7706.2 7754.1 7834.7 7904.8 7913.2 3711.8 4230.3 4333.5 4371.2 4377.9 3054.5 3452.8 3524.7 3528.5 3550.6 598.8 616.1 620.3 625.0 630.9 572.9 585.7 662.5 664.0 678.0 8317.5 8678.7 8834.4 9132.8 9314.0 647.9 666.1 676.7 683.4 690.2 4259.3 4325.6 4566.4 4570.5 4638.6 81617.8 88882.0 97520.0 98488.0 99162.0 83080.6 85937.1 86769.6 87641.1 89518.0 65531.3 75599.6 77613.0 78989.8 79139.6 8703.0 8724.4 8753.6 8757.6 8819.2 49307.5 49474.0 50821.7 51257.3 51464.7 63377.4 65620.7 69555.7 70367.3 71050.9 11440.2 11571.5 11675.5 11715.5 11759.1 12599.8 12674.3 12802.7 12863.8 13216.8 9958.0 9981.8 10598.7 11839.0 12329.3 9300.7 10618.5 11834.9 12189.5 12213.2 9844.4 10164.2 11665.5 12299.3 12341.4 8382.9 8565.8 10249.4 10490.3 10585.2 7985.8 8952.2 10212.3 10340.2 10343.7 22:18:49 INFO - PROCESS | 1641 | -------- Summary: end -------- 22:18:49 INFO - PROCESS | 1641 | 22:18:50 INFO - TEST-INFO | 1641: exit 0 22:18:50 INFO - TEST-OK | dromaeo_css | took 1117075ms 22:18:50 INFO - TEST-START | kraken 22:18:50 INFO - operating with platform_type : mac_ 22:18:50 INFO - Initialising browser for kraken test... 22:18:50 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmpfRQi0d/profile http://localhost:49242/getInfo.html) 22:18:52 INFO - PROCESS | 1652 | 2016-12-20 22:18:52.811 plugin-container[1653:10014] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c47, name = 'com.apple.tsm.portname' 22:18:52 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:18:52 INFO - PROCESS | 1652 | 2016-12-20 22:18:52.813 plugin-container[1653:10014] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 22:18:52 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:18:52 INFO - PROCESS | 1652 | 2016-12-20 22:18:52.813 plugin-container[1653:10014] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:18:52 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 22:18:52 INFO - PROCESS | 1652 | colorDepth:24 22:18:52 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 22:18:52 INFO - PROCESS | 1652 | __metrics 22:18:52 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3232: TypeError: this.tabs is undefined 22:18:53 INFO - TEST-INFO | 1652: exit 0 22:18:53 INFO - Browser initialized. 22:18:53 INFO - Running cycle 1/1 for kraken test... 22:18:53 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/T/tmpfRQi0d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:18:55 INFO - PROCESS | 1654 | 2016-12-20 22:18:55.849 plugin-container[1655:10130] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 22:18:55 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:18:55 INFO - PROCESS | 1654 | 2016-12-20 22:18:55.850 plugin-container[1655:10130] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 22:18:55 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 22:18:55 INFO - PROCESS | 1654 | 2016-12-20 22:18:55.850 plugin-container[1655:10130] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 22:19:05 INFO - PROCESS | 1654 | RSS: Main: 234348544 22:19:05 INFO - PROCESS | 1654 | 22:19:08 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:09 INFO - PROCESS | 1654 | RSS: Main: 247218176 22:19:09 INFO - PROCESS | 1654 | 22:19:12 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 22:19:12 INFO - PROCESS | 1654 | RSS: Main: 254742528 22:19:12 INFO - PROCESS | 1654 | 22:19:16 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 22:19:16 INFO - PROCESS | 1654 | RSS: Main: 257351680 22:19:16 INFO - PROCESS | 1654 | 22:19:18 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 22:19:19 INFO - PROCESS | 1654 | RSS: Main: 259510272 22:19:19 INFO - PROCESS | 1654 | 22:19:21 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:22 INFO - PROCESS | 1654 | RSS: Main: 260128768 22:19:22 INFO - PROCESS | 1654 | 22:19:25 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:25 INFO - PROCESS | 1654 | RSS: Main: 265916416 22:19:25 INFO - PROCESS | 1654 | 22:19:28 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 22:19:29 INFO - PROCESS | 1654 | RSS: Main: 264962048 22:19:29 INFO - PROCESS | 1654 | 22:19:32 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 22:19:33 INFO - PROCESS | 1654 | RSS: Main: 264982528 22:19:33 INFO - PROCESS | 1654 | 22:19:34 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:19:35 INFO - PROCESS | 1654 | RSS: Main: 264245248 22:19:35 INFO - PROCESS | 1654 | 22:19:37 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:19:37 INFO - PROCESS | 1654 | RSS: Main: 264421376 22:19:37 INFO - PROCESS | 1654 | 22:19:40 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:19:40 INFO - PROCESS | 1654 | RSS: Main: 264359936 22:19:40 INFO - PROCESS | 1654 | 22:19:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:19:44 INFO - PROCESS | 1654 | RSS: Main: 264798208 22:19:44 INFO - PROCESS | 1654 | 22:19:47 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:19:48 INFO - PROCESS | 1654 | RSS: Main: 264396800 22:19:48 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 22:19:50 INFO - PROCESS | 1654 | RSS: Main: 265510912 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | __start_tp_report 22:19:50 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 22:19:50 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 22:19:50 INFO - PROCESS | 1654 | |i|pagename|runs| 22:19:50 INFO - PROCESS | 1654 | |0;ai-astar;116;174;162;117;117;116;118;120;119;117 22:19:50 INFO - PROCESS | 1654 | |1;audio-beat-detection;151;118;111;147;113;118;113;134;171;118 22:19:50 INFO - PROCESS | 1654 | |2;audio-dft;191;217;256;221;196;199;195;199;197;196 22:19:50 INFO - PROCESS | 1654 | |3;audio-fft;85;77;59;73;51;63;73;84;94;59 22:19:50 INFO - PROCESS | 1654 | |4;audio-oscillator;88;87;76;59;59;75;120;105;102;116 22:19:50 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;108;111;112;114;111;124;103;174;137;127 22:19:50 INFO - PROCESS | 1654 | |6;imaging-darkroom;96;95;97;119;157;105;97;103;145;96 22:19:50 INFO - PROCESS | 1654 | |7;imaging-desaturate;91;95;94;94;95;93;104;151;97;99 22:19:50 INFO - PROCESS | 1654 | |8;json-parse-financial;60;59;59;62;62;61;62;62;61;63 22:19:50 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;66;69;76;81;78;74;69;69;71;71 22:19:50 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;92;88;90;83;96;110;85;97;110;111 22:19:50 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;157;142;148;137;159;164;157;158;258;182 22:19:50 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;170;173;175;173;173;173;176;169;168;172 22:19:50 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;88;88;91;91;67;68;66;71;74;60 22:19:50 INFO - PROCESS | 1654 | __end_tp_report 22:19:50 INFO - PROCESS | 1654 | __start_cc_report 22:19:50 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,922 22:19:50 INFO - PROCESS | 1654 | __end_cc_report 22:19:50 INFO - PROCESS | 1654 | __startTimestamp1482301190378__endTimestamp 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | ------- Summary: start ------- 22:19:50 INFO - PROCESS | 1654 | Number of tests: 14 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:127.60 Median:118.50 stddev:21.52 (18.2%) stddev-sans-first:22.41 22:19:50 INFO - PROCESS | 1654 | Values: 116.0 174.0 162.0 117.0 117.0 116.0 118.0 120.0 119.0 117.0 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:129.40 Median:126.00 stddev:20.53 (16.3%) stddev-sans-first:20.24 22:19:50 INFO - PROCESS | 1654 | Values: 151.0 118.0 111.0 147.0 113.0 118.0 113.0 134.0 171.0 118.0 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:206.70 Median:199.00 stddev:19.91 (10.0%) stddev-sans-first:20.29 22:19:50 INFO - PROCESS | 1654 | Values: 191.0 217.0 256.0 221.0 196.0 199.0 195.0 199.0 197.0 196.0 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:71.80 Median:75.00 stddev:13.68 (18.2%) stddev-sans-first:13.65 22:19:50 INFO - PROCESS | 1654 | Values: 85.0 77.0 59.0 73.0 51.0 63.0 73.0 84.0 94.0 59.0 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:67.00 stddev:21.82 (32.6%) stddev-sans-first:23.14 22:19:50 INFO - PROCESS | 1654 | Values: 88.0 87.0 76.0 59.0 59.0 75.0 120.0 105.0 102.0 116.0 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:122.10 Median:119.00 stddev:20.87 (17.5%) stddev-sans-first:21.51 22:19:50 INFO - PROCESS | 1654 | Values: 108.0 111.0 112.0 114.0 111.0 124.0 103.0 174.0 137.0 127.0 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:111.00 Median:95.50 stddev:22.44 (23.5%) stddev-sans-first:23.14 22:19:50 INFO - PROCESS | 1654 | Values: 96.0 95.0 97.0 119.0 157.0 105.0 97.0 103.0 145.0 96.0 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:101.30 Median:94.50 stddev:17.83 (18.9%) stddev-sans-first:18.52 22:19:50 INFO - PROCESS | 1654 | Values: 91.0 95.0 94.0 94.0 95.0 93.0 104.0 151.0 97.0 99.0 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:62.00 stddev:1.37 (2.2%) stddev-sans-first:1.39 22:19:50 INFO - PROCESS | 1654 | Values: 60.0 59.0 59.0 62.0 62.0 61.0 62.0 62.0 61.0 63.0 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:72.50 stddev:4.72 (6.5%) stddev-sans-first:4.40 22:19:50 INFO - PROCESS | 1654 | Values: 66.0 69.0 76.0 81.0 78.0 74.0 69.0 69.0 71.0 71.0 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:96.20 Median:89.00 stddev:10.66 (12.0%) stddev-sans-first:11.20 22:19:50 INFO - PROCESS | 1654 | Values: 92.0 88.0 90.0 83.0 96.0 110.0 85.0 97.0 110.0 111.0 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:166.20 Median:158.50 stddev:34.54 (21.8%) stddev-sans-first:36.48 22:19:50 INFO - PROCESS | 1654 | Values: 157.0 142.0 148.0 137.0 159.0 164.0 157.0 158.0 258.0 182.0 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:173.00 stddev:2.53 (1.5%) stddev-sans-first:2.55 22:19:50 INFO - PROCESS | 1654 | Values: 170.0 173.0 175.0 173.0 173.0 173.0 176.0 169.0 168.0 172.0 22:19:50 INFO - PROCESS | 1654 | 22:19:50 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.40 Median:81.00 stddev:11.86 (14.6%) stddev-sans-first:11.82 22:19:50 INFO - PROCESS | 1654 | Values: 88.0 88.0 91.0 91.0 67.0 68.0 66.0 71.0 74.0 60.0 22:19:50 INFO - PROCESS | 1654 | -------- Summary: end -------- 22:19:50 INFO - PROCESS | 1654 | 22:19:51 INFO - TEST-INFO | 1654: exit 0 22:19:51 INFO - TEST-OK | kraken | took 61041ms 22:19:51 INFO - SUITE-END | took 1178s 22:19:51 INFO - Completed test suite (00:19:38) 22:19:51 INFO - javascript benchmark 22:19:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7101.211294276406, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3399.5580574525306, 3406.8466918988643, 3426.280481098969, 3441.5698037745283, 3452.6202117767048, 5050.646454748169, 5081.1108056090125, 5581.916271255935, 5667.404922483137, 5692.117721753125, 5621.662700237978, 5713.514351280146, 5775.480206781399, 5810.331811841629, 5837.79567715129, 4568.748718820463, 4925.162722337212, 5210.869728256786, 5277.234800953878, 5306.204069389584, 5195.480451954812, 5299.655522391032, 5316.5215130638235, 5324.574034077284, 5377.220303056055, 5121.462246464105, 5165.509276618753, 5266.683998960075, 5287.550558202557, 5295.338082739658, 4195.8741237762915, 5132.0, 5248.160294352885, 5284.81503147388, 5313.1764576490705, 5143.02282566315, 5151.484851514856, 5164.561012313958, 5204.68771873685, 5214.009338225763, 4735.550122738335, 5545.334559852803, 5723.914141287884, 5752.395998420147, 5752.798652047159, 6078.574499785017, 6102.943731970943, 6126.785562505335, 6157.7536898524, 6172.7530898764, 6224.9688751556405, 6252.937470625281, 6257.342978987186, 6262.906056409158, 6274.278457977345, 5794.5074668653215, 5832.445917637818, 5833.0375488044, 5842.444967728059, 5874.9412505874825, 6120.660465672121, 6202.844928876724, 6204.906926396107, 6221.408966148299, 6246.6876656167005, 5651.576131790132, 6106.786754545499, 6141.393954534099, 6142.345304543789, 6148.938510614926, 4537.069900670354, 5181.300524429229, 5253.001929633434, 5967.940320596826, 6105.64170830808, 6103.938960610426, 6104.359042300494, 6111.348653136725, 6127.479164270998, 6189.0, 4871.464138944713, 5939.584229103922, 6163.96918015407, 6208.906866397007, 6221.844453888689, 4816.470188279286, 4908.386451693538, 4911.238757992517, 4918.5819205367225, 4919.7540122993705, 4264.658827293809, 4371.9725864421835, 4398.516163222043, 4412.051408947092, 4443.0, 5773.047447171254, 5821.650700957956, 5866.6480011199465, 5876.794312199053, 5903.645781253139, 6193.84515387119, 6251.624902505864, 6254.655993920378, 6259.7496100156395, 6281.968590157111, 5450.618456708072, 5792.594518383757, 5798.159266906359, 5801.564882633819, 5825.766969321265, 5211.687298762086, 5259.710715910662, 5263.394709608444, 5320.467953204726, 5334.813281535127, 6279.529035322369, 6284.057391391237, 6299.527535434952, 6300.0234963580715, 6302.779402720883, 6211.534134939988, 6256.31180570146, 6277.717502712298, 6298.275698294755, 6298.307186209605, 6172.259328880563, 6214.40963108504, 6255.937440625536, 6288.5283603728985, 6302.684865756785, 6113.385090541831, 6184.690765461799, 6186.164867742978, 6221.564490485623, 6229.53278504123, 6233.127362169391, 6234.345393733593, 6248.12526246335, 6253.656048917172, 6287.74849006053, 5782.971085144547, 5892.204552385373, 6068.4538391544975, 6080.69596520181, 6143.815685529441, 5937.198478205387, 5949.494292984971, 6072.483838873745, 6082.513398928164, 6117.265928088658, 5309.893802124013, 5808.21589085485, 6014.458698717136, 6024.307204671519, 6038.728257228523, 5841.824745257649, 6035.969820151046, 6102.542309326729, 6105.206323178136, 6116.3883611638485, 6011.338752737108, 6030.939690603213, 6032.366601506954, 6068.605540639845, 6109.266887973472], "value": 5637.2274265755705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.53128480737627, 465.7554783738538, 482.08163448630347, 488.09702051205255, 570.6718636783847, 35072.824635876816, 37605.623943760555, 37612.0, 37716.0, 37717.868463946055, 31821.68178318216, 37898.81050594743, 38529.61470385295, 38648.42027369592, 38731.225375492475, 8403.033651130107, 8658.696945606906, 8893.110688931103, 9236.815263694722, 10870.18473614482, 10870.782584348308, 11120.55517779288, 11122.666320010372, 11134.99785019348, 11166.720831979224, 11092.33445993239, 11106.389148596823, 11123.110151187926, 11160.832587511193, 11163.944180279128, 11035.72410689735, 11085.390303533302, 11156.442177891155, 11159.0, 11178.329300242012, 8609.870851937227, 9572.0, 10947.178961577834, 11027.83458248127, 11070.833937490945, 35508.644913550794, 37491.8125409374, 37727.0, 37772.81113594415, 37778.811105944296, 3233.4341490239112, 3556.2354093869685, 3572.7141828653644, 3623.420252759572, 3693.8522459101605, 21447.46381340479, 26544.336391590172, 26631.600525992126, 27274.5908811368, 27492.45015099707, 3149.937001259962, 3190.7766456348063, 3204.5834041574444, 3205.6313523944814, 3206.2144774530157, 488619.0, 494110.0, 495932.0, 500622.0, 500940.0, 42183.578164218576, 51555.968880622175, 51933.740331298104, 51970.70073248199, 52118.69703257373, 54247.0, 54683.72658136684, 54962.45037549653, 55043.17435238475, 55064.0, 14621.78067328991, 14999.850001500063, 15111.093334399971, 15118.319675614624, 15120.54638360851, 10640.521176547074, 10897.182711296684, 11512.712182195344, 11738.471768770425, 11801.232919860182, 16543.007419554626, 16603.750943735853, 16692.41576544815, 16732.24704888283, 17030.403935862185, 7374.188839227681, 7490.925090749131, 7522.285382888617, 7533.510321829063, 7587.203343648947, 808.2604416958535, 887.3730288173142, 951.9857202141974, 1030.5447519013026, 1053.115383078218, 24611.753882461304, 25461.745382545938, 27519.036833710725, 28821.423571528452, 29210.7078929208, 1006.1648831469862, 1018.1294992781213, 1047.1936608811172, 1071.6945670483874, 1127.9266847654876, 11571.76856462866, 14719.852801472063, 14941.925290373696, 15226.695466090838, 15291.0, 639098.0, 643532.0, 646094.0, 647046.0, 648142.0, 54254.45745542494, 54467.0, 54792.45207547953, 54868.17697734537, 54869.45130548644, 1327.774278372679, 1375.8417781955204, 1390.1172755300456, 1391.2139641102947, 1391.6660001599746, 28413.715862841105, 28700.712992869805, 28731.5690264642, 29229.97695080662, 29432.852835735684, 46189.76905115453, 46642.0, 46684.0, 46708.299375510076, 46761.0, 546299.0, 549969.0, 550574.0, 550859.0, 551769.0, 24282.878585607665, 24978.125765598117, 25038.62442063334, 25077.74922250754, 25671.17617062159, 40078.398824018244, 40115.398269025405, 40303.0, 40764.98087547835, 40859.79570102131, 33564.99305020853, 33864.3227135451, 34435.82782086074, 34827.651723483454, 34916.0, 31423.528647069856, 31436.842815785774, 33082.5037624431, 33817.49273760945, 34243.31513369769, 32984.505232422016, 33559.83220083982, 33574.83212584019, 33588.49617255792, 33984.830075849466, 29491.0, 29840.80636774505, 30184.5472317911, 30431.391372172875, 30521.389572208875, 17943.371981980566, 20748.06633701457, 23170.304890853302, 23644.645330320403, 23793.881030594737], "value": 18941.167835535354, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.64882141430286, 371.27415901911746, 372.9216864458464, 386.07534953785665, 402.5069290119602, 18564.907175464137, 18892.90553547232, 19634.410967670956, 19799.40601781947, 19854.106565204565, 17082.0, 19459.708104378446, 20183.899080504576, 20536.8973155134, 20554.0, 5561.0, 5597.776088956437, 5828.912566311487, 5829.242198514187, 5844.094165404348, 5613.550915926737, 5717.399673034334, 5749.741261643236, 5756.625819321752, 5760.308762948431, 5579.609427340088, 5615.736459296666, 5686.943130568683, 5706.486416222539, 5730.742116604742, 5550.250716153308, 5651.886962260732, 5669.348024977139, 5671.7164141792955, 5701.714914254312, 4907.9263811042865, 4941.061198372334, 4960.280759289883, 4987.202047672391, 4999.925001124986, 21456.356309310744, 21609.67585486219, 22238.88880555603, 24767.752322476725, 24839.62740558893, 2215.423989762657, 2259.3109101723967, 2382.54731600997, 2651.602259661047, 2660.175345642838, 14789.482368117064, 15678.372865085383, 15703.057816531045, 15861.206939653086, 16206.108664023473, 1726.6891959447294, 1789.9463016109537, 1835.779706435223, 1887.546589126365, 1910.3122875764714, 93340.06659933382, 93747.0, 94145.0, 97759.0, 99355.50322248414, 10543.683689489328, 10893.0, 10911.83632245517, 10940.890591093987, 11153.888461115448, 13628.454861805416, 13778.173309601456, 13785.379657915419, 13785.793213101811, 13794.517191898236, 7756.224377562312, 8088.757337279891, 8365.330773538102, 8486.19381158789, 8583.871241931376, 7498.587577683171, 8285.212904774036, 8328.8334233315, 8342.499450033018, 8379.287760540301, 6631.653907779969, 6753.898691519631, 6767.526273160832, 6825.726970921207, 6886.0, 1548.3342162869849, 1730.7144321186863, 1834.7981722010568, 1875.8780679255806, 1878.4083013850593, 767.4167632599265, 885.9589981771393, 918.5499105438287, 946.6450081219542, 1005.8189525885265, 15984.488589592382, 17936.641267174582, 18309.084545772657, 20984.580308393746, 21436.356909292746, 809.7408829174608, 946.2855544064188, 993.2717072294156, 998.8401855703053, 1022.2077889635443, 8541.871871921927, 11261.268017578832, 11436.771264574661, 11504.827427588592, 11515.754427886483, 470151.6492417516, 552453.2377338088, 563571.0, 568584.0, 570242.0, 119227.0, 134252.0, 137847.0, 140759.0, 141816.0, 993.0615568288043, 1026.1175389165312, 1045.5086109528509, 1045.628801775374, 1047.9782212343057, 15074.321655525748, 18314.633707326044, 19547.315843945395, 19551.08978204393, 19648.508787280432, 36036.63963360333, 37118.0, 41418.37872431856, 50473.49526504688, 52492.47507524876, 70727.0, 74116.0, 76917.23082769325, 79296.60351698204, 84186.57906710428, 7866.646000929857, 7950.204979502004, 8074.3540516759695, 8104.230098140667, 8287.461315014505, 11950.581729639422, 12330.81503777462, 12387.690307742017, 12721.872781272068, 12752.74494510123, 10425.801032881012, 10434.321769084985, 10569.365838049742, 10875.456227188452, 11066.0, 9470.384425012353, 10264.0, 10347.793044139225, 10500.842487362543, 10775.353478791298, 8849.926325033179, 9253.352265341362, 10534.157267418741, 10627.09669678086, 10960.835587466036, 7808.336291415293, 7873.566953817595, 8090.919090809017, 8240.381971352292, 8255.0, 7977.282044616012, 8807.0, 9502.667406640734, 10907.78184436291, 10934.781304374028], "value": 9368.282173390046, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.8754005909498, 1498.5354540092571, 1716.622343084521, 1746.5109769264611, 1871.2234422714582, 7539.547627142375, 7793.727219547317, 7968.840623187532, 8402.369822263325, 8431.66273349066, 7950.761477155695, 8263.21499457552, 8293.668253269861, 8386.20331068549, 8403.621837017334, 2260.4461906832807, 2297.655351697242, 2300.5513924784673, 2302.0561569756405, 2310.9884450577724, 2323.8954247058923, 2359.7876191142796, 2366.994027538289, 2379.524095180962, 2380.4048987753063, 1896.80083591223, 1900.8499857586169, 2217.667349897512, 2240.361496973363, 2246.3710161154822, 1882.5481884347726, 2264.445210923318, 2271.3299576624936, 2272.3183045086407, 2278.715160604924, 2256.8758718270487, 2281.406834223114, 2284.234781348234, 2284.7601001894727, 2331.0, 7596.442729240493, 7860.449768516149, 8384.83230335396, 8401.201885820838, 8420.621072051712, 5028.673136246132, 5187.144121219994, 5194.428612852583, 5196.376434827845, 5205.9219111713355, 3185.3629274145264, 3270.100722301386, 3425.4861770734587, 3431.3823511767873, 3433.416319225713, 1010.1211945607295, 1041.4740556019162, 1045.4406892312577, 1049.643121338741, 1060.5174645536263, 10768.192385571114, 10774.138068954464, 10802.13582913373, 10901.672949811518, 10962.068224200952, 3731.6828069613844, 4644.326572646947, 4710.52894710533, 4749.501302363271, 4752.1921273383605, 9320.06799320076, 9399.10708482693, 9418.858717119248, 9430.90569094314, 9435.292353073546, 5164.767585458663, 5193.870153246199, 5194.584433245332, 5198.2202669599865, 5258.5267325940085, 4240.809163587646, 4293.441852559147, 4689.859304220879, 4737.786799594027, 4775.641826863, 3770.698344132463, 3844.3272427325664, 3889.9611003890163, 3907.6873850091924, 3920.9805450583053, 1233.5497543396596, 1267.0, 1278.6164150754737, 1283.8202651628778, 1298.2470167302943, 828.747232094205, 890.5369208011798, 902.4946030222965, 923.5890028937193, 949.838527450335, 5412.458754124556, 5823.650580965155, 5828.94171058284, 5846.853828654318, 5872.559558033165, 875.6322344615149, 888.5868071346855, 889.0, 918.701422037827, 920.889493260813, 3829.215010922754, 3848.6728628066926, 3855.6529912307465, 3951.7431366961055, 4006.419069234945, 9796.167325777245, 10130.088292053602, 10173.0, 10173.694789156189, 10212.642557510451, 10019.549120289605, 10128.442935638463, 10140.340877843064, 10168.33905796121, 10189.337693049929, 7045.542039767399, 7412.888806667905, 7440.255974402517, 7724.0731112266885, 7859.960700196462, 4799.928001079917, 5739.5695322850115, 5909.704514774158, 5952.226210592596, 5988.730507127103, 9067.727968160965, 9270.675526356545, 9278.582463789011, 9401.52992350366, 9419.293552983416, 9382.48396338208, 9431.669891553762, 9435.811283774423, 9442.15020648145, 9564.282678798978, 4788.545088216614, 6203.689815509116, 6823.93176068233, 7007.283215612208, 7289.052423184952, 7833.529988200727, 8000.359971202406, 8008.519488830689, 8013.799655008672, 8055.798605034921, 6152.569320147547, 7073.929260707327, 7177.641117944187, 7255.600941948243, 7262.491625586158, 5692.516136128475, 6101.755929762938, 6754.696038678369, 7001.649917504206, 7020.087388639648, 6605.47156227491, 6656.201255849329, 6667.066610674607, 6721.395074443128, 6743.325667433218, 4790.281457781221, 4833.564979151894, 4874.634402419903, 4901.0, 5007.023630392038, 4103.343465045578, 4845.0, 4998.950010499994, 5002.324686167321, 5006.49935006511], "value": 4380.954041287128, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.84807216572125, 357.7924803613904, 365.2785748147411, 373.9027852758282, 378.5759948857279, 4597.5402459754005, 4858.153901517428, 4930.8767280818, 5321.547668448182, 5332.813351532697, 4473.351364052219, 5005.124103281929, 5063.974680126595, 5319.882824606828, 5462.153366228241, 4062.6546743526837, 4263.189993901165, 4288.914221715564, 4302.182585308797, 4304.548022457644, 3691.3724666806575, 4037.7375470594466, 4291.313389857623, 4302.26861433557, 4319.308910574308, 3906.4921560197135, 3928.6464218220353, 4068.6338229559333, 4070.8982275443204, 4072.470578824749, 4094.5905409459115, 4104.0970986382945, 4117.485314335708, 4120.608542188487, 4149.502059752849, 3424.195314101184, 3527.5414196154593, 3553.8578456861696, 3565.0552603560077, 3586.228960773446, 4261.403403523509, 4452.732836029849, 5327.893442131136, 5337.119375303109, 5418.672425255798, 4471.2398892188085, 4683.531646835289, 4714.292856071583, 4722.0, 4751.7624118794265, 4836.564709176191, 5095.363079615048, 5559.385709860806, 5725.828225153252, 5809.970950145264, 3172.476541370671, 3603.1532589841368, 3709.9426663401073, 3848.2495913296916, 3877.4571559981623, 4964.478729733398, 5324.760385782649, 5435.456454354572, 5639.238702775114, 6102.9694851525455, 3213.694699003591, 3838.9232215356096, 3956.4065390191126, 3987.940180897289, 3988.581198974124, 3785.848566057382, 3807.7715337079308, 3968.6428221460205, 3983.661388781928, 4005.5593884673244, 4434.645228381722, 4501.257292546693, 4646.442426908792, 4654.394928659252, 4747.715137091785, 5022.744313921519, 5240.4759524047295, 5819.25730529617, 5918.733656985446, 5944.970275148597, 1221.578555398404, 1261.5143169879661, 1273.7452509498137, 1308.9672758180932, 1309.508934149694, 852.5098068610574, 881.4314766975265, 881.5151666583354, 890.3900827932887, 890.8552510024717, 4509.977450112794, 4848.0, 4892.633052521075, 5196.298499702491, 5215.478452154754, 5083.669561478492, 5085.804835863569, 5179.778480538349, 5339.839804805862, 5699.658020518699, 4010.8903663661663, 4365.257906155961, 5041.571466425322, 5052.747362631853, 5107.416700822757, 2576.2224065395194, 2632.2364016109254, 2795.888164473439, 2842.7725781937397, 2869.613855650311, 5388.868337649137, 5780.653160810365, 5898.911516327258, 5909.168157871074, 5947.702614869239, 4636.976815115971, 5077.796888124508, 5547.861303467445, 5710.885782284331, 5874.823755287348, 5631.4087020863035, 5796.681182535001, 5805.796797112081, 5882.264716910387, 5968.791092311835, 5166.870828229325, 5265.420803711512, 5451.3458384994055, 5619.606627536034, 5719.48524632785, 4805.399325084364, 5257.921131182959, 5521.558275337883, 5556.777728890799, 5631.493165615114, 5180.430152683127, 5873.4126587340925, 5884.676342801015, 5907.3797251288, 5963.70181490915, 3113.7041981011766, 3295.868165273362, 3630.5659264589813, 3782.508273924482, 3789.696824253998, 4524.742185626344, 5247.55395791362, 5629.943700563106, 5668.178114173505, 5713.400092990176, 4836.613070954386, 4922.901541969069, 4981.850544483671, 5648.519875810603, 5864.706764661664, 5454.945450545444, 5807.647902599285, 5812.244408226903, 5884.882302353843, 5887.970560147343, 5361.169018802092, 5668.886622267614, 5673.5461163107675, 5704.229928959538, 5802.709864506842, 5499.670019798825, 5850.899023517542, 5894.764209431574, 5909.5863289569315, 5936.5844390892225, 5145.485451454824, 5366.329208848894, 5539.590278228983, 5742.684152371659, 5843.181954526284], "value": 4090.827668182493, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.8069658057709, 724.7173602295104, 758.0335072782202, 763.1910175214269, 812.719611733952, 14605.488807891727, 14902.701945961087, 15293.84706152938, 15441.150736709476, 15637.139957302357, 13123.475060997549, 13171.93414032931, 13190.0, 14993.925030374832, 15520.844791552081, 876.4697358098371, 900.8063266397756, 904.5567671840784, 906.6554709210491, 909.4361495872536, 699.8915168148919, 717.5909731453074, 812.7724237213561, 892.5314210039717, 896.3501461440436, 910.0990019880304, 933.7712260496188, 935.550935550936, 935.9719208423725, 936.442816524167, 927.8747369105185, 929.5677509957834, 930.2511478259999, 932.0912110692021, 935.3546053223288, 687.2543290529732, 691.629977961788, 695.2317688953734, 696.6412297666706, 697.5465947134403, 14481.131132132, 14897.627559310995, 14910.329035193334, 14912.0, 14947.626309342244, 13664.0, 13911.79132313016, 13928.51250206238, 14027.0, 14075.085119467201, 11755.88244117565, 11763.35301558414, 11839.940800295943, 11866.52533898643, 12268.631941041784, 3091.9536206956914, 3518.683318501347, 3692.8892133236045, 3697.334479793636, 3799.0692280391204, 99216.0, 105605.47197264041, 106406.0, 107431.31421714442, 112412.4379378098, 9495.192908602847, 10402.427866467266, 10570.577176912837, 10597.470126493645, 10737.463126843626, 20854.792989180245, 21451.892740536197, 21457.570848582942, 21531.78468215329, 21560.78439215619, 7706.190849960785, 7754.069511658637, 7834.686612535549, 7904.841903161904, 7913.248241417056, 3711.7958512281543, 4230.323148296257, 4333.5016473106, 4371.23503386906, 4377.934330985037, 3054.4501989641635, 3452.7583069184916, 3524.665156810099, 3528.5236493073107, 3550.55618047744, 598.775459202799, 616.0666590115978, 620.3294815817857, 624.9718762655691, 630.8738252349549, 572.8539222498237, 585.689584520205, 662.466390306439, 663.9668016599247, 677.9932200678029, 8317.459365141247, 8678.739637810875, 8834.381593288408, 9132.771680708036, 9314.0, 647.9449246814073, 666.1306994372391, 676.681959479044, 683.4327508168209, 690.1821341709989, 4259.339802330644, 4325.567443255649, 4566.437928883343, 4570.451545814523, 4638.5593368629925, 81617.77573336405, 88882.0, 97520.0, 98488.0, 99162.0, 83080.58459707662, 85937.14062859291, 86769.56615216883, 87641.12358876457, 89518.0, 65531.344686552526, 75599.62200189073, 77613.0, 78989.81515277276, 79139.60430197812, 8703.0, 8724.389292749447, 8753.64985400577, 8757.605907734294, 8819.162179592928, 49307.50692493029, 49474.0, 50821.74589127031, 51257.286261336405, 51464.742676287875, 63377.36622633899, 65620.67189664021, 69555.65222174059, 70367.29632703608, 71050.93423598753, 11440.199186056896, 11571.537138514364, 11675.474603642686, 11715.472803723682, 11759.118066145244, 12599.811002834782, 12674.302913339854, 12802.679933001376, 12863.807042894552, 13216.839395043278, 9957.950210248902, 9981.750456238362, 10598.735031624272, 11839.0, 12329.321887296284, 9300.674476393293, 10618.52216650268, 11834.940825295818, 12189.51241950312, 12213.206141600767, 9844.409335439897, 10164.18686505063, 11665.533378664759, 12299.323537205539, 12341.3829308536, 8382.874256886274, 8565.828683426422, 10249.436281004617, 10490.31812932157, 10585.153187744809, 7985.760427186961, 8952.23905968, 10212.285140040125, 10340.224483163642, 10343.741406464898], "value": 7152.157540006671, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1603.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 174.0, 162.0, 117.0, 117.0, 116.0, 118.0, 120.0, 119.0, 117.0], "value": 127.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 111.0, 147.0, 113.0, 118.0, 113.0, 134.0, 171.0, 118.0], "value": 129.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 217.0, 256.0, 221.0, 196.0, 199.0, 195.0, 199.0, 197.0, 196.0], "value": 206.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 77.0, 59.0, 73.0, 51.0, 63.0, 73.0, 84.0, 94.0, 59.0], "value": 71.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 76.0, 59.0, 59.0, 75.0, 120.0, 105.0, 102.0, 116.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 112.0, 114.0, 111.0, 124.0, 103.0, 174.0, 137.0, 127.0], "value": 122.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 97.0, 119.0, 157.0, 105.0, 97.0, 103.0, 145.0, 96.0], "value": 111.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 94.0, 94.0, 95.0, 93.0, 104.0, 151.0, 97.0, 99.0], "value": 101.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 63.0], "value": 61.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 76.0, 81.0, 78.0, 74.0, 69.0, 69.0, 71.0, 71.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 90.0, 83.0, 96.0, 110.0, 85.0, 97.0, 110.0, 111.0], "value": 96.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 142.0, 148.0, 137.0, 159.0, 164.0, 157.0, 158.0, 258.0, 182.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 175.0, 173.0, 173.0, 173.0, 176.0, 169.0, 168.0, 172.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 91.0, 91.0, 67.0, 68.0, 66.0, 71.0, 74.0, 60.0], "value": 76.4, "unit": "score"}]}]} 22:19:51 INFO - Return code: 0 22:19:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:19:51 ERROR - # TBPL SUCCESS # 22:19:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:19:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:19:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:19:51 INFO - 2016-12-20 22:19:51.732 screenresolution[1659:10521] starting screenresolution argv=screenresolution get 22:19:51 INFO - 2016-12-20 22:19:51.735 screenresolution[1659:10521] Display 0: 1600x1200x32@60 22:19:51 INFO - 2016-12-20 22:19:51.741 screenresolution[1660:10524] starting screenresolution argv=screenresolution list 22:19:51 INFO - Available Modes on Display 0 22:19:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:19:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:19:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:19:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:19:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:19:51 INFO - Intel Iris: 22:19:51 INFO - Chipset Model: Intel Iris 22:19:51 INFO - Type: GPU 22:19:51 INFO - Bus: Built-In 22:19:51 INFO - VRAM (Dynamic, Max): 1536 MB 22:19:51 INFO - Vendor: Intel (0x8086) 22:19:51 INFO - Device ID: 0x0a2e 22:19:51 INFO - Revision ID: 0x0009 22:19:51 INFO - Displays: 22:19:51 INFO - Display: 22:19:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:19:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:19:51 INFO - Display Serial Number: 1600x1200 60 22:19:51 INFO - Main Display: Yes 22:19:51 INFO - Mirror: Off 22:19:51 INFO - Online: Yes 22:19:51 INFO - Rotation: Supported 22:19:51 INFO - Return code: 0 22:19:51 INFO - Running post-action listener: _resource_record_post_action 22:19:51 INFO - [mozharness: 2016-12-21 06:19:51.976498Z] Finished run-tests step (success) 22:19:51 INFO - Running post-run listener: _resource_record_post_run 22:19:52 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 37902848; Write bytes: 553063424; Read time: 397; Write time: 1882 22:19:52 INFO - TinderboxPrint: CPU usage
54.7% 22:19:52 INFO - TinderboxPrint: I/O read bytes / time
37,902,848 / 397 22:19:52 INFO - TinderboxPrint: I/O write bytes / time
553,063,424 / 1,882 22:19:52 INFO - TinderboxPrint: CPU idle
2,175.9 (45.3%) 22:19:52 INFO - TinderboxPrint: CPU system
970.8 (20.2%) 22:19:52 INFO - TinderboxPrint: CPU user
1,659.0 (34.5%) 22:19:52 INFO - TinderboxPrint: Swap in / out
287,436,800 / 0 22:19:52 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 243341824; Write bytes: 237676032; Read time: 18222; Write time: 462 22:19:52 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 35801600; Write bytes: 299679232; Read time: 371; Write time: 1379 22:19:52 INFO - Running post-run listener: _upload_blobber_files 22:19:52 INFO - Blob upload gear active. 22:19:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:19:52 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:19:52 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:19:52 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:19:52 INFO - (blobuploader) - INFO - Open directory for files ... 22:19:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:19:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:19:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:54 INFO - (blobuploader) - INFO - Done attempting. 22:19:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:19:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:19:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:56 INFO - (blobuploader) - INFO - Done attempting. 22:19:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:19:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:19:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:57 INFO - (blobuploader) - INFO - Done attempting. 22:19:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:19:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:19:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:19:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:19:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:19:59 INFO - (blobuploader) - INFO - Done attempting. 22:19:59 INFO - (blobuploader) - INFO - Iteration through files over. 22:19:59 INFO - Return code: 0 22:19:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:19:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:19:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9819ae5e299455341d4ac7e40fbebe422cee9d8fc1f87bbc7604d839d83eadafd6741b63992271275a90e8cc73dccbffda1294b15ef909879ed03b5ab2c1dd0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00813261e9dc4e24edd82c82b2e2f2c7b303ce59e470515a87817f2d59bb797576156ad8510f24bd703ba9679b3a93707bea671f71dbafb861cc70be844ffd75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d999bfcbb1f083d05ff8b9d9a798eac6043b943182e0d72f59d3fbb0963afa23da7c4239a0bab1725cb8dce9a364cd1f6cce491d3c675c8b97927b27089119a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aaccde929fc0c88c8dcbe457ec75790bca342aa825cb5a326c5619bf241555e67c324653c3cb177efacddbe01be4f6a0b9911585e5de560c3a5795abc33e9980"} 22:19:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:19:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:19:59 INFO - Contents: 22:19:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9819ae5e299455341d4ac7e40fbebe422cee9d8fc1f87bbc7604d839d83eadafd6741b63992271275a90e8cc73dccbffda1294b15ef909879ed03b5ab2c1dd0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00813261e9dc4e24edd82c82b2e2f2c7b303ce59e470515a87817f2d59bb797576156ad8510f24bd703ba9679b3a93707bea671f71dbafb861cc70be844ffd75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d999bfcbb1f083d05ff8b9d9a798eac6043b943182e0d72f59d3fbb0963afa23da7c4239a0bab1725cb8dce9a364cd1f6cce491d3c675c8b97927b27089119a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aaccde929fc0c88c8dcbe457ec75790bca342aa825cb5a326c5619bf241555e67c324653c3cb177efacddbe01be4f6a0b9911585e5de560c3a5795abc33e9980"} 22:19:59 INFO - Running post-run listener: copy_logs_to_upload_dir 22:19:59 INFO - Copying logs to upload dir... 22:19:59 INFO - mkdir: /builds/slave/test/build/upload/logs 22:19:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.281388 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-12-20 22:19:59.627314) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 22:19:59.631186) ========= 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.I9K67pyzFJ/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.EboKBxntCq/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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/Firefox/sha512/9819ae5e299455341d4ac7e40fbebe422cee9d8fc1f87bbc7604d839d83eadafd6741b63992271275a90e8cc73dccbffda1294b15ef909879ed03b5ab2c1dd0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00813261e9dc4e24edd82c82b2e2f2c7b303ce59e470515a87817f2d59bb797576156ad8510f24bd703ba9679b3a93707bea671f71dbafb861cc70be844ffd75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d999bfcbb1f083d05ff8b9d9a798eac6043b943182e0d72f59d3fbb0963afa23da7c4239a0bab1725cb8dce9a364cd1f6cce491d3c675c8b97927b27089119a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aaccde929fc0c88c8dcbe457ec75790bca342aa825cb5a326c5619bf241555e67c324653c3cb177efacddbe01be4f6a0b9911585e5de560c3a5795abc33e9980"} build_url:https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/DkyMu6TySlmVLmQyzgcaQg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9819ae5e299455341d4ac7e40fbebe422cee9d8fc1f87bbc7604d839d83eadafd6741b63992271275a90e8cc73dccbffda1294b15ef909879ed03b5ab2c1dd0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00813261e9dc4e24edd82c82b2e2f2c7b303ce59e470515a87817f2d59bb797576156ad8510f24bd703ba9679b3a93707bea671f71dbafb861cc70be844ffd75", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d999bfcbb1f083d05ff8b9d9a798eac6043b943182e0d72f59d3fbb0963afa23da7c4239a0bab1725cb8dce9a364cd1f6cce491d3c675c8b97927b27089119a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aaccde929fc0c88c8dcbe457ec75790bca342aa825cb5a326c5619bf241555e67c324653c3cb177efacddbe01be4f6a0b9911585e5de560c3a5795abc33e9980"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-20 22:19:59.666355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 22:19:59.666692) ========= 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.I9K67pyzFJ/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.EboKBxntCq/Listeners TMPDIR=/var/folders/kd/tq17xhqx0413zl3ljjzhv7wc00000w/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.005259 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-20 22:19:59.715617) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 22:19:59.715947) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-20 22:19:59.716294) ========= ========= Total master_lag: 0.19 =========