builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0073 starttime: 1485879406.65 results: success (0) buildid: 20170131065509 builduid: 6a6ead44ff534deb98fea64fadaa9421 revision: b47946b2076f6ac3ffd2cb72367f789237a11ab6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 08:16:46.650684) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 08:16:46.651136) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-01-31 08:16:46.651479) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2017-01-31 08:16:49.772760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 08:16:49.773207) ========= 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.uNnv46mfph/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.KyVPAxNm8C/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 --2017-01-31 08:16:49-- 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% 13.6M=0.001s 2017-01-31 08:16:49 (13.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160821 ========= master_lag: 0.89 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 08:16:50.822453) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 08:16:50.822804) ========= 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.uNnv46mfph/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.KyVPAxNm8C/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.031211 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 08:16:50.879737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 08:16:50.880101) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b47946b2076f6ac3ffd2cb72367f789237a11ab6 --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 b47946b2076f6ac3ffd2cb72367f789237a11ab6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.uNnv46mfph/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.KyVPAxNm8C/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 2017-01-31 08:16:50,986 truncating revision to first 12 chars 2017-01-31 08:16:50,986 Setting DEBUG logging. 2017-01-31 08:16:50,986 attempt 1/10 2017-01-31 08:16:50,986 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b47946b2076f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-31 08:16:52,032 unpacking tar archive at: mozilla-central-b47946b2076f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.313184 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 08:16:52.219742) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 08:16:52.220066) ========= script_repo_revision: b47946b2076f6ac3ffd2cb72367f789237a11ab6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 08:16:52.223509) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 08:16:52.223782) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 08:16:52.243815) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-31 08:16:52.244228) ========= /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.uNnv46mfph/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.KyVPAxNm8C/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 08:16:52 INFO - MultiFileLogger online at 20170131 08:16:52 in /builds/slave/test 08:16: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 08:16:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:16:52 INFO - {'append_to_log': False, 08:16:52 INFO - 'base_work_dir': '/builds/slave/test', 08:16:52 INFO - 'blob_upload_branch': 'Firefox', 08:16:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:16:52 INFO - 'branch': 'Firefox', 08:16:52 INFO - 'buildbot_json_path': 'buildprops.json', 08:16:52 INFO - 'config_files': ('talos/mac_config.py',), 08:16:52 INFO - 'default_actions': ('clobber', 08:16:52 INFO - 'read-buildbot-config', 08:16:52 INFO - 'download-and-extract', 08:16:52 INFO - 'populate-webroot', 08:16:52 INFO - 'create-virtualenv', 08:16:52 INFO - 'install', 08:16:52 INFO - 'run-tests'), 08:16:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:16:52 INFO - 'download_minidump_stackwalk': True, 08:16:52 INFO - 'download_symbols': 'ondemand', 08:16:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:16:52 INFO - 'tooltool.py': '/tools/tooltool.py', 08:16:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:16:52 INFO - '/tools/misc-python/virtualenv.py')}, 08:16:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:16:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:16:52 INFO - 'installer_path': 'installer.exe', 08:16:52 INFO - 'log_level': 'info', 08:16:52 INFO - 'log_name': 'talos', 08:16:52 INFO - 'log_to_console': True, 08:16:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:16:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:16:52 INFO - 'opt_config_files': (), 08:16:52 INFO - 'pip_index': False, 08:16:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:16:52 INFO - 'cmd': ('bash', 08:16:52 INFO - '-c', 08:16:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:16:52 INFO - 'enabled': True, 08:16:52 INFO - 'halt_on_failure': False, 08:16:52 INFO - 'name': 'check_screen_resolution'},), 08:16:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:16:52 INFO - 'cmd': ('bash', 08:16:52 INFO - '-c', 08:16:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:16:52 INFO - 'enabled': True, 08:16:52 INFO - 'halt_on_failure': False, 08:16:52 INFO - 'name': 'check_screen_resolution'},), 08:16:52 INFO - 'run_cmd_checks_enabled': True, 08:16:52 INFO - 'sps_profile': False, 08:16:52 INFO - 'sps_profile_interval': 0, 08:16:52 INFO - 'suite': 'dromaeojs-e10s', 08:16:52 INFO - 'system_bits': '32', 08:16:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:16:52 INFO - 'title': 't-yosemite-r7-0073', 08:16:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:16:52 INFO - 'use_talos_json': True, 08:16:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:16:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:16:52 INFO - 'work_dir': 'build'} 08:16:52 INFO - [mozharness: 2017-01-31 16:16:52.456490Z] Running clobber step. 08:16:52 INFO - Running pre-action listener: _resource_record_pre_action 08:16:52 INFO - Running main action method: clobber 08:16:52 INFO - rmtree: /builds/slave/test/build 08:16:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:16:54 INFO - Running post-action listener: _resource_record_post_action 08:16:54 INFO - [mozharness: 2017-01-31 16:16:54.956549Z] Finished clobber step (success) 08:16:54 INFO - [mozharness: 2017-01-31 16:16:54.956677Z] Running read-buildbot-config step. 08:16:54 INFO - Running pre-action listener: _resource_record_pre_action 08:16:54 INFO - Running main action method: read_buildbot_config 08:16:54 INFO - Using buildbot properties: 08:16:54 INFO - { 08:16:54 INFO - "project": "", 08:16:54 INFO - "product": "firefox", 08:16:54 INFO - "script_repo_revision": "production", 08:16:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 08:16:54 INFO - "repository": "", 08:16:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 08:16:54 INFO - "buildid": "20170131065509", 08:16:54 INFO - "pgo_build": "False", 08:16:54 INFO - "basedir": "/builds/slave/test", 08:16:54 INFO - "buildnumber": 34, 08:16:54 INFO - "slavename": "t-yosemite-r7-0073", 08:16:54 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:16:54 INFO - "platform": "yosemite_r7", 08:16:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:16:54 INFO - "branch": "mozilla-central", 08:16:54 INFO - "repo_path": "mozilla-central", 08:16:54 INFO - "revision": "b47946b2076f6ac3ffd2cb72367f789237a11ab6", 08:16:54 INFO - "stage_platform": "macosx64", 08:16:54 INFO - "builduid": "6a6ead44ff534deb98fea64fadaa9421", 08:16:54 INFO - "slavebuilddir": "test" 08:16:54 INFO - } 08:16:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 08:16:54 INFO - Running post-action listener: _resource_record_post_action 08:16:54 INFO - [mozharness: 2017-01-31 16:16:54.960060Z] Finished read-buildbot-config step (success) 08:16:54 INFO - [mozharness: 2017-01-31 16:16:54.960196Z] Running download-and-extract step. 08:16:54 INFO - Running pre-action listener: _resource_record_pre_action 08:16:54 INFO - Running main action method: download_and_extract 08:16:54 INFO - mkdir: /builds/slave/test/build/tests 08:16: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')]} 08:16:54 INFO - trying https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 08:16:54 INFO - Downloading https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 08:16:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 08:16:55 INFO - Downloaded 1199 bytes. 08:16:55 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 08:16:55 INFO - Using the following test package requirements: 08:16:55 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 08:16:55 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:16:55 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 08:16:55 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:16:55 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 08:16:55 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:16:55 INFO - u'jsshell-mac.zip'], 08:16:55 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:16:55 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 08:16:55 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 08:16:55 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:16:55 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 08:16:55 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:16:55 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 08:16:55 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:16:55 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 08:16:55 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:16:55 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 08:16:55 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:16:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 08:16:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:16:55 INFO - Fetch https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 08:16:56 INFO - Expected file size: 16371943 08:16:56 INFO - Obtained file size: 16371943 08:17:03 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:17:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 08:17:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:17:03 INFO - Fetch https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 08:17:04 INFO - Expected file size: 16371943 08:17:04 INFO - Obtained file size: 16371943 08:17:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 08:17:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:17:10 INFO - Fetch https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 08:17:11 INFO - Expected file size: 14403454 08:17:11 INFO - Obtained file size: 14403454 08:17:11 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')]} 08:17:11 INFO - trying https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:17:11 INFO - Downloading https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 08:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 08:17:13 INFO - Downloaded 70213218 bytes. 08:17:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:17:13 INFO - mkdir: /builds/slave/test/properties 08:17:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:17:13 INFO - Writing to file /builds/slave/test/properties/build_url 08:17:13 INFO - Contents: 08:17:13 INFO - build_url:https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:17:14 INFO - Running post-action listener: _resource_record_post_action 08:17:14 INFO - Running post-action listener: set_extra_try_arguments 08:17:14 INFO - [mozharness: 2017-01-31 16:17:14.631982Z] Finished download-and-extract step (success) 08:17:14 INFO - [mozharness: 2017-01-31 16:17:14.632137Z] Running populate-webroot step. 08:17:14 INFO - Running pre-action listener: _resource_record_pre_action 08:17:14 INFO - Running main action method: populate_webroot 08:17:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:17:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:17:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:17:14 INFO - '--tppagecycles', 08:17:14 INFO - '7'], 08:17:14 INFO - 'tests': ['tsvgm']}}, 08:17:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:17:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:17:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:17:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:17:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:17:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:17:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:17:14 INFO - 'talos_options': ['--disable-e10s'], 08:17:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:17:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:17:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:17:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:17:14 INFO - 'talos_options': ['--disable-e10s'], 08:17:14 INFO - 'tests': ['damp', 'tps']}, 08:17:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:17:14 INFO - 'tests': ['damp', 'tps']}, 08:17:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:17:14 INFO - 'tests': ['dromaeo_dom']}, 08:17:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:17:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:17:14 INFO - 'tests': ['basic_compositor_video']}, 08:17:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:17:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:17:14 INFO - 'tests': ['a11yr', 08:17:14 INFO - 'ts_paint', 08:17:14 INFO - 'tpaint', 08:17:14 INFO - 'sessionrestore', 08:17:14 INFO - 'sessionrestore_no_auto_restore', 08:17:14 INFO - 'tabpaint']}, 08:17:14 INFO - 'other-e10s': {'tests': ['a11yr', 08:17:14 INFO - 'ts_paint', 08:17:14 INFO - 'tpaint', 08:17:14 INFO - 'sessionrestore', 08:17:14 INFO - 'sessionrestore_no_auto_restore', 08:17:14 INFO - 'tabpaint']}, 08:17:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:17:14 INFO - 'ts_paint', 08:17:14 INFO - 'tpaint', 08:17:14 INFO - 'sessionrestore', 08:17:14 INFO - 'sessionrestore_no_auto_restore', 08:17:14 INFO - 'tabpaint']}, 08:17:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:17:14 INFO - 'ts_paint', 08:17:14 INFO - 'tpaint', 08:17:14 INFO - 'sessionrestore', 08:17:14 INFO - 'sessionrestore_no_auto_restore', 08:17:14 INFO - 'tabpaint']}, 08:17:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:17:14 INFO - 'tests': ['a11yr', 08:17:14 INFO - 'ts_paint', 08:17:14 INFO - 'tpaint', 08:17:14 INFO - 'sessionrestore', 08:17:14 INFO - 'sessionrestore_no_auto_restore', 08:17:14 INFO - 'tabpaint']}, 08:17:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:17:14 INFO - 'tests': ['a11yr', 08:17:14 INFO - 'ts_paint', 08:17:14 INFO - 'tpaint', 08:17:14 INFO - 'sessionrestore', 08:17:14 INFO - 'sessionrestore_no_auto_restore', 08:17:14 INFO - 'tabpaint']}, 08:17:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:17:14 INFO - 'tests': ['tsvgx', 08:17:14 INFO - 'tsvgr_opacity', 08:17:14 INFO - 'tart', 08:17:14 INFO - 'tscrollx', 08:17:14 INFO - 'cart', 08:17:14 INFO - 'tsvg_static']}, 08:17:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:17:14 INFO - 'tsvgr_opacity', 08:17:14 INFO - 'tart', 08:17:14 INFO - 'tscrollx', 08:17:14 INFO - 'cart', 08:17:14 INFO - 'tsvg_static']}, 08:17:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:17:14 INFO - 'talos_options': ['--disable-e10s'], 08:17:14 INFO - 'tests': ['tp5o']}, 08:17:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:17:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:17:14 INFO - 'talos_options': ['--disable-e10s', 08:17:14 INFO - '--xperf_path', 08:17:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:17:14 INFO - 'tests': ['tp5n']}, 08:17:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:17:14 INFO - 'talos_options': ['--xperf_path', 08:17:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:17:14 INFO - 'tests': ['tp5n']}}, 08:17:14 INFO - 'talos.zip': {'path': '', 08:17:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:17:14 INFO - Running post-action listener: _resource_record_post_action 08:17:14 INFO - [mozharness: 2017-01-31 16:17:14.650391Z] Finished populate-webroot step (success) 08:17:14 INFO - [mozharness: 2017-01-31 16:17:14.650528Z] Running create-virtualenv step. 08:17:14 INFO - Running pre-action listener: _resource_record_pre_action 08:17:14 INFO - Running main action method: create_virtualenv 08:17:14 INFO - Creating virtualenv /builds/slave/test/build/venv 08:17:14 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 08:17:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:17:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:17:14 INFO - Using real prefix '/tools/python27' 08:17:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:17:15 INFO - Installing distribute.............................................................................................................................................................................................done. 08:17:18 INFO - Installing pip.................done. 08:17:18 INFO - Return code: 0 08:17:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:17:18 INFO - Reading from file tmpfile_stdout 08:17:18 INFO - Output received: 08:17:18 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) 08:17:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:17:18 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')]} 08:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:18 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')]} 08:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:18 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 0x10ff8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412d5b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd6cd30>, '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 0x10fc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61be8>, '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.uNnv46mfph/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.KyVPAxNm8C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 08:17:18 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 08:17:18 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 08:17:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNnv46mfph/Render', 08:17:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:18 INFO - 'HOME': '/Users/cltbld', 08:17:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:18 INFO - 'LOGNAME': 'cltbld', 08:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:18 INFO - 'MOZ_NO_REMOTE': '1', 08:17:18 INFO - 'NO_EM_RESTART': '1', 08:17:18 INFO - 'PAGER': '/bin/cat', 08:17:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:18 INFO - 'PWD': '/builds/slave/test', 08:17:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:18 INFO - 'SHELL': '/bin/bash', 08:17:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KyVPAxNm8C/Listeners', 08:17:18 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 08:17:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:18 INFO - 'USER': 'cltbld', 08:17:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:18 INFO - 'XPC_FLAGS': '0x0', 08:17:18 INFO - 'XPC_SERVICE_NAME': '0', 08:17:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:18 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 08:17:18 INFO - Cleaning up... 08:17:18 INFO - Return code: 0 08:17:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:17:18 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')]} 08:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:18 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')]} 08:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:18 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 0x10ff8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412d5b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd6cd30>, '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 0x10fc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61be8>, '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.uNnv46mfph/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.KyVPAxNm8C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 08:17:18 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 08:17:18 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 08:17:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNnv46mfph/Render', 08:17:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:18 INFO - 'HOME': '/Users/cltbld', 08:17:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:18 INFO - 'LOGNAME': 'cltbld', 08:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:18 INFO - 'MOZ_NO_REMOTE': '1', 08:17:18 INFO - 'NO_EM_RESTART': '1', 08:17:18 INFO - 'PAGER': '/bin/cat', 08:17:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:18 INFO - 'PWD': '/builds/slave/test', 08:17:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:18 INFO - 'SHELL': '/bin/bash', 08:17:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KyVPAxNm8C/Listeners', 08:17:18 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 08:17:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:18 INFO - 'USER': 'cltbld', 08:17:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:18 INFO - 'XPC_FLAGS': '0x0', 08:17:18 INFO - 'XPC_SERVICE_NAME': '0', 08:17:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:19 INFO - Downloading/unpacking psutil>=3.1.1 08:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:17:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:23 INFO - Installing collected packages: psutil 08:17:23 INFO - Running setup.py install for psutil 08:17:23 INFO - building 'psutil._psutil_osx' extension 08:17:23 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 08:17:23 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 08:17:23 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 08:17:23 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 08:17:23 INFO - building 'psutil._psutil_posix' extension 08:17:23 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 08:17:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:17:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:17:23 INFO - ^ 08:17:24 INFO - 1 warning generated. 08:17:24 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 08:17:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:24 INFO - Successfully installed psutil 08:17:24 INFO - Cleaning up... 08:17:24 INFO - Return code: 0 08:17:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:24 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 0x10ff8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412d5b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd6cd30>, '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 0x10fc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61be8>, '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.uNnv46mfph/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.KyVPAxNm8C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 08:17:24 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 08:17:24 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 08:17:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNnv46mfph/Render', 08:17:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:24 INFO - 'HOME': '/Users/cltbld', 08:17:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:24 INFO - 'LOGNAME': 'cltbld', 08:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:24 INFO - 'MOZ_NO_REMOTE': '1', 08:17:24 INFO - 'NO_EM_RESTART': '1', 08:17:24 INFO - 'PAGER': '/bin/cat', 08:17:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:24 INFO - 'PWD': '/builds/slave/test', 08:17:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:24 INFO - 'SHELL': '/bin/bash', 08:17:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KyVPAxNm8C/Listeners', 08:17:24 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 08:17:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:24 INFO - 'USER': 'cltbld', 08:17:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:24 INFO - 'XPC_FLAGS': '0x0', 08:17:24 INFO - 'XPC_SERVICE_NAME': '0', 08:17:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:17:24 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 08:17:24 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 08:17:24 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 08:17:24 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 08:17:24 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 08:17:24 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 08:17:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:17:27 INFO - Installing collected packages: mozsystemmonitor 08:17:27 INFO - Running setup.py install for mozsystemmonitor 08:17:27 INFO - Successfully installed mozsystemmonitor 08:17:27 INFO - Cleaning up... 08:17:27 INFO - Return code: 0 08:17:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:17:27 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')]} 08:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:27 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')]} 08:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:27 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 0x10ff8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412d5b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd6cd30>, '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 0x10fc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61be8>, '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.uNnv46mfph/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.KyVPAxNm8C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 08:17:27 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 08:17:27 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 08:17:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNnv46mfph/Render', 08:17:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:27 INFO - 'HOME': '/Users/cltbld', 08:17:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:27 INFO - 'LOGNAME': 'cltbld', 08:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:27 INFO - 'MOZ_NO_REMOTE': '1', 08:17:27 INFO - 'NO_EM_RESTART': '1', 08:17:27 INFO - 'PAGER': '/bin/cat', 08:17:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:27 INFO - 'PWD': '/builds/slave/test', 08:17:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:27 INFO - 'SHELL': '/bin/bash', 08:17:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KyVPAxNm8C/Listeners', 08:17:27 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 08:17:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:27 INFO - 'USER': 'cltbld', 08:17:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:27 INFO - 'XPC_FLAGS': '0x0', 08:17:27 INFO - 'XPC_SERVICE_NAME': '0', 08:17:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:27 INFO - Downloading/unpacking jsonschema==2.5.1 08:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:17:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:17:30 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 08:17:30 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 08:17:30 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 08:17:30 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 08:17:30 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 08:17:30 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 08:17:30 INFO - Downloading functools32-3.2.3-2.tar.gz 08:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:17:30 INFO - warning: no files found matching '*.txt' 08:17:30 INFO - no previously-included directories found matching 'build' 08:17:30 INFO - no previously-included directories found matching 'dist' 08:17:30 INFO - no previously-included directories found matching '.git*' 08:17:30 INFO - Installing collected packages: jsonschema, functools32 08:17:30 INFO - Running setup.py install for functools32 08:17:31 INFO - warning: no files found matching '*.txt' 08:17:31 INFO - no previously-included directories found matching 'build' 08:17:31 INFO - no previously-included directories found matching 'dist' 08:17:31 INFO - no previously-included directories found matching '.git*' 08:17:31 INFO - Successfully installed jsonschema functools32 08:17:31 INFO - Cleaning up... 08:17:31 INFO - Return code: 0 08:17:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ff8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412d5b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd6cd30>, '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 0x10fc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61be8>, '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.uNnv46mfph/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.KyVPAxNm8C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 08:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:17:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNnv46mfph/Render', 08:17:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:31 INFO - 'HOME': '/Users/cltbld', 08:17:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:31 INFO - 'LOGNAME': 'cltbld', 08:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:31 INFO - 'MOZ_NO_REMOTE': '1', 08:17:31 INFO - 'NO_EM_RESTART': '1', 08:17:31 INFO - 'PAGER': '/bin/cat', 08:17:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:31 INFO - 'PWD': '/builds/slave/test', 08:17:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:31 INFO - 'SHELL': '/bin/bash', 08:17:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KyVPAxNm8C/Listeners', 08:17:31 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 08:17:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:31 INFO - 'USER': 'cltbld', 08:17:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:31 INFO - 'XPC_FLAGS': '0x0', 08:17:31 INFO - 'XPC_SERVICE_NAME': '0', 08:17:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:17:31 INFO - Cleaning up... 08:17:31 INFO - Return code: 0 08:17:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ff8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412d5b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd6cd30>, '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 0x10fc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61be8>, '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.uNnv46mfph/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.KyVPAxNm8C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 08:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:17:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNnv46mfph/Render', 08:17:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:31 INFO - 'HOME': '/Users/cltbld', 08:17:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:31 INFO - 'LOGNAME': 'cltbld', 08:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:31 INFO - 'MOZ_NO_REMOTE': '1', 08:17:31 INFO - 'NO_EM_RESTART': '1', 08:17:31 INFO - 'PAGER': '/bin/cat', 08:17:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:31 INFO - 'PWD': '/builds/slave/test', 08:17:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:31 INFO - 'SHELL': '/bin/bash', 08:17:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KyVPAxNm8C/Listeners', 08:17:31 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 08:17:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:31 INFO - 'USER': 'cltbld', 08:17:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:31 INFO - 'XPC_FLAGS': '0x0', 08:17:31 INFO - 'XPC_SERVICE_NAME': '0', 08:17:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:31 INFO - Downloading/unpacking blobuploader==1.2.4 08:17:31 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 08:17:31 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 08:17:31 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 08:17:31 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 08:17:31 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 08:17:31 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 08:17:34 INFO - Downloading blobuploader-1.2.4.tar.gz 08:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:17:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:17:34 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 08:17:34 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 08:17:34 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 08:17:34 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 08:17:34 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 08:17:34 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 08:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:17:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:17:35 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 08:17:35 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 08:17:35 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 08:17:35 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 08:17:35 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 08:17:35 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 08:17:35 INFO - Downloading docopt-0.6.1.tar.gz 08:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:17:35 INFO - Installing collected packages: blobuploader, requests, docopt 08:17:35 INFO - Running setup.py install for blobuploader 08:17:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:17:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:17:35 INFO - Running setup.py install for requests 08:17:36 INFO - Running setup.py install for docopt 08:17:36 INFO - Successfully installed blobuploader requests docopt 08:17:36 INFO - Cleaning up... 08:17:36 INFO - Return code: 0 08:17:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:36 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')]} 08:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:36 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')]} 08:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:36 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 0x10ff8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412d5b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd6cd30>, '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 0x10fc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61be8>, '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.uNnv46mfph/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.KyVPAxNm8C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 08:17:36 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 08:17:36 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 08:17:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNnv46mfph/Render', 08:17:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:36 INFO - 'HOME': '/Users/cltbld', 08:17:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:36 INFO - 'LOGNAME': 'cltbld', 08:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:36 INFO - 'MOZ_NO_REMOTE': '1', 08:17:36 INFO - 'NO_EM_RESTART': '1', 08:17:36 INFO - 'PAGER': '/bin/cat', 08:17:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:36 INFO - 'PWD': '/builds/slave/test', 08:17:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:36 INFO - 'SHELL': '/bin/bash', 08:17:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KyVPAxNm8C/Listeners', 08:17:36 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 08:17:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:36 INFO - 'USER': 'cltbld', 08:17:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:36 INFO - 'XPC_FLAGS': '0x0', 08:17:36 INFO - 'XPC_SERVICE_NAME': '0', 08:17:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:36 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-pbEICv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:36 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-jCJl4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:37 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-E7U2nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:37 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-ojmo08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:37 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-JrElzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:37 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-yE9o7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:37 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-FPpbC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:37 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-whTQdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:37 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-IlW5Iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:37 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-QYzv9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:37 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-0xak9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-XAbfkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-0KLrTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-gfX7TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-bBNvI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-HOjnOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:38 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-LtTlcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:17:38 INFO - Running setup.py install for manifestparser 08:17:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:17:38 INFO - Running setup.py install for mozcrash 08:17:38 INFO - Running setup.py install for mozdebug 08:17:39 INFO - Running setup.py install for mozdevice 08:17:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:17:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:17:39 INFO - Running setup.py install for mozfile 08:17:39 INFO - Running setup.py install for mozhttpd 08:17:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:17:39 INFO - Running setup.py install for mozinfo 08:17:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:17:39 INFO - Running setup.py install for mozInstall 08:17:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:17:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:17:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:17:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:17:39 INFO - Running setup.py install for mozleak 08:17:39 INFO - Running setup.py install for mozlog 08:17:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:17:40 INFO - Running setup.py install for moznetwork 08:17:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:17:40 INFO - Running setup.py install for mozprocess 08:17:40 INFO - Running setup.py install for mozprofile 08:17:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:17:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:17:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:17:40 INFO - Running setup.py install for mozrunner 08:17:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:17:40 INFO - Running setup.py install for mozscreenshot 08:17:40 INFO - Running setup.py install for moztest 08:17:41 INFO - Running setup.py install for mozversion 08:17:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:17:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:17:41 INFO - Cleaning up... 08:17:41 INFO - Return code: 0 08:17:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:41 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 0x10ff8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412d5b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd6cd30>, '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 0x10fc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61be8>, '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.uNnv46mfph/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.KyVPAxNm8C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 08:17:41 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 08:17:41 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 08:17:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNnv46mfph/Render', 08:17:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:41 INFO - 'HOME': '/Users/cltbld', 08:17:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:41 INFO - 'LOGNAME': 'cltbld', 08:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:41 INFO - 'MOZ_NO_REMOTE': '1', 08:17:41 INFO - 'NO_EM_RESTART': '1', 08:17:41 INFO - 'PAGER': '/bin/cat', 08:17:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:41 INFO - 'PWD': '/builds/slave/test', 08:17:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:41 INFO - 'SHELL': '/bin/bash', 08:17:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KyVPAxNm8C/Listeners', 08:17:41 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 08:17:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:41 INFO - 'USER': 'cltbld', 08:17:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:41 INFO - 'XPC_FLAGS': '0x0', 08:17:41 INFO - 'XPC_SERVICE_NAME': '0', 08:17:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:41 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-5bDWDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:41 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)) 08:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:41 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-c5jIiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:41 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)) 08:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:41 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-03JaVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:41 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)) 08:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:41 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-qL3T9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:41 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)) 08:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:41 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-VuGbe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:42 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)) 08:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:42 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-YaQYxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:42 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)) 08:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:42 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-6SA6ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:42 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)) 08:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:42 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-lPohQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:42 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)) 08:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:42 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Ok9u3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:42 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)) 08:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:42 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-e89hAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:42 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)) 08:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:42 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-o0EUb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:42 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)) 08:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:42 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-NxDhnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 08:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:42 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-MhOUA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:42 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)) 08:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:42 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-CtEzYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:42 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)) 08:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:42 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-BOjodo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:43 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)) 08:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:43 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-yDQCaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 08:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:43 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-RVkCvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:43 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)) 08:17:43 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)) 08:17:43 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)) 08:17:43 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)) 08:17:43 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)) 08:17:43 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)) 08:17:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:43 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 08:17:43 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 08:17:43 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 08:17:43 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 08:17:43 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 08:17:43 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 08:17:45 INFO - Downloading blessings-1.6.tar.gz 08:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:17:46 INFO - Installing collected packages: blessings 08:17:46 INFO - Running setup.py install for blessings 08:17:46 INFO - Successfully installed blessings 08:17:46 INFO - Cleaning up... 08:17:46 INFO - Return code: 0 08:17:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:17:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:46 INFO - Reading from file tmpfile_stdout 08:17:46 INFO - Current package versions: 08:17:46 INFO - blessings == 1.6 08:17:46 INFO - blobuploader == 1.2.4 08:17:46 INFO - docopt == 0.6.1 08:17:46 INFO - functools32 == 3.2.3-2 08:17:46 INFO - jsonschema == 2.5.1 08:17:46 INFO - manifestparser == 1.1 08:17:46 INFO - mozInstall == 1.12 08:17:46 INFO - mozcrash == 1.0 08:17:46 INFO - mozdebug == 0.1 08:17:46 INFO - mozdevice == 0.49 08:17:46 INFO - mozfile == 1.2 08:17:46 INFO - mozhttpd == 0.7 08:17:46 INFO - mozinfo == 0.9 08:17:46 INFO - mozleak == 0.1 08:17:46 INFO - mozlog == 3.4 08:17:46 INFO - moznetwork == 0.27 08:17:46 INFO - mozprocess == 0.24 08:17:46 INFO - mozprofile == 0.28 08:17:46 INFO - mozrunner == 6.13 08:17:46 INFO - mozscreenshot == 0.1 08:17:46 INFO - mozsystemmonitor == 0.3 08:17:46 INFO - moztest == 0.8 08:17:46 INFO - mozversion == 1.4 08:17:46 INFO - psutil == 3.1.1 08:17:46 INFO - requests == 1.2.3 08:17:46 INFO - wsgiref == 0.1.2 08:17:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:46 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 0x10ff8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412d5b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd6cd30>, '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 0x10fc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61be8>, '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.uNnv46mfph/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.KyVPAxNm8C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 08:17:46 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 08:17:46 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 08:17:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNnv46mfph/Render', 08:17:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:46 INFO - 'HOME': '/Users/cltbld', 08:17:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:46 INFO - 'LOGNAME': 'cltbld', 08:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:46 INFO - 'MOZ_NO_REMOTE': '1', 08:17:46 INFO - 'NO_EM_RESTART': '1', 08:17:46 INFO - 'PAGER': '/bin/cat', 08:17:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:46 INFO - 'PWD': '/builds/slave/test', 08:17:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:46 INFO - 'SHELL': '/bin/bash', 08:17:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KyVPAxNm8C/Listeners', 08:17:46 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 08:17:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:46 INFO - 'USER': 'cltbld', 08:17:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:46 INFO - 'XPC_FLAGS': '0x0', 08:17:46 INFO - 'XPC_SERVICE_NAME': '0', 08:17:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:46 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)) 08:17:46 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)) 08:17:46 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)) 08:17:46 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)) 08:17:46 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)) 08:17:46 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)) 08:17:46 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)) 08:17:46 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)) 08:17:46 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)) 08:17:46 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)) 08:17:46 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)) 08:17:46 INFO - Cleaning up... 08:17:46 INFO - Return code: 0 08:17:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ff8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc412d5b010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd6cd30>, '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 0x10fc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61be8>, '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.uNnv46mfph/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.KyVPAxNm8C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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 08:17:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:17:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNnv46mfph/Render', 08:17:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:17:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:17:46 INFO - 'HOME': '/Users/cltbld', 08:17:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:17:46 INFO - 'LOGNAME': 'cltbld', 08:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:46 INFO - 'MOZ_NO_REMOTE': '1', 08:17:46 INFO - 'NO_EM_RESTART': '1', 08:17:46 INFO - 'PAGER': '/bin/cat', 08:17:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:46 INFO - 'PWD': '/builds/slave/test', 08:17:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:17:46 INFO - 'SHELL': '/bin/bash', 08:17:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KyVPAxNm8C/Listeners', 08:17:46 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 08:17:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:17:46 INFO - 'USER': 'cltbld', 08:17:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:17:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:46 INFO - 'XPC_FLAGS': '0x0', 08:17:46 INFO - 'XPC_SERVICE_NAME': '0', 08:17:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:17:47 INFO - Cleaning up... 08:17:47 INFO - Return code: 0 08:17:47 INFO - Running post-action listener: _resource_record_post_action 08:17:47 INFO - Running post-action listener: _start_resource_monitoring 08:17:47 INFO - Starting resource monitoring. 08:17:47 INFO - [mozharness: 2017-01-31 16:17:47.179027Z] Finished create-virtualenv step (success) 08:17:47 INFO - [mozharness: 2017-01-31 16:17:47.179991Z] Running install step. 08:17:47 INFO - Running pre-action listener: _resource_record_pre_action 08:17:47 INFO - Running main action method: install 08:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:47 INFO - Reading from file tmpfile_stdout 08:17:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:17:47 INFO - Reading from file tmpfile_stdout 08:17:47 INFO - Output received: 08:17:47 INFO - Usage: mozinstall [options] installer 08:17:47 INFO - Options: 08:17:47 INFO - -h, --help show this help message and exit 08:17:47 INFO - -d DEST, --destination=DEST 08:17:47 INFO - Directory to install application into. [default: 08:17:47 INFO - "/builds/slave/test"] 08:17:47 INFO - --app=APP Application being installed. [default: firefox] 08:17:47 INFO - mkdir: /builds/slave/test/build/application 08:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:18:09 INFO - Reading from file tmpfile_stdout 08:18:09 INFO - Output received: 08:18:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:18:09 INFO - Running post-action listener: _resource_record_post_action 08:18:09 INFO - [mozharness: 2017-01-31 16:18:09.438432Z] Finished install step (success) 08:18:09 INFO - [mozharness: 2017-01-31 16:18:09.438611Z] Running run-tests step. 08:18:09 INFO - Running pre-action listener: _resource_record_pre_action 08:18:09 INFO - Running main action method: run_tests 08:18:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:18:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:18:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:18:09 INFO - 2017-01-31 08:18:09.451 screenresolution[1632:7572] starting screenresolution argv=screenresolution get 08:18:09 INFO - 2017-01-31 08:18:09.453 screenresolution[1632:7572] Display 0: 1600x1200x32@60 08:18:09 INFO - 2017-01-31 08:18:09.458 screenresolution[1633:7574] starting screenresolution argv=screenresolution list 08:18:09 INFO - Available Modes on Display 0 08:18:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:18:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:18:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:18:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:18:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:18:09 INFO - Intel Iris: 08:18:09 INFO - Chipset Model: Intel Iris 08:18:09 INFO - Type: GPU 08:18:09 INFO - Bus: Built-In 08:18:09 INFO - VRAM (Dynamic, Max): 1536 MB 08:18:09 INFO - Vendor: Intel (0x8086) 08:18:09 INFO - Device ID: 0x0a2e 08:18:09 INFO - Revision ID: 0x0009 08:18:09 INFO - Displays: 08:18:09 INFO - Display: 08:18:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:18:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:18:09 INFO - Display Serial Number: 1600x1200 60 08:18:09 INFO - Main Display: Yes 08:18:09 INFO - Mirror: Off 08:18:09 INFO - Online: Yes 08:18:09 INFO - Rotation: Supported 08:18:09 INFO - Return code: 0 08:18:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:18:09 INFO - Python 2.7.3 08:18:09 INFO - Return code: 0 08:18:09 INFO - grabbing minidump binary from tooltool 08:18:09 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')]} 08:18:09 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 0x10fd6cd30>, '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 0x10fc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fd61be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:18:09 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 08:18:09 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 08:18:09 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 08:18:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:18:09 INFO - Return code: 0 08:18:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:18:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:18:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:18:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:18:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:18:09 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/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--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 08:18:09 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/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0073 --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 08:18:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.uNnv46mfph/Render', 08:18:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:18:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:18:09 INFO - 'HOME': '/Users/cltbld', 08:18:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:18:09 INFO - 'LOGNAME': 'cltbld', 08:18:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:18:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:09 INFO - 'MOZ_NO_REMOTE': '1', 08:18:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:18:09 INFO - 'NO_EM_RESTART': '1', 08:18:09 INFO - 'PAGER': '/bin/cat', 08:18:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:09 INFO - 'PWD': '/builds/slave/test', 08:18:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:18:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:18:09 INFO - 'SHELL': '/bin/bash', 08:18:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KyVPAxNm8C/Listeners', 08:18:09 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 08:18:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:18:09 INFO - 'USER': 'cltbld', 08:18:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:18:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:09 INFO - 'XPC_FLAGS': '0x0', 08:18:09 INFO - 'XPC_SERVICE_NAME': '0', 08:18:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:18:09 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/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--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 08:18:10 INFO - mozversion application_buildid: 20170131065509 08:18:10 INFO - mozversion application_changeset: b47946b2076f6ac3ffd2cb72367f789237a11ab6 08:18:10 INFO - mozversion application_display_name: Nightly 08:18:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:18:10 INFO - mozversion application_name: Firefox 08:18:10 INFO - mozversion application_remotingname: firefox 08:18:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:18:10 INFO - mozversion application_vendor: Mozilla 08:18:10 INFO - mozversion application_version: 54.0a1 08:18:10 INFO - mozversion platform_buildid: 20170131065509 08:18:10 INFO - mozversion platform_changeset: b47946b2076f6ac3ffd2cb72367f789237a11ab6 08:18:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:18:10 INFO - mozversion platform_version: 54.0a1 08:18:10 INFO - using testdate: 1485879490 08:18:10 INFO - actual date: 1485879490 08:18:10 INFO - starting webserver on 'localhost:49248' 08:18:10 INFO - SUITE-START | Running 2 tests 08:18:10 INFO - TEST-START | dromaeo_css 08:18:10 INFO - operating with platform_type : mac_ 08:18:10 INFO - Initialising browser for dromaeo_css test... 08:18:10 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpfR0RT9/profile http://localhost:49248/getInfo.html) 08:18:13 INFO - PROCESS | 1643 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 08:18:13 INFO - PROCESS | 1643 | 2017-01-31 08:18:13.230 plugin-container[1645:7741] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4843, name = 'com.apple.tsm.portname' 08:18:13 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:18:13 INFO - PROCESS | 1643 | 2017-01-31 08:18:13.233 plugin-container[1645:7741] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 08:18:13 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:18:13 INFO - PROCESS | 1643 | 2017-01-31 08:18:13.233 plugin-container[1645:7741] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:18:13 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 08:18:13 INFO - PROCESS | 1643 | colorDepth:24 08:18:13 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 08:18:13 INFO - PROCESS | 1643 | __metrics 08:18:13 ERROR - PROCESS | 1643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3284: TypeError: this.tabs is undefined 08:18:13 INFO - PROCESS | 1643 | 1485879493378 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpfR0RT9/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpfR0RT9/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpfR0RT9/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpfR0RT9/profile/extensions/talos-powers@TalosPowersService.js:55:9 08:18:13 INFO - TEST-INFO | 1643: exit 0 08:18:13 INFO - Browser initialized. 08:18:13 INFO - Running cycle 1/1 for dromaeo_css test... 08:18:14 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpfR0RT9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:18:16 INFO - PROCESS | 1646 | 2017-01-31 08:18:16.532 plugin-container[1647:7863] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 08:18:16 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:18:16 INFO - PROCESS | 1646 | 2017-01-31 08:18:16.532 plugin-container[1647:7863] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 08:18:16 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:18:16 INFO - PROCESS | 1646 | 2017-01-31 08:18:16.532 plugin-container[1647:7863] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:18:26 INFO - PROCESS | 1646 | RSS: Main: 233684992 08:18:26 INFO - PROCESS | 1646 | 08:21:29 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 08:21:30 INFO - PROCESS | 1646 | RSS: Main: 258486272 08:21:30 INFO - PROCESS | 1646 | 08:23:14 INFO - PROCESS | 1646 | ************************* 08:23:14 INFO - PROCESS | 1646 | A coding exception was thrown and uncaught in a Task. 08:23:14 INFO - PROCESS | 1646 | 08:23:14 ERROR - PROCESS | 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:23:14 INFO - PROCESS | 1646 | Full stack: 08:23:14 INFO - PROCESS | 1646 | ************************* 08:24:32 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 08:24:33 INFO - PROCESS | 1646 | RSS: Main: 264187904 08:24:33 INFO - PROCESS | 1646 | 08:27:35 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 08:27:35 INFO - PROCESS | 1646 | RSS: Main: 275451904 08:27:35 INFO - PROCESS | 1646 | 08:30:37 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 08:30:38 INFO - PROCESS | 1646 | RSS: Main: 268025856 08:30:38 INFO - PROCESS | 1646 | 08:33:41 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 08:33:41 INFO - PROCESS | 1646 | RSS: Main: 273043456 08:33:41 INFO - PROCESS | 1646 | 08:36:44 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 08:36:44 INFO - PROCESS | 1646 | RSS: Main: 274927616 08:36:44 INFO - PROCESS | 1646 | 08:36:44 INFO - PROCESS | 1646 | __start_tp_report 08:36:44 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 08:36:44 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 08:36:44 INFO - PROCESS | 1646 | |i|pagename|runs| 08:36:44 INFO - PROCESS | 1646 | |0;dojo.html;2626.8292560983537;3322.7009569138772;3347.799132052077;3377.9662203377975;3385.424477838767;5566.944330556693;5657.377688454272;5677.574181936356;5727.455891690282;5731.254936858208;5596.776128954847;5654;5665.660060396379;5679.659220446766;5684.658920464775;5133.845984620468;5178.067947769418;5193.195054766517;5196.090684130281;5247.606429517782;5231.26762253283;5248.71132087735;5249.842504724865;5261.921306132233;5267.394249661281;5245.4754524547625;5252.658577192489;5259.894802103956;5269.552088072518;5290.285811415468;5233.4243233244315;5243.501867322599;5251.317328747238;5259.0270799901755;5273.129933560957;5079.542841144278;5196.76614552346;5201.323827902386;5222.2427747976335;5254.106801843657;5732.168835518826;5745.339285982123;5800.955827950967;5869.970650146722;5891.086881533369;6041;6168.074788781674;6228.564000519966;6251.843703907393;6257.749690012394;6148.1392605035335;6155.384461553854;6173.938260617381;6196.132541444202;6210.223722034746;5895.55783316253;5914.083317085859;5914.201582786269;5921.348651648315;5953.702314884282;6258.687065646699;6273.466755325849;6278.843028924313;6280.434760871543;6283.277423096311;6036.758529658852;6057.757689692451;6101.7559297627595;6121.540884433685;6168.814935551941;6125.479334256638;6186.19579454677;6191.535634827406;6205.875882482325;6213.906791398133;5125.718085505258;6198.6280823149855;6214.502839772807;6218.378162183745;6239.937600624026;6058.545609079337;6124.411449639965;6217.564770466024;6218.502519798405;6230.501559875199;4916.3362946001835;4951.984843107154;4953.455119936804;4959.90080198394;5023.34696489454;4417.757023363746;4423.535528769497;4424.867253982386;4437.933430998538;4442.711223770445;6002.519798416116;6011.128386384037;6012.098185272244;6015.789447369321;6019.097135429633;5185.533302002837;6073.089036644538;6128.136482154469;6135.754569817157;6155.891939450852;5953.22608060958;6034.456898879122;6036.577439579188;6042.788502402394;6077.574569780073;4980.402351717817;5391.973040134852;5451.536619387317;5487.396386397493;5504.174373843955;5345.091334473227;6341.778037768656;6392.552521323462;6397.936020639827;6407.070974708734;6106.73370229429;6191.442770150708;6219.191505104308;6219.315875253628;6219.906701399392;6338.492920566436;6398.232212134573;6403.775867844603;6407.807765767035;6417.2299324081405;5271.209318602087;6116.8227554565365;6206.968965155145;6223.253209614875;6238.563300568917;5996.760129594767;6147.969260153671;6175.197224360804;6210.875782484415;6212.751489940351;6129.908051379144;6166.290876549254;6173.444390004921;6179.876402472015;6186.041163619646;5963.0459126539545;6158.476529495043;6171.722272497838;6173.38266173397;6177.042558403455;5025.623078269071;5924.022536281465;5962;6058.303295121117;6068.089786532056;6139.272938940574;6146.938530614637;6169.876602467836;6173.074038894202;6194.101855231056;6055.878882422238;6065.272167339771;6065.8180254592435;6071.939280607314;6091.664958427152 08:36:44 INFO - PROCESS | 1646 | |1;ext.html;409.26128338349287;457.4442052905719;469.73459995102775;479.3648415849001;491.53058828818484;39615.801920990394;41668.37497437537;41872.162556748925;41955.16089678204;42007.579924200785;42521;42845.57154428455;43282;43301.566984330144;43343;8364.954380702413;8590.196058827654;9091.409058411198;9392.107749763762;9418.058194180561;11121.888781112166;11353.659390218307;11374.943125284404;11545.884541154564;11586.942065289662;11292.604758833442;11321.716957076056;11324.263922844988;11328.603498877541;11358.148138889575;11279.154063445234;11337.319760814295;11340.376279304675;11342.603008894732;11369.545218191262;11233.494492747846;11248.325100493996;11312.264702794291;11319.717007074807;11332.43337833105;40669.18661626751;40689.79655101735;40755.796221019;40879.38680919789;41023;4040.333344998072;4051.453053837753;4071.450354202204;4083.3466645336603;4196.279525394573;29846;29969.550456743167;30153.396932061234;30373.24066898323;30683.386332273454;2536.8837711406923;3070.861811218478;3242.951355729666;3266.444704400234;3300.603927528688;486319;496653;498410;498736;501102.49448752886;61031;61160.69419652873;61804;61805.07292390618;62042.68978655078;64123.358766412675;64365;64508.35491645023;64582.67708661521;64680;13289.534866279633;13353.599392018255;13664.863351366557;16027.919860400856;16239.269232884548;11329.546818127348;11583.884161158448;12432.502699892084;12609.558665446666;12702.555410560586;15445.768313475306;16892.226316236618;16936.40722574704;17088.316467341167;17133.742993855103;6442.259140198843;6491.480681545465;6504.869902601921;6518.348165183538;6533.444657204096;834.3950635789125;859.2910848549972;862.9093945135796;863.5974261410024;863.7667829686076;29894.701052989625;30005;30070.398592028476;30210.84894575557;31033.37933241368;1028.789098234875;1035.8549803027581;1072.2012100984816;1074.59165517103;1194.7311854832767;15388.769168462482;15670.451534196249;15677.05937643745;15683.372665093268;15915;527983;583402;585034;585655;588434;60899.69550152221;60903.69548152231;61023.08465373023;61110.69444652748;61200.08199877005;1358.7554240236655;1390.2909516146635;1399.6430910118058;1405.4799724102147;1406.205493895966;28957.85521072381;29387.265318367212;29608.851955740083;30461.847690761406;30477.847610761804;50900.72748181177;51216.74391628018;51347.2297915539;51386.715332117;51447;510725;511900;513305;514943;515725;40000;40596.39105413362;40796.38805417862;40863.59136408598;40986.1802763949;45636;46463.07073858436;47074;47521.04957900892;47778;31006;38215.61784382121;38424.42363364496;39593;40121.1975760489;31335.903243386372;32083.518747219277;38061.048473788374;38363;39364.60635393609;36339.45490817587;36548.81725591355;36727;37334.06664833401;38010.809945950095;31619;32818;33868.40606926261;34197;34356.656433435346;24891.62662560099;24998.875005624854;25078.62382064307;25390;25531.617025745 08:36:44 INFO - PROCESS | 1646 | |2;jquery.html;362.8983884512336;390.9628585284397;400.4493820996131;400.8637063398444;402.18958798021987;14901.403943842246;17410.738838917394;20588.588228235425;21319.253826116088;21528.246511372086;18122.909385453055;20048.59902801943;21211.257605983792;21225.36323910281;21548.81481518516;4956.157453232959;5691.7723291068305;5835.649861008353;5868;5885.558583106263;5715.171300161474;5843.094320380348;5864.4135586441225;5869.178315035877;5883.999720047581;5162.264000079945;5328.307320048389;5791.7972870949525;5794.565407594426;5835.503982161521;4945.727984960826;5739.397363276858;5755.30936287644;5763.7982670606325;5768.971155144219;4894.216925291972;4992.40091189056;5026.195808670632;5076.441591424978;5079.009593129341;25605.975760969537;25691.486170276676;25779.839907204034;26066.478670426484;26397.868010660015;2082.739657542807;2698.244491542371;2701.3786829029236;2713.8507382093976;2731.412746259564;14824.777628335583;14918.88108391875;15296.388144474207;15803.841961580467;16200.35198592055;1693.2549678141702;1844.8339649431616;1859.191251805469;1868.8504919606398;1904.8285654291042;128345.35827320897;133818;133906;137221;139161.3041934784;11360.48877800501;11416.517962021497;11536.192466527262;11548.307101573933;11614.941925290488;14611.123332600078;14735.92632036833;14764;14779.630509237355;14802.777958330633;7161.89257161143;8477.152284771597;8725.389222754346;8751.606177722018;8860.4240724354;8527.488350698854;8541;8560.48637081777;8678.305735541142;8728.432651877734;6175.62946223228;7235.92764072363;7348.96325518369;7354.756799176195;7358.96320518394;1761.436340371069;1840.3098837935775;1915.2542372881355;1935.98064019358;1958.1482055305987;720.9387202087777;859.4886042804521;873.1443185678071;879.692107762278;903.1735961595198;20044.797312161318;21670.78329216719;22175.112995480322;22329.888350558143;22343.77656223417;805.6898094233762;899.8380291547453;926.7312479381039;931.3759780946782;941.0683423410774;8726.432781869158;10568.630097946534;11402.232653938652;11607.36159511235;11613.36126513033;598376.016239832;605562;633339;655638;720144;135835;141138.70890328748;142012;165680;171002.14498927427;995.8406654935176;999.9400035997863;1039.870016247969;1041.9010194031555;1044.921630877672;20035.799642003978;20197.49506262355;20404.28584999518;20471.283505077252;20484;58457.538561536305;59577;60496;60697.69651151892;60975;82912.75630865662;83354.16645833464;84962;85002;85509.86225344417;7188.245234250328;7397.927300541499;7485.812854678677;8133.918660813316;8625.568721564023;9135.77160570991;11736.413179340829;12329.321887295926;12469.563565275172;12836.486540538273;7909.7231596893835;10588.364698118137;10871.836922446328;10957.123430125412;11029.669109926715;5136.948630513796;8241.969753780777;8691.521966291915;10474.895251047392;11080.947310005537;10820.891791082304;11108.333499990027;11140.663120425601;11181.72045698864;11219.046381057375;7273.818154545967;7511.248875112445;7621;7695.307422332017;7699.114601820862;5605.355384130714;6908.447324214151;7750.689972401041;9740.318177727491;11382.146339024772 08:36:44 INFO - PROCESS | 1646 | |3;mootools.html;1397.7414178377;1420.1053336398068;1423.459085547492;1428.4643258777958;1441.776524638681;7471.7011319547155;7749.380049596033;8098.514089154647;8506;8519.829603407929;7992.280694737473;8304.21109994551;8304.875426868586;8369.581520923944;8379.790505237372;2264.3772962435337;2305.170138750049;2313.4447732544236;2318.9072437102495;2319.663648770927;2046.355398049617;2133.391983284764;2272.681824544565;2303.7696230376996;2304.781045800646;1968.6161198566285;2233.6091184042807;2312.5143719818857;2313.53729254149;2318.8724620145886;2298.7816457277586;2303.974731244597;2314.976850231493;2316.6061769499224;2321.953560928772;2299.6320588705726;2318.860868347888;2326.1160758911506;2343.5078633486987;2352.4118970257437;8400.831983360298;8420.326373890073;8460.83078338436;8464.78838029048;8497.95751021247;4457.264551349023;5055.368078990126;5231.032259032053;5241.318628578299;5251.842444726664;3012.9454690858242;3232.2565809863627;3344.065208298872;3478.252175782219;3526.047967048908;1087.613897066538;1153.8557680289964;1190.678516800459;1232.2360136715204;1239.5661518468464;8654.48073115615;10680.893191068068;10778.784424311549;10815.18886083547;10832.350058996406;4382.101669157815;4696.755359829648;4703.153432382135;4741.407324084489;4760.381150450419;9444.386114902509;9536.713898583053;9541.61833526665;9548.665796697222;9550.808983820423;5220.451852555427;5249.501297376743;5251.711155886386;5262.868428289324;5263.210518422267;4527.9547204527535;4694.741789201558;4720.268358404453;4784.665073444895;4801.01579176268;3782.508273924427;3816;3869.2648396804516;3897.719833897202;3907.1794923066473;1174.9823752643717;1212.5816593275306;1288.5039259885011;1289.9806502902463;1297.8961683065331;723.3092396761081;753;755.0486387152228;779.3258831111048;801.1787917384611;4804.567588917014;5218.66078704883;5438.619296649196;5717.715691721575;6027.969860150672;952.1620973543376;980.6518685866557;996.6511720897628;1004.4826914139225;1020.4692960559162;3007.7293043626178;3513.4905438711244;3739.5512538495555;3753.136778540896;3775.1505911169766;9630.422174669542;9904.702858914245;9956.800863982824;9972.152367048882;9975.700728978143;9872.062154095349;9908.20734341251;9928.900710992797;10042;10076.244281678903;7364.77905662831;7618.162002179756;7737.729179478692;7885.093214280317;7905.169957154531;5311.041796631316;5319.813806516753;5344.786208551614;5528.7235638218735;5619.269494965628;9043.603445087188;9236.72289831306;9247.491387973727;9283.814323713354;9306.162445379949;6999.51003429755;9174.220191283548;9193.264538836744;9214.815703686023;9337.53312334367;6628.436582890508;7657.119431265253;7774.766756997299;7798.220177982156;7803.843923121392;7689.92310076892;7771.883421748791;7818.257265559762;7818.296353328228;7836.882446763417;6553.606783593;6957.582545047313;6970.895436568557;7006.824829379307;7123.964380178066;6916.377526022682;6941.548799328028;7056.082709247765;7056.223815380202;7150.141982962078;6250.499960003098;6315.400036996478;6397.488200944006;6401.103845461546;6427.550071495138;4866.80532778699;4879.853604391874;4933.925991110208;4940.283658869372;5007.123753343223;4424.446944131983;4899.04468628614;4928.137575924271;4943.728094954812;4943.901121977612 08:36:44 INFO - PROCESS | 1646 | |4;prototype.html;317.8506102131998;347.61414829539206;353.7273020841097;368.52828379674025;369.44583125312033;4591.747453890039;4855.902881942359;4979.253112033197;5116.948830511694;5541.564230177286;4265.466816647919;4372.819338778536;5161.251618515313;5306.602004849632;5400.785677872073;3666.8716594919183;4259.488861336628;4278.465191851011;4283.528811830696;4300.032492689151;3725.795081270529;3740.6259374062647;4297.247981603207;4298;4313.741175529478;3280.311134661724;4117.485314335708;4160.54234034256;4230.365445183216;4290.528041915387;4227.957720422787;4231.724937879058;4232.38630398592;4235.449391579105;4247.957520424787;3252.36578867121;3741.1021354874906;3741.5323084614424;3765.303418867491;3773.5660399054186;4498.820047198108;5038.470960549163;5346.8395948121615;5380.058489764276;5381.596380271456;4126.906369812003;4471.597556219924;4924;4936.6297527685565;4956.281339205831;4815.8441973926;4849.660523763338;5432.375276843174;5854.736536855852;5875.265591801025;3729.067733066733;3822.9808850955847;4020.4773379460776;4095.365218391154;4129.15352352767;5119.825708061026;5454.663607416169;6000.669963152025;6103.938960610381;6169.660668663222;3648.3068217038676;4237.576242375738;4241.791089539528;4266.394896312611;4271.337942618899;3625.1662117712544;4271.167122411162;4308.267594508941;4310.482742070972;4328.7402755834755;4292.656587472995;4581.816727330869;4810.230363141881;4839.661223714376;4938.728369939616;5832.24180856486;5838;5864.618799778001;5873.383294754075;5900.557458190567;1147.7532330548804;1186.727052777866;1286.3568215892053;1408.338081101901;1419.432227109144;856.5246288310047;905.2938707807921;967.274544091931;982.4841957971979;988.4761076629397;4726.669133160645;4802.855914322576;5057.974710126499;5321.627486076015;5352.4915133062295;5124.8206312778875;5694.715264236855;5711.857203569861;5712.171735098387;5713.057560429474;4361.80371883266;4897.3878265216845;4899;5002.2496625506465;5231.319928409359;2851.2871782054485;2878.409925965172;2900.9564856527168;2937.8677959491874;2971.925701857471;5250.3962044364625;5454.400015998237;5661.377248502661;5906.645601263938;5946.643201407929;5603;5714.000099964979;5868.7382212823595;5881.5588830837005;5904.822855314262;5305.071612467803;5341.62608617393;5503.202790074835;5613.382527922007;5878.735456904449;5122.745991763612;5184;5280.471952804689;5520.861978450571;5685.715714214355;4974.567548391743;5239.397469291081;5530.640508366943;5583.330000399978;5656.85857853557;5500.339959204921;5509.393966663744;5694.914576281276;5882.205902203319;5884.704965063543;3428.2971990742335;3625.546806649169;3986.86045988389;4037.37420699792;4054.493188351456;5101.438841727481;5264.31563896691;5410;5681.375048744552;5710.428957104256;4525.683202175816;4801.351817504592;4922.089413458521;5052.671576347526;5460.563154947516;4887.413510378778;5122.5400760782995;5461.057742742824;5472.522418946783;5495.560355171657;4341.7829108545075;5065.417476990193;5390.083685773349;5402.405735369185;5494.011078005998;4811.591014763784;5770.884582308414;5792.565557583114;5804.82585522435;5827.854303642443;5231.822839861153;5662.716864156693;5672.659640421588;5677.971610141923;5705.286839145107 08:36:44 INFO - PROCESS | 1646 | |5;yui.html;709.2588245283678;733.8348871503912;765.7166848266143;771.7993321736348;867.427497851418;14673.486427975024;15154.848451515481;15705.764413533792;15772.053676779373;15807.525774226762;14243.92878035611;14398.712025759478;14616.926915365435;14623;14627.707445851103;769.9307062364372;859.96130174142;860.7503823891064;860.9827803443927;861.6897916749965;843.877637742527;859.7549698335976;873.6156091319831;876.1063715010686;879.0286733159862;745.8247311881703;915.1534830281996;916.3036092569629;919.9908000919972;920.9815803683922;912.2291663544295;912.703371404293;913.2191975860676;913.8857642794651;915.702396721065;681.3152781454606;682.952193346466;685.5920727167377;685.6845850908588;685.7188552693422;15727.13500757458;15744.212789360487;15953.76069358949;15989.760153597705;15997.040177589382;13715;13936.93031534846;14182.858171418256;14232.92883535586;14255.358508867126;11661;11719.355435451047;11734.647960561197;11771.7057073573;12044.81932771009;3712.3874560697454;3729.515163028816;3742.8315725792404;3761.191343861083;3885.747426417302;77019;110336;112405.43797280961;113039;113844;10540.209484288709;10545.156387488982;10664;10665.84001239982;10677.199210059276;22263.666045009337;22444.55110897773;22487.32538023862;22512.549749004927;22622.321330360115;7608.771736847903;7610.543367397974;7641.847163056707;7676.884846727304;7768.922310776933;4167.562405947332;4223.598758117974;4234.364845273172;4260.893477663021;4316.223079845595;3566.4293713005795;3662.688671462902;3674.0447483654443;3756.3426400379826;3948.980255098764;699.1644984243779;699.5942353434996;704.5385272646424;706.5407485134601;716.7527203114917;586.4370204603629;588.9057750759857;700.2087640965676;712.2379054411833;712.9465290103263;9751.3661611995;10352.171826253882;10375.578462332958;10539.314944528582;10664;644.0243031806816;654.0679531667355;655.2530115668142;692.4840993459804;702.4801646781345;4355.586219309161;5034.345535080416;5093.923591146136;5099.5410413063;5111.974440127776;99934.5003274979;107697.92302077035;109458;110053;112126.43936780264;81724.18275817284;85303;91660.54169729241;94022;95149.5242523783;71397.50108746273;80087.59956200299;81578;81680;82201;9092.636294548409;9936.006399360007;9961.203103751828;9978.750531236486;10001.849972250277;42064.1587168261;44902.55097448984;46045.53954460547;53345.733271333396;54185;53019.73490132679;54118.458815412916;71451;72624.27375726175;72723.27276727164;11496.482658280565;11691.707707307385;11790.646280611596;11799.17405781587;11921.880781192423;12867.420966056363;12961.481540738265;13065.608031759062;13180.406881690154;13296.534621288209;11769;11787.351695656478;11890.323890046653;11906.821397678868;12118.151729378858;11781.941090294493;11787.705307367385;12022.879771202175;12137.21108127969;12416;12205.511779528719;13059.906636411617;13387.19676819355;13505.527306544223;13771.380287886868;10773.030427261585;10987.560497580007;11214.215004949901;11450.885491144982;11542.365169915734;10818.350898946088;10866.891331086588;10965.396903170402;11023.944880275547;11128.054115400282 08:36:44 INFO - PROCESS | 1646 | __end_tp_report 08:36:44 INFO - PROCESS | 1646 | __start_cc_report 08:36:44 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,401 08:36:44 INFO - PROCESS | 1646 | __end_cc_report 08:36:44 INFO - PROCESS | 1646 | __startTimestamp1485880604778__endTimestamp 08:36:44 INFO - PROCESS | 1646 | 08:36:44 INFO - PROCESS | 1646 | ------- Summary: start ------- 08:36:44 INFO - PROCESS | 1646 | Number of tests: 6 08:36:44 INFO - PROCESS | 1646 | 08:36:44 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5742.37 Median:6036.76 stddev:660.94 (10.9%) stddev-sans-first:616.12 08:36:44 INFO - PROCESS | 1646 | Values: 2626.8 3322.7 3347.8 3378.0 3385.4 5566.9 5657.4 5677.6 5727.5 5731.3 5596.8 5654.0 5665.7 5679.7 5684.7 5133.8 5178.1 5193.2 5196.1 5247.6 5231.3 5248.7 5249.8 5261.9 5267.4 5245.5 5252.7 5259.9 5269.6 5290.3 5233.4 5243.5 5251.3 5259.0 5273.1 5079.5 5196.8 5201.3 5222.2 5254.1 5732.2 5745.3 5801.0 5870.0 5891.1 6041.0 6168.1 6228.6 6251.8 6257.7 6148.1 6155.4 6173.9 6196.1 6210.2 5895.6 5914.1 5914.2 5921.3 5953.7 6258.7 6273.5 6278.8 6280.4 6283.3 6036.8 6057.8 6101.8 6121.5 6168.8 6125.5 6186.2 6191.5 6205.9 6213.9 5125.7 6198.6 6214.5 6218.4 6239.9 6058.5 6124.4 6217.6 6218.5 6230.5 4916.3 4952.0 4953.5 4959.9 5023.3 4417.8 4423.5 4424.9 4437.9 4442.7 6002.5 6011.1 6012.1 6015.8 6019.1 5185.5 6073.1 6128.1 6135.8 6155.9 5953.2 6034.5 6036.6 6042.8 6077.6 4980.4 5392.0 5451.5 5487.4 5504.2 5345.1 6341.8 6392.6 6397.9 6407.1 6106.7 6191.4 6219.2 6219.3 6219.9 6338.5 6398.2 6403.8 6407.8 6417.2 5271.2 6116.8 6207.0 6223.3 6238.6 5996.8 6148.0 6175.2 6210.9 6212.8 6129.9 6166.3 6173.4 6179.9 6186.0 5963.0 6158.5 6171.7 6173.4 6177.0 5025.6 5924.0 5962.0 6058.3 6068.1 6139.3 6146.9 6169.9 6173.1 6194.1 6055.9 6065.3 6065.8 6071.9 6091.7 08:36:44 INFO - PROCESS | 1646 | 08:36:44 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:67352.08 Median:38393.71 stddev:140836.04 (366.8%) stddev-sans-first:141141.44 08:36:44 INFO - PROCESS | 1646 | Values: 409.3 457.4 469.7 479.4 491.5 39615.8 41668.4 41872.2 41955.2 42007.6 42521.0 42845.6 43282.0 43301.6 43343.0 8365.0 8590.2 9091.4 9392.1 9418.1 11121.9 11353.7 11374.9 11545.9 11586.9 11292.6 11321.7 11324.3 11328.6 11358.1 11279.2 11337.3 11340.4 11342.6 11369.5 11233.5 11248.3 11312.3 11319.7 11332.4 40669.2 40689.8 40755.8 40879.4 41023.0 4040.3 4051.5 4071.5 4083.3 4196.3 29846.0 29969.6 30153.4 30373.2 30683.4 2536.9 3070.9 3243.0 3266.4 3300.6 486319.0 496653.0 498410.0 498736.0 501102.5 61031.0 61160.7 61804.0 61805.1 62042.7 64123.4 64365.0 64508.4 64582.7 64680.0 13289.5 13353.6 13664.9 16027.9 16239.3 11329.5 11583.9 12432.5 12609.6 12702.6 15445.8 16892.2 16936.4 17088.3 17133.7 6442.3 6491.5 6504.9 6518.3 6533.4 834.4 859.3 862.9 863.6 863.8 29894.7 30005.0 30070.4 30210.8 31033.4 1028.8 1035.9 1072.2 1074.6 1194.7 15388.8 15670.5 15677.1 15683.4 15915.0 527983.0 583402.0 585034.0 585655.0 588434.0 60899.7 60903.7 61023.1 61110.7 61200.1 1358.8 1390.3 1399.6 1405.5 1406.2 28957.9 29387.3 29608.9 30461.8 30477.8 50900.7 51216.7 51347.2 51386.7 51447.0 510725.0 511900.0 513305.0 514943.0 515725.0 40000.0 40596.4 40796.4 40863.6 40986.2 45636.0 46463.1 47074.0 47521.0 47778.0 31006.0 38215.6 38424.4 39593.0 40121.2 31335.9 32083.5 38061.0 38363.0 39364.6 36339.5 36548.8 36727.0 37334.1 38010.8 31619.0 32818.0 33868.4 34197.0 34356.7 24891.6 24998.9 25078.6 25390.0 25531.6 08:36:44 INFO - PROCESS | 1646 | 08:36:44 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:37755.68 Median:400.66 stddev:108246.44 (27017.3%) stddev-sans-first:108513.69 08:36:44 INFO - PROCESS | 1646 | Values: 362.9 391.0 400.4 400.9 402.2 14901.4 17410.7 20588.6 21319.3 21528.2 18122.9 20048.6 21211.3 21225.4 21548.8 4956.2 5691.8 5835.6 5868.0 5885.6 5715.2 5843.1 5864.4 5869.2 5884.0 5162.3 5328.3 5791.8 5794.6 5835.5 4945.7 5739.4 5755.3 5763.8 5769.0 4894.2 4992.4 5026.2 5076.4 5079.0 25606.0 25691.5 25779.8 26066.5 26397.9 2082.7 2698.2 2701.4 2713.9 2731.4 14824.8 14918.9 15296.4 15803.8 16200.4 1693.3 1844.8 1859.2 1868.9 1904.8 128345.4 133818.0 133906.0 137221.0 139161.3 11360.5 11416.5 11536.2 11548.3 11614.9 14611.1 14735.9 14764.0 14779.6 14802.8 7161.9 8477.2 8725.4 8751.6 8860.4 8527.5 8541.0 8560.5 8678.3 8728.4 6175.6 7235.9 7349.0 7354.8 7359.0 1761.4 1840.3 1915.3 1936.0 1958.1 720.9 859.5 873.1 879.7 903.2 20044.8 21670.8 22175.1 22329.9 22343.8 805.7 899.8 926.7 931.4 941.1 8726.4 10568.6 11402.2 11607.4 11613.4 598376.0 605562.0 633339.0 655638.0 720144.0 135835.0 141138.7 142012.0 165680.0 171002.1 995.8 999.9 1039.9 1041.9 1044.9 20035.8 20197.5 20404.3 20471.3 20484.0 58457.5 59577.0 60496.0 60697.7 60975.0 82912.8 83354.2 84962.0 85002.0 85509.9 7188.2 7397.9 7485.8 8133.9 8625.6 9135.8 11736.4 12329.3 12469.6 12836.5 7909.7 10588.4 10871.8 10957.1 11029.7 5136.9 8242.0 8691.5 10474.9 11080.9 10820.9 11108.3 11140.7 11181.7 11219.0 7273.8 7511.2 7621.0 7695.3 7699.1 5605.4 6908.4 7750.7 9740.3 11382.1 08:36:44 INFO - PROCESS | 1646 | 08:36:44 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5384.92 Median:5250.61 stddev:2940.84 (56.0%) stddev-sans-first:2933.83 08:36:44 INFO - PROCESS | 1646 | Values: 1397.7 1420.1 1423.5 1428.5 1441.8 7471.7 7749.4 8098.5 8506.0 8519.8 7992.3 8304.2 8304.9 8369.6 8379.8 2264.4 2305.2 2313.4 2318.9 2319.7 2046.4 2133.4 2272.7 2303.8 2304.8 1968.6 2233.6 2312.5 2313.5 2318.9 2298.8 2304.0 2315.0 2316.6 2322.0 2299.6 2318.9 2326.1 2343.5 2352.4 8400.8 8420.3 8460.8 8464.8 8498.0 4457.3 5055.4 5231.0 5241.3 5251.8 3012.9 3232.3 3344.1 3478.3 3526.0 1087.6 1153.9 1190.7 1232.2 1239.6 8654.5 10680.9 10778.8 10815.2 10832.4 4382.1 4696.8 4703.2 4741.4 4760.4 9444.4 9536.7 9541.6 9548.7 9550.8 5220.5 5249.5 5251.7 5262.9 5263.2 4528.0 4694.7 4720.3 4784.7 4801.0 3782.5 3816.0 3869.3 3897.7 3907.2 1175.0 1212.6 1288.5 1290.0 1297.9 723.3 753.0 755.0 779.3 801.2 4804.6 5218.7 5438.6 5717.7 6028.0 952.2 980.7 996.7 1004.5 1020.5 3007.7 3513.5 3739.6 3753.1 3775.2 9630.4 9904.7 9956.8 9972.2 9975.7 9872.1 9908.2 9928.9 10042.0 10076.2 7364.8 7618.2 7737.7 7885.1 7905.2 5311.0 5319.8 5344.8 5528.7 5619.3 9043.6 9236.7 9247.5 9283.8 9306.2 6999.5 9174.2 9193.3 9214.8 9337.5 6628.4 7657.1 7774.8 7798.2 7803.8 7689.9 7771.9 7818.3 7818.3 7836.9 6553.6 6957.6 6970.9 7006.8 7124.0 6916.4 6941.5 7056.1 7056.2 7150.1 6250.5 6315.4 6397.5 6401.1 6427.6 4866.8 4879.9 4933.9 4940.3 5007.1 4424.4 4899.0 4928.1 4943.7 4943.9 08:36:44 INFO - PROCESS | 1646 | 08:36:44 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4557.75 Median:5020.36 stddev:1355.47 (27.0%) stddev-sans-first:1321.39 08:36:44 INFO - PROCESS | 1646 | Values: 317.9 347.6 353.7 368.5 369.4 4591.7 4855.9 4979.3 5116.9 5541.6 4265.5 4372.8 5161.3 5306.6 5400.8 3666.9 4259.5 4278.5 4283.5 4300.0 3725.8 3740.6 4297.2 4298.0 4313.7 3280.3 4117.5 4160.5 4230.4 4290.5 4228.0 4231.7 4232.4 4235.4 4248.0 3252.4 3741.1 3741.5 3765.3 3773.6 4498.8 5038.5 5346.8 5380.1 5381.6 4126.9 4471.6 4924.0 4936.6 4956.3 4815.8 4849.7 5432.4 5854.7 5875.3 3729.1 3823.0 4020.5 4095.4 4129.2 5119.8 5454.7 6000.7 6103.9 6169.7 3648.3 4237.6 4241.8 4266.4 4271.3 3625.2 4271.2 4308.3 4310.5 4328.7 4292.7 4581.8 4810.2 4839.7 4938.7 5832.2 5838.0 5864.6 5873.4 5900.6 1147.8 1186.7 1286.4 1408.3 1419.4 856.5 905.3 967.3 982.5 988.5 4726.7 4802.9 5058.0 5321.6 5352.5 5124.8 5694.7 5711.9 5712.2 5713.1 4361.8 4897.4 4899.0 5002.2 5231.3 2851.3 2878.4 2901.0 2937.9 2971.9 5250.4 5454.4 5661.4 5906.6 5946.6 5603.0 5714.0 5868.7 5881.6 5904.8 5305.1 5341.6 5503.2 5613.4 5878.7 5122.7 5184.0 5280.5 5520.9 5685.7 4974.6 5239.4 5530.6 5583.3 5656.9 5500.3 5509.4 5694.9 5882.2 5884.7 3428.3 3625.5 3986.9 4037.4 4054.5 5101.4 5264.3 5410.0 5681.4 5710.4 4525.7 4801.4 4922.1 5052.7 5460.6 4887.4 5122.5 5461.1 5472.5 5495.6 4341.8 5065.4 5390.1 5402.4 5494.0 4811.6 5770.9 5792.6 5804.8 5827.9 5231.8 5662.7 5672.7 5678.0 5705.3 08:36:44 INFO - PROCESS | 1646 | 08:36:44 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:20425.41 Median:3823.47 stddev:29861.25 (781.0%) stddev-sans-first:29908.32 08:36:44 INFO - PROCESS | 1646 | Values: 709.3 733.8 765.7 771.8 867.4 14673.5 15154.8 15705.8 15772.1 15807.5 14243.9 14398.7 14616.9 14623.0 14627.7 769.9 860.0 860.8 861.0 861.7 843.9 859.8 873.6 876.1 879.0 745.8 915.2 916.3 920.0 921.0 912.2 912.7 913.2 913.9 915.7 681.3 683.0 685.6 685.7 685.7 15727.1 15744.2 15953.8 15989.8 15997.0 13715.0 13936.9 14182.9 14232.9 14255.4 11661.0 11719.4 11734.6 11771.7 12044.8 3712.4 3729.5 3742.8 3761.2 3885.7 77019.0 110336.0 112405.4 113039.0 113844.0 10540.2 10545.2 10664.0 10665.8 10677.2 22263.7 22444.6 22487.3 22512.5 22622.3 7608.8 7610.5 7641.8 7676.9 7768.9 4167.6 4223.6 4234.4 4260.9 4316.2 3566.4 3662.7 3674.0 3756.3 3949.0 699.2 699.6 704.5 706.5 716.8 586.4 588.9 700.2 712.2 712.9 9751.4 10352.2 10375.6 10539.3 10664.0 644.0 654.1 655.3 692.5 702.5 4355.6 5034.3 5093.9 5099.5 5112.0 99934.5 107697.9 109458.0 110053.0 112126.4 81724.2 85303.0 91660.5 94022.0 95149.5 71397.5 80087.6 81578.0 81680.0 82201.0 9092.6 9936.0 9961.2 9978.8 10001.8 42064.2 44902.6 46045.5 53345.7 54185.0 53019.7 54118.5 71451.0 72624.3 72723.3 11496.5 11691.7 11790.6 11799.2 11921.9 12867.4 12961.5 13065.6 13180.4 13296.5 11769.0 11787.4 11890.3 11906.8 12118.2 11781.9 11787.7 12022.9 12137.2 12416.0 12205.5 13059.9 13387.2 13505.5 13771.4 10773.0 10987.6 11214.2 11450.9 11542.4 10818.4 10866.9 10965.4 11023.9 11128.1 08:36:44 INFO - PROCESS | 1646 | -------- Summary: end -------- 08:36:44 INFO - PROCESS | 1646 | 08:36:45 INFO - TEST-INFO | 1646: exit 0 08:36:45 INFO - TEST-OK | dromaeo_css | took 1115394ms 08:36:45 INFO - TEST-START | kraken 08:36:45 INFO - operating with platform_type : mac_ 08:36:45 INFO - Initialising browser for kraken test... 08:36:45 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpRBC8KI/profile http://localhost:49248/getInfo.html) 08:36:48 INFO - PROCESS | 1658 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 08:36:48 INFO - PROCESS | 1658 | 2017-01-31 08:36:48.104 plugin-container[1659:10233] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 08:36:48 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:36:48 INFO - PROCESS | 1658 | 2017-01-31 08:36:48.107 plugin-container[1659:10233] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 08:36:48 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:36:48 INFO - PROCESS | 1658 | 2017-01-31 08:36:48.107 plugin-container[1659:10233] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:36:48 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 08:36:48 INFO - PROCESS | 1658 | colorDepth:24 08:36:48 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 08:36:48 INFO - PROCESS | 1658 | __metrics 08:36:48 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3284: TypeError: this.tabs is undefined 08:36:48 INFO - PROCESS | 1658 | 1485880608267 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpRBC8KI/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpRBC8KI/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpRBC8KI/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpRBC8KI/profile/extensions/talos-powers@TalosPowersService.js:55:9 08:36:48 INFO - TEST-INFO | 1658: exit 0 08:36:48 INFO - Browser initialized. 08:36:48 INFO - Running cycle 1/1 for kraken test... 08:36:48 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpRBC8KI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:51 INFO - PROCESS | 1660 | 2017-01-31 08:36:51.446 plugin-container[1661:10348] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x894b, name = 'com.apple.tsm.portname' 08:36:51 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:36:51 INFO - PROCESS | 1660 | 2017-01-31 08:36:51.446 plugin-container[1661:10348] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 08:36:51 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:36:51 INFO - PROCESS | 1660 | 2017-01-31 08:36:51.446 plugin-container[1661:10348] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:37:01 INFO - PROCESS | 1660 | RSS: Main: 234045440 08:37:01 INFO - PROCESS | 1660 | 08:37:04 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 08:37:05 INFO - PROCESS | 1660 | RSS: Main: 247386112 08:37:05 INFO - PROCESS | 1660 | 08:37:07 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 08:37:08 INFO - PROCESS | 1660 | RSS: Main: 256311296 08:37:08 INFO - PROCESS | 1660 | 08:37:11 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 08:37:12 INFO - PROCESS | 1660 | RSS: Main: 258224128 08:37:12 INFO - PROCESS | 1660 | 08:37:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 08:37:14 INFO - PROCESS | 1660 | RSS: Main: 259129344 08:37:14 INFO - PROCESS | 1660 | 08:37:17 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:37:17 INFO - PROCESS | 1660 | RSS: Main: 259493888 08:37:17 INFO - PROCESS | 1660 | 08:37:20 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 08:37:21 INFO - PROCESS | 1660 | RSS: Main: 264892416 08:37:21 INFO - PROCESS | 1660 | 08:37:24 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 08:37:24 INFO - PROCESS | 1660 | RSS: Main: 264269824 08:37:24 INFO - PROCESS | 1660 | 08:37:28 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 08:37:28 INFO - PROCESS | 1660 | RSS: Main: 264118272 08:37:28 INFO - PROCESS | 1660 | 08:37:30 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:37:30 INFO - PROCESS | 1660 | RSS: Main: 263610368 08:37:30 INFO - PROCESS | 1660 | 08:37:32 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:37:33 INFO - PROCESS | 1660 | RSS: Main: 263639040 08:37:33 INFO - PROCESS | 1660 | 08:37:35 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:37:36 INFO - PROCESS | 1660 | RSS: Main: 263757824 08:37:36 INFO - PROCESS | 1660 | 08:37:39 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:37:40 INFO - PROCESS | 1660 | RSS: Main: 265375744 08:37:40 INFO - PROCESS | 1660 | 08:37:43 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:37:43 INFO - PROCESS | 1660 | RSS: Main: 265170944 08:37:43 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 08:37:45 INFO - PROCESS | 1660 | RSS: Main: 267030528 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | __start_tp_report 08:37:45 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 08:37:45 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 08:37:45 INFO - PROCESS | 1660 | |i|pagename|runs| 08:37:45 INFO - PROCESS | 1660 | |0;ai-astar;136;117;117;119;118;131;120;118;118;117 08:37:45 INFO - PROCESS | 1660 | |1;audio-beat-detection;145;144;141;153;112;112;114;111;134;114 08:37:45 INFO - PROCESS | 1660 | |2;audio-dft;196;213;218;207;195;200;195;196;195;196 08:37:45 INFO - PROCESS | 1660 | |3;audio-fft;75;63;59;85;60;61;52;74;87;86 08:37:45 INFO - PROCESS | 1660 | |4;audio-oscillator;73;83;116;104;102;106;82;70;71;82 08:37:45 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;90;83;137;87;91;99;90;87;91;88 08:37:45 INFO - PROCESS | 1660 | |6;imaging-darkroom;96;97;96;144;97;95;96;119;143;150 08:37:45 INFO - PROCESS | 1660 | |7;imaging-desaturate;148;147;110;150;114;93;91;92;81;144 08:37:45 INFO - PROCESS | 1660 | |8;json-parse-financial;65;65;65;66;66;66;66;66;66;66 08:37:45 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;75;77;77;83;75;70;70;68;72;72 08:37:45 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;88;85;87;88;91;88;93;89;87;93 08:37:45 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;165;149;151;167;152;155;159;138;203;170 08:37:45 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;179;187;188;174;174;175;174;175;175;208 08:37:45 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;68;75;81;85;89;73;66;68;68;70 08:37:45 INFO - PROCESS | 1660 | __end_tp_report 08:37:45 INFO - PROCESS | 1660 | __start_cc_report 08:37:45 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,932 08:37:45 INFO - PROCESS | 1660 | __end_cc_report 08:37:45 INFO - PROCESS | 1660 | __startTimestamp1485880665774__endTimestamp 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | ------- Summary: start ------- 08:37:45 INFO - PROCESS | 1660 | Number of tests: 14 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:121.10 Median:118.50 stddev:6.71 (5.7%) stddev-sans-first:4.45 08:37:45 INFO - PROCESS | 1660 | Values: 136.0 117.0 117.0 119.0 118.0 131.0 120.0 118.0 118.0 117.0 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:137.50 stddev:16.89 (12.3%) stddev-sans-first:16.76 08:37:45 INFO - PROCESS | 1660 | Values: 145.0 144.0 141.0 153.0 112.0 112.0 114.0 111.0 134.0 114.0 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:201.10 Median:198.00 stddev:8.52 (4.3%) stddev-sans-first:8.83 08:37:45 INFO - PROCESS | 1660 | Values: 196.0 213.0 218.0 207.0 195.0 200.0 195.0 196.0 195.0 196.0 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:70.20 Median:74.50 stddev:12.85 (17.2%) stddev-sans-first:13.51 08:37:45 INFO - PROCESS | 1660 | Values: 75.0 63.0 59.0 85.0 60.0 61.0 52.0 74.0 87.0 86.0 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:72.00 stddev:16.62 (23.1%) stddev-sans-first:16.61 08:37:45 INFO - PROCESS | 1660 | Values: 73.0 83.0 116.0 104.0 102.0 106.0 82.0 70.0 71.0 82.0 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:94.30 Median:90.00 stddev:15.56 (17.3%) stddev-sans-first:16.42 08:37:45 INFO - PROCESS | 1660 | Values: 90.0 83.0 137.0 87.0 91.0 99.0 90.0 87.0 91.0 88.0 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:113.30 Median:96.00 stddev:23.49 (24.5%) stddev-sans-first:24.07 08:37:45 INFO - PROCESS | 1660 | Values: 96.0 97.0 96.0 144.0 97.0 95.0 96.0 119.0 143.0 150.0 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:117.00 Median:115.50 stddev:27.71 (24.0%) stddev-sans-first:27.02 08:37:45 INFO - PROCESS | 1660 | Values: 148.0 147.0 110.0 150.0 114.0 93.0 91.0 92.0 81.0 144.0 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 08:37:45 INFO - PROCESS | 1660 | Values: 65.0 65.0 65.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:73.90 Median:75.00 stddev:4.43 (5.9%) stddev-sans-first:4.68 08:37:45 INFO - PROCESS | 1660 | Values: 75.0 77.0 77.0 83.0 75.0 70.0 70.0 68.0 72.0 72.0 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:88.50 stddev:2.64 (3.0%) stddev-sans-first:2.78 08:37:45 INFO - PROCESS | 1660 | Values: 88.0 85.0 87.0 88.0 91.0 88.0 93.0 89.0 87.0 93.0 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:160.90 Median:162.00 stddev:17.61 (10.9%) stddev-sans-first:18.62 08:37:45 INFO - PROCESS | 1660 | Values: 165.0 149.0 151.0 167.0 152.0 155.0 159.0 138.0 203.0 170.0 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.90 Median:177.00 stddev:10.92 (6.2%) stddev-sans-first:11.56 08:37:45 INFO - PROCESS | 1660 | Values: 179.0 187.0 188.0 174.0 174.0 175.0 174.0 175.0 175.0 208.0 08:37:45 INFO - PROCESS | 1660 | 08:37:45 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.30 Median:74.00 stddev:8.06 (10.9%) stddev-sans-first:8.22 08:37:45 INFO - PROCESS | 1660 | Values: 68.0 75.0 81.0 85.0 89.0 73.0 66.0 68.0 68.0 70.0 08:37:45 INFO - PROCESS | 1660 | -------- Summary: end -------- 08:37:45 INFO - PROCESS | 1660 | 08:37:46 INFO - TEST-INFO | 1660: exit 0 08:37:46 INFO - TEST-OK | kraken | took 61252ms 08:37:46 INFO - SUITE-END | took 1176s 08:37:46 INFO - Completed test suite (00:19:36) 08:37:46 INFO - javascript benchmark 08:37:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7296.2664677880875, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2626.8292560983537, 3322.7009569138772, 3347.799132052077, 3377.9662203377975, 3385.424477838767, 5566.944330556693, 5657.377688454272, 5677.574181936356, 5727.455891690282, 5731.254936858208, 5596.776128954847, 5654.0, 5665.660060396379, 5679.659220446766, 5684.658920464775, 5133.845984620468, 5178.067947769418, 5193.195054766517, 5196.090684130281, 5247.606429517782, 5231.26762253283, 5248.71132087735, 5249.842504724865, 5261.921306132233, 5267.394249661281, 5245.4754524547625, 5252.658577192489, 5259.894802103956, 5269.552088072518, 5290.285811415468, 5233.4243233244315, 5243.501867322599, 5251.317328747238, 5259.0270799901755, 5273.129933560957, 5079.542841144278, 5196.76614552346, 5201.323827902386, 5222.2427747976335, 5254.106801843657, 5732.168835518826, 5745.339285982123, 5800.955827950967, 5869.970650146722, 5891.086881533369, 6041.0, 6168.074788781674, 6228.564000519966, 6251.843703907393, 6257.749690012394, 6148.1392605035335, 6155.384461553854, 6173.938260617381, 6196.132541444202, 6210.223722034746, 5895.55783316253, 5914.083317085859, 5914.201582786269, 5921.348651648315, 5953.702314884282, 6258.687065646699, 6273.466755325849, 6278.843028924313, 6280.434760871543, 6283.277423096311, 6036.758529658852, 6057.757689692451, 6101.7559297627595, 6121.540884433685, 6168.814935551941, 6125.479334256638, 6186.19579454677, 6191.535634827406, 6205.875882482325, 6213.906791398133, 5125.718085505258, 6198.6280823149855, 6214.502839772807, 6218.378162183745, 6239.937600624026, 6058.545609079337, 6124.411449639965, 6217.564770466024, 6218.502519798405, 6230.501559875199, 4916.3362946001835, 4951.984843107154, 4953.455119936804, 4959.90080198394, 5023.34696489454, 4417.757023363746, 4423.535528769497, 4424.867253982386, 4437.933430998538, 4442.711223770445, 6002.519798416116, 6011.128386384037, 6012.098185272244, 6015.789447369321, 6019.097135429633, 5185.533302002837, 6073.089036644538, 6128.136482154469, 6135.754569817157, 6155.891939450852, 5953.22608060958, 6034.456898879122, 6036.577439579188, 6042.788502402394, 6077.574569780073, 4980.402351717817, 5391.973040134852, 5451.536619387317, 5487.396386397493, 5504.174373843955, 5345.091334473227, 6341.778037768656, 6392.552521323462, 6397.936020639827, 6407.070974708734, 6106.73370229429, 6191.442770150708, 6219.191505104308, 6219.315875253628, 6219.906701399392, 6338.492920566436, 6398.232212134573, 6403.775867844603, 6407.807765767035, 6417.2299324081405, 5271.209318602087, 6116.8227554565365, 6206.968965155145, 6223.253209614875, 6238.563300568917, 5996.760129594767, 6147.969260153671, 6175.197224360804, 6210.875782484415, 6212.751489940351, 6129.908051379144, 6166.290876549254, 6173.444390004921, 6179.876402472015, 6186.041163619646, 5963.0459126539545, 6158.476529495043, 6171.722272497838, 6173.38266173397, 6177.042558403455, 5025.623078269071, 5924.022536281465, 5962.0, 6058.303295121117, 6068.089786532056, 6139.272938940574, 6146.938530614637, 6169.876602467836, 6173.074038894202, 6194.101855231056, 6055.878882422238, 6065.272167339771, 6065.8180254592435, 6071.939280607314, 6091.664958427152], "value": 5698.945567339721, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.26128338349287, 457.4442052905719, 469.73459995102775, 479.3648415849001, 491.53058828818484, 39615.801920990394, 41668.37497437537, 41872.162556748925, 41955.16089678204, 42007.579924200785, 42521.0, 42845.57154428455, 43282.0, 43301.566984330144, 43343.0, 8364.954380702413, 8590.196058827654, 9091.409058411198, 9392.107749763762, 9418.058194180561, 11121.888781112166, 11353.659390218307, 11374.943125284404, 11545.884541154564, 11586.942065289662, 11292.604758833442, 11321.716957076056, 11324.263922844988, 11328.603498877541, 11358.148138889575, 11279.154063445234, 11337.319760814295, 11340.376279304675, 11342.603008894732, 11369.545218191262, 11233.494492747846, 11248.325100493996, 11312.264702794291, 11319.717007074807, 11332.43337833105, 40669.18661626751, 40689.79655101735, 40755.796221019, 40879.38680919789, 41023.0, 4040.333344998072, 4051.453053837753, 4071.450354202204, 4083.3466645336603, 4196.279525394573, 29846.0, 29969.550456743167, 30153.396932061234, 30373.24066898323, 30683.386332273454, 2536.8837711406923, 3070.861811218478, 3242.951355729666, 3266.444704400234, 3300.603927528688, 486319.0, 496653.0, 498410.0, 498736.0, 501102.49448752886, 61031.0, 61160.69419652873, 61804.0, 61805.07292390618, 62042.68978655078, 64123.358766412675, 64365.0, 64508.35491645023, 64582.67708661521, 64680.0, 13289.534866279633, 13353.599392018255, 13664.863351366557, 16027.919860400856, 16239.269232884548, 11329.546818127348, 11583.884161158448, 12432.502699892084, 12609.558665446666, 12702.555410560586, 15445.768313475306, 16892.226316236618, 16936.40722574704, 17088.316467341167, 17133.742993855103, 6442.259140198843, 6491.480681545465, 6504.869902601921, 6518.348165183538, 6533.444657204096, 834.3950635789125, 859.2910848549972, 862.9093945135796, 863.5974261410024, 863.7667829686076, 29894.701052989625, 30005.0, 30070.398592028476, 30210.84894575557, 31033.37933241368, 1028.789098234875, 1035.8549803027581, 1072.2012100984816, 1074.59165517103, 1194.7311854832767, 15388.769168462482, 15670.451534196249, 15677.05937643745, 15683.372665093268, 15915.0, 527983.0, 583402.0, 585034.0, 585655.0, 588434.0, 60899.69550152221, 60903.69548152231, 61023.08465373023, 61110.69444652748, 61200.08199877005, 1358.7554240236655, 1390.2909516146635, 1399.6430910118058, 1405.4799724102147, 1406.205493895966, 28957.85521072381, 29387.265318367212, 29608.851955740083, 30461.847690761406, 30477.847610761804, 50900.72748181177, 51216.74391628018, 51347.2297915539, 51386.715332117, 51447.0, 510725.0, 511900.0, 513305.0, 514943.0, 515725.0, 40000.0, 40596.39105413362, 40796.38805417862, 40863.59136408598, 40986.1802763949, 45636.0, 46463.07073858436, 47074.0, 47521.04957900892, 47778.0, 31006.0, 38215.61784382121, 38424.42363364496, 39593.0, 40121.1975760489, 31335.903243386372, 32083.518747219277, 38061.048473788374, 38363.0, 39364.60635393609, 36339.45490817587, 36548.81725591355, 36727.0, 37334.06664833401, 38010.809945950095, 31619.0, 32818.0, 33868.40606926261, 34197.0, 34356.656433435346, 24891.62662560099, 24998.875005624854, 25078.62382064307, 25390.0, 25531.617025745], "value": 20184.582087927814, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.8983884512336, 390.9628585284397, 400.4493820996131, 400.8637063398444, 402.18958798021987, 14901.403943842246, 17410.738838917394, 20588.588228235425, 21319.253826116088, 21528.246511372086, 18122.909385453055, 20048.59902801943, 21211.257605983792, 21225.36323910281, 21548.81481518516, 4956.157453232959, 5691.7723291068305, 5835.649861008353, 5868.0, 5885.558583106263, 5715.171300161474, 5843.094320380348, 5864.4135586441225, 5869.178315035877, 5883.999720047581, 5162.264000079945, 5328.307320048389, 5791.7972870949525, 5794.565407594426, 5835.503982161521, 4945.727984960826, 5739.397363276858, 5755.30936287644, 5763.7982670606325, 5768.971155144219, 4894.216925291972, 4992.40091189056, 5026.195808670632, 5076.441591424978, 5079.009593129341, 25605.975760969537, 25691.486170276676, 25779.839907204034, 26066.478670426484, 26397.868010660015, 2082.739657542807, 2698.244491542371, 2701.3786829029236, 2713.8507382093976, 2731.412746259564, 14824.777628335583, 14918.88108391875, 15296.388144474207, 15803.841961580467, 16200.35198592055, 1693.2549678141702, 1844.8339649431616, 1859.191251805469, 1868.8504919606398, 1904.8285654291042, 128345.35827320897, 133818.0, 133906.0, 137221.0, 139161.3041934784, 11360.48877800501, 11416.517962021497, 11536.192466527262, 11548.307101573933, 11614.941925290488, 14611.123332600078, 14735.92632036833, 14764.0, 14779.630509237355, 14802.777958330633, 7161.89257161143, 8477.152284771597, 8725.389222754346, 8751.606177722018, 8860.4240724354, 8527.488350698854, 8541.0, 8560.48637081777, 8678.305735541142, 8728.432651877734, 6175.62946223228, 7235.92764072363, 7348.96325518369, 7354.756799176195, 7358.96320518394, 1761.436340371069, 1840.3098837935775, 1915.2542372881355, 1935.98064019358, 1958.1482055305987, 720.9387202087777, 859.4886042804521, 873.1443185678071, 879.692107762278, 903.1735961595198, 20044.797312161318, 21670.78329216719, 22175.112995480322, 22329.888350558143, 22343.77656223417, 805.6898094233762, 899.8380291547453, 926.7312479381039, 931.3759780946782, 941.0683423410774, 8726.432781869158, 10568.630097946534, 11402.232653938652, 11607.36159511235, 11613.36126513033, 598376.016239832, 605562.0, 633339.0, 655638.0, 720144.0, 135835.0, 141138.70890328748, 142012.0, 165680.0, 171002.14498927427, 995.8406654935176, 999.9400035997863, 1039.870016247969, 1041.9010194031555, 1044.921630877672, 20035.799642003978, 20197.49506262355, 20404.28584999518, 20471.283505077252, 20484.0, 58457.538561536305, 59577.0, 60496.0, 60697.69651151892, 60975.0, 82912.75630865662, 83354.16645833464, 84962.0, 85002.0, 85509.86225344417, 7188.245234250328, 7397.927300541499, 7485.812854678677, 8133.918660813316, 8625.568721564023, 9135.77160570991, 11736.413179340829, 12329.321887295926, 12469.563565275172, 12836.486540538273, 7909.7231596893835, 10588.364698118137, 10871.836922446328, 10957.123430125412, 11029.669109926715, 5136.948630513796, 8241.969753780777, 8691.521966291915, 10474.895251047392, 11080.947310005537, 10820.891791082304, 11108.333499990027, 11140.663120425601, 11181.72045698864, 11219.046381057375, 7273.818154545967, 7511.248875112445, 7621.0, 7695.307422332017, 7699.114601820862, 5605.355384130714, 6908.447324214151, 7750.689972401041, 9740.318177727491, 11382.146339024772], "value": 9706.786310110381, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1397.7414178377, 1420.1053336398068, 1423.459085547492, 1428.4643258777958, 1441.776524638681, 7471.7011319547155, 7749.380049596033, 8098.514089154647, 8506.0, 8519.829603407929, 7992.280694737473, 8304.21109994551, 8304.875426868586, 8369.581520923944, 8379.790505237372, 2264.3772962435337, 2305.170138750049, 2313.4447732544236, 2318.9072437102495, 2319.663648770927, 2046.355398049617, 2133.391983284764, 2272.681824544565, 2303.7696230376996, 2304.781045800646, 1968.6161198566285, 2233.6091184042807, 2312.5143719818857, 2313.53729254149, 2318.8724620145886, 2298.7816457277586, 2303.974731244597, 2314.976850231493, 2316.6061769499224, 2321.953560928772, 2299.6320588705726, 2318.860868347888, 2326.1160758911506, 2343.5078633486987, 2352.4118970257437, 8400.831983360298, 8420.326373890073, 8460.83078338436, 8464.78838029048, 8497.95751021247, 4457.264551349023, 5055.368078990126, 5231.032259032053, 5241.318628578299, 5251.842444726664, 3012.9454690858242, 3232.2565809863627, 3344.065208298872, 3478.252175782219, 3526.047967048908, 1087.613897066538, 1153.8557680289964, 1190.678516800459, 1232.2360136715204, 1239.5661518468464, 8654.48073115615, 10680.893191068068, 10778.784424311549, 10815.18886083547, 10832.350058996406, 4382.101669157815, 4696.755359829648, 4703.153432382135, 4741.407324084489, 4760.381150450419, 9444.386114902509, 9536.713898583053, 9541.61833526665, 9548.665796697222, 9550.808983820423, 5220.451852555427, 5249.501297376743, 5251.711155886386, 5262.868428289324, 5263.210518422267, 4527.9547204527535, 4694.741789201558, 4720.268358404453, 4784.665073444895, 4801.01579176268, 3782.508273924427, 3816.0, 3869.2648396804516, 3897.719833897202, 3907.1794923066473, 1174.9823752643717, 1212.5816593275306, 1288.5039259885011, 1289.9806502902463, 1297.8961683065331, 723.3092396761081, 753.0, 755.0486387152228, 779.3258831111048, 801.1787917384611, 4804.567588917014, 5218.66078704883, 5438.619296649196, 5717.715691721575, 6027.969860150672, 952.1620973543376, 980.6518685866557, 996.6511720897628, 1004.4826914139225, 1020.4692960559162, 3007.7293043626178, 3513.4905438711244, 3739.5512538495555, 3753.136778540896, 3775.1505911169766, 9630.422174669542, 9904.702858914245, 9956.800863982824, 9972.152367048882, 9975.700728978143, 9872.062154095349, 9908.20734341251, 9928.900710992797, 10042.0, 10076.244281678903, 7364.77905662831, 7618.162002179756, 7737.729179478692, 7885.093214280317, 7905.169957154531, 5311.041796631316, 5319.813806516753, 5344.786208551614, 5528.7235638218735, 5619.269494965628, 9043.603445087188, 9236.72289831306, 9247.491387973727, 9283.814323713354, 9306.162445379949, 6999.51003429755, 9174.220191283548, 9193.264538836744, 9214.815703686023, 9337.53312334367, 6628.436582890508, 7657.119431265253, 7774.766756997299, 7798.220177982156, 7803.843923121392, 7689.92310076892, 7771.883421748791, 7818.257265559762, 7818.296353328228, 7836.882446763417, 6553.606783593, 6957.582545047313, 6970.895436568557, 7006.824829379307, 7123.964380178066, 6916.377526022682, 6941.548799328028, 7056.082709247765, 7056.223815380202, 7150.141982962078, 6250.499960003098, 6315.400036996478, 6397.488200944006, 6401.103845461546, 6427.550071495138, 4866.80532778699, 4879.853604391874, 4933.925991110208, 4940.283658869372, 5007.123753343223, 4424.446944131983, 4899.04468628614, 4928.137575924271, 4943.728094954812, 4943.901121977612], "value": 4367.829701989425, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.8506102131998, 347.61414829539206, 353.7273020841097, 368.52828379674025, 369.44583125312033, 4591.747453890039, 4855.902881942359, 4979.253112033197, 5116.948830511694, 5541.564230177286, 4265.466816647919, 4372.819338778536, 5161.251618515313, 5306.602004849632, 5400.785677872073, 3666.8716594919183, 4259.488861336628, 4278.465191851011, 4283.528811830696, 4300.032492689151, 3725.795081270529, 3740.6259374062647, 4297.247981603207, 4298.0, 4313.741175529478, 3280.311134661724, 4117.485314335708, 4160.54234034256, 4230.365445183216, 4290.528041915387, 4227.957720422787, 4231.724937879058, 4232.38630398592, 4235.449391579105, 4247.957520424787, 3252.36578867121, 3741.1021354874906, 3741.5323084614424, 3765.303418867491, 3773.5660399054186, 4498.820047198108, 5038.470960549163, 5346.8395948121615, 5380.058489764276, 5381.596380271456, 4126.906369812003, 4471.597556219924, 4924.0, 4936.6297527685565, 4956.281339205831, 4815.8441973926, 4849.660523763338, 5432.375276843174, 5854.736536855852, 5875.265591801025, 3729.067733066733, 3822.9808850955847, 4020.4773379460776, 4095.365218391154, 4129.15352352767, 5119.825708061026, 5454.663607416169, 6000.669963152025, 6103.938960610381, 6169.660668663222, 3648.3068217038676, 4237.576242375738, 4241.791089539528, 4266.394896312611, 4271.337942618899, 3625.1662117712544, 4271.167122411162, 4308.267594508941, 4310.482742070972, 4328.7402755834755, 4292.656587472995, 4581.816727330869, 4810.230363141881, 4839.661223714376, 4938.728369939616, 5832.24180856486, 5838.0, 5864.618799778001, 5873.383294754075, 5900.557458190567, 1147.7532330548804, 1186.727052777866, 1286.3568215892053, 1408.338081101901, 1419.432227109144, 856.5246288310047, 905.2938707807921, 967.274544091931, 982.4841957971979, 988.4761076629397, 4726.669133160645, 4802.855914322576, 5057.974710126499, 5321.627486076015, 5352.4915133062295, 5124.8206312778875, 5694.715264236855, 5711.857203569861, 5712.171735098387, 5713.057560429474, 4361.80371883266, 4897.3878265216845, 4899.0, 5002.2496625506465, 5231.319928409359, 2851.2871782054485, 2878.409925965172, 2900.9564856527168, 2937.8677959491874, 2971.925701857471, 5250.3962044364625, 5454.400015998237, 5661.377248502661, 5906.645601263938, 5946.643201407929, 5603.0, 5714.000099964979, 5868.7382212823595, 5881.5588830837005, 5904.822855314262, 5305.071612467803, 5341.62608617393, 5503.202790074835, 5613.382527922007, 5878.735456904449, 5122.745991763612, 5184.0, 5280.471952804689, 5520.861978450571, 5685.715714214355, 4974.567548391743, 5239.397469291081, 5530.640508366943, 5583.330000399978, 5656.85857853557, 5500.339959204921, 5509.393966663744, 5694.914576281276, 5882.205902203319, 5884.704965063543, 3428.2971990742335, 3625.546806649169, 3986.86045988389, 4037.37420699792, 4054.493188351456, 5101.438841727481, 5264.31563896691, 5410.0, 5681.375048744552, 5710.428957104256, 4525.683202175816, 4801.351817504592, 4922.089413458521, 5052.671576347526, 5460.563154947516, 4887.413510378778, 5122.5400760782995, 5461.057742742824, 5472.522418946783, 5495.560355171657, 4341.7829108545075, 5065.417476990193, 5390.083685773349, 5402.405735369185, 5494.011078005998, 4811.591014763784, 5770.884582308414, 5792.565557583114, 5804.82585522435, 5827.854303642443, 5231.822839861153, 5662.716864156693, 5672.659640421588, 5677.971610141923, 5705.286839145107], "value": 4138.936437771047, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.2588245283678, 733.8348871503912, 765.7166848266143, 771.7993321736348, 867.427497851418, 14673.486427975024, 15154.848451515481, 15705.764413533792, 15772.053676779373, 15807.525774226762, 14243.92878035611, 14398.712025759478, 14616.926915365435, 14623.0, 14627.707445851103, 769.9307062364372, 859.96130174142, 860.7503823891064, 860.9827803443927, 861.6897916749965, 843.877637742527, 859.7549698335976, 873.6156091319831, 876.1063715010686, 879.0286733159862, 745.8247311881703, 915.1534830281996, 916.3036092569629, 919.9908000919972, 920.9815803683922, 912.2291663544295, 912.703371404293, 913.2191975860676, 913.8857642794651, 915.702396721065, 681.3152781454606, 682.952193346466, 685.5920727167377, 685.6845850908588, 685.7188552693422, 15727.13500757458, 15744.212789360487, 15953.76069358949, 15989.760153597705, 15997.040177589382, 13715.0, 13936.93031534846, 14182.858171418256, 14232.92883535586, 14255.358508867126, 11661.0, 11719.355435451047, 11734.647960561197, 11771.7057073573, 12044.81932771009, 3712.3874560697454, 3729.515163028816, 3742.8315725792404, 3761.191343861083, 3885.747426417302, 77019.0, 110336.0, 112405.43797280961, 113039.0, 113844.0, 10540.209484288709, 10545.156387488982, 10664.0, 10665.84001239982, 10677.199210059276, 22263.666045009337, 22444.55110897773, 22487.32538023862, 22512.549749004927, 22622.321330360115, 7608.771736847903, 7610.543367397974, 7641.847163056707, 7676.884846727304, 7768.922310776933, 4167.562405947332, 4223.598758117974, 4234.364845273172, 4260.893477663021, 4316.223079845595, 3566.4293713005795, 3662.688671462902, 3674.0447483654443, 3756.3426400379826, 3948.980255098764, 699.1644984243779, 699.5942353434996, 704.5385272646424, 706.5407485134601, 716.7527203114917, 586.4370204603629, 588.9057750759857, 700.2087640965676, 712.2379054411833, 712.9465290103263, 9751.3661611995, 10352.171826253882, 10375.578462332958, 10539.314944528582, 10664.0, 644.0243031806816, 654.0679531667355, 655.2530115668142, 692.4840993459804, 702.4801646781345, 4355.586219309161, 5034.345535080416, 5093.923591146136, 5099.5410413063, 5111.974440127776, 99934.5003274979, 107697.92302077035, 109458.0, 110053.0, 112126.43936780264, 81724.18275817284, 85303.0, 91660.54169729241, 94022.0, 95149.5242523783, 71397.50108746273, 80087.59956200299, 81578.0, 81680.0, 82201.0, 9092.636294548409, 9936.006399360007, 9961.203103751828, 9978.750531236486, 10001.849972250277, 42064.1587168261, 44902.55097448984, 46045.53954460547, 53345.733271333396, 54185.0, 53019.73490132679, 54118.458815412916, 71451.0, 72624.27375726175, 72723.27276727164, 11496.482658280565, 11691.707707307385, 11790.646280611596, 11799.17405781587, 11921.880781192423, 12867.420966056363, 12961.481540738265, 13065.608031759062, 13180.406881690154, 13296.534621288209, 11769.0, 11787.351695656478, 11890.323890046653, 11906.821397678868, 12118.151729378858, 11781.941090294493, 11787.705307367385, 12022.879771202175, 12137.21108127969, 12416.0, 12205.511779528719, 13059.906636411617, 13387.19676819355, 13505.527306544223, 13771.380287886868, 10773.030427261585, 10987.560497580007, 11214.215004949901, 11450.885491144982, 11542.365169915734, 10818.350898946088, 10866.891331086588, 10965.396903170402, 11023.944880275547, 11128.054115400282], "value": 7473.295233687493, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 117.0, 117.0, 119.0, 118.0, 131.0, 120.0, 118.0, 118.0, 117.0], "value": 121.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 141.0, 153.0, 112.0, 112.0, 114.0, 111.0, 134.0, 114.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 213.0, 218.0, 207.0, 195.0, 200.0, 195.0, 196.0, 195.0, 196.0], "value": 201.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 63.0, 59.0, 85.0, 60.0, 61.0, 52.0, 74.0, 87.0, 86.0], "value": 70.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 83.0, 116.0, 104.0, 102.0, 106.0, 82.0, 70.0, 71.0, 82.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 83.0, 137.0, 87.0, 91.0, 99.0, 90.0, 87.0, 91.0, 88.0], "value": 94.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 144.0, 97.0, 95.0, 96.0, 119.0, 143.0, 150.0], "value": 113.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 110.0, 150.0, 114.0, 93.0, 91.0, 92.0, 81.0, 144.0], "value": 117.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 83.0, 75.0, 70.0, 70.0, 68.0, 72.0, 72.0], "value": 73.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 87.0, 88.0, 91.0, 88.0, 93.0, 89.0, 87.0, 93.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 149.0, 151.0, 167.0, 152.0, 155.0, 159.0, 138.0, 203.0, 170.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 187.0, 188.0, 174.0, 174.0, 175.0, 174.0, 175.0, 175.0, 208.0], "value": 180.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 81.0, 85.0, 89.0, 73.0, 66.0, 68.0, 68.0, 70.0], "value": 74.3, "unit": "score"}]}]} 08:37:47 INFO - Return code: 0 08:37:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:37:47 ERROR - # TBPL SUCCESS # 08:37:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:37:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:37:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:37:47 INFO - 2017-01-31 08:37:47.120 screenresolution[1665:10745] starting screenresolution argv=screenresolution get 08:37:47 INFO - 2017-01-31 08:37:47.123 screenresolution[1665:10745] Display 0: 1600x1200x32@60 08:37:47 INFO - 2017-01-31 08:37:47.129 screenresolution[1666:10748] starting screenresolution argv=screenresolution list 08:37:47 INFO - Available Modes on Display 0 08:37:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:37:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:37:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:37:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:37:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:37:47 INFO - Intel Iris: 08:37:47 INFO - Chipset Model: Intel Iris 08:37:47 INFO - Type: GPU 08:37:47 INFO - Bus: Built-In 08:37:47 INFO - VRAM (Dynamic, Max): 1536 MB 08:37:47 INFO - Vendor: Intel (0x8086) 08:37:47 INFO - Device ID: 0x0a2e 08:37:47 INFO - Revision ID: 0x0009 08:37:47 INFO - Displays: 08:37:47 INFO - Display: 08:37:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:37:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:37:47 INFO - Display Serial Number: 1600x1200 60 08:37:47 INFO - Main Display: Yes 08:37:47 INFO - Mirror: Off 08:37:47 INFO - Online: Yes 08:37:47 INFO - Rotation: Supported 08:37:47 INFO - Return code: 0 08:37:47 INFO - Running post-action listener: _resource_record_post_action 08:37:47 INFO - [mozharness: 2017-01-31 16:37:47.367125Z] Finished run-tests step (success) 08:37:47 INFO - Running post-run listener: _resource_record_post_run 08:37:47 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 39991808; Write bytes: 557904384; Read time: 390; Write time: 1877 08:37:47 INFO - TinderboxPrint: CPU usage
54.5% 08:37:47 INFO - TinderboxPrint: I/O read bytes / time
39,991,808 / 390 08:37:47 INFO - TinderboxPrint: I/O write bytes / time
557,904,384 / 1,877 08:37:47 INFO - TinderboxPrint: CPU idle
2,181.1 (45.5%) 08:37:47 INFO - TinderboxPrint: CPU system
969.4 (20.2%) 08:37:47 INFO - TinderboxPrint: CPU user
1,647.3 (34.3%) 08:37:47 INFO - TinderboxPrint: Swap in / out
291,823,616 / 0 08:37:47 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 248756736; Write bytes: 242804224; Read time: 18008; Write time: 508 08:37:47 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 35596800; Write bytes: 301702144; Read time: 359; Write time: 1313 08:37:47 INFO - Running post-run listener: _upload_blobber_files 08:37:47 INFO - Blob upload gear active. 08:37:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:37:47 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 08:37:47 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'] 08:37:47 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 08:37:48 INFO - (blobuploader) - INFO - Open directory for files ... 08:37:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:37:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:37:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:49 INFO - (blobuploader) - INFO - Done attempting. 08:37:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:37:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:37:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:50 INFO - (blobuploader) - INFO - Done attempting. 08:37:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:37:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:37:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:51 INFO - (blobuploader) - INFO - Done attempting. 08:37:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:37:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:37:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:53 INFO - (blobuploader) - INFO - Done attempting. 08:37:53 INFO - (blobuploader) - INFO - Iteration through files over. 08:37:53 INFO - Return code: 0 08:37:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:37:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:37:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3adf19361a40659a084fa0da442a050fd394caa4dd01fe7c1fd6d6ce6147741dfd44a10925bf9c01944a43496b21e298f7b10268c29e107c07be8b33a7a5ffba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2378aadddbfb463961cab2b03f30d49158daee3cdc5850e12ca3f9ec7f492f089857a0086ff039a4b2dfea1869704ca6bf1cadbbd0edc817cdace4534b7a1477", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd8bcb0dd3a24bb58f6cdef579a91a5b4dadf7b3ddd36c24c4c1f1a13dac0995129d43f620f0100baf1cf24eda401df2f57f386f3bcfaaad14a10a58811e80a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5545e053866c23202e8fca3a0419c9dd594a2e5fed1b64b210470ee51a31e2b2bd57d8ad33fed973306d44fab7338d7b37e055f9e22786486792714199a8151d"} 08:37:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:37:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:37:53 INFO - Contents: 08:37:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3adf19361a40659a084fa0da442a050fd394caa4dd01fe7c1fd6d6ce6147741dfd44a10925bf9c01944a43496b21e298f7b10268c29e107c07be8b33a7a5ffba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2378aadddbfb463961cab2b03f30d49158daee3cdc5850e12ca3f9ec7f492f089857a0086ff039a4b2dfea1869704ca6bf1cadbbd0edc817cdace4534b7a1477", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd8bcb0dd3a24bb58f6cdef579a91a5b4dadf7b3ddd36c24c4c1f1a13dac0995129d43f620f0100baf1cf24eda401df2f57f386f3bcfaaad14a10a58811e80a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5545e053866c23202e8fca3a0419c9dd594a2e5fed1b64b210470ee51a31e2b2bd57d8ad33fed973306d44fab7338d7b37e055f9e22786486792714199a8151d"} 08:37:53 INFO - Running post-run listener: copy_logs_to_upload_dir 08:37:53 INFO - Copying logs to upload dir... 08:37:53 INFO - mkdir: /builds/slave/test/build/upload/logs 08:37:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.551350 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-31 08:37:53.853382) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 08:37:53.857687) ========= 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.uNnv46mfph/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.KyVPAxNm8C/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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/3adf19361a40659a084fa0da442a050fd394caa4dd01fe7c1fd6d6ce6147741dfd44a10925bf9c01944a43496b21e298f7b10268c29e107c07be8b33a7a5ffba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2378aadddbfb463961cab2b03f30d49158daee3cdc5850e12ca3f9ec7f492f089857a0086ff039a4b2dfea1869704ca6bf1cadbbd0edc817cdace4534b7a1477", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd8bcb0dd3a24bb58f6cdef579a91a5b4dadf7b3ddd36c24c4c1f1a13dac0995129d43f620f0100baf1cf24eda401df2f57f386f3bcfaaad14a10a58811e80a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5545e053866c23202e8fca3a0419c9dd594a2e5fed1b64b210470ee51a31e2b2bd57d8ad33fed973306d44fab7338d7b37e055f9e22786486792714199a8151d"} build_url:https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/f5IRagN6S0i7Ihc9sbDFHQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3adf19361a40659a084fa0da442a050fd394caa4dd01fe7c1fd6d6ce6147741dfd44a10925bf9c01944a43496b21e298f7b10268c29e107c07be8b33a7a5ffba", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2378aadddbfb463961cab2b03f30d49158daee3cdc5850e12ca3f9ec7f492f089857a0086ff039a4b2dfea1869704ca6bf1cadbbd0edc817cdace4534b7a1477", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd8bcb0dd3a24bb58f6cdef579a91a5b4dadf7b3ddd36c24c4c1f1a13dac0995129d43f620f0100baf1cf24eda401df2f57f386f3bcfaaad14a10a58811e80a2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5545e053866c23202e8fca3a0419c9dd594a2e5fed1b64b210470ee51a31e2b2bd57d8ad33fed973306d44fab7338d7b37e055f9e22786486792714199a8151d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 08:37:53.895890) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 08:37:53.896249) ========= 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.uNnv46mfph/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.KyVPAxNm8C/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.005214 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 08:37:53.944863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 08:37:53.945171) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 08:37:53.948696) ========= ========= Total master_lag: 1.07 =========