builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0005 starttime: 1491306707.49 results: success (0) buildid: 20170404033427 builduid: a3fd512aab694e85b874fa6e5ce6594b revision: 916a4ee676a33355fc717f15ecb80815ba95051e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:47.493598) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:47.494113) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:47.494451) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:47.522797) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:47.523185) ========= 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.bIhbCglnTx/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.DVJH1jj8eL/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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-04-04 04:51:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.5M=0s 2017-04-04 04:51:47 (26.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089877 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:47.640729) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:47.641502) ========= 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.bIhbCglnTx/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.DVJH1jj8eL/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.020162 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:47.692878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-04 04:51:47.693272) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 916a4ee676a33355fc717f15ecb80815ba95051e --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 916a4ee676a33355fc717f15ecb80815ba95051e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bIhbCglnTx/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.DVJH1jj8eL/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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-04-04 04:51:47,782 truncating revision to first 12 chars 2017-04-04 04:51:47,782 Setting DEBUG logging. 2017-04-04 04:51:47,782 attempt 1/10 2017-04-04 04:51:47,782 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/916a4ee676a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 04:51:48,739 unpacking tar archive at: mozilla-central-916a4ee676a3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.215792 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-04 04:51:48.933124) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:48.933510) ========= script_repo_revision: 916a4ee676a33355fc717f15ecb80815ba95051e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:48.934002) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:48.934319) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 04:51:48.954376) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-04 04:51:48.954696) ========= /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.bIhbCglnTx/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.DVJH1jj8eL/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 04:51:49 INFO - MultiFileLogger online at 20170404 04:51:49 in /builds/slave/test 04:51:49 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 04:51:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:51:49 INFO - {'append_to_log': False, 04:51:49 INFO - 'base_work_dir': '/builds/slave/test', 04:51:49 INFO - 'blob_upload_branch': 'Firefox', 04:51:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:51:49 INFO - 'branch': 'Firefox', 04:51:49 INFO - 'buildbot_json_path': 'buildprops.json', 04:51:49 INFO - 'config_files': ('talos/mac_config.py',), 04:51:49 INFO - 'default_actions': ('clobber', 04:51:49 INFO - 'read-buildbot-config', 04:51:49 INFO - 'download-and-extract', 04:51:49 INFO - 'populate-webroot', 04:51:49 INFO - 'create-virtualenv', 04:51:49 INFO - 'install', 04:51:49 INFO - 'run-tests'), 04:51:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:51:49 INFO - 'download_minidump_stackwalk': True, 04:51:49 INFO - 'download_symbols': 'ondemand', 04:51:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:51:49 INFO - 'tooltool.py': '/tools/tooltool.py', 04:51:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:51:49 INFO - '/tools/misc-python/virtualenv.py')}, 04:51:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:51:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:51:49 INFO - 'gecko_profile': False, 04:51:49 INFO - 'gecko_profile_interval': 0, 04:51:49 INFO - 'installer_path': 'installer.exe', 04:51:49 INFO - 'log_level': 'info', 04:51:49 INFO - 'log_name': 'talos', 04:51:49 INFO - 'log_to_console': True, 04:51:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:51:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:51:49 INFO - 'opt_config_files': (), 04:51:49 INFO - 'pip_index': False, 04:51:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:51:49 INFO - 'cmd': ('bash', 04:51:49 INFO - '-c', 04:51:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:51:49 INFO - 'enabled': True, 04:51:49 INFO - 'halt_on_failure': False, 04:51:49 INFO - 'name': 'check_screen_resolution'},), 04:51:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:51:49 INFO - 'cmd': ('bash', 04:51:49 INFO - '-c', 04:51:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:51:49 INFO - 'enabled': True, 04:51:49 INFO - 'halt_on_failure': False, 04:51:49 INFO - 'name': 'check_screen_resolution'},), 04:51:49 INFO - 'run_cmd_checks_enabled': True, 04:51:49 INFO - 'suite': 'dromaeojs-e10s', 04:51:49 INFO - 'system_bits': '32', 04:51:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:51:49 INFO - 'title': 't-yosemite-r7-0005', 04:51:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:51:49 INFO - 'use_talos_json': True, 04:51:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:51:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:51:49 INFO - 'work_dir': 'build'} 04:51:49 INFO - [mozharness: 2017-04-04 11:51:49.169423Z] Running clobber step. 04:51:49 INFO - Running pre-action listener: _resource_record_pre_action 04:51:49 INFO - Running main action method: clobber 04:51:49 INFO - rmtree: /builds/slave/test/build 04:51:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:51:50 INFO - Running post-action listener: _resource_record_post_action 04:51:50 INFO - [mozharness: 2017-04-04 11:51:50.074142Z] Finished clobber step (success) 04:51:50 INFO - [mozharness: 2017-04-04 11:51:50.074276Z] Running read-buildbot-config step. 04:51:50 INFO - Running pre-action listener: _resource_record_pre_action 04:51:50 INFO - Running main action method: read_buildbot_config 04:51:50 INFO - Using buildbot properties: 04:51:50 INFO - { 04:51:50 INFO - "project": "", 04:51:50 INFO - "product": "firefox", 04:51:50 INFO - "script_repo_revision": "production", 04:51:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:51:50 INFO - "repository": "", 04:51:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:51:50 INFO - "buildid": "20170404033427", 04:51:50 INFO - "pgo_build": "False", 04:51:50 INFO - "basedir": "/builds/slave/test", 04:51:50 INFO - "buildnumber": 20, 04:51:50 INFO - "slavename": "t-yosemite-r7-0005", 04:51:50 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:51:50 INFO - "platform": "yosemite_r7", 04:51:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:51:50 INFO - "branch": "mozilla-central", 04:51:50 INFO - "repo_path": "mozilla-central", 04:51:50 INFO - "revision": "916a4ee676a33355fc717f15ecb80815ba95051e", 04:51:50 INFO - "stage_platform": "macosx64", 04:51:50 INFO - "builduid": "a3fd512aab694e85b874fa6e5ce6594b", 04:51:50 INFO - "slavebuilddir": "test" 04:51:50 INFO - } 04:51:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:51:50 INFO - Running post-action listener: _resource_record_post_action 04:51:50 INFO - [mozharness: 2017-04-04 11:51:50.077499Z] Finished read-buildbot-config step (success) 04:51:50 INFO - [mozharness: 2017-04-04 11:51:50.077604Z] Running download-and-extract step. 04:51:50 INFO - Running pre-action listener: _resource_record_pre_action 04:51:50 INFO - Running main action method: download_and_extract 04:51:50 INFO - mkdir: /builds/slave/test/build/tests 04:51:50 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')]} 04:51:50 INFO - trying https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:51:50 INFO - Downloading https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:51:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:51:50 INFO - Downloaded 1325 bytes. 04:51:50 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:51:50 INFO - Using the following test package requirements: 04:51:50 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:50 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:51:50 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:51:50 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:50 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:51:50 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:50 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:51:50 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:50 INFO - u'jsshell-mac.zip'], 04:51:50 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:50 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:51:50 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:51:50 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:50 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:51:50 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:50 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:51:50 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:50 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:51:50 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:51:50 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:51:50 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:51:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:51:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:51:50 INFO - Fetch https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:51:52 INFO - Expected file size: 52517206 04:51:52 INFO - Obtained file size: 52517206 04:52:08 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:52:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:52:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:52:08 INFO - Fetch https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:52:10 INFO - Expected file size: 52517206 04:52:10 INFO - Obtained file size: 52517206 04:52:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:52:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:52:26 INFO - Fetch https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:52:27 INFO - Expected file size: 14404152 04:52:27 INFO - Obtained file size: 14404152 04:52: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')]} 04:52:27 INFO - trying https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:52:27 INFO - Downloading https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:52:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:52:30 INFO - Downloaded 75580833 bytes. 04:52:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:52:30 INFO - mkdir: /builds/slave/test/properties 04:52:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:52:30 INFO - Writing to file /builds/slave/test/properties/build_url 04:52:30 INFO - Contents: 04:52:30 INFO - build_url:https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:52:31 INFO - Running post-action listener: _resource_record_post_action 04:52:31 INFO - Running post-action listener: set_extra_try_arguments 04:52:31 INFO - [mozharness: 2017-04-04 11:52:31.707612Z] Finished download-and-extract step (success) 04:52:31 INFO - [mozharness: 2017-04-04 11:52:31.707752Z] Running populate-webroot step. 04:52:31 INFO - Running pre-action listener: _resource_record_pre_action 04:52:31 INFO - Running main action method: populate_webroot 04:52:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:52:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:52:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:52:31 INFO - '--tppagecycles', 04:52:31 INFO - '7'], 04:52:31 INFO - 'tests': ['tsvgm']}}, 04:52:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:52:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:52:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:52:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:52:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:52:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:52:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:52:31 INFO - 'talos_options': ['--disable-e10s'], 04:52:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:52:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:52:31 INFO - 'talos_options': ['--disable-e10s'], 04:52:31 INFO - 'tests': ['damp', 'tps']}, 04:52:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:52:31 INFO - 'tests': ['damp', 'tps']}, 04:52:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:52:31 INFO - 'tests': ['dromaeo_dom']}, 04:52:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:52:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:52:31 INFO - 'tests': ['basic_compositor_video']}, 04:52:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:52:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:52:31 INFO - 'tests': ['a11yr', 04:52:31 INFO - 'ts_paint', 04:52:31 INFO - 'tpaint', 04:52:31 INFO - 'sessionrestore', 04:52:31 INFO - 'sessionrestore_no_auto_restore', 04:52:31 INFO - 'tabpaint']}, 04:52:31 INFO - 'other-e10s': {'tests': ['a11yr', 04:52:31 INFO - 'ts_paint', 04:52:31 INFO - 'tpaint', 04:52:31 INFO - 'sessionrestore', 04:52:31 INFO - 'sessionrestore_no_auto_restore', 04:52:31 INFO - 'tabpaint']}, 04:52:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:52:31 INFO - 'ts_paint', 04:52:31 INFO - 'tpaint', 04:52:31 INFO - 'sessionrestore', 04:52:31 INFO - 'sessionrestore_no_auto_restore', 04:52:31 INFO - 'tabpaint']}, 04:52:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:52:31 INFO - 'ts_paint', 04:52:31 INFO - 'tpaint', 04:52:31 INFO - 'sessionrestore', 04:52:31 INFO - 'sessionrestore_no_auto_restore', 04:52:31 INFO - 'tabpaint']}, 04:52:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:52:31 INFO - 'tests': ['a11yr', 04:52:31 INFO - 'ts_paint', 04:52:31 INFO - 'tpaint', 04:52:31 INFO - 'sessionrestore', 04:52:31 INFO - 'sessionrestore_no_auto_restore', 04:52:31 INFO - 'tabpaint']}, 04:52:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:52:31 INFO - 'tests': ['a11yr', 04:52:31 INFO - 'ts_paint', 04:52:31 INFO - 'tpaint', 04:52:31 INFO - 'sessionrestore', 04:52:31 INFO - 'sessionrestore_no_auto_restore', 04:52:31 INFO - 'tabpaint']}, 04:52:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:52:31 INFO - 'tests': ['tsvgx', 04:52:31 INFO - 'tsvgr_opacity', 04:52:31 INFO - 'tart', 04:52:31 INFO - 'tscrollx', 04:52:31 INFO - 'cart', 04:52:31 INFO - 'tsvg_static']}, 04:52:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:52:31 INFO - 'tsvgr_opacity', 04:52:31 INFO - 'tart', 04:52:31 INFO - 'tscrollx', 04:52:31 INFO - 'cart', 04:52:31 INFO - 'tsvg_static']}, 04:52:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:52:31 INFO - 'talos_options': ['--disable-e10s'], 04:52:31 INFO - 'tests': ['tp5o']}, 04:52:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:52:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:52:31 INFO - 'talos_options': ['--disable-e10s', 04:52:31 INFO - '--xperf_path', 04:52:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:31 INFO - 'tests': ['tp5n']}, 04:52:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:52:31 INFO - 'talos_options': ['--xperf_path', 04:52:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:31 INFO - 'tests': ['tp5n']}}, 04:52:31 INFO - 'talos.zip': {'path': '', 04:52:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:52:31 INFO - Running post-action listener: _resource_record_post_action 04:52:31 INFO - [mozharness: 2017-04-04 11:52:31.726290Z] Finished populate-webroot step (success) 04:52:31 INFO - [mozharness: 2017-04-04 11:52:31.726403Z] Running create-virtualenv step. 04:52:31 INFO - Running pre-action listener: _resource_record_pre_action 04:52:31 INFO - Running main action method: create_virtualenv 04:52:31 INFO - Creating virtualenv /builds/slave/test/build/venv 04:52:31 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 04:52:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:52:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:52:31 INFO - Using real prefix '/tools/python27' 04:52:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:52:32 INFO - Installing distribute.............................................................................................................................................................................................done. 04:52:35 INFO - Installing pip.................done. 04:52:35 INFO - Return code: 0 04:52:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:52:35 INFO - Reading from file tmpfile_stdout 04:52:35 INFO - Output received: 04:52:35 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) 04:52:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:52:35 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')]} 04:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:35 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')]} 04:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:35 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 0x105d1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105afad30>, '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 0x105a21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aefbe8>, '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.bIhbCglnTx/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.DVJH1jj8eL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 04:52:35 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 04:52:35 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 04:52:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bIhbCglnTx/Render', 04:52:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:35 INFO - 'HOME': '/Users/cltbld', 04:52:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:35 INFO - 'LOGNAME': 'cltbld', 04:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:35 INFO - 'MOZ_NO_REMOTE': '1', 04:52:35 INFO - 'NO_EM_RESTART': '1', 04:52:35 INFO - 'PAGER': '/bin/cat', 04:52:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:35 INFO - 'PWD': '/builds/slave/test', 04:52:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:35 INFO - 'SHELL': '/bin/bash', 04:52:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DVJH1jj8eL/Listeners', 04:52:35 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:52:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:35 INFO - 'USER': 'cltbld', 04:52:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:35 INFO - 'XPC_FLAGS': '0x0', 04:52:35 INFO - 'XPC_SERVICE_NAME': '0', 04:52:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:35 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 04:52:35 INFO - Cleaning up... 04:52:35 INFO - Return code: 0 04:52:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:52:35 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')]} 04:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:35 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')]} 04:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:35 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 0x105d1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105afad30>, '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 0x105a21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aefbe8>, '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.bIhbCglnTx/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.DVJH1jj8eL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 04:52:35 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 04:52:35 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 04:52:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bIhbCglnTx/Render', 04:52:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:35 INFO - 'HOME': '/Users/cltbld', 04:52:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:35 INFO - 'LOGNAME': 'cltbld', 04:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:35 INFO - 'MOZ_NO_REMOTE': '1', 04:52:35 INFO - 'NO_EM_RESTART': '1', 04:52:35 INFO - 'PAGER': '/bin/cat', 04:52:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:35 INFO - 'PWD': '/builds/slave/test', 04:52:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:35 INFO - 'SHELL': '/bin/bash', 04:52:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DVJH1jj8eL/Listeners', 04:52:35 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:52:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:35 INFO - 'USER': 'cltbld', 04:52:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:35 INFO - 'XPC_FLAGS': '0x0', 04:52:35 INFO - 'XPC_SERVICE_NAME': '0', 04:52:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:36 INFO - Downloading/unpacking psutil>=3.1.1 04:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:52:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:39 INFO - Installing collected packages: psutil 04:52:39 INFO - Running setup.py install for psutil 04:52:39 INFO - building 'psutil._psutil_osx' extension 04:52:39 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 04:52:40 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 04:52:40 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 04:52:40 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 04:52:40 INFO - building 'psutil._psutil_posix' extension 04:52:40 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 04:52:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:52:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:52:40 INFO - ^ 04:52:40 INFO - 1 warning generated. 04:52:40 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 04:52:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:40 INFO - Successfully installed psutil 04:52:40 INFO - Cleaning up... 04:52:40 INFO - Return code: 0 04:52:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:52:40 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')]} 04:52:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:40 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')]} 04:52:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:40 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 0x105d1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105afad30>, '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 0x105a21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aefbe8>, '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.bIhbCglnTx/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.DVJH1jj8eL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 04:52:40 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 04:52:40 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 04:52:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bIhbCglnTx/Render', 04:52:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:40 INFO - 'HOME': '/Users/cltbld', 04:52:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:40 INFO - 'LOGNAME': 'cltbld', 04:52:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:40 INFO - 'MOZ_NO_REMOTE': '1', 04:52:40 INFO - 'NO_EM_RESTART': '1', 04:52:40 INFO - 'PAGER': '/bin/cat', 04:52:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:40 INFO - 'PWD': '/builds/slave/test', 04:52:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:40 INFO - 'SHELL': '/bin/bash', 04:52:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DVJH1jj8eL/Listeners', 04:52:40 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:52:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:40 INFO - 'USER': 'cltbld', 04:52:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:40 INFO - 'XPC_FLAGS': '0x0', 04:52:40 INFO - 'XPC_SERVICE_NAME': '0', 04:52:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:52:40 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 04:52:40 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 04:52:40 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 04:52:40 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 04:52:40 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 04:52:40 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 04:52:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:52:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:52:43 INFO - Installing collected packages: mozsystemmonitor 04:52:43 INFO - Running setup.py install for mozsystemmonitor 04:52:43 INFO - Successfully installed mozsystemmonitor 04:52:43 INFO - Cleaning up... 04:52:43 INFO - Return code: 0 04:52:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:44 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')]} 04:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:44 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 0x105d1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105afad30>, '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 0x105a21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aefbe8>, '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.bIhbCglnTx/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.DVJH1jj8eL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 04:52:44 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 04:52:44 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 04:52:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bIhbCglnTx/Render', 04:52:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:44 INFO - 'HOME': '/Users/cltbld', 04:52:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:44 INFO - 'LOGNAME': 'cltbld', 04:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:44 INFO - 'MOZ_NO_REMOTE': '1', 04:52:44 INFO - 'NO_EM_RESTART': '1', 04:52:44 INFO - 'PAGER': '/bin/cat', 04:52:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:44 INFO - 'PWD': '/builds/slave/test', 04:52:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:44 INFO - 'SHELL': '/bin/bash', 04:52:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DVJH1jj8eL/Listeners', 04:52:44 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:52:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:44 INFO - 'USER': 'cltbld', 04:52:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:44 INFO - 'XPC_FLAGS': '0x0', 04:52:44 INFO - 'XPC_SERVICE_NAME': '0', 04:52:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:44 INFO - Downloading/unpacking jsonschema==2.5.1 04:52:44 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 04:52:44 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 04:52:44 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 04:52:44 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 04:52:44 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 04:52:44 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 04:52:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:52:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:52:47 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 04:52:47 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 04:52:47 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 04:52:47 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 04:52:47 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 04:52:47 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 04:52:48 INFO - Downloading functools32-3.2.3-2.tar.gz 04:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:52:48 INFO - warning: no files found matching '*.txt' 04:52:48 INFO - no previously-included directories found matching 'build' 04:52:48 INFO - no previously-included directories found matching 'dist' 04:52:48 INFO - no previously-included directories found matching '.git*' 04:52:48 INFO - Installing collected packages: jsonschema, functools32 04:52:48 INFO - Running setup.py install for functools32 04:52:48 INFO - warning: no files found matching '*.txt' 04:52:48 INFO - no previously-included directories found matching 'build' 04:52:48 INFO - no previously-included directories found matching 'dist' 04:52:48 INFO - no previously-included directories found matching '.git*' 04:52:48 INFO - Successfully installed jsonschema functools32 04:52:48 INFO - Cleaning up... 04:52:48 INFO - Return code: 0 04:52:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:48 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 0x105d1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105afad30>, '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 0x105a21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aefbe8>, '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.bIhbCglnTx/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.DVJH1jj8eL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 04:52:48 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 04:52:48 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 04:52:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bIhbCglnTx/Render', 04:52:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:48 INFO - 'HOME': '/Users/cltbld', 04:52:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:48 INFO - 'LOGNAME': 'cltbld', 04:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:48 INFO - 'MOZ_NO_REMOTE': '1', 04:52:48 INFO - 'NO_EM_RESTART': '1', 04:52:48 INFO - 'PAGER': '/bin/cat', 04:52:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:48 INFO - 'PWD': '/builds/slave/test', 04:52:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:48 INFO - 'SHELL': '/bin/bash', 04:52:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DVJH1jj8eL/Listeners', 04:52:48 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:52:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:48 INFO - 'USER': 'cltbld', 04:52:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:48 INFO - 'XPC_FLAGS': '0x0', 04:52:48 INFO - 'XPC_SERVICE_NAME': '0', 04:52:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:52:49 INFO - Cleaning up... 04:52:49 INFO - Return code: 0 04:52:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105d1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105afad30>, '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 0x105a21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aefbe8>, '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.bIhbCglnTx/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.DVJH1jj8eL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 04:52:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:52:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:52:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bIhbCglnTx/Render', 04:52:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:49 INFO - 'HOME': '/Users/cltbld', 04:52:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:49 INFO - 'LOGNAME': 'cltbld', 04:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:49 INFO - 'MOZ_NO_REMOTE': '1', 04:52:49 INFO - 'NO_EM_RESTART': '1', 04:52:49 INFO - 'PAGER': '/bin/cat', 04:52:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:49 INFO - 'PWD': '/builds/slave/test', 04:52:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:49 INFO - 'SHELL': '/bin/bash', 04:52:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DVJH1jj8eL/Listeners', 04:52:49 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:52:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:49 INFO - 'USER': 'cltbld', 04:52:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:49 INFO - 'XPC_FLAGS': '0x0', 04:52:49 INFO - 'XPC_SERVICE_NAME': '0', 04:52:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:49 INFO - Downloading/unpacking blobuploader==1.2.4 04:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:51 INFO - Downloading blobuploader-1.2.4.tar.gz 04:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:52:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:52:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:52:53 INFO - Downloading docopt-0.6.1.tar.gz 04:52:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:52:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:52:53 INFO - Running setup.py install for blobuploader 04:52:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:52:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:52:53 INFO - Running setup.py install for requests 04:52:53 INFO - Running setup.py install for docopt 04:52:53 INFO - Successfully installed blobuploader requests docopt 04:52:53 INFO - Cleaning up... 04:52:54 INFO - Return code: 0 04:52:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52: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')]} 04:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52: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')]} 04:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:54 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 0x105d1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105afad30>, '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 0x105a21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aefbe8>, '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.bIhbCglnTx/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.DVJH1jj8eL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 04:52:54 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 04:52:54 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 04:52:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bIhbCglnTx/Render', 04:52:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:54 INFO - 'HOME': '/Users/cltbld', 04:52:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:54 INFO - 'LOGNAME': 'cltbld', 04:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:54 INFO - 'MOZ_NO_REMOTE': '1', 04:52:54 INFO - 'NO_EM_RESTART': '1', 04:52:54 INFO - 'PAGER': '/bin/cat', 04:52:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:54 INFO - 'PWD': '/builds/slave/test', 04:52:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:54 INFO - 'SHELL': '/bin/bash', 04:52:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DVJH1jj8eL/Listeners', 04:52:54 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:52:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:54 INFO - 'USER': 'cltbld', 04:52:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:54 INFO - 'XPC_FLAGS': '0x0', 04:52:54 INFO - 'XPC_SERVICE_NAME': '0', 04:52:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:54 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-PzngAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:54 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-kP19Kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:54 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-x71PJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:54 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-DR5CtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:54 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-jqsgPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:54 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-mI1CdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:54 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-yUhhHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:55 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-pbJv_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:55 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-fW3XrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:55 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-grnbJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:52:55 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Wfw4Xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:52:55 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Jvb8l2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:52:55 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-66tRfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:52:55 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-FrZQfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:55 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-TJk0Ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:52:55 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-L9KisL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:52:56 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-UBeZRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:52:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:52:56 INFO - Running setup.py install for manifestparser 04:52:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:52:56 INFO - Running setup.py install for mozcrash 04:52:56 INFO - Running setup.py install for mozdebug 04:52:56 INFO - Running setup.py install for mozdevice 04:52:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:52:56 INFO - Running setup.py install for mozfile 04:52:56 INFO - Running setup.py install for mozhttpd 04:52:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:52:56 INFO - Running setup.py install for mozinfo 04:52:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:52:57 INFO - Running setup.py install for mozInstall 04:52:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:52:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:52:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:52:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:52:57 INFO - Running setup.py install for mozleak 04:52:57 INFO - Running setup.py install for mozlog 04:52:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:52:57 INFO - Running setup.py install for moznetwork 04:52:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:52:57 INFO - Running setup.py install for mozprocess 04:52:57 INFO - Running setup.py install for mozprofile 04:52:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:52:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:52:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:52:58 INFO - Running setup.py install for mozrunner 04:52:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:52:58 INFO - Running setup.py install for mozscreenshot 04:52:58 INFO - Running setup.py install for moztest 04:52:58 INFO - Running setup.py install for mozversion 04:52:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:52:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:52:58 INFO - Cleaning up... 04:52:58 INFO - Return code: 0 04:52:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:52:58 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 0x105d1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105afad30>, '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 0x105a21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aefbe8>, '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.bIhbCglnTx/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.DVJH1jj8eL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 04:52:58 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 04:52:58 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 04:52:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bIhbCglnTx/Render', 04:52:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:52:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:52:58 INFO - 'HOME': '/Users/cltbld', 04:52:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:52:58 INFO - 'LOGNAME': 'cltbld', 04:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:58 INFO - 'MOZ_NO_REMOTE': '1', 04:52:58 INFO - 'NO_EM_RESTART': '1', 04:52:58 INFO - 'PAGER': '/bin/cat', 04:52:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:58 INFO - 'PWD': '/builds/slave/test', 04:52:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:52:58 INFO - 'SHELL': '/bin/bash', 04:52:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DVJH1jj8eL/Listeners', 04:52:58 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:52:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:52:58 INFO - 'USER': 'cltbld', 04:52:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:52:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:58 INFO - 'XPC_FLAGS': '0x0', 04:52:58 INFO - 'XPC_SERVICE_NAME': '0', 04:52:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:52:58 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ikit1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:52:59 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)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:52:59 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-pZHHWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:52:59 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)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:52:59 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-zB6PCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:52:59 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)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:52:59 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-LZwWD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:52:59 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)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:52:59 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-uUmNnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:52:59 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)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:52:59 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-yTQkZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:52:59 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)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:52:59 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-aSkEBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:52:59 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)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:52:59 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-_PPwuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:52:59 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)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:52:59 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-RKj4Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:52:59 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)) 04:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:52:59 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-UhjxAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:00 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)) 04:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:00 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-SvCvZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:00 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)) 04:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:00 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-OMCsnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 04:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:00 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-DnxCs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:00 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)) 04:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:00 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-uu_g_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:00 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)) 04:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:00 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-wZUXKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:00 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)) 04:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:00 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-PaZ_dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:00 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)) 04:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:00 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-txjlWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:00 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)) 04:53:00 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)) 04:53:00 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)) 04:53:00 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)) 04:53:00 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)) 04:53:00 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)) 04:53:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:00 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 04:53:00 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 04:53:00 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 04:53:00 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 04:53:00 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 04:53:00 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 04:53:03 INFO - Downloading blessings-1.6.tar.gz 04:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:03 INFO - Installing collected packages: blessings 04:53:03 INFO - Running setup.py install for blessings 04:53:03 INFO - Successfully installed blessings 04:53:03 INFO - Cleaning up... 04:53:03 INFO - Return code: 0 04:53:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:04 INFO - Reading from file tmpfile_stdout 04:53:04 INFO - Current package versions: 04:53:04 INFO - blessings == 1.6 04:53:04 INFO - blobuploader == 1.2.4 04:53:04 INFO - docopt == 0.6.1 04:53:04 INFO - functools32 == 3.2.3-2 04:53:04 INFO - jsonschema == 2.5.1 04:53:04 INFO - manifestparser == 1.1 04:53:04 INFO - mozInstall == 1.12 04:53:04 INFO - mozcrash == 1.0 04:53:04 INFO - mozdebug == 0.1 04:53:04 INFO - mozdevice == 0.49 04:53:04 INFO - mozfile == 1.2 04:53:04 INFO - mozhttpd == 0.7 04:53:04 INFO - mozinfo == 0.9 04:53:04 INFO - mozleak == 0.1 04:53:04 INFO - mozlog == 3.4 04:53:04 INFO - moznetwork == 0.27 04:53:04 INFO - mozprocess == 0.25 04:53:04 INFO - mozprofile == 0.28 04:53:04 INFO - mozrunner == 6.13 04:53:04 INFO - mozscreenshot == 0.1 04:53:04 INFO - mozsystemmonitor == 0.3 04:53:04 INFO - moztest == 0.8 04:53:04 INFO - mozversion == 1.4 04:53:04 INFO - psutil == 3.1.1 04:53:04 INFO - requests == 1.2.3 04:53:04 INFO - wsgiref == 0.1.2 04:53:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:04 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')]} 04:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:04 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')]} 04:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:04 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 0x105d1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105afad30>, '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 0x105a21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aefbe8>, '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.bIhbCglnTx/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.DVJH1jj8eL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 04:53:04 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 04:53:04 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 04:53:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bIhbCglnTx/Render', 04:53:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:04 INFO - 'HOME': '/Users/cltbld', 04:53:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:04 INFO - 'LOGNAME': 'cltbld', 04:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:04 INFO - 'MOZ_NO_REMOTE': '1', 04:53:04 INFO - 'NO_EM_RESTART': '1', 04:53:04 INFO - 'PAGER': '/bin/cat', 04:53:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:04 INFO - 'PWD': '/builds/slave/test', 04:53:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:04 INFO - 'SHELL': '/bin/bash', 04:53:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DVJH1jj8eL/Listeners', 04:53:04 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:53:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:04 INFO - 'USER': 'cltbld', 04:53:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:04 INFO - 'XPC_FLAGS': '0x0', 04:53:04 INFO - 'XPC_SERVICE_NAME': '0', 04:53:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 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)) 04:53:04 INFO - Cleaning up... 04:53:04 INFO - Return code: 0 04:53:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53:04 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')]} 04:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:04 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')]} 04:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:53:04 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 0x105d1cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d1f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ddad86a70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105afad30>, '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 0x105a21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aefbe8>, '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.bIhbCglnTx/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.DVJH1jj8eL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 04:53:04 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 04:53:04 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 04:53:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bIhbCglnTx/Render', 04:53:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:04 INFO - 'HOME': '/Users/cltbld', 04:53:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:04 INFO - 'LOGNAME': 'cltbld', 04:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:04 INFO - 'MOZ_NO_REMOTE': '1', 04:53:04 INFO - 'NO_EM_RESTART': '1', 04:53:04 INFO - 'PAGER': '/bin/cat', 04:53:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:04 INFO - 'PWD': '/builds/slave/test', 04:53:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:04 INFO - 'SHELL': '/bin/bash', 04:53:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DVJH1jj8eL/Listeners', 04:53:04 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:53:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:04 INFO - 'USER': 'cltbld', 04:53:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:04 INFO - 'XPC_FLAGS': '0x0', 04:53:04 INFO - 'XPC_SERVICE_NAME': '0', 04:53:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:53:04 INFO - Cleaning up... 04:53:04 INFO - Return code: 0 04:53:04 INFO - Running post-action listener: _resource_record_post_action 04:53:04 INFO - Running post-action listener: _start_resource_monitoring 04:53:04 INFO - Starting resource monitoring. 04:53:04 INFO - [mozharness: 2017-04-04 11:53:04.675224Z] Finished create-virtualenv step (success) 04:53:04 INFO - [mozharness: 2017-04-04 11:53:04.676204Z] Running install step. 04:53:04 INFO - Running pre-action listener: _resource_record_pre_action 04:53:04 INFO - Running main action method: install 04:53:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:04 INFO - Reading from file tmpfile_stdout 04:53:04 INFO - Detecting whether we're running mozinstall >=1.0... 04:53:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:53:05 INFO - Reading from file tmpfile_stdout 04:53:05 INFO - Output received: 04:53:05 INFO - Usage: mozinstall [options] installer 04:53:05 INFO - Options: 04:53:05 INFO - -h, --help show this help message and exit 04:53:05 INFO - -d DEST, --destination=DEST 04:53:05 INFO - Directory to install application into. [default: 04:53:05 INFO - "/builds/slave/test"] 04:53:05 INFO - --app=APP Application being installed. [default: firefox] 04:53:05 INFO - mkdir: /builds/slave/test/build/application 04:53:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:53:25 INFO - Reading from file tmpfile_stdout 04:53:25 INFO - Output received: 04:53:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:53:25 INFO - Running post-action listener: _resource_record_post_action 04:53:25 INFO - [mozharness: 2017-04-04 11:53:25.301203Z] Finished install step (success) 04:53:25 INFO - [mozharness: 2017-04-04 11:53:25.301348Z] Running run-tests step. 04:53:25 INFO - Running pre-action listener: _resource_record_pre_action 04:53:25 INFO - Running main action method: run_tests 04:53:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:53:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:53:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:53:25 INFO - 2017-04-04 04:53:25.316 screenresolution[1916:12539] starting screenresolution argv=screenresolution get 04:53:25 INFO - 2017-04-04 04:53:25.318 screenresolution[1916:12539] Display 0: 1600x1200x32@60 04:53:25 INFO - 2017-04-04 04:53:25.324 screenresolution[1917:12541] starting screenresolution argv=screenresolution list 04:53:25 INFO - Available Modes on Display 0 04:53:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:53:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:53:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:53:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:53:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:53:25 INFO - Intel Iris: 04:53:25 INFO - Chipset Model: Intel Iris 04:53:25 INFO - Type: GPU 04:53:25 INFO - Bus: Built-In 04:53:25 INFO - VRAM (Dynamic, Max): 1536 MB 04:53:25 INFO - Vendor: Intel (0x8086) 04:53:25 INFO - Device ID: 0x0a2e 04:53:25 INFO - Revision ID: 0x0009 04:53:25 INFO - Displays: 04:53:25 INFO - Display: 04:53:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:53:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:53:25 INFO - Display Serial Number: 1600x1200 60 04:53:25 INFO - Main Display: Yes 04:53:25 INFO - Mirror: Off 04:53:25 INFO - Online: Yes 04:53:25 INFO - Rotation: Supported 04:53:25 INFO - Return code: 0 04:53:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:53:25 INFO - Python 2.7.3 04:53:25 INFO - Return code: 0 04:53:25 INFO - grabbing minidump binary from tooltool 04:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:25 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 0x105afad30>, '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 0x105a21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105aefbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:53:25 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 04:53:25 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 04:53:25 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 04:53:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:53:25 INFO - Return code: 0 04:53:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:53:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:53:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:53:25 INFO - ENV: RUST_BACKTRACE is now 1 04:53:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:53:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:53:25 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/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--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 04:53:25 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/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0005 --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 04:53:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bIhbCglnTx/Render', 04:53:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:53:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:53:25 INFO - 'HOME': '/Users/cltbld', 04:53:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:53:25 INFO - 'LOGNAME': 'cltbld', 04:53:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:53:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:25 INFO - 'MOZ_NO_REMOTE': '1', 04:53:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:53:25 INFO - 'NO_EM_RESTART': '1', 04:53:25 INFO - 'PAGER': '/bin/cat', 04:53:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:25 INFO - 'PWD': '/builds/slave/test', 04:53:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:53:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:53:25 INFO - 'RUST_BACKTRACE': '1', 04:53:25 INFO - 'SHELL': '/bin/bash', 04:53:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DVJH1jj8eL/Listeners', 04:53:25 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 04:53:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:53:25 INFO - 'USER': 'cltbld', 04:53:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:53:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:25 INFO - 'XPC_FLAGS': '0x0', 04:53:25 INFO - 'XPC_SERVICE_NAME': '0', 04:53:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:53:25 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/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--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 04:53:25 INFO - mozversion application_buildid: 20170404033427 04:53:25 INFO - mozversion application_changeset: 916a4ee676a33355fc717f15ecb80815ba95051e 04:53:25 INFO - mozversion application_display_name: Nightly 04:53:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:53:25 INFO - mozversion application_name: Firefox 04:53:25 INFO - mozversion application_remotingname: firefox 04:53:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:53:25 INFO - mozversion application_vendor: Mozilla 04:53:25 INFO - mozversion application_version: 55.0a1 04:53:25 INFO - mozversion platform_buildid: 20170404033427 04:53:25 INFO - mozversion platform_changeset: 916a4ee676a33355fc717f15ecb80815ba95051e 04:53:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:53:25 INFO - mozversion platform_version: 55.0a1 04:53:25 INFO - using testdate: 1491306805 04:53:25 INFO - actual date: 1491306805 04:53:25 INFO - starting webserver on 'localhost:49527' 04:53:25 INFO - SUITE-START | Running 2 tests 04:53:25 INFO - TEST-START | dromaeo_css 04:53:25 INFO - operating with platform_type : mac_ 04:53:25 INFO - Initialising browser for dromaeo_css test... 04:53:25 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpKJ1E0t/profile http://localhost:49527/getInfo.html) 04:53:28 INFO - PID 1927 | 2017-04-04 04:53:28.596 plugin-container[1929:12710] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f43, name = 'com.apple.tsm.portname' 04:53:28 INFO - PID 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:53:28 INFO - PID 1927 | 2017-04-04 04:53:28.599 plugin-container[1929:12710] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4923, name = 'com.apple.CFPasteboardClient' 04:53:28 INFO - PID 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:53:28 INFO - PID 1927 | 2017-04-04 04:53:28.599 plugin-container[1929:12710] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:53:28 INFO - PID 1927 | __metrics Screen width/height:1600/1200 04:53:28 INFO - PID 1927 | colorDepth:24 04:53:28 INFO - PID 1927 | Browser inner width/height: 1024/663 04:53:28 INFO - PID 1927 | __metrics 04:53:28 ERROR - PID 1927 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:53:29 INFO - TEST-INFO | 1927: exit 0 04:53:29 INFO - Browser initialized. 04:53:29 INFO - Running cycle 1/1 for dromaeo_css test... 04:53:29 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpKJ1E0t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:31 INFO - PID 1930 | 2017-04-04 04:53:31.982 plugin-container[1931:12840] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 04:53:31 INFO - PID 1930 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:53:31 INFO - PID 1930 | 2017-04-04 04:53:31.983 plugin-container[1931:12840] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 04:53:31 INFO - PID 1930 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:53:31 INFO - PID 1930 | 2017-04-04 04:53:31.983 plugin-container[1931:12840] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:53:41 INFO - PID 1930 | RSS: Main: 247070720 04:53:41 INFO - PID 1930 | 04:56:46 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:49527/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49527/tests/dromaeo/cssquery-ext.html) 04:56:47 INFO - PID 1930 | RSS: Main: 264036352 04:56:47 INFO - PID 1930 | 04:58:30 INFO - PID 1930 | ************************* 04:58:30 INFO - PID 1930 | A coding exception was thrown and uncaught in a Task. 04:58:30 INFO - PID 1930 | 04:58:30 ERROR - PID 1930 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:30 INFO - PID 1930 | Full stack: 04:58:30 INFO - PID 1930 | ************************* 04:58:30 INFO - PID 1930 | ************************* 04:58:30 INFO - PID 1930 | A coding exception was thrown and uncaught in a Task. 04:58:30 INFO - PID 1930 | 04:58:30 ERROR - PID 1930 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:30 INFO - PID 1930 | Full stack: 04:58:30 INFO - PID 1930 | ************************* 04:58:30 INFO - PID 1930 | ************************* 04:58:30 INFO - PID 1930 | A coding exception was thrown and uncaught in a Task. 04:58:30 INFO - PID 1930 | 04:58:30 ERROR - PID 1930 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:30 INFO - PID 1930 | Full stack: 04:58:30 INFO - PID 1930 | ************************* 04:58:30 INFO - PID 1930 | ************************* 04:58:30 INFO - PID 1930 | A coding exception was thrown and uncaught in a Task. 04:58:30 INFO - PID 1930 | 04:58:30 ERROR - PID 1930 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:58:30 INFO - PID 1930 | Full stack: 04:58:30 INFO - PID 1930 | ************************* 04:59:49 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:49527/tests/dromaeo/cssquery-ext.html (next: http://localhost:49527/tests/dromaeo/cssquery-jquery.html) 04:59:50 INFO - PID 1930 | RSS: Main: 270073856 04:59:50 INFO - PID 1930 | 05:02:52 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:49527/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49527/tests/dromaeo/cssquery-mootools.html) 05:02:52 INFO - PID 1930 | RSS: Main: 281628672 05:02:52 INFO - PID 1930 | 05:05:54 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:49527/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49527/tests/dromaeo/cssquery-prototype.html) 05:05:55 INFO - PID 1930 | RSS: Main: 273874944 05:05:55 INFO - PID 1930 | 05:08:58 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:49527/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49527/tests/dromaeo/cssquery-yui.html) 05:08:58 INFO - PID 1930 | RSS: Main: 284209152 05:08:58 INFO - PID 1930 | 05:12:01 INFO - PID 1930 | Cycle 1(1): loaded http://localhost:49527/tests/dromaeo/cssquery-yui.html (next: http://localhost:49527/tests/dromaeo/cssquery-dojo.html) 05:12:01 INFO - PID 1930 | RSS: Main: 277827584 05:12:01 INFO - PID 1930 | 05:12:01 INFO - PID 1930 | __start_tp_report 05:12:01 INFO - PID 1930 | _x_x_mozilla_page_load 05:12:01 INFO - PID 1930 | _x_x_mozilla_page_load_details 05:12:01 INFO - PID 1930 | |i|pagename|runs| 05:12:01 INFO - PID 1930 | |0;dojo.html;3583.337082639711;3592.3174596826616;3624.1302087499007;3650.0144960860566;3657.56109266888;6153;6261.311255761862;6272.278687950881;6282.0576913463;6310.17967664203;6229.408206220402;6230.657313847737;6245.9063114053215;6284.151639528663;6336.9683151584295;5546.27898373213;5557.944420555783;5584.972075139629;5608.719564021803;5661.037623603997;5479.890402191953;5570.220169176318;5629.9866024115645;5656.349519805213;5659.745311460994;5439.456054394568;5525.143602741581;5565.693886836222;5602.635828671123;5613.7193140342815;5497.642653227527;5540.307461567304;5554.944450555483;5575.107982722745;5610.18652295419;5474.507294343488;5500.1749737539285;5522.3649280332875;5522.723863806794;5538.113901775737;5165.786040280531;6162.291336496315;6205.7517699291975;6273.498120150377;6305.0857625644485;6741.325867413219;6840.726370945156;6841.452683785285;6853.965730171317;6868.381845633867;6927.238003819576;6945.930540694579;6948.166220053576;6971.163460384786;6977.825554361131;6177.505799536027;6381.7766378177;6403.903941440882;6404.839879003016;6429.035644653246;6775.1869775626255;6954.130733658293;6987.545809522365;7012.5792452453015;7039.260877607778;6408.775692850728;6490.286068532458;6504.837379065561;6650.235222949423;6729.22613899398;6784.59292442455;6804.319568043156;6854.588724676535;6886.724531018804;6923.134608173978;6837.589744615339;6841.657917104125;6845.794626161123;6848.315168483112;6857.451403887677;6430.260520040161;6584.440322572635;6602.933970660232;6716.496262780311;6764.627945462948;5398.028354896078;5422.322209723785;5422.620416570881;5423.078076726966;5445.646033007921;4816.084943860656;4817.253325734517;4821.951780482221;4848.684835485753;4866.513348665105;6244.75020999164;6270.15352927349;6287.339829317856;6428.678566071678;6446.129772480749;5712.885742285131;6928.549644273106;6970.546914450544;6973.65131743421;6993.230744618088;6095.2685677718955;6362.713677884506;6383.616982980943;6388.872222555523;6423.421892029646;5857;5956.702164891738;6053.969730151409;6152.046432802833;6166.383361663888;6804.523683342218;6967.303269672992;7026.508144429841;7062.788116356517;7081.822954425975;6948.409385202112;6964.860702785814;6969.128858892638;6973.721051157897;6995.125609298634;5872.970635146968;6952.339527744856;7044.753433629799;7085.078939737801;7096;6424.51816113784;6450.9354906450335;6543.509236807354;6678.632675202911;6735.158105236846;6880.58716477013;6907.861842763016;6933.994570787107;6943.722251110101;6954.3045695430055;5409.350877894678;6301.212348456443;6440.903386449113;6602.537822352581;6643.069970204272;4970.577500912463;6389.233292004803;6518.608883467007;6574.27682954865;6640.236372817188;6277.623342599459;6345.428911397997;6383.904241436475;6465.094886715958;6486.513511486563;6480.222373315232;6533.640649764308;6540.934590654033;6568.47452203813;6618.602883826793;5795.623284486495;6133.723982420713;6446.548741588043;6461.806145815445;6478.1578394808375 05:12:01 INFO - PID 1930 | |1;ext.html;816.1838161838161;839.9244068033876;1116.2799994003867;1180.5690922813176;1281.6923938254822;38178.80910595447;38751.41872871906;38775.03062423437;38812.83561493153;38853.41719874197;38169;38352.42471362925;38417.231655366944;38462.23075538487;38526.422103668396;7938.126806051344;8472.576371181416;8635.784105397352;8678.479291242546;8685.522296273703;8569.400141990063;8672.219500244977;8675.219230269275;8698.695545655872;8749.256313213353;8574.271186949085;8622.698205562807;8683.782905427352;8687.782805429852;8702.347323950697;8598.269147122503;8608.913910860874;8651.65393384264;8660.437071590326;8662.956685216597;8520.19058189471;8601.827963440759;8614.224719775188;8625.611847466878;8648.30813534922;38267;38447.23105537874;38472.038199045244;38518.22963540714;38594.80702596497;3020.416701948032;3024.894128705507;3032.8331941743195;3044.969550304491;3050.740687041604;26990;27507;27940.882364705387;28095.85952070247;28379.432411351863;2774.4728501584636;2807.7192280771965;2829.3209629688727;2829.9292517687018;2837.333226691726;311962;316390;317541;317587.41206294054;317877;38903.83288501349;39728.20543589112;47634.52365476301;48824;48844.02311953741;51157.7442112787;51332.71668208325;51362;51371.48628513742;51400.48599514032;12781.744365112645;12877;12928.224306541637;12950;12951.805722914163;10233.1301839343;10243.385396876061;10244.48777561119;10262.384256944608;10502.264841461178;11219.943900280447;13778.724425511433;13834.515791947233;13841.031127821157;13970.650733731738;5946.791862284799;5958.582899197015;5979.701014949235;5987.311459182162;5993.940060599338;794.7933537280348;808.2523665609287;946.8721722567503;982.2289502740457;1011.5195282241024;19321.806781932282;22629.660555091687;23992;24069.759302407103;24139.879300603385;943.8867335919733;1065.872095348563;1075.9569617215225;1108.152263518409;1120.4957769003981;12125;12294;12336.938315308545;12347.259164450163;12372;481554;485453;485986;486108.1389186063;488960;49552.26567070135;53277;53329.733351332994;53596.92806143855;53769.462305376444;1296.6045356166271;1335.4457899971596;1429.785532170162;1438.8417324054028;1488.977665335021;18333.175007124977;23049.96275167655;23327.650085248395;23689.40776480602;23765.405864852826;37815.810920945216;37824.43263351107;37943.05142371463;38009;38083.238335232585;413213;417591.91204043786;418415.90792045847;418489;419709.9159546254;33725.98822035343;33950.49074263938;34693.65306346904;35502;35507.38404007463;39467.605323946394;39927.80036099801;43834.56165438305;44062;44079.11841763211;23961.400964976016;28913.132606021853;29519.409611808074;29990.850045750503;30735;29887.701122988492;29893.95371161999;30347.39305213839;30420.391592168475;30881.536776947913;36065.459018115274;36166.27667446689;36679.89960301195;36744;36761;28995.7100428993;29699.554506681983;30603;31181.376372472878;31621.051368458982;22040.448988774766;22325.665115022963;24314.756852431958;24410.633840492763;24878 05:12:01 INFO - PID 1930 | |2;jquery.html;364.98905032849024;420.68377960790735;429.7271232767193;442.7586965104018;446.1233675826999;20268.797312026858;21854.235101771443;22531.324060278177;22623.321300360974;22738.65892011619;22590.54818903621;22816.20143294985;23151.768482315212;23427.531449371003;23667;6211.440970312659;6248.625082495042;6394.296627370985;6396.936030639704;6406.455451286646;6049.697515124249;6281.811545653638;6289.622622642633;6295.055741638745;6297.496200303987;6018.488428483584;6204;6228.750849966019;6264.812055638338;6278.183836101323;6232.781852635158;6273.153124328226;6276.905846412307;6277.811665649992;6291.937080629204;5360.3299587551555;5549.278593782823;5571.387147413781;5623.100303951348;5632.74652640628;26974.865125674245;27218.183454496397;27296.727032729617;27302.45395092107;27638.723612763817;2009.5076706206926;2017.4149496646103;2021.848361372903;2024.2409096588779;2044.9795502044938;15791;16546.917265413715;16655.583610409714;16684.249208785634;17391.826081739146;1813.727940808876;1883.5950270691867;1887.6130393269348;1929.218666440094;1955.9706604400944;135194;138013.30993345068;146533;154255;177363.11318443454;10545.894541054491;12528.81206781899;12680.175788573713;12745.17156384832;12797.744045119045;16116.194190290438;16270.593235168979;16334.75497867533;16352.427665031666;16387.918060409622;7098.645067746592;7494.85010299791;8214.712485062993;8501.107383724744;8541.914580854236;6367.872642547123;7455.179930207672;7733.883991740128;7913.960430197927;7934.127246002935;6475.384838440341;7724.459287849909;7810.492317999312;7863.056433227935;7864.960675196702;2221.933471933481;2223.633100538393;2223.8332125090683;2227.098025299756;2371.584972629783;873.8470767615769;908.9910199678352;925.5326060339486;962.41292811385;974.4786539201635;17198.968061916326;20096.799032009785;20114.798852011587;21098.683519747217;21234.150633974466;955.2071780422233;955.5986485676033;984.8670429491926;986.1420564109128;993.513178542509;10637.872425514928;11030.558777648805;11084.778304433867;11123.221374503708;11147.554097835995;684748;685676;687241;698780;713227;147385;150917.49082509254;160499;167487;168401;1145.616218566773;1195.8086706126978;1226.7485165541043;1228.9385530723428;1230.2864338683542;19309.51726206856;20069.49826254297;20200;20772.272970445963;21469.03389347452;58551.70724146352;59225;61949.76100477875;64008;64370;68698;84604.57697711472;86700.5664971671;87018.129818701;90905.54547227222;7482.588457634883;8610.05289418151;8630.180132887366;9053.547322633975;9145.63417463294;13682;14346.85225181962;14500.564983050524;15019.774703379677;15103.39586416575;11879.58421455245;11959.461824217757;12078.154529182873;12145.939270303592;12272.570460033856;9466.621335146518;11500.137489688474;11631.243969141979;11657.533698652298;12036.097292702907;10691.30506517074;12095.75808483843;12196.207246528948;12372;12528.937355313165;7353.485256032241;7523.473356865185;7608.657610407656;8585.098564650621;8952.641894324153;9820.361676491006;11907.047436205256;11908.345041022827;12155.149139560146;12200.14598978063 05:12:01 INFO - PID 1930 | |3;mootools.html;1339.6985678222395;1394.9790753138702;1443.844924060751;1454.3600815641123;1473.0278016509103;10811.83782243266;11054.336739795597;11088.501017454213;11231.32612043278;11242.156838237124;11085.445727713603;11196.776064478727;11218.66344009679;11257.043151332125;11330.71673208168;2114.9365519034377;2446.877656117196;2485.3041148478455;2485.639582260571;2488.22864911877;2376.251480783548;2432.1487479382254;2453.595156799126;2475.950480990379;2476.616124500705;2401.987990060047;2458.754124587545;2465.827392082555;2465.852048877064;2468.6790717206736;2364.538914911593;2418.9516209675794;2435.5981263091658;2436.4030812450974;2446.021591363451;2337.368910394201;2419.1774796569075;2435.8173137014796;2437.6099824028247;2438.085717855804;10983.450827458675;10997;11062.115030797517;11077.833832492439;11080.501377438035;6293.559450838443;6522.1521202243875;6525.738970441176;6531.836704082436;6535.934640653628;4014.8996275093355;4047.5952404759582;4104.117614712851;4133.483314585676;4142.109446468993;1031.5512751952924;1175.7589694112687;1184.2894263441951;1220.5422966387605;1227.098082909061;14195.361208745631;14427.711445771025;15210.467633632881;15294.617634559114;15436.922815385964;5241.109011468059;5277.155655095243;5410.269613602192;5458.836234912959;5463.699496527729;11455.713607159887;11497.022753065916;11509.76980460386;11518.481668324945;11527.020203282815;6361.332060133712;6371;6376.585521941059;6382.489400847921;6389.648569328639;5873.2658417697785;5903.616264942765;5939.732712027969;6001.339852616209;6068.362821903725;3630.41913293877;4136.193442278787;4222.704410691284;4262.360645903077;4367.30123180296;1278.111712359901;1284.865089165624;1285.6914340558199;1300.9284489353176;1301.6810881334134;755.9848803023908;762.2263402646319;776.8679324514846;778.7157687444042;803.2447513565239;5961.254843144607;6040.36576159497;6070.848228794227;6132.468920599547;6149.3235744068115;584.1296468262343;590.9261342332209;887.6582515731361;894.9149830766066;917.1378903830378;3920;3976.8011599420493;4035.6569691575955;4190.622843943998;4200.831966721358;13041;13995.950303727057;14134.50529231472;14151.575452736435;14160.433582656784;12060.21608595456;13457.932710336581;13725.588232353046;14098.154110753389;14290.928545357207;9021.639134434548;9893.653722119836;10063.949680251551;10155.238357123097;10178.287519873686;5827.213326200908;6607.141071660653;6726.730930762715;6792.524523283323;6832.692528836114;12294;12331.075169362155;12373.876261237632;12451.688707782378;12720.87279127197;12676.936615316865;12835.807462888251;12922.224666520038;12959.092863499842;12994.480220791062;9044.502552359683;9271.907280927104;9294.442333460014;9336.673216437392;9367.953160234156;8748.956255218684;9969.45168015737;10264.281500294908;10264.58941642326;10371.066604005675;8760.51817150063;8805.471671699463;8813.823723525622;8814.691485797966;8865.512396818236;8576.699815506427;8630.913690863263;8697.999730030875;8702;8708.825823483621;7775.222477752406;7795.791652293903;7796.88304675419;7833.315837095052;7883.605819708877;5777.335606405317;5795.623284486495;5925.733341999534;5985.850353741192;6014.338422773404;4803.735794531334;5894.70526473666;6045;6058.212432383762;6104.816855494342 05:12:01 INFO - PID 1930 | |4;prototype.html;392.2096974596191;395.5767328958016;397.81103975611586;399.73018212706427;408.18566958916966;6436.131122298489;6447.1618689570405;6454.483196448842;6470.708818103185;6493.707783149758;5585.413531579186;6129.873764380165;6180.443760061594;6216.937830621692;6310.49516038717;3787.791671458069;3873.438351439054;3874.8643797467093;4336.891577710567;4718.339432479455;3962.9207415851665;4074.577355021781;4674.672772905898;4725.535084123915;4748.691335063209;4380.414201763949;4607.861764147081;4672.883177920545;4717.561143851124;4720.409948756405;4416.69083164177;4674.485806561275;4684.601808846252;4685.8594242172785;4694.835680751157;3706.0549559862334;3795.449659799341;3961.98019009906;4041.989502624344;4177.665786737054;5199.6360254782185;5865.853353666193;6081.604695694766;6113.633182009094;6151.846203844895;5537.556995440355;5542.528885044776;5546.334439867202;5546.389897111315;5553.7778488860395;6339.683015849235;6342.936570634327;6710.261871194165;6730.41835168735;6740.932590674129;3612.837422316002;3653.3789255826573;4282.143571285756;4348.21732088224;4379.75911324877;6791.660416979132;6999.475039372017;7081.787546373617;7092.751753688596;7158.463115266376;4060.959390406058;4062.410950412174;4188.806190235769;4216.831326746896;4424.867253982386;4058.939115913264;4491.618212451978;4510.548945105464;4521.4054826413085;4524.6832721709825;5014.2979982802435;5292.5501332387175;5344.706041167696;5350.170723537858;5362.195670649356;6565.376289252514;6617.66911654425;6624.436922861514;6653.900191497131;6682.231543372477;1523.725729368702;1543.8764898808067;1544.4980381376097;1545.7835902973593;1548.3729089718681;1005.9798804024025;1030.7268573827942;1110.6667999600088;1158.467105131632;1181.6986668399675;5397.514223719805;5513.476219759196;6081.027035674271;6209.5963762356205;6256.562040657111;6732.225794033749;6845.726170953206;6880.965595171992;6922.861542769117;6950.930490695028;6167.444929956236;6170.352113028157;6231.657258850716;6255.530835187288;6286.277078136073;3526.347625689256;3582.390993531106;3589.8743543975834;3600.2979419013564;3620.2035552179004;5836.686745482232;6819.522043757719;6978.581285122909;7020.403265722369;7025.473089518205;5568.805091821767;6959.269276725972;7063.788086357417;7085.937109433627;7121.786346409616;6730.697118629673;6990.196127445409;7053.470989675898;7069.611171385521;7100.964495177491;5499.4225606310765;6792.592444453348;6873.690683919136;6898.413634841095;6923;5871.73577189036;6243.282022567463;6474.125992990886;6699.698513566804;6737;6002.399760023963;6256;6752.662366881735;6871.759488417882;7144.85710285781;4184.539700632989;4461.2824062735435;4471.664625153192;4486;4494.415725955605;5640.576956728344;5872.854793315262;6392.073149393219;6798.592084474947;6993.7552185675295;6116.847078823065;6701.041229490044;6715.630640314829;6753.358430949052;6806.42145417645;6483.4164925156965;6686.465082793462;6694.899576506454;6709.913439817738;6712.160979877515;5140.717260550706;5693.316801983623;6521.739130434729;6586.37429444202;6604.5046621502615;6297.590656607306;6475.222973243241;6688.8963321053425;6703.664816759045;6741;6182.485291103709;6223.782167624111;6293.4335909766505;6516.185476815398;6549.541532092708 05:12:01 INFO - PID 1930 | |5;yui.html;650.5088658063162;689.1764341611773;735.1766022055295;741.8812989921614;760.535759614954;14928.850711492882;15508.991915525483;15528;15542.533723988285;15548.455804046875;15056.774148387756;15126.394944202246;15275.847241527608;15281.92359038206;15289.388424463008;937.2923442800676;945.0832692288469;947.6020071569957;949.3070058857038;949.5679465843025;983.4443539400216;995.7361299255703;1030.1604192583059;1031.5770534081028;1037.305005646219;951.286535098676;1057.7937302226069;1065.169168048923;1069.1927594666056;1073.50618715391;867.8741582470537;1057.783154453339;1065.2915810985685;1066.9466526673634;1067.765091679829;783.4202690009351;792.1405275276333;792.1919641965163;793.4287313134533;793.8610743119931;16423.753643695352;16768.58078548046;16898.74651880223;16985.83014169855;17012.48962531126;14212.786808197885;14845;14890.553283401516;15010.099394036393;15188.01277916932;10840.403777792219;11528.942355288169;11805.468753906094;11815.645530634094;12108.81836772449;2701.554243549812;2707.7021527631946;3060.342890246157;3074.0777766669908;3188.6811318867926;88908;95453.5681964771;108148.45925770399;117806.82193178045;123715;9494;11496.195266331277;11539.76920461586;11588.199182467491;12143.210691305037;25234;25505.48989020246;25564.616530752053;25626.74373256281;25795.96816127334;7827.686892524349;7867.449278550561;7901.683932642745;7988.600569971478;8090.110087890327;4134.503859536875;4215.641670457984;4219.767912764827;4230.725002874803;4336.089421221579;4144.357624568197;4213.873583792491;4240.321548552279;4255.702100852911;4262.424572682648;798.7164556582329;801.310872649521;802.3060053054182;803.3533005930283;812.8333691593209;562.4572287742349;573.6271423574626;585.9355470898198;595.992772214964;607.168179593959;9054.366194366463;9689.691891594686;9993.500324983721;10092.293539452316;10122.848157277647;544.0913674164156;568.4883604755753;569.4789267819981;583.886142202275;592.7865968251426;4471.329300604935;4660.300954856731;4666.719996800203;4674.182018146811;4694.530546945346;102279.46580801294;103080;103236;103398.48300758448;105494;86777.56611216904;87986.12013879907;88131.55934220288;88602;90643.54678226566;57667;72277;78382;80983;82390.58804706058;9311.906880931105;9339.673111441067;9370.906290937277;9438.858417123885;9544.141027307576;39855.60144398635;40369;41447.58552414437;41769.95575110525;41932.58067419287;52186.73906630443;52794;52973.735131324094;53335.66660833355;53643.46356536541;11375.658730238107;11532.51197469279;11662.416879155839;12061.819072714092;12299.44652490658;12136.33250171249;12142.271463712206;12287.938560307499;12374.81437778416;12438.937805310916;9631.855522167032;11649.359285239054;11978.041756659271;12093.75812483763;12148.21036632616;11406.714832129263;11602.709932251424;11731.589394371156;11989.76020479568;12134.211276267368;11212.439378030902;11501.712457188638;11534.94232528832;11871;12199.329036903055;8387.412881098264;8561.700340488052;8573.614187361709;8666.696665616673;8704.91295087041;7852.411069169721;8394;8861.822763544822;9113.541833306905;10687 05:12:01 INFO - PID 1930 | __end_tp_report 05:12:01 INFO - PID 1930 | __start_cc_report 05:12:01 INFO - PID 1930 | _x_x_mozilla_cycle_collect,429 05:12:01 INFO - PID 1930 | __end_cc_report 05:12:01 INFO - PID 1930 | __startTimestamp1491307921984__endTimestamp 05:12:01 INFO - PID 1930 | 05:12:01 INFO - PID 1930 | ------- Summary: start ------- 05:12:01 INFO - PID 1930 | Number of tests: 6 05:12:01 INFO - PID 1930 | 05:12:01 INFO - PID 1930 | [#0] dojo.html Cycles:165 Average:6229.67 Median:6408.78 stddev:742.56 (11.6%) stddev-sans-first:715.23 05:12:02 INFO - PID 1930 | Values: 3583.3 3592.3 3624.1 3650.0 3657.6 6153.0 6261.3 6272.3 6282.1 6310.2 6229.4 6230.7 6245.9 6284.2 6337.0 5546.3 5557.9 5585.0 5608.7 5661.0 5479.9 5570.2 5630.0 5656.3 5659.7 5439.5 5525.1 5565.7 5602.6 5613.7 5497.6 5540.3 5554.9 5575.1 5610.2 5474.5 5500.2 5522.4 5522.7 5538.1 5165.8 6162.3 6205.8 6273.5 6305.1 6741.3 6840.7 6841.5 6854.0 6868.4 6927.2 6945.9 6948.2 6971.2 6977.8 6177.5 6381.8 6403.9 6404.8 6429.0 6775.2 6954.1 6987.5 7012.6 7039.3 6408.8 6490.3 6504.8 6650.2 6729.2 6784.6 6804.3 6854.6 6886.7 6923.1 6837.6 6841.7 6845.8 6848.3 6857.5 6430.3 6584.4 6602.9 6716.5 6764.6 5398.0 5422.3 5422.6 5423.1 5445.6 4816.1 4817.3 4822.0 4848.7 4866.5 6244.8 6270.2 6287.3 6428.7 6446.1 5712.9 6928.5 6970.5 6973.7 6993.2 6095.3 6362.7 6383.6 6388.9 6423.4 5857.0 5956.7 6054.0 6152.0 6166.4 6804.5 6967.3 7026.5 7062.8 7081.8 6948.4 6964.9 6969.1 6973.7 6995.1 5873.0 6952.3 7044.8 7085.1 7096.0 6424.5 6450.9 6543.5 6678.6 6735.2 6880.6 6907.9 6934.0 6943.7 6954.3 5409.4 6301.2 6440.9 6602.5 6643.1 4970.6 6389.2 6518.6 6574.3 6640.2 6277.6 6345.4 6383.9 6465.1 6486.5 6480.2 6533.6 6540.9 6568.5 6618.6 5795.6 6133.7 6446.5 6461.8 6478.2 05:12:02 INFO - PID 1930 | 05:12:02 INFO - PID 1930 | [#1] ext.html Cycles:180 Average:53587.50 Median:36711.95 stddev:109658.28 (298.7%) stddev-sans-first:109894.32 05:12:02 INFO - PID 1930 | Values: 816.2 839.9 1116.3 1180.6 1281.7 38178.8 38751.4 38775.0 38812.8 38853.4 38169.0 38352.4 38417.2 38462.2 38526.4 7938.1 8472.6 8635.8 8678.5 8685.5 8569.4 8672.2 8675.2 8698.7 8749.3 8574.3 8622.7 8683.8 8687.8 8702.3 8598.3 8608.9 8651.7 8660.4 8663.0 8520.2 8601.8 8614.2 8625.6 8648.3 38267.0 38447.2 38472.0 38518.2 38594.8 3020.4 3024.9 3032.8 3045.0 3050.7 26990.0 27507.0 27940.9 28095.9 28379.4 2774.5 2807.7 2829.3 2829.9 2837.3 311962.0 316390.0 317541.0 317587.4 317877.0 38903.8 39728.2 47634.5 48824.0 48844.0 51157.7 51332.7 51362.0 51371.5 51400.5 12781.7 12877.0 12928.2 12950.0 12951.8 10233.1 10243.4 10244.5 10262.4 10502.3 11219.9 13778.7 13834.5 13841.0 13970.7 5946.8 5958.6 5979.7 5987.3 5993.9 794.8 808.3 946.9 982.2 1011.5 19321.8 22629.7 23992.0 24069.8 24139.9 943.9 1065.9 1076.0 1108.2 1120.5 12125.0 12294.0 12336.9 12347.3 12372.0 481554.0 485453.0 485986.0 486108.1 488960.0 49552.3 53277.0 53329.7 53596.9 53769.5 1296.6 1335.4 1429.8 1438.8 1489.0 18333.2 23050.0 23327.7 23689.4 23765.4 37815.8 37824.4 37943.1 38009.0 38083.2 413213.0 417591.9 418415.9 418489.0 419709.9 33726.0 33950.5 34693.7 35502.0 35507.4 39467.6 39927.8 43834.6 44062.0 44079.1 23961.4 28913.1 29519.4 29990.9 30735.0 29887.7 29894.0 30347.4 30420.4 30881.5 36065.5 36166.3 36679.9 36744.0 36761.0 28995.7 29699.6 30603.0 31181.4 31621.1 22040.4 22325.7 24314.8 24410.6 24878.0 05:12:02 INFO - PID 1930 | 05:12:02 INFO - PID 1930 | [#2] jquery.html Cycles:180 Average:40515.71 Median:23547.27 stddev:116542.23 (494.9%) stddev-sans-first:116830.17 05:12:02 INFO - PID 1930 | Values: 365.0 420.7 429.7 442.8 446.1 20268.8 21854.2 22531.3 22623.3 22738.7 22590.5 22816.2 23151.8 23427.5 23667.0 6211.4 6248.6 6394.3 6396.9 6406.5 6049.7 6281.8 6289.6 6295.1 6297.5 6018.5 6204.0 6228.8 6264.8 6278.2 6232.8 6273.2 6276.9 6277.8 6291.9 5360.3 5549.3 5571.4 5623.1 5632.7 26974.9 27218.2 27296.7 27302.5 27638.7 2009.5 2017.4 2021.8 2024.2 2045.0 15791.0 16546.9 16655.6 16684.2 17391.8 1813.7 1883.6 1887.6 1929.2 1956.0 135194.0 138013.3 146533.0 154255.0 177363.1 10545.9 12528.8 12680.2 12745.2 12797.7 16116.2 16270.6 16334.8 16352.4 16387.9 7098.6 7494.9 8214.7 8501.1 8541.9 6367.9 7455.2 7733.9 7914.0 7934.1 6475.4 7724.5 7810.5 7863.1 7865.0 2221.9 2223.6 2223.8 2227.1 2371.6 873.8 909.0 925.5 962.4 974.5 17199.0 20096.8 20114.8 21098.7 21234.2 955.2 955.6 984.9 986.1 993.5 10637.9 11030.6 11084.8 11123.2 11147.6 684748.0 685676.0 687241.0 698780.0 713227.0 147385.0 150917.5 160499.0 167487.0 168401.0 1145.6 1195.8 1226.7 1228.9 1230.3 19309.5 20069.5 20200.0 20772.3 21469.0 58551.7 59225.0 61949.8 64008.0 64370.0 68698.0 84604.6 86700.6 87018.1 90905.5 7482.6 8610.1 8630.2 9053.5 9145.6 13682.0 14346.9 14500.6 15019.8 15103.4 11879.6 11959.5 12078.2 12145.9 12272.6 9466.6 11500.1 11631.2 11657.5 12036.1 10691.3 12095.8 12196.2 12372.0 12528.9 7353.5 7523.5 7608.7 8585.1 8952.6 9820.4 11907.0 11908.3 12155.1 12200.1 05:12:02 INFO - PID 1930 | 05:12:02 INFO - PID 1930 | [#3] mootools.html Cycles:180 Average:6810.27 Median:3059.32 stddev:4197.63 (137.2%) stddev-sans-first:4189.28 05:12:02 INFO - PID 1930 | Values: 1339.7 1395.0 1443.8 1454.4 1473.0 10811.8 11054.3 11088.5 11231.3 11242.2 11085.4 11196.8 11218.7 11257.0 11330.7 2114.9 2446.9 2485.3 2485.6 2488.2 2376.3 2432.1 2453.6 2476.0 2476.6 2402.0 2458.8 2465.8 2465.9 2468.7 2364.5 2419.0 2435.6 2436.4 2446.0 2337.4 2419.2 2435.8 2437.6 2438.1 10983.5 10997.0 11062.1 11077.8 11080.5 6293.6 6522.2 6525.7 6531.8 6535.9 4014.9 4047.6 4104.1 4133.5 4142.1 1031.6 1175.8 1184.3 1220.5 1227.1 14195.4 14427.7 15210.5 15294.6 15436.9 5241.1 5277.2 5410.3 5458.8 5463.7 11455.7 11497.0 11509.8 11518.5 11527.0 6361.3 6371.0 6376.6 6382.5 6389.6 5873.3 5903.6 5939.7 6001.3 6068.4 3630.4 4136.2 4222.7 4262.4 4367.3 1278.1 1284.9 1285.7 1300.9 1301.7 756.0 762.2 776.9 778.7 803.2 5961.3 6040.4 6070.8 6132.5 6149.3 584.1 590.9 887.7 894.9 917.1 3920.0 3976.8 4035.7 4190.6 4200.8 13041.0 13996.0 14134.5 14151.6 14160.4 12060.2 13457.9 13725.6 14098.2 14290.9 9021.6 9893.7 10063.9 10155.2 10178.3 5827.2 6607.1 6726.7 6792.5 6832.7 12294.0 12331.1 12373.9 12451.7 12720.9 12676.9 12835.8 12922.2 12959.1 12994.5 9044.5 9271.9 9294.4 9336.7 9368.0 8749.0 9969.5 10264.3 10264.6 10371.1 8760.5 8805.5 8813.8 8814.7 8865.5 8576.7 8630.9 8698.0 8702.0 8708.8 7775.2 7795.8 7796.9 7833.3 7883.6 5777.3 5795.6 5925.7 5985.9 6014.3 4803.7 5894.7 6045.0 6058.2 6104.8 05:12:02 INFO - PID 1930 | 05:12:02 INFO - PID 1930 | [#4] prototype.html Cycles:180 Average:5351.57 Median:6097.62 stddev:1694.56 (27.8%) stddev-sans-first:1657.93 05:12:02 INFO - PID 1930 | Values: 392.2 395.6 397.8 399.7 408.2 6436.1 6447.2 6454.5 6470.7 6493.7 5585.4 6129.9 6180.4 6216.9 6310.5 3787.8 3873.4 3874.9 4336.9 4718.3 3962.9 4074.6 4674.7 4725.5 4748.7 4380.4 4607.9 4672.9 4717.6 4720.4 4416.7 4674.5 4684.6 4685.9 4694.8 3706.1 3795.4 3962.0 4042.0 4177.7 5199.6 5865.9 6081.6 6113.6 6151.8 5537.6 5542.5 5546.3 5546.4 5553.8 6339.7 6342.9 6710.3 6730.4 6740.9 3612.8 3653.4 4282.1 4348.2 4379.8 6791.7 6999.5 7081.8 7092.8 7158.5 4061.0 4062.4 4188.8 4216.8 4424.9 4058.9 4491.6 4510.5 4521.4 4524.7 5014.3 5292.6 5344.7 5350.2 5362.2 6565.4 6617.7 6624.4 6653.9 6682.2 1523.7 1543.9 1544.5 1545.8 1548.4 1006.0 1030.7 1110.7 1158.5 1181.7 5397.5 5513.5 6081.0 6209.6 6256.6 6732.2 6845.7 6881.0 6922.9 6950.9 6167.4 6170.4 6231.7 6255.5 6286.3 3526.3 3582.4 3589.9 3600.3 3620.2 5836.7 6819.5 6978.6 7020.4 7025.5 5568.8 6959.3 7063.8 7085.9 7121.8 6730.7 6990.2 7053.5 7069.6 7101.0 5499.4 6792.6 6873.7 6898.4 6923.0 5871.7 6243.3 6474.1 6699.7 6737.0 6002.4 6256.0 6752.7 6871.8 7144.9 4184.5 4461.3 4471.7 4486.0 4494.4 5640.6 5872.9 6392.1 6798.6 6993.8 6116.8 6701.0 6715.6 6753.4 6806.4 6483.4 6686.5 6694.9 6709.9 6712.2 5140.7 5693.3 6521.7 6586.4 6604.5 6297.6 6475.2 6688.9 6703.7 6741.0 6182.5 6223.8 6293.4 6516.2 6549.5 05:12:02 INFO - PID 1930 | 05:12:02 INFO - PID 1930 | [#5] yui.html Cycles:180 Average:19584.17 Median:41851.27 stddev:28690.74 (68.6%) stddev-sans-first:28736.00 05:12:02 INFO - PID 1930 | Values: 650.5 689.2 735.2 741.9 760.5 14928.9 15509.0 15528.0 15542.5 15548.5 15056.8 15126.4 15275.8 15281.9 15289.4 937.3 945.1 947.6 949.3 949.6 983.4 995.7 1030.2 1031.6 1037.3 951.3 1057.8 1065.2 1069.2 1073.5 867.9 1057.8 1065.3 1066.9 1067.8 783.4 792.1 792.2 793.4 793.9 16423.8 16768.6 16898.7 16985.8 17012.5 14212.8 14845.0 14890.6 15010.1 15188.0 10840.4 11528.9 11805.5 11815.6 12108.8 2701.6 2707.7 3060.3 3074.1 3188.7 88908.0 95453.6 108148.5 117806.8 123715.0 9494.0 11496.2 11539.8 11588.2 12143.2 25234.0 25505.5 25564.6 25626.7 25796.0 7827.7 7867.4 7901.7 7988.6 8090.1 4134.5 4215.6 4219.8 4230.7 4336.1 4144.4 4213.9 4240.3 4255.7 4262.4 798.7 801.3 802.3 803.4 812.8 562.5 573.6 585.9 596.0 607.2 9054.4 9689.7 9993.5 10092.3 10122.8 544.1 568.5 569.5 583.9 592.8 4471.3 4660.3 4666.7 4674.2 4694.5 102279.5 103080.0 103236.0 103398.5 105494.0 86777.6 87986.1 88131.6 88602.0 90643.5 57667.0 72277.0 78382.0 80983.0 82390.6 9311.9 9339.7 9370.9 9438.9 9544.1 39855.6 40369.0 41447.6 41770.0 41932.6 52186.7 52794.0 52973.7 53335.7 53643.5 11375.7 11532.5 11662.4 12061.8 12299.4 12136.3 12142.3 12287.9 12374.8 12438.9 9631.9 11649.4 11978.0 12093.8 12148.2 11406.7 11602.7 11731.6 11989.8 12134.2 11212.4 11501.7 11534.9 11871.0 12199.3 8387.4 8561.7 8573.6 8666.7 8704.9 7852.4 8394.0 8861.8 9113.5 10687.0 05:12:02 INFO - PID 1930 | -------- Summary: end -------- 05:12:02 INFO - PID 1930 | 05:12:02 INFO - TEST-INFO | 1930: exit 0 05:12:02 INFO - TEST-OK | dromaeo_css | took 1116740ms 05:12:02 INFO - TEST-START | kraken 05:12:02 INFO - operating with platform_type : mac_ 05:12:02 INFO - Initialising browser for kraken test... 05:12:02 INFO - TEST-INFO | started process 1938 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpriwTKM/profile http://localhost:49527/getInfo.html) 05:12:05 INFO - PID 1938 | 2017-04-04 05:12:05.262 plugin-container[1939:15063] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 05:12:05 INFO - PID 1938 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:12:05 INFO - PID 1938 | 2017-04-04 05:12:05.265 plugin-container[1939:15063] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 05:12:05 INFO - PID 1938 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:12:05 INFO - PID 1938 | 2017-04-04 05:12:05.265 plugin-container[1939:15063] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:12:05 INFO - PID 1938 | __metrics Screen width/height:1600/1200 05:12:05 INFO - PID 1938 | colorDepth:24 05:12:05 INFO - PID 1938 | Browser inner width/height: 1024/678 05:12:05 INFO - PID 1938 | __metrics 05:12:05 ERROR - PID 1938 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 05:12:06 INFO - TEST-INFO | 1938: exit 0 05:12:06 INFO - Browser initialized. 05:12:06 INFO - Running cycle 1/1 for kraken test... 05:12:06 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpriwTKM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:08 INFO - PID 1940 | 2017-04-04 05:12:08.859 plugin-container[1941:15193] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x914b, name = 'com.apple.tsm.portname' 05:12:08 INFO - PID 1940 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:12:08 INFO - PID 1940 | 2017-04-04 05:12:08.860 plugin-container[1941:15193] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0f, name = 'com.apple.CFPasteboardClient' 05:12:08 INFO - PID 1940 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:12:08 INFO - PID 1940 | 2017-04-04 05:12:08.860 plugin-container[1941:15193] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:12:18 INFO - PID 1940 | RSS: Main: 242561024 05:12:18 INFO - PID 1940 | 05:12:21 INFO - PID 1940 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49527/tests/kraken/driver.html?testName=audio-beat-detection) 05:12:22 INFO - PID 1940 | RSS: Main: 252854272 05:12:22 INFO - PID 1940 | 05:12:24 INFO - PID 1940 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49527/tests/kraken/driver.html?testName=audio-dft) 05:12:25 INFO - PID 1940 | RSS: Main: 260382720 05:12:25 INFO - PID 1940 | 05:12:29 INFO - PID 1940 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49527/tests/kraken/driver.html?testName=audio-fft) 05:12:30 INFO - PID 1940 | RSS: Main: 257568768 05:12:30 INFO - PID 1940 | 05:12:32 INFO - PID 1940 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49527/tests/kraken/driver.html?testName=audio-oscillator) 05:12:32 INFO - PID 1940 | RSS: Main: 258301952 05:12:32 INFO - PID 1940 | 05:12:34 INFO - PID 1940 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49527/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:12:35 INFO - PID 1940 | RSS: Main: 258674688 05:12:35 INFO - PID 1940 | 05:12:38 INFO - PID 1940 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49527/tests/kraken/driver.html?testName=imaging-darkroom) 05:12:39 INFO - PID 1940 | RSS: Main: 265637888 05:12:39 INFO - PID 1940 | 05:12:42 INFO - PID 1940 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49527/tests/kraken/driver.html?testName=imaging-desaturate) 05:12:42 INFO - PID 1940 | RSS: Main: 266035200 05:12:42 INFO - PID 1940 | 05:12:46 INFO - PID 1940 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49527/tests/kraken/driver.html?testName=json-parse-financial) 05:12:47 INFO - PID 1940 | RSS: Main: 265920512 05:12:47 INFO - PID 1940 | 05:12:48 INFO - PID 1940 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49527/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:12:49 INFO - PID 1940 | RSS: Main: 265318400 05:12:49 INFO - PID 1940 | 05:12:50 INFO - PID 1940 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:12:51 INFO - PID 1940 | RSS: Main: 265199616 05:12:51 INFO - PID 1940 | 05:12:54 INFO - PID 1940 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:12:54 INFO - PID 1940 | RSS: Main: 265293824 05:12:54 INFO - PID 1940 | 05:12:57 INFO - PID 1940 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:12:58 INFO - PID 1940 | RSS: Main: 265883648 05:12:58 INFO - PID 1940 | 05:13:01 INFO - PID 1940 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:02 INFO - PID 1940 | RSS: Main: 262905856 05:13:02 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49527/tests/kraken/driver.html?testName=ai-astar) 05:13:04 INFO - PID 1940 | RSS: Main: 266293248 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | __start_tp_report 05:13:04 INFO - PID 1940 | _x_x_mozilla_page_load 05:13:04 INFO - PID 1940 | _x_x_mozilla_page_load_details 05:13:04 INFO - PID 1940 | |i|pagename|runs| 05:13:04 INFO - PID 1940 | |0;ai-astar;108;121;122;123;124;124;121;143;121;123 05:13:04 INFO - PID 1940 | |1;audio-beat-detection;153;115;116;156;118;136;121;128;141;101 05:13:04 INFO - PID 1940 | |2;audio-dft;216;223;238;253;322;306;213;261;288;212 05:13:04 INFO - PID 1940 | |3;audio-fft;116;85;60;83;60;62;66;62;76;61 05:13:04 INFO - PID 1940 | |4;audio-oscillator;87;71;87;72;74;72;82;71;73;85 05:13:04 INFO - PID 1940 | |5;imaging-gaussian-blur;140;91;92;127;91;91;93;105;92;93 05:13:04 INFO - PID 1940 | |6;imaging-darkroom;101;101;125;101;161;162;99;104;100;100 05:13:04 INFO - PID 1940 | |7;imaging-desaturate;103;103;122;98;85;152;163;117;98;160 05:13:04 INFO - PID 1940 | |8;json-parse-financial;51;51;51;52;53;53;53;52;52;53 05:13:04 INFO - PID 1940 | |9;json-stringify-tinderbox;60;61;65;71;64;65;62;52;58;68 05:13:04 INFO - PID 1940 | |10;stanford-crypto-aes;79;76;105;80;116;117;112;88;117;80 05:13:04 INFO - PID 1940 | |11;stanford-crypto-ccm;148;168;144;148;147;158;156;164;221;175 05:13:04 INFO - PID 1940 | |12;stanford-crypto-pbkdf2;213;192;249;257;232;198;199;194;198;196 05:13:04 INFO - PID 1940 | |13;stanford-crypto-sha256-iterative;72;67;71;70;71;74;72;69;70;73 05:13:04 INFO - PID 1940 | __end_tp_report 05:13:04 INFO - PID 1940 | __start_cc_report 05:13:04 INFO - PID 1940 | _x_x_mozilla_cycle_collect,1061 05:13:04 INFO - PID 1940 | __end_cc_report 05:13:04 INFO - PID 1940 | __startTimestamp1491307984644__endTimestamp 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | ------- Summary: start ------- 05:13:04 INFO - PID 1940 | Number of tests: 14 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | [#0] ai-astar Cycles:10 Average:123.00 Median:123.00 stddev:8.43 (6.9%) stddev-sans-first:6.98 05:13:04 INFO - PID 1940 | Values: 108.0 121.0 122.0 123.0 124.0 124.0 121.0 143.0 121.0 123.0 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:132.00 stddev:17.73 (13.4%) stddev-sans-first:16.45 05:13:04 INFO - PID 1940 | Values: 153.0 115.0 116.0 156.0 118.0 136.0 121.0 128.0 141.0 101.0 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | [#2] audio-dft Cycles:10 Average:253.20 Median:257.00 stddev:40.32 (15.7%) stddev-sans-first:40.46 05:13:04 INFO - PID 1940 | Values: 216.0 223.0 238.0 253.0 322.0 306.0 213.0 261.0 288.0 212.0 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | [#3] audio-fft Cycles:10 Average:73.10 Median:64.00 stddev:17.87 (27.9%) stddev-sans-first:10.19 05:13:04 INFO - PID 1940 | Values: 116.0 85.0 60.0 83.0 60.0 62.0 66.0 62.0 76.0 61.0 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:78.00 stddev:6.95 (8.9%) stddev-sans-first:6.44 05:13:04 INFO - PID 1940 | Values: 87.0 71.0 87.0 72.0 74.0 72.0 82.0 71.0 73.0 85.0 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | [#5] imaging-gaussian-blur Cycles:10 Average:101.50 Median:91.50 stddev:17.64 (19.3%) stddev-sans-first:12.01 05:13:04 INFO - PID 1940 | Values: 140.0 91.0 92.0 127.0 91.0 91.0 93.0 105.0 92.0 93.0 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | [#6] imaging-darkroom Cycles:10 Average:115.40 Median:114.50 stddev:25.47 (22.2%) stddev-sans-first:26.48 05:13:04 INFO - PID 1940 | Values: 101.0 101.0 125.0 101.0 161.0 162.0 99.0 104.0 100.0 100.0 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | [#7] imaging-desaturate Cycles:10 Average:120.10 Median:161.50 stddev:28.40 (17.6%) stddev-sans-first:29.44 05:13:04 INFO - PID 1940 | Values: 103.0 103.0 122.0 98.0 85.0 152.0 163.0 117.0 98.0 160.0 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.50 stddev:0.88 (1.7%) stddev-sans-first:0.83 05:13:04 INFO - PID 1940 | Values: 51.0 51.0 51.0 52.0 53.0 53.0 53.0 52.0 52.0 53.0 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:64.50 stddev:5.34 (8.3%) stddev-sans-first:5.58 05:13:04 INFO - PID 1940 | Values: 60.0 61.0 65.0 71.0 64.0 65.0 62.0 52.0 58.0 68.0 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | [#10] stanford-crypto-aes Cycles:10 Average:97.00 Median:77.50 stddev:17.87 (23.1%) stddev-sans-first:17.73 05:13:04 INFO - PID 1940 | Values: 79.0 76.0 105.0 80.0 116.0 117.0 112.0 88.0 117.0 80.0 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | [#11] stanford-crypto-ccm Cycles:10 Average:162.90 Median:161.00 stddev:22.79 (14.2%) stddev-sans-first:23.53 05:13:04 INFO - PID 1940 | Values: 148.0 168.0 144.0 148.0 147.0 158.0 156.0 164.0 221.0 175.0 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:212.80 Median:206.00 stddev:24.33 (11.8%) stddev-sans-first:25.81 05:13:04 INFO - PID 1940 | Values: 213.0 192.0 249.0 257.0 232.0 198.0 199.0 194.0 198.0 196.0 05:13:04 INFO - PID 1940 | 05:13:04 INFO - PID 1940 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.50 stddev:2.02 (2.8%) stddev-sans-first:2.11 05:13:04 INFO - PID 1940 | Values: 72.0 67.0 71.0 70.0 71.0 74.0 72.0 69.0 70.0 73.0 05:13:04 INFO - PID 1940 | -------- Summary: end -------- 05:13:04 INFO - PID 1940 | 05:13:05 INFO - TEST-INFO | 1940: exit 0 05:13:05 INFO - TEST-OK | kraken | took 62902ms 05:13:05 INFO - SUITE-END | took 1179s 05:13:05 INFO - Completed test suite (00:19:39) 05:13:05 INFO - javascript benchmark 05:13:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7698.683657495041, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3583.337082639711, 3592.3174596826616, 3624.1302087499007, 3650.0144960860566, 3657.56109266888, 6153.0, 6261.311255761862, 6272.278687950881, 6282.0576913463, 6310.17967664203, 6229.408206220402, 6230.657313847737, 6245.9063114053215, 6284.151639528663, 6336.9683151584295, 5546.27898373213, 5557.944420555783, 5584.972075139629, 5608.719564021803, 5661.037623603997, 5479.890402191953, 5570.220169176318, 5629.9866024115645, 5656.349519805213, 5659.745311460994, 5439.456054394568, 5525.143602741581, 5565.693886836222, 5602.635828671123, 5613.7193140342815, 5497.642653227527, 5540.307461567304, 5554.944450555483, 5575.107982722745, 5610.18652295419, 5474.507294343488, 5500.1749737539285, 5522.3649280332875, 5522.723863806794, 5538.113901775737, 5165.786040280531, 6162.291336496315, 6205.7517699291975, 6273.498120150377, 6305.0857625644485, 6741.325867413219, 6840.726370945156, 6841.452683785285, 6853.965730171317, 6868.381845633867, 6927.238003819576, 6945.930540694579, 6948.166220053576, 6971.163460384786, 6977.825554361131, 6177.505799536027, 6381.7766378177, 6403.903941440882, 6404.839879003016, 6429.035644653246, 6775.1869775626255, 6954.130733658293, 6987.545809522365, 7012.5792452453015, 7039.260877607778, 6408.775692850728, 6490.286068532458, 6504.837379065561, 6650.235222949423, 6729.22613899398, 6784.59292442455, 6804.319568043156, 6854.588724676535, 6886.724531018804, 6923.134608173978, 6837.589744615339, 6841.657917104125, 6845.794626161123, 6848.315168483112, 6857.451403887677, 6430.260520040161, 6584.440322572635, 6602.933970660232, 6716.496262780311, 6764.627945462948, 5398.028354896078, 5422.322209723785, 5422.620416570881, 5423.078076726966, 5445.646033007921, 4816.084943860656, 4817.253325734517, 4821.951780482221, 4848.684835485753, 4866.513348665105, 6244.75020999164, 6270.15352927349, 6287.339829317856, 6428.678566071678, 6446.129772480749, 5712.885742285131, 6928.549644273106, 6970.546914450544, 6973.65131743421, 6993.230744618088, 6095.2685677718955, 6362.713677884506, 6383.616982980943, 6388.872222555523, 6423.421892029646, 5857.0, 5956.702164891738, 6053.969730151409, 6152.046432802833, 6166.383361663888, 6804.523683342218, 6967.303269672992, 7026.508144429841, 7062.788116356517, 7081.822954425975, 6948.409385202112, 6964.860702785814, 6969.128858892638, 6973.721051157897, 6995.125609298634, 5872.970635146968, 6952.339527744856, 7044.753433629799, 7085.078939737801, 7096.0, 6424.51816113784, 6450.9354906450335, 6543.509236807354, 6678.632675202911, 6735.158105236846, 6880.58716477013, 6907.861842763016, 6933.994570787107, 6943.722251110101, 6954.3045695430055, 5409.350877894678, 6301.212348456443, 6440.903386449113, 6602.537822352581, 6643.069970204272, 4970.577500912463, 6389.233292004803, 6518.608883467007, 6574.27682954865, 6640.236372817188, 6277.623342599459, 6345.428911397997, 6383.904241436475, 6465.094886715958, 6486.513511486563, 6480.222373315232, 6533.640649764308, 6540.934590654033, 6568.47452203813, 6618.602883826793, 5795.623284486495, 6133.723982420713, 6446.548741588043, 6461.806145815445, 6478.1578394808375], "value": 6181.938136109134, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.1838161838161, 839.9244068033876, 1116.2799994003867, 1180.5690922813176, 1281.6923938254822, 38178.80910595447, 38751.41872871906, 38775.03062423437, 38812.83561493153, 38853.41719874197, 38169.0, 38352.42471362925, 38417.231655366944, 38462.23075538487, 38526.422103668396, 7938.126806051344, 8472.576371181416, 8635.784105397352, 8678.479291242546, 8685.522296273703, 8569.400141990063, 8672.219500244977, 8675.219230269275, 8698.695545655872, 8749.256313213353, 8574.271186949085, 8622.698205562807, 8683.782905427352, 8687.782805429852, 8702.347323950697, 8598.269147122503, 8608.913910860874, 8651.65393384264, 8660.437071590326, 8662.956685216597, 8520.19058189471, 8601.827963440759, 8614.224719775188, 8625.611847466878, 8648.30813534922, 38267.0, 38447.23105537874, 38472.038199045244, 38518.22963540714, 38594.80702596497, 3020.416701948032, 3024.894128705507, 3032.8331941743195, 3044.969550304491, 3050.740687041604, 26990.0, 27507.0, 27940.882364705387, 28095.85952070247, 28379.432411351863, 2774.4728501584636, 2807.7192280771965, 2829.3209629688727, 2829.9292517687018, 2837.333226691726, 311962.0, 316390.0, 317541.0, 317587.41206294054, 317877.0, 38903.83288501349, 39728.20543589112, 47634.52365476301, 48824.0, 48844.02311953741, 51157.7442112787, 51332.71668208325, 51362.0, 51371.48628513742, 51400.48599514032, 12781.744365112645, 12877.0, 12928.224306541637, 12950.0, 12951.805722914163, 10233.1301839343, 10243.385396876061, 10244.48777561119, 10262.384256944608, 10502.264841461178, 11219.943900280447, 13778.724425511433, 13834.515791947233, 13841.031127821157, 13970.650733731738, 5946.791862284799, 5958.582899197015, 5979.701014949235, 5987.311459182162, 5993.940060599338, 794.7933537280348, 808.2523665609287, 946.8721722567503, 982.2289502740457, 1011.5195282241024, 19321.806781932282, 22629.660555091687, 23992.0, 24069.759302407103, 24139.879300603385, 943.8867335919733, 1065.872095348563, 1075.9569617215225, 1108.152263518409, 1120.4957769003981, 12125.0, 12294.0, 12336.938315308545, 12347.259164450163, 12372.0, 481554.0, 485453.0, 485986.0, 486108.1389186063, 488960.0, 49552.26567070135, 53277.0, 53329.733351332994, 53596.92806143855, 53769.462305376444, 1296.6045356166271, 1335.4457899971596, 1429.785532170162, 1438.8417324054028, 1488.977665335021, 18333.175007124977, 23049.96275167655, 23327.650085248395, 23689.40776480602, 23765.405864852826, 37815.810920945216, 37824.43263351107, 37943.05142371463, 38009.0, 38083.238335232585, 413213.0, 417591.91204043786, 418415.90792045847, 418489.0, 419709.9159546254, 33725.98822035343, 33950.49074263938, 34693.65306346904, 35502.0, 35507.38404007463, 39467.605323946394, 39927.80036099801, 43834.56165438305, 44062.0, 44079.11841763211, 23961.400964976016, 28913.132606021853, 29519.409611808074, 29990.850045750503, 30735.0, 29887.701122988492, 29893.95371161999, 30347.39305213839, 30420.391592168475, 30881.536776947913, 36065.459018115274, 36166.27667446689, 36679.89960301195, 36744.0, 36761.0, 28995.7100428993, 29699.554506681983, 30603.0, 31181.376372472878, 31621.051368458982, 22040.448988774766, 22325.665115022963, 24314.756852431958, 24410.633840492763, 24878.0], "value": 17527.397294001446, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.98905032849024, 420.68377960790735, 429.7271232767193, 442.7586965104018, 446.1233675826999, 20268.797312026858, 21854.235101771443, 22531.324060278177, 22623.321300360974, 22738.65892011619, 22590.54818903621, 22816.20143294985, 23151.768482315212, 23427.531449371003, 23667.0, 6211.440970312659, 6248.625082495042, 6394.296627370985, 6396.936030639704, 6406.455451286646, 6049.697515124249, 6281.811545653638, 6289.622622642633, 6295.055741638745, 6297.496200303987, 6018.488428483584, 6204.0, 6228.750849966019, 6264.812055638338, 6278.183836101323, 6232.781852635158, 6273.153124328226, 6276.905846412307, 6277.811665649992, 6291.937080629204, 5360.3299587551555, 5549.278593782823, 5571.387147413781, 5623.100303951348, 5632.74652640628, 26974.865125674245, 27218.183454496397, 27296.727032729617, 27302.45395092107, 27638.723612763817, 2009.5076706206926, 2017.4149496646103, 2021.848361372903, 2024.2409096588779, 2044.9795502044938, 15791.0, 16546.917265413715, 16655.583610409714, 16684.249208785634, 17391.826081739146, 1813.727940808876, 1883.5950270691867, 1887.6130393269348, 1929.218666440094, 1955.9706604400944, 135194.0, 138013.30993345068, 146533.0, 154255.0, 177363.11318443454, 10545.894541054491, 12528.81206781899, 12680.175788573713, 12745.17156384832, 12797.744045119045, 16116.194190290438, 16270.593235168979, 16334.75497867533, 16352.427665031666, 16387.918060409622, 7098.645067746592, 7494.85010299791, 8214.712485062993, 8501.107383724744, 8541.914580854236, 6367.872642547123, 7455.179930207672, 7733.883991740128, 7913.960430197927, 7934.127246002935, 6475.384838440341, 7724.459287849909, 7810.492317999312, 7863.056433227935, 7864.960675196702, 2221.933471933481, 2223.633100538393, 2223.8332125090683, 2227.098025299756, 2371.584972629783, 873.8470767615769, 908.9910199678352, 925.5326060339486, 962.41292811385, 974.4786539201635, 17198.968061916326, 20096.799032009785, 20114.798852011587, 21098.683519747217, 21234.150633974466, 955.2071780422233, 955.5986485676033, 984.8670429491926, 986.1420564109128, 993.513178542509, 10637.872425514928, 11030.558777648805, 11084.778304433867, 11123.221374503708, 11147.554097835995, 684748.0, 685676.0, 687241.0, 698780.0, 713227.0, 147385.0, 150917.49082509254, 160499.0, 167487.0, 168401.0, 1145.616218566773, 1195.8086706126978, 1226.7485165541043, 1228.9385530723428, 1230.2864338683542, 19309.51726206856, 20069.49826254297, 20200.0, 20772.272970445963, 21469.03389347452, 58551.70724146352, 59225.0, 61949.76100477875, 64008.0, 64370.0, 68698.0, 84604.57697711472, 86700.5664971671, 87018.129818701, 90905.54547227222, 7482.588457634883, 8610.05289418151, 8630.180132887366, 9053.547322633975, 9145.63417463294, 13682.0, 14346.85225181962, 14500.564983050524, 15019.774703379677, 15103.39586416575, 11879.58421455245, 11959.461824217757, 12078.154529182873, 12145.939270303592, 12272.570460033856, 9466.621335146518, 11500.137489688474, 11631.243969141979, 11657.533698652298, 12036.097292702907, 10691.30506517074, 12095.75808483843, 12196.207246528948, 12372.0, 12528.937355313165, 7353.485256032241, 7523.473356865185, 7608.657610407656, 8585.098564650621, 8952.641894324153, 9820.361676491006, 11907.047436205256, 11908.345041022827, 12155.149139560146, 12200.14598978063], "value": 10461.527289856367, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.6985678222395, 1394.9790753138702, 1443.844924060751, 1454.3600815641123, 1473.0278016509103, 10811.83782243266, 11054.336739795597, 11088.501017454213, 11231.32612043278, 11242.156838237124, 11085.445727713603, 11196.776064478727, 11218.66344009679, 11257.043151332125, 11330.71673208168, 2114.9365519034377, 2446.877656117196, 2485.3041148478455, 2485.639582260571, 2488.22864911877, 2376.251480783548, 2432.1487479382254, 2453.595156799126, 2475.950480990379, 2476.616124500705, 2401.987990060047, 2458.754124587545, 2465.827392082555, 2465.852048877064, 2468.6790717206736, 2364.538914911593, 2418.9516209675794, 2435.5981263091658, 2436.4030812450974, 2446.021591363451, 2337.368910394201, 2419.1774796569075, 2435.8173137014796, 2437.6099824028247, 2438.085717855804, 10983.450827458675, 10997.0, 11062.115030797517, 11077.833832492439, 11080.501377438035, 6293.559450838443, 6522.1521202243875, 6525.738970441176, 6531.836704082436, 6535.934640653628, 4014.8996275093355, 4047.5952404759582, 4104.117614712851, 4133.483314585676, 4142.109446468993, 1031.5512751952924, 1175.7589694112687, 1184.2894263441951, 1220.5422966387605, 1227.098082909061, 14195.361208745631, 14427.711445771025, 15210.467633632881, 15294.617634559114, 15436.922815385964, 5241.109011468059, 5277.155655095243, 5410.269613602192, 5458.836234912959, 5463.699496527729, 11455.713607159887, 11497.022753065916, 11509.76980460386, 11518.481668324945, 11527.020203282815, 6361.332060133712, 6371.0, 6376.585521941059, 6382.489400847921, 6389.648569328639, 5873.2658417697785, 5903.616264942765, 5939.732712027969, 6001.339852616209, 6068.362821903725, 3630.41913293877, 4136.193442278787, 4222.704410691284, 4262.360645903077, 4367.30123180296, 1278.111712359901, 1284.865089165624, 1285.6914340558199, 1300.9284489353176, 1301.6810881334134, 755.9848803023908, 762.2263402646319, 776.8679324514846, 778.7157687444042, 803.2447513565239, 5961.254843144607, 6040.36576159497, 6070.848228794227, 6132.468920599547, 6149.3235744068115, 584.1296468262343, 590.9261342332209, 887.6582515731361, 894.9149830766066, 917.1378903830378, 3920.0, 3976.8011599420493, 4035.6569691575955, 4190.622843943998, 4200.831966721358, 13041.0, 13995.950303727057, 14134.50529231472, 14151.575452736435, 14160.433582656784, 12060.21608595456, 13457.932710336581, 13725.588232353046, 14098.154110753389, 14290.928545357207, 9021.639134434548, 9893.653722119836, 10063.949680251551, 10155.238357123097, 10178.287519873686, 5827.213326200908, 6607.141071660653, 6726.730930762715, 6792.524523283323, 6832.692528836114, 12294.0, 12331.075169362155, 12373.876261237632, 12451.688707782378, 12720.87279127197, 12676.936615316865, 12835.807462888251, 12922.224666520038, 12959.092863499842, 12994.480220791062, 9044.502552359683, 9271.907280927104, 9294.442333460014, 9336.673216437392, 9367.953160234156, 8748.956255218684, 9969.45168015737, 10264.281500294908, 10264.58941642326, 10371.066604005675, 8760.51817150063, 8805.471671699463, 8813.823723525622, 8814.691485797966, 8865.512396818236, 8576.699815506427, 8630.913690863263, 8697.999730030875, 8702.0, 8708.825823483621, 7775.222477752406, 7795.791652293903, 7796.88304675419, 7833.315837095052, 7883.605819708877, 5777.335606405317, 5795.623284486495, 5925.733341999534, 5985.850353741192, 6014.338422773404, 4803.735794531334, 5894.70526473666, 6045.0, 6058.212432383762, 6104.816855494342], "value": 5177.976544619486, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.2096974596191, 395.5767328958016, 397.81103975611586, 399.73018212706427, 408.18566958916966, 6436.131122298489, 6447.1618689570405, 6454.483196448842, 6470.708818103185, 6493.707783149758, 5585.413531579186, 6129.873764380165, 6180.443760061594, 6216.937830621692, 6310.49516038717, 3787.791671458069, 3873.438351439054, 3874.8643797467093, 4336.891577710567, 4718.339432479455, 3962.9207415851665, 4074.577355021781, 4674.672772905898, 4725.535084123915, 4748.691335063209, 4380.414201763949, 4607.861764147081, 4672.883177920545, 4717.561143851124, 4720.409948756405, 4416.69083164177, 4674.485806561275, 4684.601808846252, 4685.8594242172785, 4694.835680751157, 3706.0549559862334, 3795.449659799341, 3961.98019009906, 4041.989502624344, 4177.665786737054, 5199.6360254782185, 5865.853353666193, 6081.604695694766, 6113.633182009094, 6151.846203844895, 5537.556995440355, 5542.528885044776, 5546.334439867202, 5546.389897111315, 5553.7778488860395, 6339.683015849235, 6342.936570634327, 6710.261871194165, 6730.41835168735, 6740.932590674129, 3612.837422316002, 3653.3789255826573, 4282.143571285756, 4348.21732088224, 4379.75911324877, 6791.660416979132, 6999.475039372017, 7081.787546373617, 7092.751753688596, 7158.463115266376, 4060.959390406058, 4062.410950412174, 4188.806190235769, 4216.831326746896, 4424.867253982386, 4058.939115913264, 4491.618212451978, 4510.548945105464, 4521.4054826413085, 4524.6832721709825, 5014.2979982802435, 5292.5501332387175, 5344.706041167696, 5350.170723537858, 5362.195670649356, 6565.376289252514, 6617.66911654425, 6624.436922861514, 6653.900191497131, 6682.231543372477, 1523.725729368702, 1543.8764898808067, 1544.4980381376097, 1545.7835902973593, 1548.3729089718681, 1005.9798804024025, 1030.7268573827942, 1110.6667999600088, 1158.467105131632, 1181.6986668399675, 5397.514223719805, 5513.476219759196, 6081.027035674271, 6209.5963762356205, 6256.562040657111, 6732.225794033749, 6845.726170953206, 6880.965595171992, 6922.861542769117, 6950.930490695028, 6167.444929956236, 6170.352113028157, 6231.657258850716, 6255.530835187288, 6286.277078136073, 3526.347625689256, 3582.390993531106, 3589.8743543975834, 3600.2979419013564, 3620.2035552179004, 5836.686745482232, 6819.522043757719, 6978.581285122909, 7020.403265722369, 7025.473089518205, 5568.805091821767, 6959.269276725972, 7063.788086357417, 7085.937109433627, 7121.786346409616, 6730.697118629673, 6990.196127445409, 7053.470989675898, 7069.611171385521, 7100.964495177491, 5499.4225606310765, 6792.592444453348, 6873.690683919136, 6898.413634841095, 6923.0, 5871.73577189036, 6243.282022567463, 6474.125992990886, 6699.698513566804, 6737.0, 6002.399760023963, 6256.0, 6752.662366881735, 6871.759488417882, 7144.85710285781, 4184.539700632989, 4461.2824062735435, 4471.664625153192, 4486.0, 4494.415725955605, 5640.576956728344, 5872.854793315262, 6392.073149393219, 6798.592084474947, 6993.7552185675295, 6116.847078823065, 6701.041229490044, 6715.630640314829, 6753.358430949052, 6806.42145417645, 6483.4164925156965, 6686.465082793462, 6694.899576506454, 6709.913439817738, 6712.160979877515, 5140.717260550706, 5693.316801983623, 6521.739130434729, 6586.37429444202, 6604.5046621502615, 6297.590656607306, 6475.222973243241, 6688.8963321053425, 6703.664816759045, 6741.0, 6182.485291103709, 6223.782167624111, 6293.4335909766505, 6516.185476815398, 6549.541532092708], "value": 4826.792221576583, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.5088658063162, 689.1764341611773, 735.1766022055295, 741.8812989921614, 760.535759614954, 14928.850711492882, 15508.991915525483, 15528.0, 15542.533723988285, 15548.455804046875, 15056.774148387756, 15126.394944202246, 15275.847241527608, 15281.92359038206, 15289.388424463008, 937.2923442800676, 945.0832692288469, 947.6020071569957, 949.3070058857038, 949.5679465843025, 983.4443539400216, 995.7361299255703, 1030.1604192583059, 1031.5770534081028, 1037.305005646219, 951.286535098676, 1057.7937302226069, 1065.169168048923, 1069.1927594666056, 1073.50618715391, 867.8741582470537, 1057.783154453339, 1065.2915810985685, 1066.9466526673634, 1067.765091679829, 783.4202690009351, 792.1405275276333, 792.1919641965163, 793.4287313134533, 793.8610743119931, 16423.753643695352, 16768.58078548046, 16898.74651880223, 16985.83014169855, 17012.48962531126, 14212.786808197885, 14845.0, 14890.553283401516, 15010.099394036393, 15188.01277916932, 10840.403777792219, 11528.942355288169, 11805.468753906094, 11815.645530634094, 12108.81836772449, 2701.554243549812, 2707.7021527631946, 3060.342890246157, 3074.0777766669908, 3188.6811318867926, 88908.0, 95453.5681964771, 108148.45925770399, 117806.82193178045, 123715.0, 9494.0, 11496.195266331277, 11539.76920461586, 11588.199182467491, 12143.210691305037, 25234.0, 25505.48989020246, 25564.616530752053, 25626.74373256281, 25795.96816127334, 7827.686892524349, 7867.449278550561, 7901.683932642745, 7988.600569971478, 8090.110087890327, 4134.503859536875, 4215.641670457984, 4219.767912764827, 4230.725002874803, 4336.089421221579, 4144.357624568197, 4213.873583792491, 4240.321548552279, 4255.702100852911, 4262.424572682648, 798.7164556582329, 801.310872649521, 802.3060053054182, 803.3533005930283, 812.8333691593209, 562.4572287742349, 573.6271423574626, 585.9355470898198, 595.992772214964, 607.168179593959, 9054.366194366463, 9689.691891594686, 9993.500324983721, 10092.293539452316, 10122.848157277647, 544.0913674164156, 568.4883604755753, 569.4789267819981, 583.886142202275, 592.7865968251426, 4471.329300604935, 4660.300954856731, 4666.719996800203, 4674.182018146811, 4694.530546945346, 102279.46580801294, 103080.0, 103236.0, 103398.48300758448, 105494.0, 86777.56611216904, 87986.12013879907, 88131.55934220288, 88602.0, 90643.54678226566, 57667.0, 72277.0, 78382.0, 80983.0, 82390.58804706058, 9311.906880931105, 9339.673111441067, 9370.906290937277, 9438.858417123885, 9544.141027307576, 39855.60144398635, 40369.0, 41447.58552414437, 41769.95575110525, 41932.58067419287, 52186.73906630443, 52794.0, 52973.735131324094, 53335.66660833355, 53643.46356536541, 11375.658730238107, 11532.51197469279, 11662.416879155839, 12061.819072714092, 12299.44652490658, 12136.33250171249, 12142.271463712206, 12287.938560307499, 12374.81437778416, 12438.937805310916, 9631.855522167032, 11649.359285239054, 11978.041756659271, 12093.75812483763, 12148.21036632616, 11406.714832129263, 11602.709932251424, 11731.589394371156, 11989.76020479568, 12134.211276267368, 11212.439378030902, 11501.712457188638, 11534.94232528832, 11871.0, 12199.329036903055, 8387.412881098264, 8561.700340488052, 8573.614187361709, 8666.696665616673, 8704.91295087041, 7852.411069169721, 8394.0, 8861.822763544822, 9113.541833306905, 10687.0], "value": 7348.7246157382115, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1650.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 121.0, 122.0, 123.0, 124.0, 124.0, 121.0, 143.0, 121.0, 123.0], "value": 123.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 115.0, 116.0, 156.0, 118.0, 136.0, 121.0, 128.0, 141.0, 101.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 223.0, 238.0, 253.0, 322.0, 306.0, 213.0, 261.0, 288.0, 212.0], "value": 253.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 85.0, 60.0, 83.0, 60.0, 62.0, 66.0, 62.0, 76.0, 61.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 87.0, 72.0, 74.0, 72.0, 82.0, 71.0, 73.0, 85.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 91.0, 92.0, 127.0, 91.0, 91.0, 93.0, 105.0, 92.0, 93.0], "value": 101.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 101.0, 125.0, 101.0, 161.0, 162.0, 99.0, 104.0, 100.0, 100.0], "value": 115.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 103.0, 122.0, 98.0, 85.0, 152.0, 163.0, 117.0, 98.0, 160.0], "value": 120.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 52.0, 53.0, 53.0, 53.0, 52.0, 52.0, 53.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 65.0, 71.0, 64.0, 65.0, 62.0, 52.0, 58.0, 68.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 105.0, 80.0, 116.0, 117.0, 112.0, 88.0, 117.0, 80.0], "value": 97.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 168.0, 144.0, 148.0, 147.0, 158.0, 156.0, 164.0, 221.0, 175.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [213.0, 192.0, 249.0, 257.0, 232.0, 198.0, 199.0, 194.0, 198.0, 196.0], "value": 212.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 71.0, 70.0, 71.0, 74.0, 72.0, 69.0, 70.0, 73.0], "value": 70.9, "unit": "score"}]}]} 05:13:05 INFO - Return code: 0 05:13:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:13:05 ERROR - # TBPL SUCCESS # 05:13:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:13:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:13:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:13:05 INFO - 2017-04-04 05:13:05.976 screenresolution[1945:15590] starting screenresolution argv=screenresolution get 05:13:05 INFO - 2017-04-04 05:13:05.979 screenresolution[1945:15590] Display 0: 1600x1200x32@60 05:13:05 INFO - 2017-04-04 05:13:05.985 screenresolution[1946:15592] starting screenresolution argv=screenresolution list 05:13:05 INFO - Available Modes on Display 0 05:13:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:13:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:13:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:13:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:13:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:13:06 INFO - Intel Iris: 05:13:06 INFO - Chipset Model: Intel Iris 05:13:06 INFO - Type: GPU 05:13:06 INFO - Bus: Built-In 05:13:06 INFO - VRAM (Dynamic, Max): 1536 MB 05:13:06 INFO - Vendor: Intel (0x8086) 05:13:06 INFO - Device ID: 0x0a2e 05:13:06 INFO - Revision ID: 0x0009 05:13:06 INFO - Displays: 05:13:06 INFO - Display: 05:13:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:13:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:13:06 INFO - Display Serial Number: 1600x1200 60 05:13:06 INFO - Main Display: Yes 05:13:06 INFO - Mirror: Off 05:13:06 INFO - Online: Yes 05:13:06 INFO - Rotation: Supported 05:13:06 INFO - Return code: 0 05:13:06 INFO - Running post-action listener: _resource_record_post_action 05:13:06 INFO - [mozharness: 2017-04-04 12:13:06.230017Z] Finished run-tests step (success) 05:13:06 INFO - Running post-run listener: _resource_record_post_run 05:13:06 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 2336256; Write bytes: 517297152; Read time: 27; Write time: 1799 05:13:06 INFO - TinderboxPrint: CPU usage
54.2% 05:13:06 INFO - TinderboxPrint: I/O read bytes / time
2,336,256 / 27 05:13:06 INFO - TinderboxPrint: I/O write bytes / time
517,297,152 / 1,799 05:13:06 INFO - TinderboxPrint: CPU idle
2,201.6 (45.8%) 05:13:06 INFO - TinderboxPrint: CPU system
966.4 (20.1%) 05:13:06 INFO - TinderboxPrint: CPU user
1,637.8 (34.1%) 05:13:06 INFO - TinderboxPrint: Swap in / out
215,072,768 / 0 05:13:06 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204929536; Write bytes: 203806208; Read time: 15589; Write time: 638 05:13:06 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 2336256; Write bytes: 302677504; Read time: 27; Write time: 1124 05:13:06 INFO - Running post-run listener: _upload_blobber_files 05:13:06 INFO - Blob upload gear active. 05:13:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:13:06 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 05:13:06 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'] 05:13:06 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 05:13:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:13:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:13:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:13:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:08 INFO - (blobuploader) - INFO - Done attempting. 05:13:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:13:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:13:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:09 INFO - (blobuploader) - INFO - Done attempting. 05:13:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:13:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:13:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:10 INFO - (blobuploader) - INFO - Done attempting. 05:13:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:13:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:13:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:12 INFO - (blobuploader) - INFO - Done attempting. 05:13:12 INFO - (blobuploader) - INFO - Iteration through files over. 05:13:12 INFO - Return code: 0 05:13:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:13:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:13:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39baa98a2cdd653eae01386d66c00236d55444a3e7069806054b06b1094b141c62c64d5a045512d3732a09448890a6768c0cb0a67f1fbd3eb46c9ee502ec6fa5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09f0787c986b91a3dd0e256a4e7fac000c4eff1e05d5dc7f5aee95606c75958d9f40aa1d981f2e982aa5bd40138b59990e7191b15d09bafa4c435223fc5306d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c5bc1c04589ac9a1f05cca8902035db16c55bb8dbc57895f42f856febc095abf65c48021b2fda9fb3c04c207457fca13f0ef890bdbf8ee466dc4598185c9380", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/172bf7f2e5cd39283bd29f68a1f17b09367c0fcb2bab7209dc96c83a06e9014770c865301bc3ba98b4b29b3e8878718d655749cf2b5fb5f3609981c41315f234"} 05:13:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:13:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:13:12 INFO - Contents: 05:13:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39baa98a2cdd653eae01386d66c00236d55444a3e7069806054b06b1094b141c62c64d5a045512d3732a09448890a6768c0cb0a67f1fbd3eb46c9ee502ec6fa5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09f0787c986b91a3dd0e256a4e7fac000c4eff1e05d5dc7f5aee95606c75958d9f40aa1d981f2e982aa5bd40138b59990e7191b15d09bafa4c435223fc5306d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c5bc1c04589ac9a1f05cca8902035db16c55bb8dbc57895f42f856febc095abf65c48021b2fda9fb3c04c207457fca13f0ef890bdbf8ee466dc4598185c9380", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/172bf7f2e5cd39283bd29f68a1f17b09367c0fcb2bab7209dc96c83a06e9014770c865301bc3ba98b4b29b3e8878718d655749cf2b5fb5f3609981c41315f234"} 05:13:12 INFO - Running post-run listener: copy_logs_to_upload_dir 05:13:12 INFO - Copying logs to upload dir... 05:13:12 INFO - mkdir: /builds/slave/test/build/upload/logs 05:13:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.561348 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-04 05:13:12.558179) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 05:13:12.561449) ========= 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.bIhbCglnTx/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.DVJH1jj8eL/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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/39baa98a2cdd653eae01386d66c00236d55444a3e7069806054b06b1094b141c62c64d5a045512d3732a09448890a6768c0cb0a67f1fbd3eb46c9ee502ec6fa5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09f0787c986b91a3dd0e256a4e7fac000c4eff1e05d5dc7f5aee95606c75958d9f40aa1d981f2e982aa5bd40138b59990e7191b15d09bafa4c435223fc5306d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c5bc1c04589ac9a1f05cca8902035db16c55bb8dbc57895f42f856febc095abf65c48021b2fda9fb3c04c207457fca13f0ef890bdbf8ee466dc4598185c9380", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/172bf7f2e5cd39283bd29f68a1f17b09367c0fcb2bab7209dc96c83a06e9014770c865301bc3ba98b4b29b3e8878718d655749cf2b5fb5f3609981c41315f234"} build_url:https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/DD5TEWs3QH215aOaprSWcQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39baa98a2cdd653eae01386d66c00236d55444a3e7069806054b06b1094b141c62c64d5a045512d3732a09448890a6768c0cb0a67f1fbd3eb46c9ee502ec6fa5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09f0787c986b91a3dd0e256a4e7fac000c4eff1e05d5dc7f5aee95606c75958d9f40aa1d981f2e982aa5bd40138b59990e7191b15d09bafa4c435223fc5306d9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c5bc1c04589ac9a1f05cca8902035db16c55bb8dbc57895f42f856febc095abf65c48021b2fda9fb3c04c207457fca13f0ef890bdbf8ee466dc4598185c9380", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/172bf7f2e5cd39283bd29f68a1f17b09367c0fcb2bab7209dc96c83a06e9014770c865301bc3ba98b4b29b3e8878718d655749cf2b5fb5f3609981c41315f234"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 05:13:12.596865) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 05:13:12.597270) ========= 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.bIhbCglnTx/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.DVJH1jj8eL/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.005091 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 05:13:12.646340) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 05:13:12.646660) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 05:13:12.647056) ========= ========= Total master_lag: 0.19 =========