builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0348 starttime: 1486009420.96 results: success (0) buildid: 20170201191809 builduid: 2ead5444a46c473b883eae42a3c8ed69 revision: f985243bb630b2c78cd57731c8d8ab191aa09527 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 20:23:40.962796) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-01 20:23:40.963282) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 20:23:40.963581) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-01 20:23:40.989439) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 20:23:40.989730) ========= 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.Ye5M99bV2E/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.P67koJQKWq/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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-02-01 20:23:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.2M=0.001s 2017-02-01 20:23:41 (19.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.143977 ========= master_lag: 0.90 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 20:23:42.028825) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 20:23:42.029209) ========= 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.Ye5M99bV2E/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.P67koJQKWq/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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.025753 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 20:23:42.077814) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 20:23:42.078164) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f985243bb630b2c78cd57731c8d8ab191aa09527 --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 f985243bb630b2c78cd57731c8d8ab191aa09527 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ye5M99bV2E/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.P67koJQKWq/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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-02-01 20:23:42,185 truncating revision to first 12 chars 2017-02-01 20:23:42,185 Setting DEBUG logging. 2017-02-01 20:23:42,185 attempt 1/10 2017-02-01 20:23:42,186 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f985243bb630?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-01 20:23:43,545 unpacking tar archive at: mozilla-central-f985243bb630/testing/mozharness/ program finished with exit code 0 elapsedTime=1.649594 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-01 20:23:43.752949) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 20:23:43.753275) ========= script_repo_revision: f985243bb630b2c78cd57731c8d8ab191aa09527 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-01 20:23:43.753649) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 20:23:43.753928) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-01 20:23:43.778010) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-01 20:23:43.778382) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.Ye5M99bV2E/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.P67koJQKWq/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 20:23:43 INFO - MultiFileLogger online at 20170201 20:23:43 in /builds/slave/test 20:23:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 20:23:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:23:43 INFO - {'append_to_log': False, 20:23:43 INFO - 'base_work_dir': '/builds/slave/test', 20:23:43 INFO - 'blob_upload_branch': 'Firefox', 20:23:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:23:43 INFO - 'branch': 'Firefox', 20:23:43 INFO - 'buildbot_json_path': 'buildprops.json', 20:23:43 INFO - 'config_files': ('talos/mac_config.py',), 20:23:43 INFO - 'default_actions': ('clobber', 20:23:43 INFO - 'read-buildbot-config', 20:23:43 INFO - 'download-and-extract', 20:23:43 INFO - 'populate-webroot', 20:23:43 INFO - 'create-virtualenv', 20:23:43 INFO - 'install', 20:23:43 INFO - 'run-tests'), 20:23:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:23:43 INFO - 'download_minidump_stackwalk': True, 20:23:43 INFO - 'download_symbols': 'ondemand', 20:23:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:23:43 INFO - 'tooltool.py': '/tools/tooltool.py', 20:23:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:23:43 INFO - '/tools/misc-python/virtualenv.py')}, 20:23:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:23:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:23:43 INFO - 'installer_path': 'installer.exe', 20:23:43 INFO - 'log_level': 'info', 20:23:43 INFO - 'log_name': 'talos', 20:23:43 INFO - 'log_to_console': True, 20:23:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:23:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:23:43 INFO - 'opt_config_files': (), 20:23:43 INFO - 'pip_index': False, 20:23:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:23:43 INFO - 'cmd': ('bash', 20:23:43 INFO - '-c', 20:23:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:23:43 INFO - 'enabled': True, 20:23:43 INFO - 'halt_on_failure': False, 20:23:43 INFO - 'name': 'check_screen_resolution'},), 20:23:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:23:43 INFO - 'cmd': ('bash', 20:23:43 INFO - '-c', 20:23:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:23:43 INFO - 'enabled': True, 20:23:43 INFO - 'halt_on_failure': False, 20:23:43 INFO - 'name': 'check_screen_resolution'},), 20:23:43 INFO - 'run_cmd_checks_enabled': True, 20:23:43 INFO - 'sps_profile': False, 20:23:43 INFO - 'sps_profile_interval': 0, 20:23:43 INFO - 'suite': 'dromaeojs', 20:23:43 INFO - 'system_bits': '32', 20:23:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:23:43 INFO - 'title': 't-yosemite-r7-0348', 20:23:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:23:43 INFO - 'use_talos_json': True, 20:23:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:23:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:23:43 INFO - 'work_dir': 'build'} 20:23:43 INFO - [mozharness: 2017-02-02 04:23:43.994186Z] Running clobber step. 20:23:43 INFO - Running pre-action listener: _resource_record_pre_action 20:23:43 INFO - Running main action method: clobber 20:23:43 INFO - rmtree: /builds/slave/test/build 20:23:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:23:46 INFO - Running post-action listener: _resource_record_post_action 20:23:46 INFO - [mozharness: 2017-02-02 04:23:46.501709Z] Finished clobber step (success) 20:23:46 INFO - [mozharness: 2017-02-02 04:23:46.501898Z] Running read-buildbot-config step. 20:23:46 INFO - Running pre-action listener: _resource_record_pre_action 20:23:46 INFO - Running main action method: read_buildbot_config 20:23:46 INFO - Using buildbot properties: 20:23:46 INFO - { 20:23:46 INFO - "project": "", 20:23:46 INFO - "product": "firefox", 20:23:46 INFO - "script_repo_revision": "production", 20:23:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 20:23:46 INFO - "repository": "", 20:23:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 20:23:46 INFO - "buildid": "20170201191809", 20:23:46 INFO - "pgo_build": "False", 20:23:46 INFO - "basedir": "/builds/slave/test", 20:23:46 INFO - "buildnumber": 53, 20:23:46 INFO - "slavename": "t-yosemite-r7-0348", 20:23:46 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 20:23:46 INFO - "platform": "yosemite_r7", 20:23:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 20:23:46 INFO - "branch": "mozilla-central", 20:23:46 INFO - "repo_path": "mozilla-central", 20:23:46 INFO - "revision": "f985243bb630b2c78cd57731c8d8ab191aa09527", 20:23:46 INFO - "stage_platform": "macosx64", 20:23:46 INFO - "builduid": "2ead5444a46c473b883eae42a3c8ed69", 20:23:46 INFO - "slavebuilddir": "test" 20:23:46 INFO - } 20:23:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 20:23:46 INFO - Running post-action listener: _resource_record_post_action 20:23:46 INFO - [mozharness: 2017-02-02 04:23:46.507432Z] Finished read-buildbot-config step (success) 20:23:46 INFO - [mozharness: 2017-02-02 04:23:46.507590Z] Running download-and-extract step. 20:23:46 INFO - Running pre-action listener: _resource_record_pre_action 20:23:46 INFO - Running main action method: download_and_extract 20:23:46 INFO - mkdir: /builds/slave/test/build/tests 20:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:23:46 INFO - trying https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 20:23:46 INFO - Downloading https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 20:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 20:23:47 INFO - Downloaded 1199 bytes. 20:23:47 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 20:23:47 INFO - Using the following test package requirements: 20:23:47 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 20:23:47 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:23:47 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 20:23:47 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:23:47 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 20:23:47 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:23:47 INFO - u'jsshell-mac.zip'], 20:23:47 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:23:47 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 20:23:47 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 20:23:47 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:23:47 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 20:23:47 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:23:47 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 20:23:47 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:23:47 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 20:23:47 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 20:23:47 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 20:23:47 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:23:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 20:23:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:23:47 INFO - Fetch https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 20:23:48 INFO - Expected file size: 16377028 20:23:48 INFO - Obtained file size: 16377028 20:23:55 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:23:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 20:23:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:23:55 INFO - Fetch https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 20:23:56 INFO - Expected file size: 16377028 20:23:56 INFO - Obtained file size: 16377028 20:24:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 20:24:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:24:02 INFO - Fetch https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 20:24:03 INFO - Expected file size: 14403454 20:24:03 INFO - Obtained file size: 14403454 20:24: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')]} 20:24:04 INFO - trying https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 20:24:04 INFO - Downloading https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 20:24:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 20:24:07 INFO - Downloaded 70202919 bytes. 20:24:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 20:24:07 INFO - mkdir: /builds/slave/test/properties 20:24:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:24:07 INFO - Writing to file /builds/slave/test/properties/build_url 20:24:07 INFO - Contents: 20:24:07 INFO - build_url:https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 20:24:08 INFO - Running post-action listener: _resource_record_post_action 20:24:08 INFO - Running post-action listener: set_extra_try_arguments 20:24:08 INFO - [mozharness: 2017-02-02 04:24:08.015960Z] Finished download-and-extract step (success) 20:24:08 INFO - [mozharness: 2017-02-02 04:24:08.016111Z] Running populate-webroot step. 20:24:08 INFO - Running pre-action listener: _resource_record_pre_action 20:24:08 INFO - Running main action method: populate_webroot 20:24:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:24:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:24:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:24:08 INFO - '--tppagecycles', 20:24:08 INFO - '7'], 20:24:08 INFO - 'tests': ['tsvgm']}}, 20:24:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:24:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:24:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:24:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:24:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:24:08 INFO - 'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:24:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:24:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:24:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:24:08 INFO - 'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['damp', 'tps']}, 20:24:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:24:08 INFO - 'tests': ['damp', 'tps']}, 20:24:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['dromaeo_dom']}, 20:24:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:24:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['basic_compositor_video']}, 20:24:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:24:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['a11yr', 20:24:08 INFO - 'ts_paint', 20:24:08 INFO - 'tpaint', 20:24:08 INFO - 'sessionrestore', 20:24:08 INFO - 'sessionrestore_no_auto_restore', 20:24:08 INFO - 'tabpaint']}, 20:24:08 INFO - 'other-e10s': {'tests': ['a11yr', 20:24:08 INFO - 'ts_paint', 20:24:08 INFO - 'tpaint', 20:24:08 INFO - 'sessionrestore', 20:24:08 INFO - 'sessionrestore_no_auto_restore', 20:24:08 INFO - 'tabpaint']}, 20:24:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:24:08 INFO - 'ts_paint', 20:24:08 INFO - 'tpaint', 20:24:08 INFO - 'sessionrestore', 20:24:08 INFO - 'sessionrestore_no_auto_restore', 20:24:08 INFO - 'tabpaint']}, 20:24:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:24:08 INFO - 'ts_paint', 20:24:08 INFO - 'tpaint', 20:24:08 INFO - 'sessionrestore', 20:24:08 INFO - 'sessionrestore_no_auto_restore', 20:24:08 INFO - 'tabpaint']}, 20:24:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['a11yr', 20:24:08 INFO - 'ts_paint', 20:24:08 INFO - 'tpaint', 20:24:08 INFO - 'sessionrestore', 20:24:08 INFO - 'sessionrestore_no_auto_restore', 20:24:08 INFO - 'tabpaint']}, 20:24:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['a11yr', 20:24:08 INFO - 'ts_paint', 20:24:08 INFO - 'tpaint', 20:24:08 INFO - 'sessionrestore', 20:24:08 INFO - 'sessionrestore_no_auto_restore', 20:24:08 INFO - 'tabpaint']}, 20:24:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['tsvgx', 20:24:08 INFO - 'tsvgr_opacity', 20:24:08 INFO - 'tart', 20:24:08 INFO - 'tscrollx', 20:24:08 INFO - 'cart', 20:24:08 INFO - 'tsvg_static']}, 20:24:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:24:08 INFO - 'tsvgr_opacity', 20:24:08 INFO - 'tart', 20:24:08 INFO - 'tscrollx', 20:24:08 INFO - 'cart', 20:24:08 INFO - 'tsvg_static']}, 20:24:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:24:08 INFO - 'talos_options': ['--disable-e10s'], 20:24:08 INFO - 'tests': ['tp5o']}, 20:24:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:24:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:24:08 INFO - 'talos_options': ['--disable-e10s', 20:24:08 INFO - '--xperf_path', 20:24:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:24:08 INFO - 'tests': ['tp5n']}, 20:24:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:24:08 INFO - 'talos_options': ['--xperf_path', 20:24:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:24:08 INFO - 'tests': ['tp5n']}}, 20:24:08 INFO - 'talos.zip': {'path': '', 20:24:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:24:08 INFO - Running post-action listener: _resource_record_post_action 20:24:08 INFO - [mozharness: 2017-02-02 04:24:08.034620Z] Finished populate-webroot step (success) 20:24:08 INFO - [mozharness: 2017-02-02 04:24:08.034728Z] Running create-virtualenv step. 20:24:08 INFO - Running pre-action listener: _resource_record_pre_action 20:24:08 INFO - Running main action method: create_virtualenv 20:24:08 INFO - Creating virtualenv /builds/slave/test/build/venv 20:24:08 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 20:24:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:24:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:24:08 INFO - Using real prefix '/tools/python27' 20:24:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:24:08 INFO - Installing distribute.............................................................................................................................................................................................done. 20:24:11 INFO - Installing pip.................done. 20:24:11 INFO - Return code: 0 20:24:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:24:11 INFO - Reading from file tmpfile_stdout 20:24:11 INFO - Output received: 20:24:11 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) 20:24:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:11 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 0x1067adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05944fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10658bd30>, '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 0x1064b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106580be8>, '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.Ye5M99bV2E/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.P67koJQKWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 20:24:11 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 20:24:11 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 20:24:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ye5M99bV2E/Render', 20:24:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:11 INFO - 'HOME': '/Users/cltbld', 20:24:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:11 INFO - 'LOGNAME': 'cltbld', 20:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:11 INFO - 'MOZ_NO_REMOTE': '1', 20:24:11 INFO - 'NO_EM_RESTART': '1', 20:24:11 INFO - 'PAGER': '/bin/cat', 20:24:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:11 INFO - 'PWD': '/builds/slave/test', 20:24:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:11 INFO - 'SHELL': '/bin/bash', 20:24:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P67koJQKWq/Listeners', 20:24:11 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 20:24:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:11 INFO - 'USER': 'cltbld', 20:24:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:11 INFO - 'XPC_FLAGS': '0x0', 20:24:11 INFO - 'XPC_SERVICE_NAME': '0', 20:24:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:12 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 20:24:12 INFO - Cleaning up... 20:24:12 INFO - Return code: 0 20:24:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:12 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 0x1067adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05944fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10658bd30>, '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 0x1064b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106580be8>, '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.Ye5M99bV2E/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.P67koJQKWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 20:24:12 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 20:24:12 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 20:24:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ye5M99bV2E/Render', 20:24:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:12 INFO - 'HOME': '/Users/cltbld', 20:24:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:12 INFO - 'LOGNAME': 'cltbld', 20:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:12 INFO - 'MOZ_NO_REMOTE': '1', 20:24:12 INFO - 'NO_EM_RESTART': '1', 20:24:12 INFO - 'PAGER': '/bin/cat', 20:24:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:12 INFO - 'PWD': '/builds/slave/test', 20:24:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:12 INFO - 'SHELL': '/bin/bash', 20:24:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P67koJQKWq/Listeners', 20:24:12 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 20:24:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:12 INFO - 'USER': 'cltbld', 20:24:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:12 INFO - 'XPC_FLAGS': '0x0', 20:24:12 INFO - 'XPC_SERVICE_NAME': '0', 20:24:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:12 INFO - Downloading/unpacking psutil>=3.1.1 20:24:12 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 20:24:12 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 20:24:12 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 20:24:12 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 20:24:12 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 20:24:12 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 20:24:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:24:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:24:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:24:15 INFO - Installing collected packages: psutil 20:24:15 INFO - Running setup.py install for psutil 20:24:16 INFO - building 'psutil._psutil_osx' extension 20:24:16 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 20:24:16 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 20:24:16 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 20:24:16 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 20:24:16 INFO - building 'psutil._psutil_posix' extension 20:24:16 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 20:24:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:24:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:24:16 INFO - ^ 20:24:16 INFO - 1 warning generated. 20:24:16 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 20:24:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:24:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:24:17 INFO - Successfully installed psutil 20:24:17 INFO - Cleaning up... 20:24:17 INFO - Return code: 0 20:24:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:24:17 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')]} 20:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:17 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')]} 20:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:17 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 0x1067adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05944fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10658bd30>, '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 0x1064b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106580be8>, '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.Ye5M99bV2E/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.P67koJQKWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 20:24:17 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 20:24:17 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 20:24:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ye5M99bV2E/Render', 20:24:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:17 INFO - 'HOME': '/Users/cltbld', 20:24:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:17 INFO - 'LOGNAME': 'cltbld', 20:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:17 INFO - 'MOZ_NO_REMOTE': '1', 20:24:17 INFO - 'NO_EM_RESTART': '1', 20:24:17 INFO - 'PAGER': '/bin/cat', 20:24:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:17 INFO - 'PWD': '/builds/slave/test', 20:24:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:17 INFO - 'SHELL': '/bin/bash', 20:24:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P67koJQKWq/Listeners', 20:24:17 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 20:24:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:17 INFO - 'USER': 'cltbld', 20:24:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:17 INFO - 'XPC_FLAGS': '0x0', 20:24:17 INFO - 'XPC_SERVICE_NAME': '0', 20:24:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:24:20 INFO - Installing collected packages: mozsystemmonitor 20:24:20 INFO - Running setup.py install for mozsystemmonitor 20:24:20 INFO - Successfully installed mozsystemmonitor 20:24:20 INFO - Cleaning up... 20:24:20 INFO - Return code: 0 20:24:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1067adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05944fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10658bd30>, '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 0x1064b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106580be8>, '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.Ye5M99bV2E/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.P67koJQKWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 20:24:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:24:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ye5M99bV2E/Render', 20:24:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:20 INFO - 'HOME': '/Users/cltbld', 20:24:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:20 INFO - 'LOGNAME': 'cltbld', 20:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:20 INFO - 'MOZ_NO_REMOTE': '1', 20:24:20 INFO - 'NO_EM_RESTART': '1', 20:24:20 INFO - 'PAGER': '/bin/cat', 20:24:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:20 INFO - 'PWD': '/builds/slave/test', 20:24:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:20 INFO - 'SHELL': '/bin/bash', 20:24:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P67koJQKWq/Listeners', 20:24:20 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 20:24:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:20 INFO - 'USER': 'cltbld', 20:24:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:20 INFO - 'XPC_FLAGS': '0x0', 20:24:20 INFO - 'XPC_SERVICE_NAME': '0', 20:24:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:20 INFO - Downloading/unpacking jsonschema==2.5.1 20:24:20 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 20:24:20 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 20:24:20 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 20:24:20 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 20:24:20 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 20:24:20 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 20:24:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:24:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:24:23 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 20:24:23 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 20:24:23 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 20:24:23 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 20:24:23 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 20:24:23 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 20:24:23 INFO - Downloading functools32-3.2.3-2.tar.gz 20:24:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:24:23 INFO - warning: no files found matching '*.txt' 20:24:23 INFO - no previously-included directories found matching 'build' 20:24:23 INFO - no previously-included directories found matching 'dist' 20:24:23 INFO - no previously-included directories found matching '.git*' 20:24:23 INFO - Installing collected packages: jsonschema, functools32 20:24:23 INFO - Running setup.py install for functools32 20:24:23 INFO - warning: no files found matching '*.txt' 20:24:23 INFO - no previously-included directories found matching 'build' 20:24:23 INFO - no previously-included directories found matching 'dist' 20:24:23 INFO - no previously-included directories found matching '.git*' 20:24:23 INFO - Successfully installed jsonschema functools32 20:24:23 INFO - Cleaning up... 20:24:24 INFO - Return code: 0 20:24:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1067adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05944fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10658bd30>, '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 0x1064b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106580be8>, '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.Ye5M99bV2E/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.P67koJQKWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 20:24:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:24:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:24:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ye5M99bV2E/Render', 20:24:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:24 INFO - 'HOME': '/Users/cltbld', 20:24:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:24 INFO - 'LOGNAME': 'cltbld', 20:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:24 INFO - 'MOZ_NO_REMOTE': '1', 20:24:24 INFO - 'NO_EM_RESTART': '1', 20:24:24 INFO - 'PAGER': '/bin/cat', 20:24:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:24 INFO - 'PWD': '/builds/slave/test', 20:24:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:24 INFO - 'SHELL': '/bin/bash', 20:24:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P67koJQKWq/Listeners', 20:24:24 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 20:24:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:24 INFO - 'USER': 'cltbld', 20:24:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:24 INFO - 'XPC_FLAGS': '0x0', 20:24:24 INFO - 'XPC_SERVICE_NAME': '0', 20:24:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:24:25 INFO - Cleaning up... 20:24:25 INFO - Return code: 0 20:24:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:24: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')]} 20:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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')]} 20:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1067adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05944fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10658bd30>, '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 0x1064b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106580be8>, '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.Ye5M99bV2E/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.P67koJQKWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 20:24:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:24:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ye5M99bV2E/Render', 20:24:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:25 INFO - 'HOME': '/Users/cltbld', 20:24:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:25 INFO - 'LOGNAME': 'cltbld', 20:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:25 INFO - 'MOZ_NO_REMOTE': '1', 20:24:25 INFO - 'NO_EM_RESTART': '1', 20:24:25 INFO - 'PAGER': '/bin/cat', 20:24:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:25 INFO - 'PWD': '/builds/slave/test', 20:24:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:25 INFO - 'SHELL': '/bin/bash', 20:24:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P67koJQKWq/Listeners', 20:24:25 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 20:24:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:25 INFO - 'USER': 'cltbld', 20:24:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:25 INFO - 'XPC_FLAGS': '0x0', 20:24:25 INFO - 'XPC_SERVICE_NAME': '0', 20:24:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:25 INFO - Downloading/unpacking blobuploader==1.2.4 20:24:25 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 20:24:25 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 20:24:25 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 20:24:25 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 20:24:25 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 20:24:25 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 20:24:28 INFO - Downloading blobuploader-1.2.4.tar.gz 20:24:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:24:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:24:28 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 20:24:28 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 20:24:28 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 20:24:28 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 20:24:28 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 20:24:28 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 20:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:24:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:29 INFO - Downloading docopt-0.6.1.tar.gz 20:24:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:24:29 INFO - Installing collected packages: blobuploader, requests, docopt 20:24:29 INFO - Running setup.py install for blobuploader 20:24:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:24:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:24:30 INFO - Running setup.py install for requests 20:24:30 INFO - Running setup.py install for docopt 20:24:30 INFO - Successfully installed blobuploader requests docopt 20:24:30 INFO - Cleaning up... 20:24:30 INFO - Return code: 0 20:24:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24:30 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')]} 20:24:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:30 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')]} 20:24:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:30 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 0x1067adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05944fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10658bd30>, '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 0x1064b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106580be8>, '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.Ye5M99bV2E/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.P67koJQKWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 20:24:30 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 20:24:30 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 20:24:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ye5M99bV2E/Render', 20:24:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:30 INFO - 'HOME': '/Users/cltbld', 20:24:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:30 INFO - 'LOGNAME': 'cltbld', 20:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:30 INFO - 'MOZ_NO_REMOTE': '1', 20:24:30 INFO - 'NO_EM_RESTART': '1', 20:24:30 INFO - 'PAGER': '/bin/cat', 20:24:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:30 INFO - 'PWD': '/builds/slave/test', 20:24:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:30 INFO - 'SHELL': '/bin/bash', 20:24:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P67koJQKWq/Listeners', 20:24:30 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 20:24:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:30 INFO - 'USER': 'cltbld', 20:24:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:30 INFO - 'XPC_FLAGS': '0x0', 20:24:30 INFO - 'XPC_SERVICE_NAME': '0', 20:24:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:24:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-nWsEqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:24:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-Tqno50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:24:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-rYycwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:24:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-LGng9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:24:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-q2pfYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:24:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-BGshlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:24:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-6bxd5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:24:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-t_THAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:24:31 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-9wkX3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:24:32 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-m9SeAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:24:32 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-Bo_BNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:24:32 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-uQyJPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:24:32 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-qvHh8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:24:32 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-p0SGAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:32 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-qw4Y2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:24:32 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-2sGuHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:24:32 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-rn_olI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:24:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:24:32 INFO - Running setup.py install for manifestparser 20:24:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:24:33 INFO - Running setup.py install for mozcrash 20:24:33 INFO - Running setup.py install for mozdebug 20:24:33 INFO - Running setup.py install for mozdevice 20:24:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:24:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:24:33 INFO - Running setup.py install for mozfile 20:24:33 INFO - Running setup.py install for mozhttpd 20:24:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:24:33 INFO - Running setup.py install for mozinfo 20:24:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:24:33 INFO - Running setup.py install for mozInstall 20:24:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:24:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:24:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:24:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:24:34 INFO - Running setup.py install for mozleak 20:24:34 INFO - Running setup.py install for mozlog 20:24:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:24:34 INFO - Running setup.py install for moznetwork 20:24:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:24:34 INFO - Running setup.py install for mozprocess 20:24:34 INFO - Running setup.py install for mozprofile 20:24:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:24:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:24:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:24:34 INFO - Running setup.py install for mozrunner 20:24:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:24:35 INFO - Running setup.py install for mozscreenshot 20:24:35 INFO - Running setup.py install for moztest 20:24:35 INFO - Running setup.py install for mozversion 20:24:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:24:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:24:35 INFO - Cleaning up... 20:24:35 INFO - Return code: 0 20:24:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24: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')]} 20:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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')]} 20:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:35 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 0x1067adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05944fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10658bd30>, '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 0x1064b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106580be8>, '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.Ye5M99bV2E/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.P67koJQKWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 20:24:35 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 20:24:35 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 20:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ye5M99bV2E/Render', 20:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:35 INFO - 'HOME': '/Users/cltbld', 20:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:35 INFO - 'LOGNAME': 'cltbld', 20:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:35 INFO - 'MOZ_NO_REMOTE': '1', 20:24:35 INFO - 'NO_EM_RESTART': '1', 20:24:35 INFO - 'PAGER': '/bin/cat', 20:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:35 INFO - 'PWD': '/builds/slave/test', 20:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:35 INFO - 'SHELL': '/bin/bash', 20:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P67koJQKWq/Listeners', 20:24:35 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 20:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:35 INFO - 'USER': 'cltbld', 20:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:35 INFO - 'XPC_FLAGS': '0x0', 20:24:35 INFO - 'XPC_SERVICE_NAME': '0', 20:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:24:35 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-6QZyXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:24:35 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)) 20:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:24:35 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-X2DL08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:24:35 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)) 20:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:24:35 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-34a_4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:24:36 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)) 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:24:36 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-bBVdsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:24:36 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)) 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:24:36 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-AV2_ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:24:36 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)) 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:24:36 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-hj9GQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:24:36 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)) 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:24:36 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-rBhOBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:24:36 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)) 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:24:36 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-1GCt_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:24:36 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)) 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:24:36 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-8q1Kzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:24:36 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)) 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:24:36 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-cGtovH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:24:36 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)) 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:24:36 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-FnG6YA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:24:36 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)) 20:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:24:36 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-lA1Fz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:24:37 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-_Hwpb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:24:37 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)) 20:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:24:37 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-3_SDE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:24:37 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)) 20:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:37 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-JvGD54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:37 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)) 20:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:24:37 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-_XK1CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:24:37 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)) 20:24:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:24:37 INFO - Running setup.py (path:/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/pip-L1JSFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:24:37 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)) 20:24:37 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)) 20:24:37 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)) 20:24:37 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)) 20:24:37 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)) 20:24:37 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)) 20:24:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:40 INFO - Downloading blessings-1.6.tar.gz 20:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:24:40 INFO - Installing collected packages: blessings 20:24:40 INFO - Running setup.py install for blessings 20:24:40 INFO - Successfully installed blessings 20:24:40 INFO - Cleaning up... 20:24:40 INFO - Return code: 0 20:24:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:24:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:24:40 INFO - Reading from file tmpfile_stdout 20:24:40 INFO - Current package versions: 20:24:40 INFO - blessings == 1.6 20:24:40 INFO - blobuploader == 1.2.4 20:24:40 INFO - docopt == 0.6.1 20:24:40 INFO - functools32 == 3.2.3-2 20:24:40 INFO - jsonschema == 2.5.1 20:24:40 INFO - manifestparser == 1.1 20:24:40 INFO - mozInstall == 1.12 20:24:40 INFO - mozcrash == 1.0 20:24:40 INFO - mozdebug == 0.1 20:24:40 INFO - mozdevice == 0.49 20:24:40 INFO - mozfile == 1.2 20:24:40 INFO - mozhttpd == 0.7 20:24:40 INFO - mozinfo == 0.9 20:24:40 INFO - mozleak == 0.1 20:24:40 INFO - mozlog == 3.4 20:24:40 INFO - moznetwork == 0.27 20:24:40 INFO - mozprocess == 0.24 20:24:40 INFO - mozprofile == 0.28 20:24:40 INFO - mozrunner == 6.13 20:24:40 INFO - mozscreenshot == 0.1 20:24:40 INFO - mozsystemmonitor == 0.3 20:24:40 INFO - moztest == 0.8 20:24:40 INFO - mozversion == 1.4 20:24:40 INFO - psutil == 3.1.1 20:24:40 INFO - requests == 1.2.3 20:24:40 INFO - wsgiref == 0.1.2 20:24:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24: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')]} 20:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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')]} 20:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:40 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 0x1067adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05944fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10658bd30>, '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 0x1064b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106580be8>, '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.Ye5M99bV2E/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.P67koJQKWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 20:24:40 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 20:24:40 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 20:24:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ye5M99bV2E/Render', 20:24:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:40 INFO - 'HOME': '/Users/cltbld', 20:24:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:40 INFO - 'LOGNAME': 'cltbld', 20:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:40 INFO - 'MOZ_NO_REMOTE': '1', 20:24:40 INFO - 'NO_EM_RESTART': '1', 20:24:40 INFO - 'PAGER': '/bin/cat', 20:24:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:40 INFO - 'PWD': '/builds/slave/test', 20:24:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:40 INFO - 'SHELL': '/bin/bash', 20:24:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P67koJQKWq/Listeners', 20:24:40 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 20:24:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:40 INFO - 'USER': 'cltbld', 20:24:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:40 INFO - 'XPC_FLAGS': '0x0', 20:24:40 INFO - 'XPC_SERVICE_NAME': '0', 20:24:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:41 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)) 20:24:41 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)) 20:24:41 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)) 20:24:41 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)) 20:24:41 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)) 20:24:41 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)) 20:24:41 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)) 20:24:41 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)) 20:24:41 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)) 20:24:41 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)) 20:24:41 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)) 20:24:41 INFO - Cleaning up... 20:24:41 INFO - Return code: 0 20:24:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1067adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1067b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb05944fb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10658bd30>, '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 0x1064b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106580be8>, '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.Ye5M99bV2E/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.P67koJQKWq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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 20:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ye5M99bV2E/Render', 20:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:41 INFO - 'HOME': '/Users/cltbld', 20:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:41 INFO - 'LOGNAME': 'cltbld', 20:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:41 INFO - 'MOZ_NO_REMOTE': '1', 20:24:41 INFO - 'NO_EM_RESTART': '1', 20:24:41 INFO - 'PAGER': '/bin/cat', 20:24:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:41 INFO - 'PWD': '/builds/slave/test', 20:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:41 INFO - 'SHELL': '/bin/bash', 20:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P67koJQKWq/Listeners', 20:24:41 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 20:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:41 INFO - 'USER': 'cltbld', 20:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:41 INFO - 'XPC_FLAGS': '0x0', 20:24:41 INFO - 'XPC_SERVICE_NAME': '0', 20:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:24:41 INFO - Cleaning up... 20:24:41 INFO - Return code: 0 20:24:41 INFO - Running post-action listener: _resource_record_post_action 20:24:41 INFO - Running post-action listener: _start_resource_monitoring 20:24:41 INFO - Starting resource monitoring. 20:24:41 INFO - [mozharness: 2017-02-02 04:24:41.371801Z] Finished create-virtualenv step (success) 20:24:41 INFO - [mozharness: 2017-02-02 04:24:41.372731Z] Running install step. 20:24:41 INFO - Running pre-action listener: _resource_record_pre_action 20:24:41 INFO - Running main action method: install 20:24:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:24:41 INFO - Reading from file tmpfile_stdout 20:24:41 INFO - Detecting whether we're running mozinstall >=1.0... 20:24:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:24:41 INFO - Reading from file tmpfile_stdout 20:24:41 INFO - Output received: 20:24:41 INFO - Usage: mozinstall [options] installer 20:24:41 INFO - Options: 20:24:41 INFO - -h, --help show this help message and exit 20:24:41 INFO - -d DEST, --destination=DEST 20:24:41 INFO - Directory to install application into. [default: 20:24:41 INFO - "/builds/slave/test"] 20:24:41 INFO - --app=APP Application being installed. [default: firefox] 20:24:41 INFO - mkdir: /builds/slave/test/build/application 20:24:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:25:03 INFO - Reading from file tmpfile_stdout 20:25:03 INFO - Output received: 20:25:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:25:03 INFO - Running post-action listener: _resource_record_post_action 20:25:03 INFO - [mozharness: 2017-02-02 04:25:03.634556Z] Finished install step (success) 20:25:03 INFO - [mozharness: 2017-02-02 04:25:03.634701Z] Running run-tests step. 20:25:03 INFO - Running pre-action listener: _resource_record_pre_action 20:25:03 INFO - Running main action method: run_tests 20:25:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:25:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:25:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:25:03 INFO - 2017-02-01 20:25:03.649 screenresolution[1621:7240] starting screenresolution argv=screenresolution get 20:25:03 INFO - 2017-02-01 20:25:03.651 screenresolution[1621:7240] Display 0: 1600x1200x32@60 20:25:03 INFO - 2017-02-01 20:25:03.657 screenresolution[1622:7242] starting screenresolution argv=screenresolution list 20:25:03 INFO - Available Modes on Display 0 20:25:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:25:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:25:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:25:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:25:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:25:03 INFO - Intel Iris: 20:25:03 INFO - Chipset Model: Intel Iris 20:25:03 INFO - Type: GPU 20:25:03 INFO - Bus: Built-In 20:25:03 INFO - VRAM (Dynamic, Max): 1536 MB 20:25:03 INFO - Vendor: Intel (0x8086) 20:25:03 INFO - Device ID: 0x0a2e 20:25:03 INFO - Revision ID: 0x0009 20:25:03 INFO - Displays: 20:25:03 INFO - Display: 20:25:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:25:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:25:03 INFO - Display Serial Number: 1600x1200 60 20:25:03 INFO - Main Display: Yes 20:25:03 INFO - Mirror: Off 20:25:03 INFO - Online: Yes 20:25:03 INFO - Rotation: Supported 20:25:03 INFO - Return code: 0 20:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:25:03 INFO - Python 2.7.3 20:25:03 INFO - Return code: 0 20:25:03 INFO - grabbing minidump binary from tooltool 20:25:03 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')]} 20:25:03 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 0x10658bd30>, '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 0x1064b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106580be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:25:03 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 20:25:03 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 20:25:03 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 20:25:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:25:04 INFO - Return code: 0 20:25:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:25:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:25:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:25:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:25:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0348', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0348 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:25:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ye5M99bV2E/Render', 20:25:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:04 INFO - 'HOME': '/Users/cltbld', 20:25:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:04 INFO - 'LOGNAME': 'cltbld', 20:25:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:25:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:04 INFO - 'MOZ_NO_REMOTE': '1', 20:25:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:25:04 INFO - 'NO_EM_RESTART': '1', 20:25:04 INFO - 'PAGER': '/bin/cat', 20:25:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:04 INFO - 'PWD': '/builds/slave/test', 20:25:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:25:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:04 INFO - 'SHELL': '/bin/bash', 20:25:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P67koJQKWq/Listeners', 20:25:04 INFO - 'TMPDIR': '/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/', 20:25:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:04 INFO - 'USER': 'cltbld', 20:25:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:04 INFO - 'XPC_FLAGS': '0x0', 20:25:04 INFO - 'XPC_SERVICE_NAME': '0', 20:25:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0348', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:25:04 INFO - mozversion application_buildid: 20170201191809 20:25:04 INFO - mozversion application_changeset: f985243bb630b2c78cd57731c8d8ab191aa09527 20:25:04 INFO - mozversion application_display_name: Nightly 20:25:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:25:04 INFO - mozversion application_name: Firefox 20:25:04 INFO - mozversion application_remotingname: firefox 20:25:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:25:04 INFO - mozversion application_vendor: Mozilla 20:25:04 INFO - mozversion application_version: 54.0a1 20:25:04 INFO - mozversion platform_buildid: 20170201191809 20:25:04 INFO - mozversion platform_changeset: f985243bb630b2c78cd57731c8d8ab191aa09527 20:25:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:25:04 INFO - mozversion platform_version: 54.0a1 20:25:04 INFO - using testdate: 1486009504 20:25:04 INFO - actual date: 1486009504 20:25:04 INFO - starting webserver on 'localhost:49235' 20:25:04 INFO - SUITE-START | Running 2 tests 20:25:04 INFO - TEST-START | dromaeo_css 20:25:04 INFO - operating with platform_type : mac_ 20:25:04 INFO - Initialising browser for dromaeo_css test... 20:25:04 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmptRggQi/profile http://localhost:49235/getInfo.html) 20:25:06 INFO - PROCESS | 1632 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 20:25:06 INFO - PROCESS | 1632 | __metrics Screen width/height:1600/1200 20:25:06 INFO - PROCESS | 1632 | colorDepth:24 20:25:06 INFO - PROCESS | 1632 | Browser inner width/height: 1024/689 20:25:06 INFO - PROCESS | 1632 | __metrics 20:25:06 INFO - PROCESS | 1632 | 1486009506815 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 20:25:06 INFO - PROCESS | 1632 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:25:06 INFO - PROCESS | 1632 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:25:07 INFO - TEST-INFO | 1632: exit 0 20:25:07 INFO - Browser initialized. 20:25:07 INFO - Running cycle 1/1 for dromaeo_css test... 20:25:07 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmptRggQi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:19 INFO - PROCESS | 1634 | RSS: Main: 237318144 20:25:19 INFO - PROCESS | 1634 | 20:28:22 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 20:28:24 INFO - PROCESS | 1634 | RSS: Main: 391716864 20:28:24 INFO - PROCESS | 1634 | 20:30:09 INFO - PROCESS | 1634 | ************************* 20:30:09 INFO - PROCESS | 1634 | A coding exception was thrown and uncaught in a Task. 20:30:09 INFO - PROCESS | 1634 | 20:30:09 ERROR - PROCESS | 1634 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:30:09 INFO - PROCESS | 1634 | Full stack: 20:30:09 INFO - PROCESS | 1634 | ************************* 20:31:27 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 20:31:28 INFO - PROCESS | 1634 | RSS: Main: 387510272 20:31:28 INFO - PROCESS | 1634 | 20:34:30 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 20:34:31 INFO - PROCESS | 1634 | RSS: Main: 362516480 20:34:31 INFO - PROCESS | 1634 | 20:37:33 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 20:37:34 INFO - PROCESS | 1634 | RSS: Main: 354926592 20:37:34 INFO - PROCESS | 1634 | 20:40:37 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 20:40:38 INFO - PROCESS | 1634 | RSS: Main: 328622080 20:40:38 INFO - PROCESS | 1634 | 20:43:41 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 20:43:42 INFO - PROCESS | 1634 | RSS: Main: 406851584 20:43:42 INFO - PROCESS | 1634 | 20:43:42 INFO - PROCESS | 1634 | __start_tp_report 20:43:42 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 20:43:42 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 20:43:42 INFO - PROCESS | 1634 | |i|pagename|runs| 20:43:42 INFO - PROCESS | 1634 | |0;dojo.html;2823.661160660721;3216.244182617086;3343.1474973881654;3359.47928071149;3410.3349846779874;5552.86117847054;5585.776568937237;5660.773569057238;5678.034734095203;5689.459501347365;5636.718164091789;5698.601097923137;5776.480116789488;5781.62419442736;5798.304203495586;5007.14878470659;5118.360204974379;5144.4083930348115;5183.17069268917;5186.636935414523;5118.3857937047605;5221.660592061523;5222.712750798704;5229.8169564065265;5297.629165958385;5099.5410413063;5207.427183009866;5221.503957124067;5236.397814251352;5245.26566280721;5090.032893750175;5113.181890897438;5147.3051138096625;5163.32876726027;5181.041507321158;5085.1355269604255;5100.438951715309;5129.358830146231;5134.589232861399;5164.92252616211;5636.04187288162;5659.122835960433;5666.291713535808;5676.460736230051;5718.199452076713;6113.174721412597;6120.020512922628;6126.548209435026;6190.84522886927;6235.7505699771955;6181.598196117283;6257.030160325156;6271.811845644593;6288.465480434169;6293.402126797947;5862.560307976876;5884.2350494436305;5890.1164825276555;5909.143174239797;5942.97028514859;6164.352742962014;6199;6206.131141640174;6265.71804268809;6275.215598050244;5190.740462976836;5215.817446389358;6115.43188682724;6131.969564675065;6178.351273116348;5218.817341393033;6128.3565225651555;6259.1550140730415;6284.465820405317;6294.905576416358;6105.74009121354;6109.541784366191;6148.893199224093;6188.381161883775;6202.596831205957;6237.189165408558;6253.906191407133;6261.8747625047245;6262.843428914313;6264.906026409608;4833.589144922721;4965.428975667773;4965.677230980047;4974.353334066621;5001.024800163933;3830.3488406970323;4390.648748100144;4401.22978478765;4428.22506061438;4497.8425755098415;5746.051901436216;5787.739551720183;5791.942080579141;5811.0411782056335;5840.8247752567495;6233.376662333731;6251.6561589113035;6265.8746825063245;6277.717502712298;6286.339934306923;5639.407862174413;5714.314282286152;5791.7683292667825;5795.391483894215;5830.82507524775;5364.570834333244;5425.267588875451;5430.755615997289;5449.5640348772;5455.61810673257;6310.810675679737;6315.778947736807;6333.714982825692;6337.176167098248;6344.143540621957;6270.592411493239;6296.37036296385;6298.811035668938;6305.905411418924;6309.305976342507;6179.196704428396;6209.348018458178;6234.096056071753;6237.126802247598;6258.280297765815;6215.689215539114;6228.0969259456215;6231.844203894939;6238.625682458885;6243.968780156252;5641.12562552805;6271.184745982993;6272.059191121369;6295.370462953668;6315.400036996478;5943.791967281124;6049.455549000611;6075.058365953284;6121.928662484136;6149.569530132848;6130.046409501579;6132.01899668756;6142.3550527194;6145.784897528744;6149.692515374303;5957.553183511167;5980.551458640706;5998.910016349845;6000.519958403404;6008.24896887889;5778.306603207642;6042.577019608585;6050.788222412194;6067.271927368744;6114.054067497291;5995.490383317467;6003.429674180946;6010.579259451972;6012.8797424052145;6047 20:43:42 INFO - PROCESS | 1634 | |1;ext.html;449.93590159273316;489.14643946313686;500.4220125754752;504.4325134223998;509.94441506082427;31050;41230.381544276825;42720.78639606801;42900;43084.138317233635;43237;43536.56463435365;43602.563974360244;43704.781476092656;43789.56210437894;9204.53977301134;9422.575984080733;9431.104045115702;9438.386504877195;9444.197243234334;8322.042965059005;8527.872081918746;11093;11352.375619340934;11390.544378224902;11216.495257713423;11290.548378064908;11296.491657875415;11298.265612735146;11347.43262836859;8308.376871734645;11192.10463162949;11270.718232044183;11288.2662626929;11304.604338848101;8351.749447516524;10986.395748233845;11283.887161128365;11299.887001130048;11430.25703329281;40319.7984010081;40990.590094098974;41257.96855078647;41728.74813755592;41791.1641767166;3981.3828856526993;3987.441758153861;4000.959990400117;4014.979925100385;4147.460830092099;31161.844190779128;31228.53157202621;31242.53136202959;31282;31320.53019204691;3051.67957364478;3225.3710526447353;3283.129970557804;3284.901452956415;3289.276359200972;367550;368173.9999999973;369291.15354423324;370317;370392;60221;60659.09011364833;60686.69656651777;60783.78432431327;60863.08705369423;63486.36513634897;63499.047514287326;63537.68231158907;63664.450332450506;63729;12668.873311266954;15701.450449234222;15712.978656387299;15752.448664296695;15771.921140394224;10941.507632156572;11271.718207044725;12108.757824843453;12187.207831491101;12216.328101954477;14177.716445671234;15886.682266354608;16171.43399980995;16250.431234906722;16319.184040797913;6281.96859015702;6336.714847831859;7377.446691498159;7458.4033277337685;7498.4001279897475;817.5217497763756;827.8261565071402;836.6987884361625;841.8653015517488;846.289117141604;29824.9970203807;29979;30031.399372012438;30864.845675771478;31276;1047.7956798424234;1055.3351388625117;1091.645215305029;1095.5070218401752;1212.7816992941355;13165.341732913315;15376.38494460209;15480.052586590347;15589.454369097028;16038.839611603968;242870;243555;243778;244236;244345;59211.40788592145;59479.702601486715;59554;59573;59660.701696492106;1419.1272367494123;1443.7112577484545;1451.4774681115002;1452.9346179421952;1459.6569806095772;28754.856225718737;28805.42389152247;29437;30510.542341864446;30695.693043070176;49767.004659907325;50288.245676315615;50408.24387634262;50468.242976356116;50562.747186263834;535207.3239633777;535390;537153.3142334264;537352.6264737303;537528;31809.681903180674;38788;39005.80497097496;39574.80212598918;39681.40477892892;39355;41110.794446027576;42945.14109717851;47074.29388559243;47169;36846.815765921;37488.43767343547;38850.80574597109;39840.60159398369;40157;37814.43278350772;38294;38903.80548097355;39909.60090399059;40021.79989100036;37481.688140914936;38758.6124138755;38762;38898.6110138895;38928;29598.556021660122;31043.689563104985;34411.82794086014;34817;35697.10757230986;24585;24713.752862471865;24777.87611061933;25122.24633260932;25808.741912580634 20:43:42 INFO - PROCESS | 1634 | |2;jquery.html;380.4768443390337;383.5383800750857;392.7525658834934;401.8934982229709;412.9628333449989;13348.619280231302;19709.50726231845;20880.269190578332;20946.89526552367;20990.370288891358;16510.504684859443;17947.910260448713;21175.470613234676;21610.783892161075;21840.890795546038;5684.2326285951385;6017.7592896284095;6018.247719035121;6027.9095813562835;6040.244969378828;5729.627574207684;5823.330317013534;5847.736851841656;5940.673262970535;5962.105684147369;5879.941200588003;5894.557908156884;5904.822855314347;5908.822735317947;5915.319738230094;5666.603337766358;5843;5844.386339434341;5875.500582450497;5923.614965027259;5116.590672746172;5121.667091639031;5134.486551344873;5202.92195617066;5203.8178663746585;24910.252692419257;25496.617550736755;25934.74065259361;26099.869500652374;26371.868140659364;2993.3863557970562;3123.109913674592;3123.5783169272313;3129.9843500782576;3141.858616362269;15002.099874007594;15600.765988510182;15619.765703514457;15768.842311576853;16419.917900410543;1829.4877434318412;1871.8689691721586;1872.6722823505831;1891.7446144770556;1903.3243198664552;89712;95374;115686.26470602948;116732.41633791776;117555.4122229392;10595.894041059491;10697.304675196243;11457.140714446283;11763.294202347886;11893.075285155877;15109.017913835565;15383.38466461329;15420.383184672712;15451.922740386226;15471.14908680011;6479.6760161991715;6819.693113809891;8049.315808156255;8338.624127019095;8550.947772534671;8246.752597422086;8268.793280168044;8287.50274983503;8387.790305242417;8479.491230526064;4366.061296821135;4415.337699345059;4722.929156062662;4723.409573803275;4761.52384761528;1634.6648936967892;2035.104553996237;2039.184326269504;2040.3776848061484;2043.5095577061397;939.1876027236391;1010.2473657125488;1017.308230403318;1017.9389236645825;1024.257413375297;21796;22101.226457074248;22104.778952210592;22304.330870073925;22500.549989000127;923.5613083785282;1024.8667673202585;1035.135661722455;1051.8264486359665;1060.8408738689104;11046.723831904106;11247.044001259821;11465.541378344773;11508.942455287837;11553.711157221136;628695;693358;736194;736270.4317186738;755184;136462;139582;140049;143261;144534;977.4428575711776;984.1978787288338;986.1666891476691;1002.7643503776461;1003.8845532763679;16799.496015119566;17778.644427111645;18619.348322808637;19299;19369.70945435848;40399.61518537681;55545.61135971471;56115.71942140263;57037.71481142568;57256.85486290167;71712.64143679249;80646;81044.59477702573;81090.59454702925;82756.17243827725;6817.284185160487;8137.59312034384;8317.251447369525;8483.78790530217;8507.149285071444;10419.426931518536;13023.47906083746;13125.409356579168;13484.595462136152;13619.727605448034;11186.272892262303;11396.904643035446;11411.942940285246;11437.771244575228;11565.653030409101;10228.158931392421;11028.448577570929;11076.501557430096;11476.885231147582;11811.527538898348;10523.736906577396;10820.621278255223;11366.715832104264;11606.825897611712;11625.941870290595;8046.597670116354;8192;8247.463914845515;8332.041815191089;8436.493810371398;8346.666133354598;9217.76955576116;9244.630214791334;10476.423796691255;10900.727481813017 20:43:42 INFO - PROCESS | 1634 | |3;mootools.html;1431.8294496777391;1432.176498513355;1442.7330943775398;1454.6726986428052;1466.9779953300695;7949;8304.252617264452;8312.625931833067;8314.459560128587;8331.958340208306;6597.703103360348;7351.485396022281;7634.656440460179;8158.388120890927;8164.020317561886;2028.9492762680904;2039.3270220827128;2048.8156065954063;2049.3646969439446;2079.677649964258;2278.840481166311;2309.6997390339234;2310.1336998625516;2311.4105902994797;2315.154968436517;1974.1313821918382;2214.944626384337;2243.4503546631017;2247.550489902018;2279.4985103277336;2064.84513661476;2255.041607316884;2270.64804955233;2272.556851413975;2279.12253782295;2104.1478201328487;2292.2435596253194;2296.1619009061737;2297.173017713622;2306.8961896714686;8236.546989915552;8280.627371768285;8298.253157215819;8300.7094751684;8347.791305217357;5028.84913452597;5185.092608793446;5186.325777648919;5210.426853046162;5215.322008138955;3013.758899288052;3237.255431250802;3239.1902024493875;3469.028671971852;3497.5453191085;1196.5572738086876;1219.9634010979596;1252.4113666576695;1266.683329167708;1270.7712611729885;10622.893771062269;10726.19553533488;10737.62418315363;10747.247692661516;10747.51636176366;4331.415258940003;4554.476235232924;4591.885202869888;4636.281376386665;4653.813847446064;9342.626294948263;9346;9347.579358928864;9354.859677104849;9355.111264429868;5110.2590124431745;5117.462666419972;5194.896102077937;5196.92204616931;5197.402298735694;4186.811593478301;4478.664100192498;4478.820847166076;4521.638268938477;4717.103750287434;3750.737448378642;3772.7359084863797;3845.8461661533224;3855.094052897567;3886.7473614214987;1256.8303279057393;1269.7270086931353;1270.7522033203436;1272.014189003511;1289.4004288006122;841.5413599588117;874.9212570868525;875.0855356152836;909.1136142261242;931.9440833550009;4349.630281426114;4788.736619485892;5002.824901128443;5057;5629.831105066854;759.9962000189963;850.5067061104545;868.8479516084786;900.7838118851429;984.3749219245831;3562.1985053362787;3712.9443058354145;3755.981220093937;3826.1773718650625;3828.2917660232947;9457.621695132118;9828.262880283864;9833.311668183302;10038.397696138109;10061.597536098621;9953.950230248802;10038.949805251073;10067.848982265272;10072.949635251776;10086.092251697382;7476.738314159087;7628.771136865903;7677.155512893577;7793.883091753628;7821.178776228414;4587.839425620087;5349.903269829598;5369.677819330853;5484.506394424521;5656.321241451053;8846.513441760764;8850.159234872677;8942.821143576963;8989.325800564853;9178.816423671356;8967.506787126771;9105.317101217302;9151.86272205904;9340.34617576763;9351.625934962525;6526.216853977363;6735.562188457735;6801.727930882709;6826.249112597511;6843.3840954314355;7831.060272767304;7920.405969552191;7922.247386498273;7937.642806073625;7945.364370850202;6830.8633827324165;6936.028955946071;7087.255838136922;7134.928650713634;7212.3148300911325;6927.653617319214;6973.686184121625;7013.018177455058;7095.538789978635;7117.964410178123;6294.24469063697;6421.165248517663;6423.839404014937;6428.325025872216;6429.164208652845;4859.392575928009;4927.211646136601;4936.086823937583;5012.448630650699;5013.172826483736;4814.446338671098;4853.830115945925;4996.475370086088;5082.618803589671;5159.638825282194 20:43:42 INFO - PROCESS | 1634 | |4;prototype.html;350.3973166154214;355.91458050067985;364.5242957939889;371.75090701257386;376.6064462636546;4864.951350486498;5196.688198708081;5240.240165176047;5263.76313065912;5270.393904700951;4501.819927202916;5180.507851754087;5198.439069237575;5209.973950130254;5246.370435547739;3529.347070791912;3792.772433653976;3850.3261929162422;4131.669466442685;4140.234056699505;3661.176235347039;4018.4575082363945;4048.9595104048876;4057.756534607918;4082.8979275518054;3447;4046.12724965275;4046.4132700758373;4061.614146656063;4136.855210067648;3437.639047899972;3758.9099161243207;4072.3077076897;4088.1398963471547;4115.609017143366;3441.2429265561536;3484.5121682964404;3619.7466177367596;3623.873164439232;3638.890833275006;4996.300517927493;5035.823746168903;5037.63983724396;5041.697498150086;5096.617753668453;4219.367094935754;4504.864854054384;4647.930281045787;4690.273007683781;4691.272852707836;4296.548862369469;4550.385697930803;5079.339685840817;5476.644018138808;5482.862928426782;3448.844307458672;3790.924181516354;3795.6773674237725;3806.467094606757;3816.5038544988975;4817.590504807095;5472.398036216013;5657.15142728594;5692.832969241337;5730.570207234432;3651.1602331463914;3738.981305093457;3774.0753515388906;3832.5017747692623;3852.016211651002;3903.6096390361304;3904;3908.921821563553;3910.237503686754;3912.4326972588815;4279.465066866642;4521.615662668644;4547.886302842456;4549.431321084864;4549.74693094439;4831.492693267227;5491.615586908878;5555.305676746774;5561.555075593943;5692.23154874095;1106.9169812264113;1260.6407173955563;1265.0701734225338;1270.4283072617359;1271.491403438632;774.6630215856121;787.4369825574742;851.9606080581681;865.9565223905179;874.7200895713438;4171.436856024458;4459.955400446019;4846.927296090562;4911.414667292896;4935.284383764334;4994.4755800640405;5388.114160044031;5398.73006349681;5447.782088716407;5482.780688772405;4324.870253892388;4534.319852022157;4742.691725037862;4834.830780922651;4870.391201099863;2358.504714010043;2737.7536021758137;2781.777457803371;2827.491051610689;2860.671022832359;5045.5459008689395;5234.607404444682;5527.778888844482;5592.728253971472;5621.8594535136945;4725.9527404726205;5379.4351593082165;5505.687611203304;5631.549476041907;5650.666106996891;5572.665640061609;5577.693226872561;5581.944180558143;5616.297962754656;5630.915536266959;5349.893002139857;5378.606520098519;5387.653086728318;5419.485148910847;5436.782528698808;4715.5065371412675;5016.247562865599;5100.566451851634;5295.655782374133;5323.733813309396;4923.286123512143;5475.5072043516275;5479.7944452220445;5584.664920104807;5693.4591213836275;3817.580066192772;3818.7326887118747;3825.824565610481;3827.770333779982;3855.575886652522;5101.770420331169;5581.469760372758;5587.245721827501;5639.731060511516;5644.379118296902;4690.671652984258;5194.467632048631;5438.428964958623;5440.972795135999;5487.725613719218;5369.812056578001;5459;5473.945260547343;5479.561635069264;5492.368377636623;4540.889490698882;4637.814487420465;5296.602754793329;5365.3293338332705;5377.569794416516;5053.155598206555;5120.718360490208;5267.499587539178;5498.45015498447;5509.201165831012;4772.7136371817805;4937.235148316954;5015.623828212972;5375.89794092218;5378.90222813111 20:43:42 INFO - PROCESS | 1634 | |5;yui.html;708.4367927497639;725.760499035318;765.8736308509096;771.0824119298035;834.7120243515986;13406.798898016525;15247.085174889515;15751.527454176394;15779.684406311866;15869.523914282576;14234.857651423483;14367.994240403175;14651.267436628152;14659.926700366483;14660.853391466082;867.4925168776274;900.1358695652149;901.5807649443008;903.8870141232346;907.5507623726264;697.7976386847808;723.3417589993107;857.3312816003527;891.0020776730039;891.189017993626;954.8519979403169;956.2923436656858;956.8756061712003;956.9951550871592;957.3920560444099;949.292776881228;951.1107114847605;952.4666186935269;953.713885834247;955.1833182628891;544.3603765575433;560.3192121572309;565.4345654345655;566.5722379603415;715.6242972439511;12298.077644176723;14385.28073596316;14962.476313328982;14984.325705343177;15274;14320.498782542561;14411.063280886814;14533.128012319296;14560;14950.476733314283;11418.54325826966;11825;11874.410055144268;12073;12292.815607765891;3698.7410881238325;3741.2143449875557;3823.063349479395;3858.266929283427;3909.4917660703927;101201;108792;109321.9999999992;109954;110013.44993275062;10569.154467642571;10716.78566428667;10981.39602321864;11027.558897644165;11299.830502542469;21959.34121976343;22245.443863903532;22370.217042403765;22456.43858903508;22513.774862251496;7645.847083058307;7702.1912699166905;7724.188960159215;7768.84462310762;7852.646630901623;4237.788110594458;4280.464941882265;4290.656747460258;4320.135972805451;4408.096340250241;3438.1748380388526;3488.790672559604;3493.12671832042;3517.223801979984;3605.441156620728;656.2846497317946;659.9935098974103;661.573285231033;662.3674390956625;674.6795272245743;553.2917865132637;652.729117416267;672.4754691340762;675.152683382352;696.7665831946254;10061.140394809201;10162.796744065077;10363.170946324275;10445.425501597334;10477.48076528899;702.9964850175717;717.3077979749567;717.8887272472775;728.4099879097947;728.7959371376023;4400.581944715247;4875.488073752276;4882.92475697827;4886.951130488721;4900.338454308694;83924;91794;109606;109973;112246;91121.08878911259;95515;96527;97185;98235.01764982402;64956.67521662361;69185;79341.60329198433;81849.59075204586;84375.578122109;10450.790984180121;10710.73223169427;10905.454727263446;11037.724056898642;11077.723056923642;39809.62094169581;41462;45075.098498030515;46583.53416465792;47225.527744723484;56277;60531;62618.29416440459;66083.66958165179;66372.668136659;12353.567625133077;12872.420741066862;12942.741145177231;13058.608241752763;13220.933895330461;14142.78785818234;14159.64600884986;14534.636634084232;14690.63273418173;14936.626584335478;12885.644381676153;12968.137521104962;13071.281079540717;13164.14433061848;13589.04876658664;9460.905390946002;13503.932480337535;13576.321183940961;13938.024338296627;13942.721145577234;12816.809192277142;13088.607341779762;13384.263865487492;13534.661633459242;13646.52237171734;8784.560771961504;10915.672529824118;11147.219694621299;11274.549018039186;11773.764524709286;10447.373157610567;10650.627228046982;10659.307145035547;10670.57317707283;10687.946560267148 20:43:42 INFO - PROCESS | 1634 | __end_tp_report 20:43:42 INFO - PROCESS | 1634 | __start_cc_report 20:43:42 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,1779 20:43:42 INFO - PROCESS | 1634 | __end_cc_report 20:43:42 INFO - PROCESS | 1634 | __startTimestamp1486010622031__endTimestamp 20:43:42 INFO - PROCESS | 1634 | 20:43:42 INFO - PROCESS | 1634 | ------- Summary: start ------- 20:43:42 INFO - PROCESS | 1634 | Number of tests: 6 20:43:42 INFO - PROCESS | 1634 | 20:43:42 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:5720.78 Median:5980.55 stddev:668.36 (11.2%) stddev-sans-first:630.58 20:43:42 INFO - PROCESS | 1634 | Values: 2823.7 3216.2 3343.1 3359.5 3410.3 5552.9 5585.8 5660.8 5678.0 5689.5 5636.7 5698.6 5776.5 5781.6 5798.3 5007.1 5118.4 5144.4 5183.2 5186.6 5118.4 5221.7 5222.7 5229.8 5297.6 5099.5 5207.4 5221.5 5236.4 5245.3 5090.0 5113.2 5147.3 5163.3 5181.0 5085.1 5100.4 5129.4 5134.6 5164.9 5636.0 5659.1 5666.3 5676.5 5718.2 6113.2 6120.0 6126.5 6190.8 6235.8 6181.6 6257.0 6271.8 6288.5 6293.4 5862.6 5884.2 5890.1 5909.1 5943.0 6164.4 6199.0 6206.1 6265.7 6275.2 5190.7 5215.8 6115.4 6132.0 6178.4 5218.8 6128.4 6259.2 6284.5 6294.9 6105.7 6109.5 6148.9 6188.4 6202.6 6237.2 6253.9 6261.9 6262.8 6264.9 4833.6 4965.4 4965.7 4974.4 5001.0 3830.3 4390.6 4401.2 4428.2 4497.8 5746.1 5787.7 5791.9 5811.0 5840.8 6233.4 6251.7 6265.9 6277.7 6286.3 5639.4 5714.3 5791.8 5795.4 5830.8 5364.6 5425.3 5430.8 5449.6 5455.6 6310.8 6315.8 6333.7 6337.2 6344.1 6270.6 6296.4 6298.8 6305.9 6309.3 6179.2 6209.3 6234.1 6237.1 6258.3 6215.7 6228.1 6231.8 6238.6 6244.0 5641.1 6271.2 6272.1 6295.4 6315.4 5943.8 6049.5 6075.1 6121.9 6149.6 6130.0 6132.0 6142.4 6145.8 6149.7 5957.6 5980.6 5998.9 6000.5 6008.2 5778.3 6042.6 6050.8 6067.3 6114.1 5995.5 6003.4 6010.6 6012.9 6047.0 20:43:42 INFO - PROCESS | 1634 | 20:43:42 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:55093.35 Median:37651.44 stddev:106641.55 (283.2%) stddev-sans-first:106861.79 20:43:42 INFO - PROCESS | 1634 | Values: 449.9 489.1 500.4 504.4 509.9 31050.0 41230.4 42720.8 42900.0 43084.1 43237.0 43536.6 43602.6 43704.8 43789.6 9204.5 9422.6 9431.1 9438.4 9444.2 8322.0 8527.9 11093.0 11352.4 11390.5 11216.5 11290.5 11296.5 11298.3 11347.4 8308.4 11192.1 11270.7 11288.3 11304.6 8351.7 10986.4 11283.9 11299.9 11430.3 40319.8 40990.6 41258.0 41728.7 41791.2 3981.4 3987.4 4001.0 4015.0 4147.5 31161.8 31228.5 31242.5 31282.0 31320.5 3051.7 3225.4 3283.1 3284.9 3289.3 367550.0 368174.0 369291.2 370317.0 370392.0 60221.0 60659.1 60686.7 60783.8 60863.1 63486.4 63499.0 63537.7 63664.5 63729.0 12668.9 15701.5 15713.0 15752.4 15771.9 10941.5 11271.7 12108.8 12187.2 12216.3 14177.7 15886.7 16171.4 16250.4 16319.2 6282.0 6336.7 7377.4 7458.4 7498.4 817.5 827.8 836.7 841.9 846.3 29825.0 29979.0 30031.4 30864.8 31276.0 1047.8 1055.3 1091.6 1095.5 1212.8 13165.3 15376.4 15480.1 15589.5 16038.8 242870.0 243555.0 243778.0 244236.0 244345.0 59211.4 59479.7 59554.0 59573.0 59660.7 1419.1 1443.7 1451.5 1452.9 1459.7 28754.9 28805.4 29437.0 30510.5 30695.7 49767.0 50288.2 50408.2 50468.2 50562.7 535207.3 535390.0 537153.3 537352.6 537528.0 31809.7 38788.0 39005.8 39574.8 39681.4 39355.0 41110.8 42945.1 47074.3 47169.0 36846.8 37488.4 38850.8 39840.6 40157.0 37814.4 38294.0 38903.8 39909.6 40021.8 37481.7 38758.6 38762.0 38898.6 38928.0 29598.6 31043.7 34411.8 34817.0 35697.1 24585.0 24713.8 24777.9 25122.2 25808.7 20:43:42 INFO - PROCESS | 1634 | 20:43:42 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:38373.61 Median:25203.44 stddev:117920.24 (467.9%) stddev-sans-first:118216.52 20:43:42 INFO - PROCESS | 1634 | Values: 380.5 383.5 392.8 401.9 413.0 13348.6 19709.5 20880.3 20946.9 20990.4 16510.5 17947.9 21175.5 21610.8 21840.9 5684.2 6017.8 6018.2 6027.9 6040.2 5729.6 5823.3 5847.7 5940.7 5962.1 5879.9 5894.6 5904.8 5908.8 5915.3 5666.6 5843.0 5844.4 5875.5 5923.6 5116.6 5121.7 5134.5 5202.9 5203.8 24910.3 25496.6 25934.7 26099.9 26371.9 2993.4 3123.1 3123.6 3130.0 3141.9 15002.1 15600.8 15619.8 15768.8 16419.9 1829.5 1871.9 1872.7 1891.7 1903.3 89712.0 95374.0 115686.3 116732.4 117555.4 10595.9 10697.3 11457.1 11763.3 11893.1 15109.0 15383.4 15420.4 15451.9 15471.1 6479.7 6819.7 8049.3 8338.6 8550.9 8246.8 8268.8 8287.5 8387.8 8479.5 4366.1 4415.3 4722.9 4723.4 4761.5 1634.7 2035.1 2039.2 2040.4 2043.5 939.2 1010.2 1017.3 1017.9 1024.3 21796.0 22101.2 22104.8 22304.3 22500.5 923.6 1024.9 1035.1 1051.8 1060.8 11046.7 11247.0 11465.5 11508.9 11553.7 628695.0 693358.0 736194.0 736270.4 755184.0 136462.0 139582.0 140049.0 143261.0 144534.0 977.4 984.2 986.2 1002.8 1003.9 16799.5 17778.6 18619.3 19299.0 19369.7 40399.6 55545.6 56115.7 57037.7 57256.9 71712.6 80646.0 81044.6 81090.6 82756.2 6817.3 8137.6 8317.3 8483.8 8507.1 10419.4 13023.5 13125.4 13484.6 13619.7 11186.3 11396.9 11411.9 11437.8 11565.7 10228.2 11028.4 11076.5 11476.9 11811.5 10523.7 10820.6 11366.7 11606.8 11625.9 8046.6 8192.0 8247.5 8332.0 8436.5 8346.7 9217.8 9244.6 10476.4 10900.7 20:43:42 INFO - PROCESS | 1634 | 20:43:42 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:5337.92 Median:5096.44 stddev:2931.57 (57.5%) stddev-sans-first:2925.09 20:43:42 INFO - PROCESS | 1634 | Values: 1431.8 1432.2 1442.7 1454.7 1467.0 7949.0 8304.3 8312.6 8314.5 8332.0 6597.7 7351.5 7634.7 8158.4 8164.0 2028.9 2039.3 2048.8 2049.4 2079.7 2278.8 2309.7 2310.1 2311.4 2315.2 1974.1 2214.9 2243.5 2247.6 2279.5 2064.8 2255.0 2270.6 2272.6 2279.1 2104.1 2292.2 2296.2 2297.2 2306.9 8236.5 8280.6 8298.3 8300.7 8347.8 5028.8 5185.1 5186.3 5210.4 5215.3 3013.8 3237.3 3239.2 3469.0 3497.5 1196.6 1220.0 1252.4 1266.7 1270.8 10622.9 10726.2 10737.6 10747.2 10747.5 4331.4 4554.5 4591.9 4636.3 4653.8 9342.6 9346.0 9347.6 9354.9 9355.1 5110.3 5117.5 5194.9 5196.9 5197.4 4186.8 4478.7 4478.8 4521.6 4717.1 3750.7 3772.7 3845.8 3855.1 3886.7 1256.8 1269.7 1270.8 1272.0 1289.4 841.5 874.9 875.1 909.1 931.9 4349.6 4788.7 5002.8 5057.0 5629.8 760.0 850.5 868.8 900.8 984.4 3562.2 3712.9 3756.0 3826.2 3828.3 9457.6 9828.3 9833.3 10038.4 10061.6 9954.0 10038.9 10067.8 10072.9 10086.1 7476.7 7628.8 7677.2 7793.9 7821.2 4587.8 5349.9 5369.7 5484.5 5656.3 8846.5 8850.2 8942.8 8989.3 9178.8 8967.5 9105.3 9151.9 9340.3 9351.6 6526.2 6735.6 6801.7 6826.2 6843.4 7831.1 7920.4 7922.2 7937.6 7945.4 6830.9 6936.0 7087.3 7134.9 7212.3 6927.7 6973.7 7013.0 7095.5 7118.0 6294.2 6421.2 6423.8 6428.3 6429.2 4859.4 4927.2 4936.1 5012.4 5013.2 4814.4 4853.8 4996.5 5082.6 5159.6 20:43:42 INFO - PROCESS | 1634 | 20:43:42 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4401.44 Median:4917.35 stddev:1319.48 (26.8%) stddev-sans-first:1287.67 20:43:42 INFO - PROCESS | 1634 | Values: 350.4 355.9 364.5 371.8 376.6 4865.0 5196.7 5240.2 5263.8 5270.4 4501.8 5180.5 5198.4 5210.0 5246.4 3529.3 3792.8 3850.3 4131.7 4140.2 3661.2 4018.5 4049.0 4057.8 4082.9 3447.0 4046.1 4046.4 4061.6 4136.9 3437.6 3758.9 4072.3 4088.1 4115.6 3441.2 3484.5 3619.7 3623.9 3638.9 4996.3 5035.8 5037.6 5041.7 5096.6 4219.4 4504.9 4647.9 4690.3 4691.3 4296.5 4550.4 5079.3 5476.6 5482.9 3448.8 3790.9 3795.7 3806.5 3816.5 4817.6 5472.4 5657.2 5692.8 5730.6 3651.2 3739.0 3774.1 3832.5 3852.0 3903.6 3904.0 3908.9 3910.2 3912.4 4279.5 4521.6 4547.9 4549.4 4549.7 4831.5 5491.6 5555.3 5561.6 5692.2 1106.9 1260.6 1265.1 1270.4 1271.5 774.7 787.4 852.0 866.0 874.7 4171.4 4460.0 4846.9 4911.4 4935.3 4994.5 5388.1 5398.7 5447.8 5482.8 4324.9 4534.3 4742.7 4834.8 4870.4 2358.5 2737.8 2781.8 2827.5 2860.7 5045.5 5234.6 5527.8 5592.7 5621.9 4726.0 5379.4 5505.7 5631.5 5650.7 5572.7 5577.7 5581.9 5616.3 5630.9 5349.9 5378.6 5387.7 5419.5 5436.8 4715.5 5016.2 5100.6 5295.7 5323.7 4923.3 5475.5 5479.8 5584.7 5693.5 3817.6 3818.7 3825.8 3827.8 3855.6 5101.8 5581.5 5587.2 5639.7 5644.4 4690.7 5194.5 5438.4 5441.0 5487.7 5369.8 5459.0 5473.9 5479.6 5492.4 4540.9 4637.8 5296.6 5365.3 5377.6 5053.2 5120.7 5267.5 5498.5 5509.2 4772.7 4937.2 5015.6 5375.9 5378.9 20:43:42 INFO - PROCESS | 1634 | 20:43:42 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:20322.39 Median:3652.09 stddev:29501.97 (807.8%) stddev-sans-first:29547.97 20:43:42 INFO - PROCESS | 1634 | Values: 708.4 725.8 765.9 771.1 834.7 13406.8 15247.1 15751.5 15779.7 15869.5 14234.9 14368.0 14651.3 14659.9 14660.9 867.5 900.1 901.6 903.9 907.6 697.8 723.3 857.3 891.0 891.2 954.9 956.3 956.9 957.0 957.4 949.3 951.1 952.5 953.7 955.2 544.4 560.3 565.4 566.6 715.6 12298.1 14385.3 14962.5 14984.3 15274.0 14320.5 14411.1 14533.1 14560.0 14950.5 11418.5 11825.0 11874.4 12073.0 12292.8 3698.7 3741.2 3823.1 3858.3 3909.5 101201.0 108792.0 109322.0 109954.0 110013.4 10569.2 10716.8 10981.4 11027.6 11299.8 21959.3 22245.4 22370.2 22456.4 22513.8 7645.8 7702.2 7724.2 7768.8 7852.6 4237.8 4280.5 4290.7 4320.1 4408.1 3438.2 3488.8 3493.1 3517.2 3605.4 656.3 660.0 661.6 662.4 674.7 553.3 652.7 672.5 675.2 696.8 10061.1 10162.8 10363.2 10445.4 10477.5 703.0 717.3 717.9 728.4 728.8 4400.6 4875.5 4882.9 4887.0 4900.3 83924.0 91794.0 109606.0 109973.0 112246.0 91121.1 95515.0 96527.0 97185.0 98235.0 64956.7 69185.0 79341.6 81849.6 84375.6 10450.8 10710.7 10905.5 11037.7 11077.7 39809.6 41462.0 45075.1 46583.5 47225.5 56277.0 60531.0 62618.3 66083.7 66372.7 12353.6 12872.4 12942.7 13058.6 13220.9 14142.8 14159.6 14534.6 14690.6 14936.6 12885.6 12968.1 13071.3 13164.1 13589.0 9460.9 13503.9 13576.3 13938.0 13942.7 12816.8 13088.6 13384.3 13534.7 13646.5 8784.6 10915.7 11147.2 11274.5 11773.8 10447.4 10650.6 10659.3 10670.6 10687.9 20:43:42 INFO - PROCESS | 1634 | -------- Summary: end -------- 20:43:42 INFO - PROCESS | 1634 | 20:43:42 INFO - TEST-INFO | 1634: exit 0 20:43:42 INFO - TEST-OK | dromaeo_css | took 1118472ms 20:43:42 INFO - TEST-START | kraken 20:43:42 INFO - operating with platform_type : mac_ 20:43:42 INFO - Initialising browser for kraken test... 20:43:42 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmpLWrbyH/profile http://localhost:49235/getInfo.html) 20:43:44 INFO - PROCESS | 1644 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 20:43:45 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 20:43:45 INFO - PROCESS | 1644 | colorDepth:24 20:43:45 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 20:43:45 INFO - PROCESS | 1644 | __metrics 20:43:45 INFO - PROCESS | 1644 | 1486010625219 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 20:43:45 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:43:45 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:43:46 INFO - TEST-INFO | 1644: exit 0 20:43:46 INFO - Browser initialized. 20:43:46 INFO - Running cycle 1/1 for kraken test... 20:43:46 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/T/tmpLWrbyH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:43:58 INFO - PROCESS | 1645 | RSS: Main: 237334528 20:43:58 INFO - PROCESS | 1645 | 20:44:00 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 20:44:01 INFO - PROCESS | 1645 | RSS: Main: 290013184 20:44:01 INFO - PROCESS | 1645 | 20:44:04 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 20:44:05 INFO - PROCESS | 1645 | RSS: Main: 293187584 20:44:05 INFO - PROCESS | 1645 | 20:44:08 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 20:44:08 INFO - PROCESS | 1645 | RSS: Main: 382832640 20:44:08 INFO - PROCESS | 1645 | 20:44:10 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 20:44:11 INFO - PROCESS | 1645 | RSS: Main: 283766784 20:44:11 INFO - PROCESS | 1645 | 20:44:13 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:44:14 INFO - PROCESS | 1645 | RSS: Main: 286883840 20:44:14 INFO - PROCESS | 1645 | 20:44:16 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 20:44:17 INFO - PROCESS | 1645 | RSS: Main: 330584064 20:44:17 INFO - PROCESS | 1645 | 20:44:20 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 20:44:21 INFO - PROCESS | 1645 | RSS: Main: 333467648 20:44:21 INFO - PROCESS | 1645 | 20:44:24 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 20:44:24 INFO - PROCESS | 1645 | RSS: Main: 329080832 20:44:24 INFO - PROCESS | 1645 | 20:44:26 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:44:26 INFO - PROCESS | 1645 | RSS: Main: 304824320 20:44:26 INFO - PROCESS | 1645 | 20:44:28 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:44:29 INFO - PROCESS | 1645 | RSS: Main: 309985280 20:44:29 INFO - PROCESS | 1645 | 20:44:31 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:44:32 INFO - PROCESS | 1645 | RSS: Main: 310784000 20:44:32 INFO - PROCESS | 1645 | 20:44:35 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:44:35 INFO - PROCESS | 1645 | RSS: Main: 330276864 20:44:35 INFO - PROCESS | 1645 | 20:44:38 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:44:39 INFO - PROCESS | 1645 | RSS: Main: 324366336 20:44:39 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 20:44:41 INFO - PROCESS | 1645 | RSS: Main: 369659904 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | __start_tp_report 20:44:41 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 20:44:41 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 20:44:41 INFO - PROCESS | 1645 | |i|pagename|runs| 20:44:41 INFO - PROCESS | 1645 | |0;ai-astar;114;115;114;113;114;114;116;114;115;115 20:44:41 INFO - PROCESS | 1645 | |1;audio-beat-detection;144;109;108;145;111;109;110;119;156;135 20:44:41 INFO - PROCESS | 1645 | |2;audio-dft;184;184;185;184;183;184;178;185;184;182 20:44:41 INFO - PROCESS | 1645 | |3;audio-fft;84;57;59;86;60;59;57;59;74;59 20:44:41 INFO - PROCESS | 1645 | |4;audio-oscillator;89;73;85;70;67;69;84;67;68;82 20:44:41 INFO - PROCESS | 1645 | |5;imaging-gaussian-blur;87;86;87;85;87;84;87;84;87;84 20:44:41 INFO - PROCESS | 1645 | |6;imaging-darkroom;96;96;96;95;95;116;166;159;96;96 20:44:41 INFO - PROCESS | 1645 | |7;imaging-desaturate;85;85;86;88;86;84;85;88;86;85 20:44:41 INFO - PROCESS | 1645 | |8;json-parse-financial;58;57;57;56;58;58;59;58;58;58 20:44:41 INFO - PROCESS | 1645 | |9;json-stringify-tinderbox;64;74;76;74;73;69;70;71;71;70 20:44:41 INFO - PROCESS | 1645 | |10;stanford-crypto-aes;85;87;85;84;101;103;106;105;85;86 20:44:41 INFO - PROCESS | 1645 | |11;stanford-crypto-ccm;141;142;137;137;137;140;138;138;180;139 20:44:41 INFO - PROCESS | 1645 | |12;stanford-crypto-pbkdf2;171;173;170;172;172;172;172;170;172;173 20:44:41 INFO - PROCESS | 1645 | |13;stanford-crypto-sha256-iterative;67;68;67;65;67;66;67;66;66;65 20:44:41 INFO - PROCESS | 1645 | __end_tp_report 20:44:41 INFO - PROCESS | 1645 | __start_cc_report 20:44:41 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1960 20:44:41 INFO - PROCESS | 1645 | __end_cc_report 20:44:41 INFO - PROCESS | 1645 | __startTimestamp1486010681393__endTimestamp 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | ------- Summary: start ------- 20:44:41 INFO - PROCESS | 1645 | Number of tests: 14 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 20:44:41 INFO - PROCESS | 1645 | Values: 114.0 115.0 114.0 113.0 114.0 114.0 116.0 114.0 115.0 115.0 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#1] audio-beat-detection Cycles:10 Average:124.60 Median:127.00 stddev:18.49 (14.6%) stddev-sans-first:18.24 20:44:41 INFO - PROCESS | 1645 | Values: 144.0 109.0 108.0 145.0 111.0 109.0 110.0 119.0 156.0 135.0 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:2.06 (1.1%) stddev-sans-first:2.17 20:44:41 INFO - PROCESS | 1645 | Values: 184.0 184.0 185.0 184.0 183.0 184.0 178.0 185.0 184.0 182.0 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#3] audio-fft Cycles:10 Average:65.40 Median:59.50 stddev:11.44 (19.2%) stddev-sans-first:9.96 20:44:41 INFO - PROCESS | 1645 | Values: 84.0 57.0 59.0 86.0 60.0 59.0 57.0 59.0 74.0 59.0 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:77.50 stddev:8.60 (11.1%) stddev-sans-first:7.59 20:44:41 INFO - PROCESS | 1645 | Values: 89.0 73.0 85.0 70.0 67.0 69.0 84.0 67.0 68.0 82.0 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:87.00 stddev:1.40 (1.6%) stddev-sans-first:1.41 20:44:41 INFO - PROCESS | 1645 | Values: 87.0 86.0 87.0 85.0 87.0 84.0 87.0 84.0 87.0 84.0 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#6] imaging-darkroom Cycles:10 Average:111.10 Median:96.00 stddev:27.87 (29.0%) stddev-sans-first:29.02 20:44:41 INFO - PROCESS | 1645 | Values: 96.0 96.0 96.0 95.0 95.0 116.0 166.0 159.0 96.0 96.0 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.32 (1.5%) stddev-sans-first:1.36 20:44:41 INFO - PROCESS | 1645 | Values: 85.0 85.0 86.0 88.0 86.0 84.0 85.0 88.0 86.0 85.0 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 20:44:41 INFO - PROCESS | 1645 | Values: 58.0 57.0 57.0 56.0 58.0 58.0 59.0 58.0 58.0 58.0 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:72.00 stddev:3.36 (4.7%) stddev-sans-first:2.35 20:44:41 INFO - PROCESS | 1645 | Values: 64.0 74.0 76.0 74.0 73.0 69.0 70.0 71.0 71.0 70.0 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:85.00 stddev:9.63 (11.3%) stddev-sans-first:9.80 20:44:41 INFO - PROCESS | 1645 | Values: 85.0 87.0 85.0 84.0 101.0 103.0 106.0 105.0 85.0 86.0 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:139.50 stddev:13.15 (9.4%) stddev-sans-first:13.93 20:44:41 INFO - PROCESS | 1645 | Values: 141.0 142.0 137.0 137.0 137.0 140.0 138.0 138.0 180.0 139.0 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:172.00 stddev:1.06 (0.6%) stddev-sans-first:1.09 20:44:41 INFO - PROCESS | 1645 | Values: 171.0 173.0 170.0 172.0 172.0 172.0 172.0 170.0 172.0 173.0 20:44:41 INFO - PROCESS | 1645 | 20:44:41 INFO - PROCESS | 1645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 20:44:41 INFO - PROCESS | 1645 | Values: 67.0 68.0 67.0 65.0 67.0 66.0 67.0 66.0 66.0 65.0 20:44:41 INFO - PROCESS | 1645 | -------- Summary: end -------- 20:44:41 INFO - PROCESS | 1645 | 20:44:42 INFO - TEST-INFO | 1645: exit 0 20:44:42 INFO - TEST-OK | kraken | took 59600ms 20:44:42 INFO - SUITE-END | took 1178s 20:44:42 INFO - Completed test suite (00:19:38) 20:44:42 INFO - javascript benchmark 20:44:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7214.53045087804, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2823.661160660721, 3216.244182617086, 3343.1474973881654, 3359.47928071149, 3410.3349846779874, 5552.86117847054, 5585.776568937237, 5660.773569057238, 5678.034734095203, 5689.459501347365, 5636.718164091789, 5698.601097923137, 5776.480116789488, 5781.62419442736, 5798.304203495586, 5007.14878470659, 5118.360204974379, 5144.4083930348115, 5183.17069268917, 5186.636935414523, 5118.3857937047605, 5221.660592061523, 5222.712750798704, 5229.8169564065265, 5297.629165958385, 5099.5410413063, 5207.427183009866, 5221.503957124067, 5236.397814251352, 5245.26566280721, 5090.032893750175, 5113.181890897438, 5147.3051138096625, 5163.32876726027, 5181.041507321158, 5085.1355269604255, 5100.438951715309, 5129.358830146231, 5134.589232861399, 5164.92252616211, 5636.04187288162, 5659.122835960433, 5666.291713535808, 5676.460736230051, 5718.199452076713, 6113.174721412597, 6120.020512922628, 6126.548209435026, 6190.84522886927, 6235.7505699771955, 6181.598196117283, 6257.030160325156, 6271.811845644593, 6288.465480434169, 6293.402126797947, 5862.560307976876, 5884.2350494436305, 5890.1164825276555, 5909.143174239797, 5942.97028514859, 6164.352742962014, 6199.0, 6206.131141640174, 6265.71804268809, 6275.215598050244, 5190.740462976836, 5215.817446389358, 6115.43188682724, 6131.969564675065, 6178.351273116348, 5218.817341393033, 6128.3565225651555, 6259.1550140730415, 6284.465820405317, 6294.905576416358, 6105.74009121354, 6109.541784366191, 6148.893199224093, 6188.381161883775, 6202.596831205957, 6237.189165408558, 6253.906191407133, 6261.8747625047245, 6262.843428914313, 6264.906026409608, 4833.589144922721, 4965.428975667773, 4965.677230980047, 4974.353334066621, 5001.024800163933, 3830.3488406970323, 4390.648748100144, 4401.22978478765, 4428.22506061438, 4497.8425755098415, 5746.051901436216, 5787.739551720183, 5791.942080579141, 5811.0411782056335, 5840.8247752567495, 6233.376662333731, 6251.6561589113035, 6265.8746825063245, 6277.717502712298, 6286.339934306923, 5639.407862174413, 5714.314282286152, 5791.7683292667825, 5795.391483894215, 5830.82507524775, 5364.570834333244, 5425.267588875451, 5430.755615997289, 5449.5640348772, 5455.61810673257, 6310.810675679737, 6315.778947736807, 6333.714982825692, 6337.176167098248, 6344.143540621957, 6270.592411493239, 6296.37036296385, 6298.811035668938, 6305.905411418924, 6309.305976342507, 6179.196704428396, 6209.348018458178, 6234.096056071753, 6237.126802247598, 6258.280297765815, 6215.689215539114, 6228.0969259456215, 6231.844203894939, 6238.625682458885, 6243.968780156252, 5641.12562552805, 6271.184745982993, 6272.059191121369, 6295.370462953668, 6315.400036996478, 5943.791967281124, 6049.455549000611, 6075.058365953284, 6121.928662484136, 6149.569530132848, 6130.046409501579, 6132.01899668756, 6142.3550527194, 6145.784897528744, 6149.692515374303, 5957.553183511167, 5980.551458640706, 5998.910016349845, 6000.519958403404, 6008.24896887889, 5778.306603207642, 6042.577019608585, 6050.788222412194, 6067.271927368744, 6114.054067497291, 5995.490383317467, 6003.429674180946, 6010.579259451972, 6012.8797424052145, 6047.0], "value": 5675.587698830558, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.93590159273316, 489.14643946313686, 500.4220125754752, 504.4325134223998, 509.94441506082427, 31050.0, 41230.381544276825, 42720.78639606801, 42900.0, 43084.138317233635, 43237.0, 43536.56463435365, 43602.563974360244, 43704.781476092656, 43789.56210437894, 9204.53977301134, 9422.575984080733, 9431.104045115702, 9438.386504877195, 9444.197243234334, 8322.042965059005, 8527.872081918746, 11093.0, 11352.375619340934, 11390.544378224902, 11216.495257713423, 11290.548378064908, 11296.491657875415, 11298.265612735146, 11347.43262836859, 8308.376871734645, 11192.10463162949, 11270.718232044183, 11288.2662626929, 11304.604338848101, 8351.749447516524, 10986.395748233845, 11283.887161128365, 11299.887001130048, 11430.25703329281, 40319.7984010081, 40990.590094098974, 41257.96855078647, 41728.74813755592, 41791.1641767166, 3981.3828856526993, 3987.441758153861, 4000.959990400117, 4014.979925100385, 4147.460830092099, 31161.844190779128, 31228.53157202621, 31242.53136202959, 31282.0, 31320.53019204691, 3051.67957364478, 3225.3710526447353, 3283.129970557804, 3284.901452956415, 3289.276359200972, 367550.0, 368173.9999999973, 369291.15354423324, 370317.0, 370392.0, 60221.0, 60659.09011364833, 60686.69656651777, 60783.78432431327, 60863.08705369423, 63486.36513634897, 63499.047514287326, 63537.68231158907, 63664.450332450506, 63729.0, 12668.873311266954, 15701.450449234222, 15712.978656387299, 15752.448664296695, 15771.921140394224, 10941.507632156572, 11271.718207044725, 12108.757824843453, 12187.207831491101, 12216.328101954477, 14177.716445671234, 15886.682266354608, 16171.43399980995, 16250.431234906722, 16319.184040797913, 6281.96859015702, 6336.714847831859, 7377.446691498159, 7458.4033277337685, 7498.4001279897475, 817.5217497763756, 827.8261565071402, 836.6987884361625, 841.8653015517488, 846.289117141604, 29824.9970203807, 29979.0, 30031.399372012438, 30864.845675771478, 31276.0, 1047.7956798424234, 1055.3351388625117, 1091.645215305029, 1095.5070218401752, 1212.7816992941355, 13165.341732913315, 15376.38494460209, 15480.052586590347, 15589.454369097028, 16038.839611603968, 242870.0, 243555.0, 243778.0, 244236.0, 244345.0, 59211.40788592145, 59479.702601486715, 59554.0, 59573.0, 59660.701696492106, 1419.1272367494123, 1443.7112577484545, 1451.4774681115002, 1452.9346179421952, 1459.6569806095772, 28754.856225718737, 28805.42389152247, 29437.0, 30510.542341864446, 30695.693043070176, 49767.004659907325, 50288.245676315615, 50408.24387634262, 50468.242976356116, 50562.747186263834, 535207.3239633777, 535390.0, 537153.3142334264, 537352.6264737303, 537528.0, 31809.681903180674, 38788.0, 39005.80497097496, 39574.80212598918, 39681.40477892892, 39355.0, 41110.794446027576, 42945.14109717851, 47074.29388559243, 47169.0, 36846.815765921, 37488.43767343547, 38850.80574597109, 39840.60159398369, 40157.0, 37814.43278350772, 38294.0, 38903.80548097355, 39909.60090399059, 40021.79989100036, 37481.688140914936, 38758.6124138755, 38762.0, 38898.6110138895, 38928.0, 29598.556021660122, 31043.689563104985, 34411.82794086014, 34817.0, 35697.10757230986, 24585.0, 24713.752862471865, 24777.87611061933, 25122.24633260932, 25808.741912580634], "value": 19499.141269901276, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.4768443390337, 383.5383800750857, 392.7525658834934, 401.8934982229709, 412.9628333449989, 13348.619280231302, 19709.50726231845, 20880.269190578332, 20946.89526552367, 20990.370288891358, 16510.504684859443, 17947.910260448713, 21175.470613234676, 21610.783892161075, 21840.890795546038, 5684.2326285951385, 6017.7592896284095, 6018.247719035121, 6027.9095813562835, 6040.244969378828, 5729.627574207684, 5823.330317013534, 5847.736851841656, 5940.673262970535, 5962.105684147369, 5879.941200588003, 5894.557908156884, 5904.822855314347, 5908.822735317947, 5915.319738230094, 5666.603337766358, 5843.0, 5844.386339434341, 5875.500582450497, 5923.614965027259, 5116.590672746172, 5121.667091639031, 5134.486551344873, 5202.92195617066, 5203.8178663746585, 24910.252692419257, 25496.617550736755, 25934.74065259361, 26099.869500652374, 26371.868140659364, 2993.3863557970562, 3123.109913674592, 3123.5783169272313, 3129.9843500782576, 3141.858616362269, 15002.099874007594, 15600.765988510182, 15619.765703514457, 15768.842311576853, 16419.917900410543, 1829.4877434318412, 1871.8689691721586, 1872.6722823505831, 1891.7446144770556, 1903.3243198664552, 89712.0, 95374.0, 115686.26470602948, 116732.41633791776, 117555.4122229392, 10595.894041059491, 10697.304675196243, 11457.140714446283, 11763.294202347886, 11893.075285155877, 15109.017913835565, 15383.38466461329, 15420.383184672712, 15451.922740386226, 15471.14908680011, 6479.6760161991715, 6819.693113809891, 8049.315808156255, 8338.624127019095, 8550.947772534671, 8246.752597422086, 8268.793280168044, 8287.50274983503, 8387.790305242417, 8479.491230526064, 4366.061296821135, 4415.337699345059, 4722.929156062662, 4723.409573803275, 4761.52384761528, 1634.6648936967892, 2035.104553996237, 2039.184326269504, 2040.3776848061484, 2043.5095577061397, 939.1876027236391, 1010.2473657125488, 1017.308230403318, 1017.9389236645825, 1024.257413375297, 21796.0, 22101.226457074248, 22104.778952210592, 22304.330870073925, 22500.549989000127, 923.5613083785282, 1024.8667673202585, 1035.135661722455, 1051.8264486359665, 1060.8408738689104, 11046.723831904106, 11247.044001259821, 11465.541378344773, 11508.942455287837, 11553.711157221136, 628695.0, 693358.0, 736194.0, 736270.4317186738, 755184.0, 136462.0, 139582.0, 140049.0, 143261.0, 144534.0, 977.4428575711776, 984.1978787288338, 986.1666891476691, 1002.7643503776461, 1003.8845532763679, 16799.496015119566, 17778.644427111645, 18619.348322808637, 19299.0, 19369.70945435848, 40399.61518537681, 55545.61135971471, 56115.71942140263, 57037.71481142568, 57256.85486290167, 71712.64143679249, 80646.0, 81044.59477702573, 81090.59454702925, 82756.17243827725, 6817.284185160487, 8137.59312034384, 8317.251447369525, 8483.78790530217, 8507.149285071444, 10419.426931518536, 13023.47906083746, 13125.409356579168, 13484.595462136152, 13619.727605448034, 11186.272892262303, 11396.904643035446, 11411.942940285246, 11437.771244575228, 11565.653030409101, 10228.158931392421, 11028.448577570929, 11076.501557430096, 11476.885231147582, 11811.527538898348, 10523.736906577396, 10820.621278255223, 11366.715832104264, 11606.825897611712, 11625.941870290595, 8046.597670116354, 8192.0, 8247.463914845515, 8332.041815191089, 8436.493810371398, 8346.666133354598, 9217.76955576116, 9244.630214791334, 10476.423796691255, 10900.727481813017], "value": 9827.712198513309, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1431.8294496777391, 1432.176498513355, 1442.7330943775398, 1454.6726986428052, 1466.9779953300695, 7949.0, 8304.252617264452, 8312.625931833067, 8314.459560128587, 8331.958340208306, 6597.703103360348, 7351.485396022281, 7634.656440460179, 8158.388120890927, 8164.020317561886, 2028.9492762680904, 2039.3270220827128, 2048.8156065954063, 2049.3646969439446, 2079.677649964258, 2278.840481166311, 2309.6997390339234, 2310.1336998625516, 2311.4105902994797, 2315.154968436517, 1974.1313821918382, 2214.944626384337, 2243.4503546631017, 2247.550489902018, 2279.4985103277336, 2064.84513661476, 2255.041607316884, 2270.64804955233, 2272.556851413975, 2279.12253782295, 2104.1478201328487, 2292.2435596253194, 2296.1619009061737, 2297.173017713622, 2306.8961896714686, 8236.546989915552, 8280.627371768285, 8298.253157215819, 8300.7094751684, 8347.791305217357, 5028.84913452597, 5185.092608793446, 5186.325777648919, 5210.426853046162, 5215.322008138955, 3013.758899288052, 3237.255431250802, 3239.1902024493875, 3469.028671971852, 3497.5453191085, 1196.5572738086876, 1219.9634010979596, 1252.4113666576695, 1266.683329167708, 1270.7712611729885, 10622.893771062269, 10726.19553533488, 10737.62418315363, 10747.247692661516, 10747.51636176366, 4331.415258940003, 4554.476235232924, 4591.885202869888, 4636.281376386665, 4653.813847446064, 9342.626294948263, 9346.0, 9347.579358928864, 9354.859677104849, 9355.111264429868, 5110.2590124431745, 5117.462666419972, 5194.896102077937, 5196.92204616931, 5197.402298735694, 4186.811593478301, 4478.664100192498, 4478.820847166076, 4521.638268938477, 4717.103750287434, 3750.737448378642, 3772.7359084863797, 3845.8461661533224, 3855.094052897567, 3886.7473614214987, 1256.8303279057393, 1269.7270086931353, 1270.7522033203436, 1272.014189003511, 1289.4004288006122, 841.5413599588117, 874.9212570868525, 875.0855356152836, 909.1136142261242, 931.9440833550009, 4349.630281426114, 4788.736619485892, 5002.824901128443, 5057.0, 5629.831105066854, 759.9962000189963, 850.5067061104545, 868.8479516084786, 900.7838118851429, 984.3749219245831, 3562.1985053362787, 3712.9443058354145, 3755.981220093937, 3826.1773718650625, 3828.2917660232947, 9457.621695132118, 9828.262880283864, 9833.311668183302, 10038.397696138109, 10061.597536098621, 9953.950230248802, 10038.949805251073, 10067.848982265272, 10072.949635251776, 10086.092251697382, 7476.738314159087, 7628.771136865903, 7677.155512893577, 7793.883091753628, 7821.178776228414, 4587.839425620087, 5349.903269829598, 5369.677819330853, 5484.506394424521, 5656.321241451053, 8846.513441760764, 8850.159234872677, 8942.821143576963, 8989.325800564853, 9178.816423671356, 8967.506787126771, 9105.317101217302, 9151.86272205904, 9340.34617576763, 9351.625934962525, 6526.216853977363, 6735.562188457735, 6801.727930882709, 6826.249112597511, 6843.3840954314355, 7831.060272767304, 7920.405969552191, 7922.247386498273, 7937.642806073625, 7945.364370850202, 6830.8633827324165, 6936.028955946071, 7087.255838136922, 7134.928650713634, 7212.3148300911325, 6927.653617319214, 6973.686184121625, 7013.018177455058, 7095.538789978635, 7117.964410178123, 6294.24469063697, 6421.165248517663, 6423.839404014937, 6428.325025872216, 6429.164208652845, 4859.392575928009, 4927.211646136601, 4936.086823937583, 5012.448630650699, 5013.172826483736, 4814.446338671098, 4853.830115945925, 4996.475370086088, 5082.618803589671, 5159.638825282194], "value": 4332.619420420054, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.3973166154214, 355.91458050067985, 364.5242957939889, 371.75090701257386, 376.6064462636546, 4864.951350486498, 5196.688198708081, 5240.240165176047, 5263.76313065912, 5270.393904700951, 4501.819927202916, 5180.507851754087, 5198.439069237575, 5209.973950130254, 5246.370435547739, 3529.347070791912, 3792.772433653976, 3850.3261929162422, 4131.669466442685, 4140.234056699505, 3661.176235347039, 4018.4575082363945, 4048.9595104048876, 4057.756534607918, 4082.8979275518054, 3447.0, 4046.12724965275, 4046.4132700758373, 4061.614146656063, 4136.855210067648, 3437.639047899972, 3758.9099161243207, 4072.3077076897, 4088.1398963471547, 4115.609017143366, 3441.2429265561536, 3484.5121682964404, 3619.7466177367596, 3623.873164439232, 3638.890833275006, 4996.300517927493, 5035.823746168903, 5037.63983724396, 5041.697498150086, 5096.617753668453, 4219.367094935754, 4504.864854054384, 4647.930281045787, 4690.273007683781, 4691.272852707836, 4296.548862369469, 4550.385697930803, 5079.339685840817, 5476.644018138808, 5482.862928426782, 3448.844307458672, 3790.924181516354, 3795.6773674237725, 3806.467094606757, 3816.5038544988975, 4817.590504807095, 5472.398036216013, 5657.15142728594, 5692.832969241337, 5730.570207234432, 3651.1602331463914, 3738.981305093457, 3774.0753515388906, 3832.5017747692623, 3852.016211651002, 3903.6096390361304, 3904.0, 3908.921821563553, 3910.237503686754, 3912.4326972588815, 4279.465066866642, 4521.615662668644, 4547.886302842456, 4549.431321084864, 4549.74693094439, 4831.492693267227, 5491.615586908878, 5555.305676746774, 5561.555075593943, 5692.23154874095, 1106.9169812264113, 1260.6407173955563, 1265.0701734225338, 1270.4283072617359, 1271.491403438632, 774.6630215856121, 787.4369825574742, 851.9606080581681, 865.9565223905179, 874.7200895713438, 4171.436856024458, 4459.955400446019, 4846.927296090562, 4911.414667292896, 4935.284383764334, 4994.4755800640405, 5388.114160044031, 5398.73006349681, 5447.782088716407, 5482.780688772405, 4324.870253892388, 4534.319852022157, 4742.691725037862, 4834.830780922651, 4870.391201099863, 2358.504714010043, 2737.7536021758137, 2781.777457803371, 2827.491051610689, 2860.671022832359, 5045.5459008689395, 5234.607404444682, 5527.778888844482, 5592.728253971472, 5621.8594535136945, 4725.9527404726205, 5379.4351593082165, 5505.687611203304, 5631.549476041907, 5650.666106996891, 5572.665640061609, 5577.693226872561, 5581.944180558143, 5616.297962754656, 5630.915536266959, 5349.893002139857, 5378.606520098519, 5387.653086728318, 5419.485148910847, 5436.782528698808, 4715.5065371412675, 5016.247562865599, 5100.566451851634, 5295.655782374133, 5323.733813309396, 4923.286123512143, 5475.5072043516275, 5479.7944452220445, 5584.664920104807, 5693.4591213836275, 3817.580066192772, 3818.7326887118747, 3825.824565610481, 3827.770333779982, 3855.575886652522, 5101.770420331169, 5581.469760372758, 5587.245721827501, 5639.731060511516, 5644.379118296902, 4690.671652984258, 5194.467632048631, 5438.428964958623, 5440.972795135999, 5487.725613719218, 5369.812056578001, 5459.0, 5473.945260547343, 5479.561635069264, 5492.368377636623, 4540.889490698882, 4637.814487420465, 5296.602754793329, 5365.3293338332705, 5377.569794416516, 5053.155598206555, 5120.718360490208, 5267.499587539178, 5498.45015498447, 5509.201165831012, 4772.7136371817805, 4937.235148316954, 5015.623828212972, 5375.89794092218, 5378.90222813111], "value": 3991.258452897566, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.4367927497639, 725.760499035318, 765.8736308509096, 771.0824119298035, 834.7120243515986, 13406.798898016525, 15247.085174889515, 15751.527454176394, 15779.684406311866, 15869.523914282576, 14234.857651423483, 14367.994240403175, 14651.267436628152, 14659.926700366483, 14660.853391466082, 867.4925168776274, 900.1358695652149, 901.5807649443008, 903.8870141232346, 907.5507623726264, 697.7976386847808, 723.3417589993107, 857.3312816003527, 891.0020776730039, 891.189017993626, 954.8519979403169, 956.2923436656858, 956.8756061712003, 956.9951550871592, 957.3920560444099, 949.292776881228, 951.1107114847605, 952.4666186935269, 953.713885834247, 955.1833182628891, 544.3603765575433, 560.3192121572309, 565.4345654345655, 566.5722379603415, 715.6242972439511, 12298.077644176723, 14385.28073596316, 14962.476313328982, 14984.325705343177, 15274.0, 14320.498782542561, 14411.063280886814, 14533.128012319296, 14560.0, 14950.476733314283, 11418.54325826966, 11825.0, 11874.410055144268, 12073.0, 12292.815607765891, 3698.7410881238325, 3741.2143449875557, 3823.063349479395, 3858.266929283427, 3909.4917660703927, 101201.0, 108792.0, 109321.9999999992, 109954.0, 110013.44993275062, 10569.154467642571, 10716.78566428667, 10981.39602321864, 11027.558897644165, 11299.830502542469, 21959.34121976343, 22245.443863903532, 22370.217042403765, 22456.43858903508, 22513.774862251496, 7645.847083058307, 7702.1912699166905, 7724.188960159215, 7768.84462310762, 7852.646630901623, 4237.788110594458, 4280.464941882265, 4290.656747460258, 4320.135972805451, 4408.096340250241, 3438.1748380388526, 3488.790672559604, 3493.12671832042, 3517.223801979984, 3605.441156620728, 656.2846497317946, 659.9935098974103, 661.573285231033, 662.3674390956625, 674.6795272245743, 553.2917865132637, 652.729117416267, 672.4754691340762, 675.152683382352, 696.7665831946254, 10061.140394809201, 10162.796744065077, 10363.170946324275, 10445.425501597334, 10477.48076528899, 702.9964850175717, 717.3077979749567, 717.8887272472775, 728.4099879097947, 728.7959371376023, 4400.581944715247, 4875.488073752276, 4882.92475697827, 4886.951130488721, 4900.338454308694, 83924.0, 91794.0, 109606.0, 109973.0, 112246.0, 91121.08878911259, 95515.0, 96527.0, 97185.0, 98235.01764982402, 64956.67521662361, 69185.0, 79341.60329198433, 81849.59075204586, 84375.578122109, 10450.790984180121, 10710.73223169427, 10905.454727263446, 11037.724056898642, 11077.723056923642, 39809.62094169581, 41462.0, 45075.098498030515, 46583.53416465792, 47225.527744723484, 56277.0, 60531.0, 62618.29416440459, 66083.66958165179, 66372.668136659, 12353.567625133077, 12872.420741066862, 12942.741145177231, 13058.608241752763, 13220.933895330461, 14142.78785818234, 14159.64600884986, 14534.636634084232, 14690.63273418173, 14936.626584335478, 12885.644381676153, 12968.137521104962, 13071.281079540717, 13164.14433061848, 13589.04876658664, 9460.905390946002, 13503.932480337535, 13576.321183940961, 13938.024338296627, 13942.721145577234, 12816.809192277142, 13088.607341779762, 13384.263865487492, 13534.661633459242, 13646.52237171734, 8784.560771961504, 10915.672529824118, 11147.219694621299, 11274.549018039186, 11773.764524709286, 10447.373157610567, 10650.627228046982, 10659.307145035547, 10670.57317707283, 10687.946560267148], "value": 7496.533886523406, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1448.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 116.0, 114.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 108.0, 145.0, 111.0, 109.0, 110.0, 119.0, 156.0, 135.0], "value": 124.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 185.0, 184.0, 183.0, 184.0, 178.0, 185.0, 184.0, 182.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 57.0, 59.0, 86.0, 60.0, 59.0, 57.0, 59.0, 74.0, 59.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 73.0, 85.0, 70.0, 67.0, 69.0, 84.0, 67.0, 68.0, 82.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 85.0, 87.0, 84.0, 87.0, 84.0, 87.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 116.0, 166.0, 159.0, 96.0, 96.0], "value": 111.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 88.0, 86.0, 84.0, 85.0, 88.0, 86.0, 85.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 56.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 76.0, 74.0, 73.0, 69.0, 70.0, 71.0, 71.0, 70.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 85.0, 84.0, 101.0, 103.0, 106.0, 105.0, 85.0, 86.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 142.0, 137.0, 137.0, 137.0, 140.0, 138.0, 138.0, 180.0, 139.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 170.0, 172.0, 172.0, 172.0, 172.0, 170.0, 172.0, 173.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 65.0, 67.0, 66.0, 67.0, 66.0, 66.0, 65.0], "value": 66.4, "unit": "score"}]}]} 20:44:42 INFO - Return code: 0 20:44:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:44:42 ERROR - # TBPL SUCCESS # 20:44:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:44:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:44:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:44:42 INFO - 2017-02-01 20:44:42.737 screenresolution[1649:9553] starting screenresolution argv=screenresolution get 20:44:42 INFO - 2017-02-01 20:44:42.739 screenresolution[1649:9553] Display 0: 1600x1200x32@60 20:44:42 INFO - 2017-02-01 20:44:42.746 screenresolution[1650:9556] starting screenresolution argv=screenresolution list 20:44:42 INFO - Available Modes on Display 0 20:44:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:44:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:44:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:44:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:44:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:44:42 INFO - Intel Iris: 20:44:42 INFO - Chipset Model: Intel Iris 20:44:42 INFO - Type: GPU 20:44:42 INFO - Bus: Built-In 20:44:42 INFO - VRAM (Dynamic, Max): 1536 MB 20:44:42 INFO - Vendor: Intel (0x8086) 20:44:42 INFO - Device ID: 0x0a2e 20:44:42 INFO - Revision ID: 0x0009 20:44:42 INFO - Displays: 20:44:42 INFO - Display: 20:44:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:44:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:44:42 INFO - Display Serial Number: 1600x1200 60 20:44:42 INFO - Main Display: Yes 20:44:42 INFO - Mirror: Off 20:44:42 INFO - Online: Yes 20:44:42 INFO - Rotation: Supported 20:44:42 INFO - Return code: 0 20:44:42 INFO - Running post-action listener: _resource_record_post_action 20:44:42 INFO - [mozharness: 2017-02-02 04:44:42.982653Z] Finished run-tests step (success) 20:44:42 INFO - Running post-run listener: _resource_record_post_run 20:44:43 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 37823488; Write bytes: 554317824; Read time: 237; Write time: 1677 20:44:43 INFO - TinderboxPrint: CPU usage
53.9% 20:44:43 INFO - TinderboxPrint: I/O read bytes / time
37,823,488 / 237 20:44:43 INFO - TinderboxPrint: I/O write bytes / time
554,317,824 / 1,677 20:44:43 INFO - TinderboxPrint: CPU idle
2,213.3 (46.1%) 20:44:43 INFO - TinderboxPrint: CPU system
964.4 (20.1%) 20:44:43 INFO - TinderboxPrint: CPU user
1,627.9 (33.9%) 20:44:43 INFO - TinderboxPrint: Swap in / out
289,771,520 / 0 20:44:43 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 248838656; Write bytes: 244307968; Read time: 18213; Write time: 544 20:44:43 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34313216; Write bytes: 296607744; Read time: 214; Write time: 1092 20:44:43 INFO - Running post-run listener: _upload_blobber_files 20:44:43 INFO - Blob upload gear active. 20:44:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:44:43 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 20:44:43 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'] 20:44:43 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 20:44:43 INFO - (blobuploader) - INFO - Open directory for files ... 20:44:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:44:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:44:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:44:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:44:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:44:44 INFO - (blobuploader) - INFO - Done attempting. 20:44:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:44:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:44:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:44:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:44:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:44:45 INFO - (blobuploader) - INFO - Done attempting. 20:44:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:44:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:44:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:44:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:44:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:44:46 INFO - (blobuploader) - INFO - Done attempting. 20:44:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:44:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:44:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:44:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:44:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:44:49 INFO - (blobuploader) - INFO - Done attempting. 20:44:49 INFO - (blobuploader) - INFO - Iteration through files over. 20:44:49 INFO - Return code: 0 20:44:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:44:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:44:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af161947f204cdb58db20272aed9f2c2b5e6831e4540844992f463302bc24d8dbc7ca44e4e91b5aa2f15ab159450882260d223cc20a86bf6721a807256280222", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c2f5441073f5e36ef2e7527ad5f3266994e92d45c27fdcd397e6fc90ea5e15babdd189bc2d7f5e0b034094136c442bfb8666a3555229eb9a3919123326c505b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e523f8988ffcce90063e83a4f651bb931f30842f0ce6b3607575499f167066ef9aa3e53c18fc1a77f670f3e7ed670d4be10106d882d85c08b811f271678410d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c52e6405d59aeae6ad4582958d799280d3c94efc8a56fabafcd6e79713b6bf295450ca416fba8ff405ee5f2b4f5eb2706bb0bc6053adef9fe1e71202c62ff4e"} 20:44:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:44:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:44:49 INFO - Contents: 20:44:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af161947f204cdb58db20272aed9f2c2b5e6831e4540844992f463302bc24d8dbc7ca44e4e91b5aa2f15ab159450882260d223cc20a86bf6721a807256280222", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c2f5441073f5e36ef2e7527ad5f3266994e92d45c27fdcd397e6fc90ea5e15babdd189bc2d7f5e0b034094136c442bfb8666a3555229eb9a3919123326c505b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e523f8988ffcce90063e83a4f651bb931f30842f0ce6b3607575499f167066ef9aa3e53c18fc1a77f670f3e7ed670d4be10106d882d85c08b811f271678410d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c52e6405d59aeae6ad4582958d799280d3c94efc8a56fabafcd6e79713b6bf295450ca416fba8ff405ee5f2b4f5eb2706bb0bc6053adef9fe1e71202c62ff4e"} 20:44:49 INFO - Running post-run listener: copy_logs_to_upload_dir 20:44:49 INFO - Copying logs to upload dir... 20:44:49 INFO - mkdir: /builds/slave/test/build/upload/logs 20:44:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.425472 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-01 20:44:49.246389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 20:44:49.250376) ========= 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.Ye5M99bV2E/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.P67koJQKWq/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af161947f204cdb58db20272aed9f2c2b5e6831e4540844992f463302bc24d8dbc7ca44e4e91b5aa2f15ab159450882260d223cc20a86bf6721a807256280222", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c2f5441073f5e36ef2e7527ad5f3266994e92d45c27fdcd397e6fc90ea5e15babdd189bc2d7f5e0b034094136c442bfb8666a3555229eb9a3919123326c505b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e523f8988ffcce90063e83a4f651bb931f30842f0ce6b3607575499f167066ef9aa3e53c18fc1a77f670f3e7ed670d4be10106d882d85c08b811f271678410d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c52e6405d59aeae6ad4582958d799280d3c94efc8a56fabafcd6e79713b6bf295450ca416fba8ff405ee5f2b4f5eb2706bb0bc6053adef9fe1e71202c62ff4e"} build_url:https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011158 build_url: 'https://queue.taskcluster.net/v1/task/CNfUlDoAQeG79M2e_QWLpg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af161947f204cdb58db20272aed9f2c2b5e6831e4540844992f463302bc24d8dbc7ca44e4e91b5aa2f15ab159450882260d223cc20a86bf6721a807256280222", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c2f5441073f5e36ef2e7527ad5f3266994e92d45c27fdcd397e6fc90ea5e15babdd189bc2d7f5e0b034094136c442bfb8666a3555229eb9a3919123326c505b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e523f8988ffcce90063e83a4f651bb931f30842f0ce6b3607575499f167066ef9aa3e53c18fc1a77f670f3e7ed670d4be10106d882d85c08b811f271678410d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c52e6405d59aeae6ad4582958d799280d3c94efc8a56fabafcd6e79713b6bf295450ca416fba8ff405ee5f2b4f5eb2706bb0bc6053adef9fe1e71202c62ff4e"}' ========= master_lag: 0.36 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-01 20:44:49.623298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 20:44:49.623680) ========= 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.Ye5M99bV2E/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.P67koJQKWq/Listeners TMPDIR=/var/folders/yv/7cgcw59j42ddm7qwtql8l57m00000w/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.005069 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-01 20:44:49.673070) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 20:44:49.673428) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-01 20:44:49.673784) ========= ========= Total master_lag: 1.39 =========