builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0047 starttime: 1471421536.04 results: success (0) buildid: 20160816221115 builduid: c8d6926770644070a3748264b2619f35 revision: 72f11467d2cf3ba94248e265acaad58216660210 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 01:12:16.042282) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 01:12:16.042730) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 01:12:16.042998) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 01:12:16.112268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 01:12:16.112712) ========= 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.OieBWXGF42/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.6xy09G0H0H/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-17 01:12:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.2M=0.001s 2016-08-17 01:12:16 (14.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168492 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 01:12:16.312518) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 01:12:16.312839) ========= 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.OieBWXGF42/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.6xy09G0H0H/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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.028343 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 01:12:16.382329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 01:12:16.382738) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 72f11467d2cf3ba94248e265acaad58216660210 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 72f11467d2cf3ba94248e265acaad58216660210 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OieBWXGF42/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.6xy09G0H0H/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-17 01:12:16,465 truncating revision to first 12 chars 2016-08-17 01:12:16,465 Setting DEBUG logging. 2016-08-17 01:12:16,465 attempt 1/10 2016-08-17 01:12:16,465 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/72f11467d2cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 01:12:17,086 unpacking tar archive at: fx-team-72f11467d2cf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.901080 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 01:12:17.309354) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 01:12:17.309619) ========= script_repo_revision: 72f11467d2cf3ba94248e265acaad58216660210 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 01:12:17.309968) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 01:12:17.310239) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 01:12:17.331676) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-08-17 01:12:17.332048) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OieBWXGF42/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.6xy09G0H0H/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 01:12:17 INFO - MultiFileLogger online at 20160817 01:12:17 in /builds/slave/test 01:12:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:12:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:12:17 INFO - {'append_to_log': False, 01:12:17 INFO - 'base_work_dir': '/builds/slave/test', 01:12:17 INFO - 'blob_upload_branch': 'Fx-Team', 01:12:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:12:17 INFO - 'branch': 'Fx-Team', 01:12:17 INFO - 'buildbot_json_path': 'buildprops.json', 01:12:17 INFO - 'config_files': ('talos/mac_config.py',), 01:12:17 INFO - 'default_actions': ('clobber', 01:12:17 INFO - 'read-buildbot-config', 01:12:17 INFO - 'download-and-extract', 01:12:17 INFO - 'populate-webroot', 01:12:17 INFO - 'create-virtualenv', 01:12:17 INFO - 'install', 01:12:17 INFO - 'run-tests'), 01:12:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:12:17 INFO - 'download_minidump_stackwalk': True, 01:12:17 INFO - 'download_symbols': 'ondemand', 01:12:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:12:17 INFO - 'tooltool.py': '/tools/tooltool.py', 01:12:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:12:17 INFO - '/tools/misc-python/virtualenv.py')}, 01:12:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:12:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:12:17 INFO - 'installer_path': 'installer.exe', 01:12:17 INFO - 'log_level': 'info', 01:12:17 INFO - 'log_name': 'talos', 01:12:17 INFO - 'log_to_console': True, 01:12:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:12:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:12:17 INFO - 'opt_config_files': (), 01:12:17 INFO - 'pip_index': False, 01:12:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:12:17 INFO - 'cmd': ('bash', 01:12:17 INFO - '-c', 01:12:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:12:17 INFO - 'enabled': True, 01:12:17 INFO - 'halt_on_failure': False, 01:12:17 INFO - 'name': 'check_screen_resolution'},), 01:12:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:12:17 INFO - 'cmd': ('bash', 01:12:17 INFO - '-c', 01:12:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:12:17 INFO - 'enabled': True, 01:12:17 INFO - 'halt_on_failure': False, 01:12:17 INFO - 'name': 'check_screen_resolution'},), 01:12:17 INFO - 'run_cmd_checks_enabled': True, 01:12:17 INFO - 'sps_profile': False, 01:12:17 INFO - 'sps_profile_interval': 0, 01:12:17 INFO - 'suite': 'dromaeojs', 01:12:17 INFO - 'system_bits': '32', 01:12:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:12:17 INFO - 'title': 't-yosemite-r7-0047', 01:12:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:12:17 INFO - 'use_talos_json': True, 01:12:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:12:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:12:17 INFO - 'work_dir': 'build'} 01:12:17 INFO - [mozharness: 2016-08-17 08:12:17.533533Z] Running clobber step. 01:12:17 INFO - Running pre-action listener: _resource_record_pre_action 01:12:17 INFO - Running main action method: clobber 01:12:17 INFO - rmtree: /builds/slave/test/build 01:12:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:12:19 INFO - Running post-action listener: _resource_record_post_action 01:12:19 INFO - [mozharness: 2016-08-17 08:12:19.633840Z] Finished clobber step (success) 01:12:19 INFO - [mozharness: 2016-08-17 08:12:19.633968Z] Running read-buildbot-config step. 01:12:19 INFO - Running pre-action listener: _resource_record_pre_action 01:12:19 INFO - Running main action method: read_buildbot_config 01:12:19 INFO - Using buildbot properties: 01:12:19 INFO - { 01:12:19 INFO - "project": "", 01:12:19 INFO - "product": "firefox", 01:12:19 INFO - "script_repo_revision": "production", 01:12:19 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 01:12:19 INFO - "repository": "", 01:12:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 01:12:19 INFO - "buildid": "20160816221115", 01:12:19 INFO - "pgo_build": "False", 01:12:19 INFO - "basedir": "/builds/slave/test", 01:12:19 INFO - "buildnumber": 134, 01:12:19 INFO - "slavename": "t-yosemite-r7-0047", 01:12:19 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 01:12:19 INFO - "platform": "yosemite_r7", 01:12:19 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 01:12:19 INFO - "branch": "fx-team", 01:12:19 INFO - "repo_path": "integration/fx-team", 01:12:19 INFO - "revision": "72f11467d2cf3ba94248e265acaad58216660210", 01:12:19 INFO - "stage_platform": "macosx64", 01:12:19 INFO - "builduid": "c8d6926770644070a3748264b2619f35", 01:12:19 INFO - "slavebuilddir": "test" 01:12:19 INFO - } 01:12:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 01:12:19 INFO - Running post-action listener: _resource_record_post_action 01:12:19 INFO - [mozharness: 2016-08-17 08:12:19.637386Z] Finished read-buildbot-config step (success) 01:12:19 INFO - [mozharness: 2016-08-17 08:12:19.637528Z] Running download-and-extract step. 01:12:19 INFO - Running pre-action listener: _resource_record_pre_action 01:12:19 INFO - Running main action method: download_and_extract 01:12:19 INFO - mkdir: /builds/slave/test/build/tests 01:12:19 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')]} 01:12:19 INFO - trying https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 01:12:19 INFO - Downloading https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 01:12:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 01:12:20 INFO - Downloaded 1199 bytes. 01:12:20 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 01:12:20 INFO - Using the following test package requirements: 01:12:20 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 01:12:20 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:12:20 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 01:12:20 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:12:20 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 01:12:20 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:12:20 INFO - u'jsshell-mac.zip'], 01:12:20 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:12:20 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 01:12:20 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 01:12:20 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:12:20 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 01:12:20 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:12:20 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 01:12:20 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:12:20 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 01:12:20 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 01:12:20 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 01:12:20 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:12: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')]} 01:12:20 INFO - trying https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 01:12:20 INFO - Downloading https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 01:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:12:22 INFO - Downloaded 16336651 bytes. 01:12:22 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 01:12:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:12:28 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')]} 01:12:28 INFO - trying https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 01:12:28 INFO - Downloading https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 01:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:12:29 INFO - Downloaded 16336651 bytes. 01:12:29 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 01:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:12:36 INFO - trying https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 01:12:36 INFO - Downloading https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 01:12:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:12:39 INFO - Downloaded 14413981 bytes. 01:12:39 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 01:12:39 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')]} 01:12:39 INFO - trying https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 01:12:39 INFO - Downloading https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 01:12:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 01:12:53 INFO - Downloaded 111222488 bytes. 01:12:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 01:12:53 INFO - mkdir: /builds/slave/test/properties 01:12:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:12:53 INFO - Writing to file /builds/slave/test/properties/build_url 01:12:53 INFO - Contents: 01:12:53 INFO - build_url:https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 01:12:54 INFO - Running post-action listener: _resource_record_post_action 01:12:54 INFO - Running post-action listener: set_extra_try_arguments 01:12:54 INFO - [mozharness: 2016-08-17 08:12:54.435921Z] Finished download-and-extract step (success) 01:12:54 INFO - [mozharness: 2016-08-17 08:12:54.436036Z] Running populate-webroot step. 01:12:54 INFO - Running pre-action listener: _resource_record_pre_action 01:12:54 INFO - Running main action method: populate_webroot 01:12:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:12:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:12:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:12:54 INFO - '--tppagecycles', 01:12:54 INFO - '7'], 01:12:54 INFO - 'tests': ['tsvgm']}}, 01:12:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:12:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:12:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:12:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:12:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:12:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:12:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:54 INFO - 'talos_options': ['--disable-e10s'], 01:12:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:12:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:12:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:54 INFO - 'talos_options': ['--disable-e10s'], 01:12:54 INFO - 'tests': ['damp', 'tps']}, 01:12:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:54 INFO - 'tests': ['damp', 'tps']}, 01:12:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:12:54 INFO - 'tests': ['dromaeo_dom']}, 01:12:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:12:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:12:54 INFO - 'tests': ['basic_compositor_video']}, 01:12:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:12:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:12:54 INFO - 'tests': ['a11yr', 01:12:54 INFO - 'ts_paint', 01:12:54 INFO - 'tpaint', 01:12:54 INFO - 'sessionrestore', 01:12:54 INFO - 'sessionrestore_no_auto_restore', 01:12:54 INFO - 'tabpaint']}, 01:12:54 INFO - 'other-e10s': {'tests': ['a11yr', 01:12:54 INFO - 'ts_paint', 01:12:54 INFO - 'tpaint', 01:12:54 INFO - 'sessionrestore', 01:12:54 INFO - 'sessionrestore_no_auto_restore', 01:12:54 INFO - 'tabpaint']}, 01:12:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:12:54 INFO - 'ts_paint', 01:12:54 INFO - 'tpaint', 01:12:54 INFO - 'sessionrestore', 01:12:54 INFO - 'sessionrestore_no_auto_restore', 01:12:54 INFO - 'tabpaint']}, 01:12:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:12:54 INFO - 'ts_paint', 01:12:54 INFO - 'tpaint', 01:12:54 INFO - 'sessionrestore', 01:12:54 INFO - 'sessionrestore_no_auto_restore', 01:12:54 INFO - 'tabpaint']}, 01:12:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:12:54 INFO - 'tests': ['a11yr', 01:12:54 INFO - 'ts_paint', 01:12:54 INFO - 'tpaint', 01:12:54 INFO - 'sessionrestore', 01:12:54 INFO - 'sessionrestore_no_auto_restore', 01:12:54 INFO - 'tabpaint']}, 01:12:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:12:54 INFO - 'tests': ['a11yr', 01:12:54 INFO - 'ts_paint', 01:12:54 INFO - 'tpaint', 01:12:54 INFO - 'sessionrestore', 01:12:54 INFO - 'sessionrestore_no_auto_restore', 01:12:54 INFO - 'tabpaint']}, 01:12:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:12:54 INFO - 'tests': ['tsvgx', 01:12:54 INFO - 'tsvgr_opacity', 01:12:54 INFO - 'tart', 01:12:54 INFO - 'tscrollx', 01:12:54 INFO - 'cart']}, 01:12:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:12:54 INFO - 'tsvgr_opacity', 01:12:54 INFO - 'tart', 01:12:54 INFO - 'tscrollx', 01:12:54 INFO - 'cart']}, 01:12:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:54 INFO - 'talos_options': ['--disable-e10s'], 01:12:54 INFO - 'tests': ['tp5o']}, 01:12:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:54 INFO - 'tests': ['tp5o']}, 01:12:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:54 INFO - 'talos_options': ['--disable-e10s', 01:12:54 INFO - '--xperf_path', 01:12:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:12:54 INFO - 'tests': ['tp5n']}, 01:12:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:12:54 INFO - 'talos_options': ['--xperf_path', 01:12:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:12:54 INFO - 'tests': ['tp5n']}}, 01:12:54 INFO - 'talos.zip': {'path': '', 01:12:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:12:54 INFO - Running post-action listener: _resource_record_post_action 01:12:54 INFO - [mozharness: 2016-08-17 08:12:54.455343Z] Finished populate-webroot step (success) 01:12:54 INFO - [mozharness: 2016-08-17 08:12:54.455485Z] Running create-virtualenv step. 01:12:54 INFO - Running pre-action listener: _resource_record_pre_action 01:12:54 INFO - Running main action method: create_virtualenv 01:12:54 INFO - Creating virtualenv /builds/slave/test/build/venv 01:12:54 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 01:12:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:12:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:12:54 INFO - Using real prefix '/tools/python27' 01:12:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:12:55 INFO - Installing distribute.............................................................................................................................................................................................done. 01:12:58 INFO - Installing pip.................done. 01:12:58 INFO - Return code: 0 01:12:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:58 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 0x102fb6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff45b5c99e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f1ad30>, '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 0x102c7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f12b20>, '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.OieBWXGF42/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.6xy09G0H0H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 01:12:58 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 01:12:58 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 01:12:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OieBWXGF42/Render', 01:12:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:12:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:12:58 INFO - 'HOME': '/Users/cltbld', 01:12:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:12:58 INFO - 'LOGNAME': 'cltbld', 01:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:58 INFO - 'MOZ_NO_REMOTE': '1', 01:12:58 INFO - 'NO_EM_RESTART': '1', 01:12:58 INFO - 'PAGER': '/bin/cat', 01:12:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:58 INFO - 'PWD': '/builds/slave/test', 01:12:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:12:58 INFO - 'SHELL': '/bin/bash', 01:12:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6xy09G0H0H/Listeners', 01:12:58 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 01:12:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:12:58 INFO - 'USER': 'cltbld', 01:12:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:12:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:58 INFO - 'XPC_FLAGS': '0x0', 01:12:58 INFO - 'XPC_SERVICE_NAME': '0', 01:12:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:58 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 01:12:58 INFO - Cleaning up... 01:12:58 INFO - Return code: 0 01:12:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:58 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 0x102fb6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff45b5c99e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f1ad30>, '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 0x102c7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f12b20>, '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.OieBWXGF42/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.6xy09G0H0H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 01:12:58 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 01:12:58 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 01:12:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OieBWXGF42/Render', 01:12:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:12:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:12:58 INFO - 'HOME': '/Users/cltbld', 01:12:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:12:58 INFO - 'LOGNAME': 'cltbld', 01:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:58 INFO - 'MOZ_NO_REMOTE': '1', 01:12:58 INFO - 'NO_EM_RESTART': '1', 01:12:58 INFO - 'PAGER': '/bin/cat', 01:12:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:58 INFO - 'PWD': '/builds/slave/test', 01:12:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:12:58 INFO - 'SHELL': '/bin/bash', 01:12:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6xy09G0H0H/Listeners', 01:12:58 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 01:12:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:12:58 INFO - 'USER': 'cltbld', 01:12:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:12:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:58 INFO - 'XPC_FLAGS': '0x0', 01:12:58 INFO - 'XPC_SERVICE_NAME': '0', 01:12:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:58 INFO - Downloading/unpacking psutil>=3.1.1 01:12:58 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 01:12:58 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 01:12:58 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 01:12:58 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 01:12:58 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 01:12:58 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 01:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:13:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:13:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:13:03 INFO - Installing collected packages: psutil 01:13:03 INFO - Running setup.py install for psutil 01:13:03 INFO - building 'psutil._psutil_osx' extension 01:13:03 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 01:13:04 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 01:13:04 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 01:13:04 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 01:13:04 INFO - building 'psutil._psutil_posix' extension 01:13:04 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 01:13:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:13:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:13:04 INFO - ^ 01:13:04 INFO - 1 warning generated. 01:13:04 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 01:13:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:13:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:13:04 INFO - Successfully installed psutil 01:13:04 INFO - Cleaning up... 01:13:04 INFO - Return code: 0 01:13:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:13: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')]} 01:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13: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')]} 01:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102fb6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff45b5c99e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f1ad30>, '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 0x102c7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f12b20>, '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.OieBWXGF42/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.6xy09G0H0H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 01:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:13:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OieBWXGF42/Render', 01:13:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:13:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:13:04 INFO - 'HOME': '/Users/cltbld', 01:13:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:13:04 INFO - 'LOGNAME': 'cltbld', 01:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:04 INFO - 'MOZ_NO_REMOTE': '1', 01:13:04 INFO - 'NO_EM_RESTART': '1', 01:13:04 INFO - 'PAGER': '/bin/cat', 01:13:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:04 INFO - 'PWD': '/builds/slave/test', 01:13:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:13:04 INFO - 'SHELL': '/bin/bash', 01:13:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6xy09G0H0H/Listeners', 01:13:04 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 01:13:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:13:04 INFO - 'USER': 'cltbld', 01:13:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:13:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:04 INFO - 'XPC_FLAGS': '0x0', 01:13:04 INFO - 'XPC_SERVICE_NAME': '0', 01:13:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:13:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:13:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:13:07 INFO - Installing collected packages: mozsystemmonitor 01:13:07 INFO - Running setup.py install for mozsystemmonitor 01:13:07 INFO - Successfully installed mozsystemmonitor 01:13:07 INFO - Cleaning up... 01:13:07 INFO - Return code: 0 01:13:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:13:07 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')]} 01:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:07 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')]} 01:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:07 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 0x102fb6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff45b5c99e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f1ad30>, '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 0x102c7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f12b20>, '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.OieBWXGF42/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.6xy09G0H0H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 01:13:07 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 01:13:07 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 01:13:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OieBWXGF42/Render', 01:13:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:13:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:13:07 INFO - 'HOME': '/Users/cltbld', 01:13:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:13:07 INFO - 'LOGNAME': 'cltbld', 01:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:07 INFO - 'MOZ_NO_REMOTE': '1', 01:13:07 INFO - 'NO_EM_RESTART': '1', 01:13:07 INFO - 'PAGER': '/bin/cat', 01:13:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:07 INFO - 'PWD': '/builds/slave/test', 01:13:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:13:07 INFO - 'SHELL': '/bin/bash', 01:13:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6xy09G0H0H/Listeners', 01:13:07 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 01:13:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:13:07 INFO - 'USER': 'cltbld', 01:13:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:13:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:07 INFO - 'XPC_FLAGS': '0x0', 01:13:07 INFO - 'XPC_SERVICE_NAME': '0', 01:13:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:08 INFO - Downloading/unpacking jsonschema==2.5.1 01:13:08 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 01:13:08 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 01:13:08 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 01:13:08 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 01:13:08 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 01:13:08 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 01:13:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:13:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:13:10 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 01:13:10 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 01:13:10 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 01:13:10 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 01:13:10 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 01:13:10 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 01:13:11 INFO - Downloading functools32-3.2.3-2.tar.gz 01:13:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:13:11 INFO - warning: no files found matching '*.txt' 01:13:11 INFO - no previously-included directories found matching 'build' 01:13:11 INFO - no previously-included directories found matching 'dist' 01:13:11 INFO - no previously-included directories found matching '.git*' 01:13:11 INFO - Installing collected packages: jsonschema, functools32 01:13:11 INFO - Running setup.py install for functools32 01:13:11 INFO - warning: no files found matching '*.txt' 01:13:11 INFO - no previously-included directories found matching 'build' 01:13:11 INFO - no previously-included directories found matching 'dist' 01:13:11 INFO - no previously-included directories found matching '.git*' 01:13:11 INFO - Successfully installed jsonschema functools32 01:13:11 INFO - Cleaning up... 01:13:11 INFO - Return code: 0 01:13:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:13: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')]} 01:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13: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')]} 01:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13: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', '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 0x102fb6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff45b5c99e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f1ad30>, '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 0x102c7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f12b20>, '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.OieBWXGF42/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.6xy09G0H0H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 01:13: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:13: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 functools32==3.2.3-2 01:13:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OieBWXGF42/Render', 01:13:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:13:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:13:11 INFO - 'HOME': '/Users/cltbld', 01:13:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:13:11 INFO - 'LOGNAME': 'cltbld', 01:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:11 INFO - 'MOZ_NO_REMOTE': '1', 01:13:11 INFO - 'NO_EM_RESTART': '1', 01:13:11 INFO - 'PAGER': '/bin/cat', 01:13:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:11 INFO - 'PWD': '/builds/slave/test', 01:13:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:13:11 INFO - 'SHELL': '/bin/bash', 01:13:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6xy09G0H0H/Listeners', 01:13:11 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 01:13:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:13:11 INFO - 'USER': 'cltbld', 01:13:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:13:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:11 INFO - 'XPC_FLAGS': '0x0', 01:13:11 INFO - 'XPC_SERVICE_NAME': '0', 01:13:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:13:11 INFO - Cleaning up... 01:13:11 INFO - Return code: 0 01:13:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:13: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')]} 01:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13: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')]} 01:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13: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', '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 0x102fb6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff45b5c99e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f1ad30>, '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 0x102c7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f12b20>, '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.OieBWXGF42/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.6xy09G0H0H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 01:13: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:13: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 blobuploader==1.2.4 01:13:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OieBWXGF42/Render', 01:13:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:13:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:13:11 INFO - 'HOME': '/Users/cltbld', 01:13:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:13:11 INFO - 'LOGNAME': 'cltbld', 01:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:11 INFO - 'MOZ_NO_REMOTE': '1', 01:13:11 INFO - 'NO_EM_RESTART': '1', 01:13:11 INFO - 'PAGER': '/bin/cat', 01:13:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:11 INFO - 'PWD': '/builds/slave/test', 01:13:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:13:11 INFO - 'SHELL': '/bin/bash', 01:13:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6xy09G0H0H/Listeners', 01:13:11 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 01:13:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:13:11 INFO - 'USER': 'cltbld', 01:13:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:13:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:11 INFO - 'XPC_FLAGS': '0x0', 01:13:11 INFO - 'XPC_SERVICE_NAME': '0', 01:13:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:11 INFO - Downloading/unpacking blobuploader==1.2.4 01:13:11 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 01:13:11 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 01:13:11 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 01:13:11 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 01:13:11 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 01:13:11 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 01:13:14 INFO - Downloading blobuploader-1.2.4.tar.gz 01:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:13:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:13:14 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 01:13:14 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 01:13:14 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 01:13:14 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 01:13:14 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 01:13:14 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 01:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:13:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:13:15 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 01:13:15 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 01:13:15 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 01:13:15 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 01:13:15 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 01:13:15 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 01:13:15 INFO - Downloading docopt-0.6.1.tar.gz 01:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:13:15 INFO - Installing collected packages: blobuploader, requests, docopt 01:13:15 INFO - Running setup.py install for blobuploader 01:13:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:13:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:13:15 INFO - Running setup.py install for requests 01:13:16 INFO - Running setup.py install for docopt 01:13:16 INFO - Successfully installed blobuploader requests docopt 01:13:16 INFO - Cleaning up... 01:13:16 INFO - Return code: 0 01:13:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:13:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:16 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 0x102fb6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff45b5c99e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f1ad30>, '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 0x102c7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f12b20>, '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.OieBWXGF42/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.6xy09G0H0H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 01:13:16 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 01:13:16 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 01:13:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OieBWXGF42/Render', 01:13:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:13:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:13:16 INFO - 'HOME': '/Users/cltbld', 01:13:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:13:16 INFO - 'LOGNAME': 'cltbld', 01:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:16 INFO - 'MOZ_NO_REMOTE': '1', 01:13:16 INFO - 'NO_EM_RESTART': '1', 01:13:16 INFO - 'PAGER': '/bin/cat', 01:13:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:16 INFO - 'PWD': '/builds/slave/test', 01:13:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:13:16 INFO - 'SHELL': '/bin/bash', 01:13:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6xy09G0H0H/Listeners', 01:13:16 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 01:13:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:13:16 INFO - 'USER': 'cltbld', 01:13:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:13:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:16 INFO - 'XPC_FLAGS': '0x0', 01:13:16 INFO - 'XPC_SERVICE_NAME': '0', 01:13:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:13:16 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-pusATd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:13:16 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-_1s4ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:13:17 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-_s3BpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:13:17 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-Goc0ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:13:17 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-ZtgEek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:13:17 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-ZnEe3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:13:17 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-8o719R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:13:17 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-KLRk3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:13:17 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-E0jQ1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:13:17 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-Upvt1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:13:17 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-MdMfbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:13:17 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-_HLDjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:13:18 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-R6MUby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:13:18 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-z71yby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:13:18 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-GSaMDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:13:18 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-RsW6BP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:13:18 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-xAJ8Wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:13:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:13:18 INFO - Running setup.py install for manifestparser 01:13:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:13:18 INFO - Running setup.py install for mozcrash 01:13:18 INFO - Running setup.py install for mozdebug 01:13:18 INFO - Running setup.py install for mozdevice 01:13:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:13:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:13:19 INFO - Running setup.py install for mozfile 01:13:19 INFO - Running setup.py install for mozhttpd 01:13:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:13:19 INFO - Running setup.py install for mozinfo 01:13:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:13:19 INFO - Running setup.py install for mozInstall 01:13:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:13:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:13:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:13:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:13:19 INFO - Running setup.py install for mozleak 01:13:19 INFO - Running setup.py install for mozlog 01:13:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:13:20 INFO - Running setup.py install for moznetwork 01:13:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:13:20 INFO - Running setup.py install for mozprocess 01:13:20 INFO - Running setup.py install for mozprofile 01:13:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:13:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:13:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:13:20 INFO - Running setup.py install for mozrunner 01:13:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:13:20 INFO - Running setup.py install for mozscreenshot 01:13:20 INFO - Running setup.py install for moztest 01:13:20 INFO - Running setup.py install for mozversion 01:13:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:13:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:13:21 INFO - Cleaning up... 01:13:21 INFO - Return code: 0 01:13:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:13:21 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')]} 01:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:21 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')]} 01:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:21 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 0x102fb6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff45b5c99e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f1ad30>, '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 0x102c7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f12b20>, '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.OieBWXGF42/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.6xy09G0H0H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 01:13:21 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 01:13:21 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 01:13:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OieBWXGF42/Render', 01:13:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:13:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:13:21 INFO - 'HOME': '/Users/cltbld', 01:13:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:13:21 INFO - 'LOGNAME': 'cltbld', 01:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:21 INFO - 'MOZ_NO_REMOTE': '1', 01:13:21 INFO - 'NO_EM_RESTART': '1', 01:13:21 INFO - 'PAGER': '/bin/cat', 01:13:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:21 INFO - 'PWD': '/builds/slave/test', 01:13:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:13:21 INFO - 'SHELL': '/bin/bash', 01:13:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6xy09G0H0H/Listeners', 01:13:21 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 01:13:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:13:21 INFO - 'USER': 'cltbld', 01:13:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:13:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:21 INFO - 'XPC_FLAGS': '0x0', 01:13:21 INFO - 'XPC_SERVICE_NAME': '0', 01:13:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:13:21 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-_iwuQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:13:21 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)) 01:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:13:21 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-1csyIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:13:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:13:21 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-9toesg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:13:21 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)) 01:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:13:21 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-1shXcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:13:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:13:21 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-1Zqsr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:13:21 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)) 01:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:13:21 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-k5_UiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:13:22 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)) 01:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:13:22 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-0O5_5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:13:22 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)) 01:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:13:22 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-DnV2aE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:13:22 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)) 01:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:13:22 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-J6kSwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:13:22 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)) 01:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:13:22 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-r_nKEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 01:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:13:22 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-F87nYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:13:22 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)) 01:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:13:22 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-ZleUky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:13:22 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-zWiaXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:13:22 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)) 01:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:13:22 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-nk8vH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:13:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:13:22 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-XNRwmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:13:22 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)) 01:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:13:22 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-I3XRe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:13:23 INFO - Running setup.py (path:/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/pip-hgVNsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:13:23 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)) 01:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:13:23 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)) 01:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:13:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:13: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 01:13: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 01:13: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 01:13: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 01:13: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 01:13: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 01:13:25 INFO - Downloading blessings-1.6.tar.gz 01:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:13:25 INFO - Installing collected packages: blessings 01:13:25 INFO - Running setup.py install for blessings 01:13:25 INFO - Successfully installed blessings 01:13:25 INFO - Cleaning up... 01:13:25 INFO - Return code: 0 01:13:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:13:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:13:26 INFO - Reading from file tmpfile_stdout 01:13:26 INFO - Current package versions: 01:13:26 INFO - blessings == 1.6 01:13:26 INFO - blobuploader == 1.2.4 01:13:26 INFO - docopt == 0.6.1 01:13:26 INFO - functools32 == 3.2.3-2 01:13:26 INFO - jsonschema == 2.5.1 01:13:26 INFO - manifestparser == 1.1 01:13:26 INFO - mozInstall == 1.12 01:13:26 INFO - mozcrash == 0.17 01:13:26 INFO - mozdebug == 0.1 01:13:26 INFO - mozdevice == 0.48 01:13:26 INFO - mozfile == 1.2 01:13:26 INFO - mozhttpd == 0.7 01:13:26 INFO - mozinfo == 0.9 01:13:26 INFO - mozleak == 0.1 01:13:26 INFO - mozlog == 3.3 01:13:26 INFO - moznetwork == 0.27 01:13:26 INFO - mozprocess == 0.23 01:13:26 INFO - mozprofile == 0.28 01:13:26 INFO - mozrunner == 6.12 01:13:26 INFO - mozscreenshot == 0.1 01:13:26 INFO - mozsystemmonitor == 0.3 01:13:26 INFO - moztest == 0.7 01:13:26 INFO - mozversion == 1.4 01:13:26 INFO - psutil == 3.1.1 01:13:26 INFO - requests == 1.2.3 01:13:26 INFO - wsgiref == 0.1.2 01:13:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:13:26 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')]} 01:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:26 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')]} 01:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:26 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 0x102fb6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff45b5c99e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f1ad30>, '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 0x102c7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f12b20>, '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.OieBWXGF42/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.6xy09G0H0H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 01:13:26 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 01:13:26 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 01:13:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OieBWXGF42/Render', 01:13:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:13:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:13:26 INFO - 'HOME': '/Users/cltbld', 01:13:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:13:26 INFO - 'LOGNAME': 'cltbld', 01:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:26 INFO - 'MOZ_NO_REMOTE': '1', 01:13:26 INFO - 'NO_EM_RESTART': '1', 01:13:26 INFO - 'PAGER': '/bin/cat', 01:13:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:26 INFO - 'PWD': '/builds/slave/test', 01:13:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:13:26 INFO - 'SHELL': '/bin/bash', 01:13:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6xy09G0H0H/Listeners', 01:13:26 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 01:13:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:13:26 INFO - 'USER': 'cltbld', 01:13:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:13:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:26 INFO - 'XPC_FLAGS': '0x0', 01:13:26 INFO - 'XPC_SERVICE_NAME': '0', 01:13:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:26 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)) 01:13:26 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)) 01:13:26 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)) 01:13:26 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)) 01:13:26 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)) 01:13:26 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)) 01:13:26 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)) 01:13:26 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)) 01:13:26 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)) 01:13:26 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)) 01:13:26 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)) 01:13:26 INFO - Cleaning up... 01:13:26 INFO - Return code: 0 01:13:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:13:26 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')]} 01:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:26 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')]} 01:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:13:26 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 0x102fb6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10304b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff45b5c99e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f1ad30>, '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 0x102c7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f12b20>, '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.OieBWXGF42/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.6xy09G0H0H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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 01:13:26 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 01:13:26 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 01:13:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OieBWXGF42/Render', 01:13:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:13:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:13:26 INFO - 'HOME': '/Users/cltbld', 01:13:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:13:26 INFO - 'LOGNAME': 'cltbld', 01:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:26 INFO - 'MOZ_NO_REMOTE': '1', 01:13:26 INFO - 'NO_EM_RESTART': '1', 01:13:26 INFO - 'PAGER': '/bin/cat', 01:13:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:26 INFO - 'PWD': '/builds/slave/test', 01:13:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:13:26 INFO - 'SHELL': '/bin/bash', 01:13:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6xy09G0H0H/Listeners', 01:13:26 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 01:13:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:13:26 INFO - 'USER': 'cltbld', 01:13:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:13:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:26 INFO - 'XPC_FLAGS': '0x0', 01:13:26 INFO - 'XPC_SERVICE_NAME': '0', 01:13:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:13:26 INFO - Cleaning up... 01:13:26 INFO - Return code: 0 01:13:26 INFO - Running post-action listener: _resource_record_post_action 01:13:26 INFO - Running post-action listener: _start_resource_monitoring 01:13:26 INFO - Starting resource monitoring. 01:13:26 INFO - [mozharness: 2016-08-17 08:13:26.812423Z] Finished create-virtualenv step (success) 01:13:26 INFO - [mozharness: 2016-08-17 08:13:26.813434Z] Running install step. 01:13:26 INFO - Running pre-action listener: _resource_record_pre_action 01:13:26 INFO - Running main action method: install 01:13:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:13:27 INFO - Reading from file tmpfile_stdout 01:13:27 INFO - Detecting whether we're running mozinstall >=1.0... 01:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:13:27 INFO - Reading from file tmpfile_stdout 01:13:27 INFO - Output received: 01:13:27 INFO - Usage: mozinstall [options] installer 01:13:27 INFO - Options: 01:13:27 INFO - -h, --help show this help message and exit 01:13:27 INFO - -d DEST, --destination=DEST 01:13:27 INFO - Directory to install application into. [default: 01:13:27 INFO - "/builds/slave/test"] 01:13:27 INFO - --app=APP Application being installed. [default: firefox] 01:13:27 INFO - mkdir: /builds/slave/test/build/application 01:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:14:01 INFO - Reading from file tmpfile_stdout 01:14:01 INFO - Output received: 01:14:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:14:01 INFO - Running post-action listener: _resource_record_post_action 01:14:01 INFO - [mozharness: 2016-08-17 08:14:01.020449Z] Finished install step (success) 01:14:01 INFO - [mozharness: 2016-08-17 08:14:01.020623Z] Running run-tests step. 01:14:01 INFO - Running pre-action listener: _resource_record_pre_action 01:14:01 INFO - Running main action method: run_tests 01:14:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:14:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:14:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:14:01 INFO - 2016-08-17 01:14:01.035 screenresolution[1635:8052] starting screenresolution argv=screenresolution get 01:14:01 INFO - 2016-08-17 01:14:01.037 screenresolution[1635:8052] Display 0: 1600x1200x32@60 01:14:01 INFO - 2016-08-17 01:14:01.043 screenresolution[1636:8054] starting screenresolution argv=screenresolution list 01:14:01 INFO - Available Modes on Display 0 01:14:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:14:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:14:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:14:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:14:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:14:01 INFO - Intel Iris: 01:14:01 INFO - Chipset Model: Intel Iris 01:14:01 INFO - Type: GPU 01:14:01 INFO - Bus: Built-In 01:14:01 INFO - VRAM (Dynamic, Max): 1536 MB 01:14:01 INFO - Vendor: Intel (0x8086) 01:14:01 INFO - Device ID: 0x0a2e 01:14:01 INFO - Revision ID: 0x0009 01:14:01 INFO - Displays: 01:14:01 INFO - Display: 01:14:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:14:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:14:01 INFO - Display Serial Number: 1600x1200 60 01:14:01 INFO - Main Display: Yes 01:14:01 INFO - Mirror: Off 01:14:01 INFO - Online: Yes 01:14:01 INFO - Rotation: Supported 01:14:01 INFO - Return code: 0 01:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:14:01 INFO - Python 2.7.3 01:14:01 INFO - Return code: 0 01:14:01 INFO - grabbing minidump binary from tooltool 01:14:01 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')]} 01:14:01 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 0x102f1ad30>, '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 0x102c7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102f12b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:14:01 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 01:14:01 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 01:14:01 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 01:14:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:14:01 INFO - Return code: 0 01:14:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:14:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:14:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:14:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:14:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:14:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0047', '--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 01:14:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0047 --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 01:14:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OieBWXGF42/Render', 01:14:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:14:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:14:01 INFO - 'HOME': '/Users/cltbld', 01:14:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:14:01 INFO - 'LOGNAME': 'cltbld', 01:14:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:14:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:14:01 INFO - 'MOZ_NO_REMOTE': '1', 01:14:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:14:01 INFO - 'NO_EM_RESTART': '1', 01:14:01 INFO - 'PAGER': '/bin/cat', 01:14:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:14:01 INFO - 'PWD': '/builds/slave/test', 01:14:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:14:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:14:01 INFO - 'SHELL': '/bin/bash', 01:14:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6xy09G0H0H/Listeners', 01:14:01 INFO - 'TMPDIR': '/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/', 01:14:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:14:01 INFO - 'USER': 'cltbld', 01:14:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:14:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:14:01 INFO - 'XPC_FLAGS': '0x0', 01:14:01 INFO - 'XPC_SERVICE_NAME': '0', 01:14:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:14:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0047', '--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 01:14:01 INFO - mozversion application_buildid: 20160816221115 01:14:01 INFO - mozversion application_changeset: 72f11467d2cf3ba94248e265acaad58216660210 01:14:01 INFO - mozversion application_display_name: Nightly 01:14:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:14:01 INFO - mozversion application_name: Firefox 01:14:01 INFO - mozversion application_remotingname: firefox 01:14:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:14:01 INFO - mozversion application_vendor: Mozilla 01:14:01 INFO - mozversion application_version: 51.0a1 01:14:01 INFO - mozversion platform_buildid: 20160816221115 01:14:01 INFO - mozversion platform_changeset: 72f11467d2cf3ba94248e265acaad58216660210 01:14:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:14:01 INFO - mozversion platform_version: 51.0a1 01:14:01 INFO - using testdate: 1471421641 01:14:01 INFO - actual date: 1471421641 01:14:01 INFO - starting webserver on 'localhost:49267' 01:14:01 INFO - SUITE-START | Running 2 tests 01:14:01 INFO - TEST-START | dromaeo_css 01:14:01 INFO - operating with platform_type : mac_ 01:14:01 INFO - Initialising browser for dromaeo_css test... 01:14:01 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpwMa3hp/profile http://localhost:49267/getInfo.html) 01:14:03 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 01:14:03 INFO - PROCESS | 1646 | colorDepth:24 01:14:03 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 01:14:03 INFO - PROCESS | 1646 | __metrics 01:14:04 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:14:04 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:14:04 INFO - TEST-INFO | 1646: exit 0 01:14:04 INFO - Browser initialized. 01:14:04 INFO - Running cycle 1/1 for dromaeo_css test... 01:14:04 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpwMa3hp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:14:16 INFO - PROCESS | 1649 | RSS: Main: 226181120 01:14:16 INFO - PROCESS | 1649 | 01:15:08 INFO - PROCESS | 1649 | 1471421708014 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:17:20 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 01:17:21 INFO - PROCESS | 1649 | RSS: Main: 340430848 01:17:21 INFO - PROCESS | 1649 | 01:20:24 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 01:20:24 INFO - PROCESS | 1649 | RSS: Main: 371474432 01:20:24 INFO - PROCESS | 1649 | 01:23:27 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 01:23:28 INFO - PROCESS | 1649 | RSS: Main: 360689664 01:23:28 INFO - PROCESS | 1649 | 01:26:30 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 01:26:31 INFO - PROCESS | 1649 | RSS: Main: 353492992 01:26:31 INFO - PROCESS | 1649 | 01:29:34 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 01:29:35 INFO - PROCESS | 1649 | RSS: Main: 333352960 01:29:35 INFO - PROCESS | 1649 | 01:32:38 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 01:32:38 INFO - PROCESS | 1649 | RSS: Main: 507219968 01:32:38 INFO - PROCESS | 1649 | 01:32:38 INFO - PROCESS | 1649 | __start_tp_report 01:32:38 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 01:32:38 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 01:32:38 INFO - PROCESS | 1649 | |i|pagename|runs| 01:32:38 INFO - PROCESS | 1649 | |0;dojo.html;3314.105191598268;3341.732661387089;3344.3311337732453;3361.932761344775;3399.1672040350104;5527.115661494162;5601.383847776747;5651.802186923458;5699.629524080932;5702.173184888189;5637.943620563793;5688.203651488795;5695.74369153388;5696;5700.087985922243;5153.69077855328;5188;5202.401723801773;5222.869428264305;5269.262303277545;4032.6572241359518;5198.45416231296;5207.661502002376;5226.242194881759;5240.528352448279;5138.383393992707;5162.251473536335;5188.610854185932;5207.765650545734;5226.7647955841885;5234.607404444644;5256.526912577886;5264.473552644743;5264.710440925747;5313.309269794902;5072.0870243356185;5093.0577843099145;5093.847184584469;5187.559057480119;5208.218767184915;5598.916016259759;5622.746976386073;5628.605997580171;5630.465105814982;5646.20953066571;6202.224721909762;6205.5345849061505;6212.81361559154;6214.875702485925;6226.533010024221;6063.291643431861;6191.2570491540855;6213.409726076015;6278.277998030239;6280.183576135073;5821.417858214145;5831.183634291203;5853.560982926298;5858.765649373977;5862.472377485961;6387;6395.360463953567;6396.776112836028;6409.551331406757;6415.486761059104;5900.468957793733;5999.280086389661;6073.331933487313;6074.75700971965;6092.268843234487;6214.036824292242;6241.656708881055;6245.094461303085;6251.937480625226;6252.531060170414;6102.7558897644485;6141.447269745744;6158.846028849314;6163.952128138228;6166;5982.371850955674;6028.156058151862;6034.577579569388;6181.84545386369;6188.969055154786;4893.168161412568;4910.116179087799;4930.6795058321095;4931.137051016058;4935.21036634144;4345.587169218919;4448.888777780581;4461.24158892989;4494.842680506166;4525.502194758574;5626.803061892814;5631.324241091095;5657.32112146545;5671.177679236487;5729.427057294237;6215.160953271251;6297.874042519124;6301;6305.5901366411035;6319.431251187415;5539.390667026624;5598.664080155204;5607.495325420732;5660.405657405913;5670.603057785998;5366.168243922199;5377.973110134502;5388.676679399248;5395.05586522357;5407.134858422633;6333.714982825876;6378.712957916812;6384.32964538726;6394.840128996812;6408.327125651739;5788.710564471844;5878.647281163144;6098.0852872069545;6152.969235153795;6276.278228003838;6343.016832390987;6368.108464814837;6379.808605741835;6383.5212359074185;6392.3927226913365;6150.415710507495;6179;6181.721822518088;6193.907091393543;6199.752009919553;6066.757329706762;6163.568550201443;6217.316095229611;6231.594946328474;6297.992321228581;6039.456448919618;6108.847278818065;6110.26676798787;6113.5414843886;6137.140800287874;6092.086187071975;6102.908456373247;6103.969480152571;6115.847103822262;6125.019996800491;5041.495850414929;5567.610267281251;5658.349289831722;5699.202111704448;5715.685637289989;4859.2954021667365;5883.146943693226;5891.675957822361;5894.941050589439;5924.229850119629;5696.088625819849;5733.885322293448;5747.166660834072;5750.338711048115;5750.5112065474905 01:32:38 INFO - PROCESS | 1649 | |1;ext.html;485.23090900922034;503.65021741732164;510.0411226893442;523.0611053159578;526.9710165940874;31253.687463125363;32952;41216;42182.367264491055;42374.57625423745;43761;44035;44188;44233.89415264612;44261.336079958826;9728.70813875583;9883.604655813759;9898.010198980117;9901.059399357086;9905.20758339331;8751.212390884819;8951.552422378887;8968.775780605505;8978.685745998891;9634.75913102171;8968.686095986643;11866.821997670042;12206.45070971804;12236.143469957107;12461.750764984696;12067.456964436622;12193.39033048353;12193.695157621041;12197.329146896916;12222.877771222351;12021.218620789708;12070.637880863587;12081.758364832654;12092.093093018058;12104.636860894187;40654.39018414726;40999;41036.1792764143;41057.973550661176;41063.384049239285;3389.1018879996823;3399.847006884696;3416;3423.9144021399416;3621.257642183346;31767.84116079428;32039.359212815612;32945.83527082373;33299.33401331984;34391.14022149441;2871.310885387513;3249.9187520311943;3292.0782180989363;3314.4696848504122;3384.4415671414185;473264;480221;481829;483791;488528.5573572145;62186.689066554376;62683;62789.68605157037;62827.6858615704;62914.68542657257;34022.48966265508;34471.82764086164;34768;65982;66300;16348.75476867848;16835.158242087848;16840.9895406276;16846.66306673884;16847.41034063802;12830.294333811544;12949.676258093434;12959.157654752411;12971.610851674464;12983.221006739626;16945.661086778196;17270.481885543453;19403.223871045;19499.8050019498;19516.707249390987;6880.965595172092;6942.444604431634;7579.696812127563;7713.884291735629;7752.224777522316;889.3241136736127;983;1006.7030226083323;1012.3925644613173;1025.5436330832708;30466.695333046828;30611.234719131753;30959.69040309568;31148;31611.683883160873;1081.1458947431597;1093.420487141816;1100.1858624617726;1138.9066496163775;1140.4126874659557;15604.531864044096;15701.528954131394;15946.60133496672;16053.839461605468;16088;609429;612839;622623;627462;632232;51904.22143667848;58989;59643.70178149168;59841.700791495765;60189.39810601838;1182.1901997131993;1343.5499107798996;1395.0304538345752;1396.5461225101678;1398.321813920248;30199.09402717922;31197.53203701901;31198;31727.84136079305;32207.35585288328;51533.7423312881;51991;52011.21983170331;52037.7398113007;52202.21696674629;539654;863942;884728;886689;887070;42868;42892.78553607212;43110.35334470048;43351;43858.56141438545;47174;47717;48726;48734.512654873;48815.5118448811;38591;38920.80539597284;39201.411978820914;39795;40496.79751601223;35354.58581656705;36695.02669960913;39674;39692;40338;38401.847944561705;38441;38704.03239919025;39100.02249943774;39222.60777392304;32727.018189454353;32918.835405822814;34138.65861341454;34435.4834677475;34602.13494662654;22492.887535562873;25035.749642503342;25083.122090726738;25619.6157057648;25746 01:32:38 INFO - PROCESS | 1649 | |2;jquery.html;304.5644728038904;347.04735501049623;367.86572900891184;372.7614326830828;398.2353880549345;15200.543983680493;17456.650866982654;20255.797442025574;20517.179312827488;20955.580888382225;16241.593960151002;20736.89631551844;20748.688769668468;20981.16075356984;21232.681509777365;4948.886500537386;5437.483439073291;5653.745581448824;5664.830055098354;5673.914891276634;3969.563348031714;4174.77038762868;6114.113453549233;6144.5084393248435;6206.038064100049;6609.504287178457;6921.342472465108;6947.166340039203;6956.478264130185;6987.965060174692;6579.144711187539;6781.152355955505;6819.897701534481;6835.07726456927;6920.861582768342;5306.92039619406;6015.518758499309;6024.126501657235;6029.095635654687;6030.788922387739;13241.404136813866;13905.165690058528;13907.304634768221;13919.652008699763;18099.366522171662;2172.6415141501634;2212.192549719357;2300.2064287820676;2305.216226483004;2951.3359494113865;9131.26949844011;9918.206543476505;10014.24893133018;10071.5467803949;14579.781303280459;1495.461633811827;1704.6675898199856;1738.1048759888668;1776.8450507170442;1841.2542920117373;96041;120008;125532.37233813864;129218.35390822985;130445;10874.130069594414;11429.485673144729;11517.827232591519;11713;11917.940410297893;12151.635450936486;14669.853301466848;14671.33978970949;14709.485168019282;14716.117032978056;7764.572948487775;8222.958885205655;8445.57772111392;8723.956380218058;8841.911580884238;7039.612821294775;7116.964415177891;8718.258947989365;8718.302535797122;8895.822083558292;4468.79890404926;4567.2464043432465;4569.840055598038;4646.117237724821;4659.720416775004;1771.16755125091;1821.9908900455414;1892.2241880828794;1914.7406060848332;1931.4355372148605;819.6885183630183;905.3210092430677;927.4157280912982;958.726762872592;1027.6249169053242;20163.19347226124;21499.738851443715;21719.67420488694;21759.347219583437;21895.562088758135;908.1145882764253;935.5696379665294;970.8106919150839;977.4917043137528;1003.4681618742078;9953.900460995443;11351.772964540829;11524.596639117759;11542.769144617228;11561.132915031407;613935;616836;623730.6440403397;630254;635979;127090;128408.35795821148;146281.5371846268;148702;150534;979.294907666479;982.9655962041294;1019.6686077024997;1022.0392830739081;1025.0364657222187;11059.557617695202;18262.634747305245;18811.24755009839;20085.58545047316;20140.79859201448;57242.634987911726;57333;57793.9772107991;57798;58410.12384814146;60103.39896600978;76280;78543;80943.59528202322;82180;7862.52824830512;7981.760547183594;8048.1147073823;8341.749747507585;8560.101189375026;11986.220895641756;12945.417456214305;13088;13458;13533.661658458617;8963.59663815143;9936.751581210528;10821.593192884875;11810.881891180978;11864.822027669765;10580.259381843505;10928.726781830517;10934.56261749521;11270.267432616854;11524.250923689933;11520.769584608428;11612.709682258012;11682;11994.280343179436;12035.277883327028;8009.399295053011;8069.636866341146;8268.932766808299;8309.418340716093;8462.746117616482;8445.831083378174;10908.672739817817;11160.162987776112;11244.144716122075;11493.770124597628 01:32:38 INFO - PROCESS | 1649 | |3;mootools.html;1417.8369487508935;1497.393555609978;1638.7787648667434;1794.7128459446492;1826.6164105537837;8432.494050356983;8924.241439477635;8931.776705582364;8935.419197752142;8979.236764874993;7829.608519574027;8079.515229086259;8326.209010144043;8653.394262401634;8710.782230444242;2329.4176455886027;2381.785639292463;2381.8928148233285;2381.988090059547;2384.3204686664303;2345.64815277708;2359.6785799951995;2386.9761302387014;2394.162043284845;2398.3524448399007;2360.3980984848927;2382.332946774906;2391.0794344177443;2394.221877889684;2396.508715713275;2317.617593097137;2325.2210509479346;2334.159702507096;2338.3101984914492;2362.350353652742;2338.088145623208;2365.065799009382;2366.420227044368;2368.052778888441;2370.383700237933;8125.959370203171;8196.42625016249;8197.139300373494;8204.8359032819;8212.917870821275;5141.357330333708;5294.52349288562;5299.099153143936;5304;5320.733963301858;3252.918677033093;3305.5537502437105;3328.73370130389;3359.748018898568;3613.1509095362567;1057.1278695076517;1059.1262208677795;1068.9679309620724;1082;1086.5708045322053;9640.276979226586;11408.714782130513;11657.183997120204;11667.183297169202;11698;4604.700694454849;4662.790174442158;4868.172410690191;4882.438519570295;4885.438174609894;10049.145822605014;10059.64791232318;10061.993800620026;10063.949680251699;10068.194544436428;5410.567154627621;5419.539339156216;5421.159720243369;5424.213489044067;5424.484673955968;4406.27296496081;4597.931031034537;4789.544993225638;4904.558589726942;4946.060248552763;3890;3952.150287688103;3996.300647386696;4040.939385909214;4059.9797001014804;1286.395394164741;1314.3625341709455;1314.7962065879804;1325.509561462265;1330.6427444007059;772.559641004622;907.3195103672246;912.3031162038603;915.1626261970223;916.7937214126769;5592.5805564582815;5685;5788.102844059177;5801.027650598817;6027.156198132265;441.5209497694973;452.6582430265129;452.75098695717224;457.1884904294837;458.28049961560697;3888.3778595424596;3939.625735555118;3993.880183594497;3997.960020399759;4027.0536423940353;7763.301302882654;10700.250982431155;10816;10825.83761243582;10830.350178989129;10375.066244038073;10751.784964300827;10754.73113172177;10764.085052770446;10779.461026948622;8062.314703250172;8251.669933202606;8253.174682531819;8256.504609723435;8304.83390332202;5288.233206185005;5704.0588302929555;5736.4550367715;5741.827745167651;5805.854853628524;9802;10020.549075291483;10064.345817521838;10104.393736375841;10157.746056348651;8592.957035214784;9650.903490965282;10155.593776248867;10157.644482443078;10233.74415639615;6929.757458488929;7173.0675012248075;7308.451866110169;7491.438142139253;7671.808204794925;8175.79560510992;8484.830303394021;8498.872516912128;8499.617517211616;8506.532140732319;7331.890021649786;7424;7466.25337466249;7548.773536793905;7570.9242907570215;7269.491135620456;7279.818004549928;7292.234315396807;7408.518446300973;7500.062492188476;6844.794656160323;7016.19313778922;7025;7028.578285302899;7057.7176912922905;4898.657094003385;4944.752762361795;4973.129702302011;5015.473375295687;5082.313887625123;4792.616590672807;4883.229283495286;4900.779464924016;5125.1799712045895;5156.097682905402 01:32:38 INFO - PROCESS | 1649 | |4;prototype.html;290.61058182036066;302.4857741838874;312.10114869176766;314.50779530035504;316.38147421790404;4609.966279505433;5030.245463180525;5215.217717342401;5233.86915327117;5294.523492885644;4463.152001119785;4580.5419458054175;4768.783960090181;4850.447856685862;5188.351456067991;3283.456775315604;3842.3852183650483;3995.8002099895034;3999.300122478569;4015.0765323975356;4009.5589485156756;4011.8595849145286;4018.1361007383407;4023.5574086850424;4044.4631040204827;3679.797611131387;3944.2900277950102;3956.76259424434;3988.5213774346976;3997.2804895118866;3254.658260882609;3269.673032696735;3629.237860049393;3957.56466788653;3960.425738267964;3409.3010932758725;3423.2811109667;3429.7652844975787;3435.5362026126654;3438.381091403546;4912.214140587138;5084.56781173597;5097.617678674077;5116.718580478072;5124.538791508745;3693.3905905525558;4361.171377438277;4456.994352541369;4520.344550040226;4533.863984080483;4504.617107545862;4939.753012349404;5461.754221060062;5500.28496295483;5520.171974203861;3788.7726736395903;3792.563855156665;3797.9810100949594;3799.848006079781;3806.809659517013;4388.05656783793;4790.281457781326;5594.929875945885;5608.915866262009;5742.186328698949;3081.845907704606;3361.4453615153716;3821.3885778275344;3821.38857782759;3836.506270923922;3210;3566.0728210665416;3887.2031233597045;3895.182011777502;3906.980465097656;3961.16815468749;4186.518550366747;4227.894302642397;4488.214562451558;4549.7042692224895;5243.898781255979;5496.532794712414;5510.586705997066;5513.04286978125;5543.780368318963;1118.8265818797936;1170.5961443302047;1327.1638867513404;1328.2827273272517;1333.9666508337175;644.6679959820696;745.7949064007333;814.9470284431493;815.8409110223569;831.5364957674416;3403.217260030207;4034.455348527911;4162.812673429703;4278.908878236092;4342.717723347972;4074.7758873262255;4390.868273951786;4656.2517173675515;4740.525947405232;4759.6668233223345;3750.3811871041516;3978.5225772906856;3999.420084087791;4318.654507639444;4339.414179085846;2214.490667146565;2225.7662945390825;2281.243442549228;2488.8008959283216;2500.312414086141;4332.26351520236;4884.972736314461;4897.824522114738;4905;4921.8523444296725;4189.853355132555;4332.631726303236;4552.860155726803;4820.421549414023;4851.908320627901;4672.696274742131;4739.763011849463;4930.728809915489;5882.852928676817;5981.461668449686;5685.555211259199;5700.657960522382;5706.714664266853;5708.429157084258;5768.682722450306;5050.823221187241;5204.583633309402;5718.3702644746045;5727.570432217683;5747.482726554463;5094.592432605308;5612.410696876769;5685.175649530877;5923.881522369442;5925.466707996301;3500.0724807925412;3828.3109040373;3853.3834586466032;3862.1889403224513;3869.303525365461;4605.953940460552;5377.516023557899;5619.538919880943;5716.628419152742;5736.856578585569;4820.734859582757;4992.675476094042;5040.243963405518;5270.657407268515;5288.709120998382;4777.976110119427;4780.665353425227;5555.666660000413;5573.275474188492;5616.6068375213345;4933.925991110208;5228;5449;5470.699111548903;5495.818399044225;5511.905475919125;5525.254090697705;5536.446355364431;5552.305961754781;5579.656544251343;4034.4150098236178;5430.51125398716;5442.401335853132;5500.477454641803;5502.312210973629 01:32:38 INFO - PROCESS | 1649 | |5;yui.html;772.3087836386433;787.8969442780107;790.8497385496755;814.767791179514;828.9046759622645;15290.46483373082;15698.529044128665;16290.592735181626;16334.18329083547;16372.508824735278;12337.629871103858;14897.776533351982;15088.396464141448;15127.621809454742;15128.24358782062;676.6751959059654;837.4054421360826;849.2229609906927;851.8764779107025;852.1563651984521;692.8891377379621;835.5738573327586;854.2055888024136;862.4135587800293;862.9439086459391;912.7809325761802;915.7847905742178;920.7652048727565;921.5898924978387;922.1884741427534;716.7742161219252;898.0839543665458;898.8022635020252;898.9595468203946;899.4018977380034;651.7914267434423;666.4035688059208;666.4868051600289;676.2797620534164;676.546713701821;15082.849171508255;15123.319450624638;15144.924275378553;15147.924260378737;15171.772423413657;14180.50368237117;14367.928160359132;14385.568432946924;14435.422583096664;14586.70826583473;11999.100067494886;12846.679081315953;13308.93345533266;13389.263590502518;13695.657608559866;4639.870246819602;4712.764361781898;4741.5732584067255;4757.931134418281;4867.8783030424165;117477;119570.4021479887;120217.39891300575;120378.39810800977;120500;10995.560177592806;11052.392118433403;11172.273802202993;11292.943535282435;11625.18623696333;22759;22811.973461194288;22910.65634015491;22971.88514057419;23114;7861.882071768928;8001.599920003977;8072.273495385443;8096.595170241464;8184.2224988625985;4298.656107511454;4327.978360108243;4367.847125350598;4401.449818772653;4500.954990450119;3440.9311813763584;3562.5724913010604;3566.037169964147;3568.37553428149;3571.8928432147077;501.0905207049194;504.32672382369947;505.2043032224262;532.430299579454;563.8054871069556;514.7477735909453;536.549298589187;581.1776336483828;598.9031657724321;604.1753007145215;7372.926270737331;8091.878621820678;8520.105388934197;8589.52757598338;8681.088485709037;522.8954209158184;538.8356551251827;550.7686771555956;553.8283132229022;574.8936446757364;4158.972220567498;4251.914961700749;4270.615644592001;4302.3546468030045;4330.696851220448;138353.3082334582;138485;154968;156099;156645;137075;137288;140705;140958;144487.2775636115;29121;29199.270018249288;29219.56170657442;29242.41515169685;74414.62792686219;7985.121636619851;8086.231807978233;8116.350691944748;8139.267465928095;8407.285380742705;46412.30381544212;53752.1623053927;54356.456435436725;56170.8765824673;56249;70272;81170.18829811626;87955.56022219847;88082;89778.10221897959;11721.531138754355;11924.701882453008;12194.854407658697;12479.750404992032;12498.312862734556;14331.35508902081;14509.492167774077;14662.633434163805;14675.165604299462;15121.548006732126;9964.302498825302;13503.39234734459;13505.397692021343;13859.722805544034;13904.652383690489;10999.890001100206;13141;13299.601011969657;13661.86338136606;13784.241866697428;12231.87768122343;12582.758432295692;12868.613941581767;13072.673183170496;13250.204987700768;11105.389203593557;11276.469424104427;11291.774164516499;11291.943540282246;11348.602798901999;9239.214666753402;9437.292203084658;10893.727656808325;11176.217664763388;11186.552537898393 01:32:38 INFO - PROCESS | 1649 | __end_tp_report 01:32:38 INFO - PROCESS | 1649 | __start_cc_report 01:32:38 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1168 01:32:38 INFO - PROCESS | 1649 | __end_cc_report 01:32:38 INFO - PROCESS | 1649 | __startTimestamp1471422758717__endTimestamp 01:32:38 INFO - PROCESS | 1649 | 01:32:38 INFO - PROCESS | 1649 | ------- Summary: start ------- 01:32:38 INFO - PROCESS | 1649 | Number of tests: 6 01:32:38 INFO - PROCESS | 1649 | 01:32:38 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5693.97 Median:5821.42 stddev:649.85 (11.2%) stddev-sans-first:624.45 01:32:38 INFO - PROCESS | 1649 | Values: 3314.1 3341.7 3344.3 3361.9 3399.2 5527.1 5601.4 5651.8 5699.6 5702.2 5637.9 5688.2 5695.7 5696.0 5700.1 5153.7 5188.0 5202.4 5222.9 5269.3 4032.7 5198.5 5207.7 5226.2 5240.5 5138.4 5162.3 5188.6 5207.8 5226.8 5234.6 5256.5 5264.5 5264.7 5313.3 5072.1 5093.1 5093.8 5187.6 5208.2 5598.9 5622.7 5628.6 5630.5 5646.2 6202.2 6205.5 6212.8 6214.9 6226.5 6063.3 6191.3 6213.4 6278.3 6280.2 5821.4 5831.2 5853.6 5858.8 5862.5 6387.0 6395.4 6396.8 6409.6 6415.5 5900.5 5999.3 6073.3 6074.8 6092.3 6214.0 6241.7 6245.1 6251.9 6252.5 6102.8 6141.4 6158.8 6164.0 6166.0 5982.4 6028.2 6034.6 6181.8 6189.0 4893.2 4910.1 4930.7 4931.1 4935.2 4345.6 4448.9 4461.2 4494.8 4525.5 5626.8 5631.3 5657.3 5671.2 5729.4 6215.2 6297.9 6301.0 6305.6 6319.4 5539.4 5598.7 5607.5 5660.4 5670.6 5366.2 5378.0 5388.7 5395.1 5407.1 6333.7 6378.7 6384.3 6394.8 6408.3 5788.7 5878.6 6098.1 6153.0 6276.3 6343.0 6368.1 6379.8 6383.5 6392.4 6150.4 6179.0 6181.7 6193.9 6199.8 6066.8 6163.6 6217.3 6231.6 6298.0 6039.5 6108.8 6110.3 6113.5 6137.1 6092.1 6102.9 6104.0 6115.8 6125.0 5041.5 5567.6 5658.3 5699.2 5715.7 4859.3 5883.1 5891.7 5894.9 5924.2 5696.1 5733.9 5747.2 5750.3 5750.5 01:32:38 INFO - PROCESS | 1649 | 01:32:38 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:76562.80 Median:38516.00 stddev:176715.65 (458.8%) stddev-sans-first:177119.06 01:32:38 INFO - PROCESS | 1649 | Values: 485.2 503.7 510.0 523.1 527.0 31253.7 32952.0 41216.0 42182.4 42374.6 43761.0 44035.0 44188.0 44233.9 44261.3 9728.7 9883.6 9898.0 9901.1 9905.2 8751.2 8951.6 8968.8 8978.7 9634.8 8968.7 11866.8 12206.5 12236.1 12461.8 12067.5 12193.4 12193.7 12197.3 12222.9 12021.2 12070.6 12081.8 12092.1 12104.6 40654.4 40999.0 41036.2 41058.0 41063.4 3389.1 3399.8 3416.0 3423.9 3621.3 31767.8 32039.4 32945.8 33299.3 34391.1 2871.3 3249.9 3292.1 3314.5 3384.4 473264.0 480221.0 481829.0 483791.0 488528.6 62186.7 62683.0 62789.7 62827.7 62914.7 34022.5 34471.8 34768.0 65982.0 66300.0 16348.8 16835.2 16841.0 16846.7 16847.4 12830.3 12949.7 12959.2 12971.6 12983.2 16945.7 17270.5 19403.2 19499.8 19516.7 6881.0 6942.4 7579.7 7713.9 7752.2 889.3 983.0 1006.7 1012.4 1025.5 30466.7 30611.2 30959.7 31148.0 31611.7 1081.1 1093.4 1100.2 1138.9 1140.4 15604.5 15701.5 15946.6 16053.8 16088.0 609429.0 612839.0 622623.0 627462.0 632232.0 51904.2 58989.0 59643.7 59841.7 60189.4 1182.2 1343.5 1395.0 1396.5 1398.3 30199.1 31197.5 31198.0 31727.8 32207.4 51533.7 51991.0 52011.2 52037.7 52202.2 539654.0 863942.0 884728.0 886689.0 887070.0 42868.0 42892.8 43110.4 43351.0 43858.6 47174.0 47717.0 48726.0 48734.5 48815.5 38591.0 38920.8 39201.4 39795.0 40496.8 35354.6 36695.0 39674.0 39692.0 40338.0 38401.8 38441.0 38704.0 39100.0 39222.6 32727.0 32918.8 34138.7 34435.5 34602.1 22492.9 25035.7 25083.1 25619.6 25746.0 01:32:38 INFO - PROCESS | 1649 | 01:32:38 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:35896.30 Median:2302.71 stddev:104404.48 (4534.0%) stddev-sans-first:104663.16 01:32:38 INFO - PROCESS | 1649 | Values: 304.6 347.0 367.9 372.8 398.2 15200.5 17456.7 20255.8 20517.2 20955.6 16241.6 20736.9 20748.7 20981.2 21232.7 4948.9 5437.5 5653.7 5664.8 5673.9 3969.6 4174.8 6114.1 6144.5 6206.0 6609.5 6921.3 6947.2 6956.5 6988.0 6579.1 6781.2 6819.9 6835.1 6920.9 5306.9 6015.5 6024.1 6029.1 6030.8 13241.4 13905.2 13907.3 13919.7 18099.4 2172.6 2212.2 2300.2 2305.2 2951.3 9131.3 9918.2 10014.2 10071.5 14579.8 1495.5 1704.7 1738.1 1776.8 1841.3 96041.0 120008.0 125532.4 129218.4 130445.0 10874.1 11429.5 11517.8 11713.0 11917.9 12151.6 14669.9 14671.3 14709.5 14716.1 7764.6 8223.0 8445.6 8724.0 8841.9 7039.6 7117.0 8718.3 8718.3 8895.8 4468.8 4567.2 4569.8 4646.1 4659.7 1771.2 1822.0 1892.2 1914.7 1931.4 819.7 905.3 927.4 958.7 1027.6 20163.2 21499.7 21719.7 21759.3 21895.6 908.1 935.6 970.8 977.5 1003.5 9953.9 11351.8 11524.6 11542.8 11561.1 613935.0 616836.0 623730.6 630254.0 635979.0 127090.0 128408.4 146281.5 148702.0 150534.0 979.3 983.0 1019.7 1022.0 1025.0 11059.6 18262.6 18811.2 20085.6 20140.8 57242.6 57333.0 57794.0 57798.0 58410.1 60103.4 76280.0 78543.0 80943.6 82180.0 7862.5 7981.8 8048.1 8341.7 8560.1 11986.2 12945.4 13088.0 13458.0 13533.7 8963.6 9936.8 10821.6 11810.9 11864.8 10580.3 10928.7 10934.6 11270.3 11524.3 11520.8 11612.7 11682.0 11994.3 12035.3 8009.4 8069.6 8268.9 8309.4 8462.7 8445.8 10908.7 11160.2 11244.1 11493.8 01:32:38 INFO - PROCESS | 1649 | 01:32:38 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5643.81 Median:4830.39 stddev:3159.27 (65.4%) stddev-sans-first:3152.17 01:32:38 INFO - PROCESS | 1649 | Values: 1417.8 1497.4 1638.8 1794.7 1826.6 8432.5 8924.2 8931.8 8935.4 8979.2 7829.6 8079.5 8326.2 8653.4 8710.8 2329.4 2381.8 2381.9 2382.0 2384.3 2345.6 2359.7 2387.0 2394.2 2398.4 2360.4 2382.3 2391.1 2394.2 2396.5 2317.6 2325.2 2334.2 2338.3 2362.4 2338.1 2365.1 2366.4 2368.1 2370.4 8126.0 8196.4 8197.1 8204.8 8212.9 5141.4 5294.5 5299.1 5304.0 5320.7 3252.9 3305.6 3328.7 3359.7 3613.2 1057.1 1059.1 1069.0 1082.0 1086.6 9640.3 11408.7 11657.2 11667.2 11698.0 4604.7 4662.8 4868.2 4882.4 4885.4 10049.1 10059.6 10062.0 10063.9 10068.2 5410.6 5419.5 5421.2 5424.2 5424.5 4406.3 4597.9 4789.5 4904.6 4946.1 3890.0 3952.2 3996.3 4040.9 4060.0 1286.4 1314.4 1314.8 1325.5 1330.6 772.6 907.3 912.3 915.2 916.8 5592.6 5685.0 5788.1 5801.0 6027.2 441.5 452.7 452.8 457.2 458.3 3888.4 3939.6 3993.9 3998.0 4027.1 7763.3 10700.3 10816.0 10825.8 10830.4 10375.1 10751.8 10754.7 10764.1 10779.5 8062.3 8251.7 8253.2 8256.5 8304.8 5288.2 5704.1 5736.5 5741.8 5805.9 9802.0 10020.5 10064.3 10104.4 10157.7 8593.0 9650.9 10155.6 10157.6 10233.7 6929.8 7173.1 7308.5 7491.4 7671.8 8175.8 8484.8 8498.9 8499.6 8506.5 7331.9 7424.0 7466.3 7548.8 7570.9 7269.5 7279.8 7292.2 7408.5 7500.1 6844.8 7016.2 7025.0 7028.6 7057.7 4898.7 4944.8 4973.1 5015.5 5082.3 4792.6 4883.2 4900.8 5125.2 5156.1 01:32:38 INFO - PROCESS | 1649 | 01:32:38 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4266.37 Median:4593.25 stddev:1341.23 (29.2%) stddev-sans-first:1311.37 01:32:38 INFO - PROCESS | 1649 | Values: 290.6 302.5 312.1 314.5 316.4 4610.0 5030.2 5215.2 5233.9 5294.5 4463.2 4580.5 4768.8 4850.4 5188.4 3283.5 3842.4 3995.8 3999.3 4015.1 4009.6 4011.9 4018.1 4023.6 4044.5 3679.8 3944.3 3956.8 3988.5 3997.3 3254.7 3269.7 3629.2 3957.6 3960.4 3409.3 3423.3 3429.8 3435.5 3438.4 4912.2 5084.6 5097.6 5116.7 5124.5 3693.4 4361.2 4457.0 4520.3 4533.9 4504.6 4939.8 5461.8 5500.3 5520.2 3788.8 3792.6 3798.0 3799.8 3806.8 4388.1 4790.3 5594.9 5608.9 5742.2 3081.8 3361.4 3821.4 3821.4 3836.5 3210.0 3566.1 3887.2 3895.2 3907.0 3961.2 4186.5 4227.9 4488.2 4549.7 5243.9 5496.5 5510.6 5513.0 5543.8 1118.8 1170.6 1327.2 1328.3 1334.0 644.7 745.8 814.9 815.8 831.5 3403.2 4034.5 4162.8 4278.9 4342.7 4074.8 4390.9 4656.3 4740.5 4759.7 3750.4 3978.5 3999.4 4318.7 4339.4 2214.5 2225.8 2281.2 2488.8 2500.3 4332.3 4885.0 4897.8 4905.0 4921.9 4189.9 4332.6 4552.9 4820.4 4851.9 4672.7 4739.8 4930.7 5882.9 5981.5 5685.6 5700.7 5706.7 5708.4 5768.7 5050.8 5204.6 5718.4 5727.6 5747.5 5094.6 5612.4 5685.2 5923.9 5925.5 3500.1 3828.3 3853.4 3862.2 3869.3 4606.0 5377.5 5619.5 5716.6 5736.9 4820.7 4992.7 5040.2 5270.7 5288.7 4778.0 4780.7 5555.7 5573.3 5616.6 4933.9 5228.0 5449.0 5470.7 5495.8 5511.9 5525.3 5536.4 5552.3 5579.7 4034.4 5430.5 5442.4 5500.5 5502.3 01:32:38 INFO - PROCESS | 1649 | 01:32:38 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:22945.45 Median:3865.43 stddev:38117.83 (986.1%) stddev-sans-first:38188.40 01:32:38 INFO - PROCESS | 1649 | Values: 772.3 787.9 790.8 814.8 828.9 15290.5 15698.5 16290.6 16334.2 16372.5 12337.6 14897.8 15088.4 15127.6 15128.2 676.7 837.4 849.2 851.9 852.2 692.9 835.6 854.2 862.4 862.9 912.8 915.8 920.8 921.6 922.2 716.8 898.1 898.8 899.0 899.4 651.8 666.4 666.5 676.3 676.5 15082.8 15123.3 15144.9 15147.9 15171.8 14180.5 14367.9 14385.6 14435.4 14586.7 11999.1 12846.7 13308.9 13389.3 13695.7 4639.9 4712.8 4741.6 4757.9 4867.9 117477.0 119570.4 120217.4 120378.4 120500.0 10995.6 11052.4 11172.3 11292.9 11625.2 22759.0 22812.0 22910.7 22971.9 23114.0 7861.9 8001.6 8072.3 8096.6 8184.2 4298.7 4328.0 4367.8 4401.4 4501.0 3440.9 3562.6 3566.0 3568.4 3571.9 501.1 504.3 505.2 532.4 563.8 514.7 536.5 581.2 598.9 604.2 7372.9 8091.9 8520.1 8589.5 8681.1 522.9 538.8 550.8 553.8 574.9 4159.0 4251.9 4270.6 4302.4 4330.7 138353.3 138485.0 154968.0 156099.0 156645.0 137075.0 137288.0 140705.0 140958.0 144487.3 29121.0 29199.3 29219.6 29242.4 74414.6 7985.1 8086.2 8116.4 8139.3 8407.3 46412.3 53752.2 54356.5 56170.9 56249.0 70272.0 81170.2 87955.6 88082.0 89778.1 11721.5 11924.7 12194.9 12479.8 12498.3 14331.4 14509.5 14662.6 14675.2 15121.5 9964.3 13503.4 13505.4 13859.7 13904.7 10999.9 13141.0 13299.6 13661.9 13784.2 12231.9 12582.8 12868.6 13072.7 13250.2 11105.4 11276.5 11291.8 11291.9 11348.6 9239.2 9437.3 10893.7 11176.2 11186.6 01:32:38 INFO - PROCESS | 1649 | -------- Summary: end -------- 01:32:38 INFO - PROCESS | 1649 | 01:32:39 INFO - TEST-INFO | 1649: exit 0 01:32:39 INFO - TEST-OK | dromaeo_css | took 1117766ms 01:32:39 INFO - TEST-START | kraken 01:32:39 INFO - operating with platform_type : mac_ 01:32:39 INFO - Initialising browser for kraken test... 01:32:39 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpJgDFq8/profile http://localhost:49267/getInfo.html) 01:32:41 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 01:32:41 INFO - PROCESS | 1656 | colorDepth:24 01:32:41 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 01:32:41 INFO - PROCESS | 1656 | __metrics 01:32:41 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:32:41 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:32:42 INFO - TEST-INFO | 1656: exit 0 01:32:42 INFO - Browser initialized. 01:32:42 INFO - Running cycle 1/1 for kraken test... 01:32:42 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/T/tmpJgDFq8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:32:54 INFO - PROCESS | 1657 | RSS: Main: 226017280 01:32:54 INFO - PROCESS | 1657 | 01:32:56 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 01:32:57 INFO - PROCESS | 1657 | RSS: Main: 284209152 01:32:57 INFO - PROCESS | 1657 | 01:33:00 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 01:33:01 INFO - PROCESS | 1657 | RSS: Main: 290693120 01:33:01 INFO - PROCESS | 1657 | 01:33:04 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 01:33:05 INFO - PROCESS | 1657 | RSS: Main: 388120576 01:33:05 INFO - PROCESS | 1657 | 01:33:07 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 01:33:07 INFO - PROCESS | 1657 | RSS: Main: 288940032 01:33:07 INFO - PROCESS | 1657 | 01:33:09 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:33:10 INFO - PROCESS | 1657 | RSS: Main: 293564416 01:33:10 INFO - PROCESS | 1657 | 01:33:13 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 01:33:13 INFO - PROCESS | 1657 | RSS: Main: 328622080 01:33:13 INFO - PROCESS | 1657 | 01:33:16 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 01:33:17 INFO - PROCESS | 1657 | RSS: Main: 330268672 01:33:17 INFO - PROCESS | 1657 | 01:33:20 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 01:33:20 INFO - PROCESS | 1657 | RSS: Main: 332337152 01:33:20 INFO - PROCESS | 1657 | 01:33:22 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:33:23 INFO - PROCESS | 1657 | RSS: Main: 300843008 01:33:23 INFO - PROCESS | 1657 | 01:33:24 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:33:25 INFO - PROCESS | 1657 | RSS: Main: 307159040 01:33:25 INFO - PROCESS | 1657 | 01:33:27 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:33:28 INFO - PROCESS | 1657 | RSS: Main: 305168384 01:33:28 INFO - PROCESS | 1657 | 01:33:31 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:33:31 INFO - PROCESS | 1657 | RSS: Main: 313106432 01:33:31 INFO - PROCESS | 1657 | 01:33:34 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:33:35 INFO - PROCESS | 1657 | RSS: Main: 314458112 01:33:35 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 01:33:37 INFO - PROCESS | 1657 | RSS: Main: 357793792 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | __start_tp_report 01:33:37 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 01:33:37 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 01:33:37 INFO - PROCESS | 1657 | |i|pagename|runs| 01:33:37 INFO - PROCESS | 1657 | |0;ai-astar;103;114;113;114;106;112;110;113;113;112 01:33:37 INFO - PROCESS | 1657 | |1;audio-beat-detection;143;115;126;195;140;107;129;110;143;108 01:33:37 INFO - PROCESS | 1657 | |2;audio-dft;186;186;184;185;185;180;182;185;181;181 01:33:37 INFO - PROCESS | 1657 | |3;audio-fft;78;58;59;87;58;58;67;61;85;57 01:33:37 INFO - PROCESS | 1657 | |4;audio-oscillator;83;69;103;71;80;69;97;71;68;102 01:33:37 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;89;86;89;87;89;85;90;86;90;86 01:33:37 INFO - PROCESS | 1657 | |6;imaging-darkroom;101;131;94;94;93;93;93;94;92;93 01:33:37 INFO - PROCESS | 1657 | |7;imaging-desaturate;86;86;84;87;82;83;86;86;87;86 01:33:37 INFO - PROCESS | 1657 | |8;json-parse-financial;58;57;56;55;57;57;55;55;57;55 01:33:37 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;65;65;75;77;72;69;69;69;69;71 01:33:37 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;88;88;85;85;84;87;84;85;84;89 01:33:37 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;145;131;152;153;133;139;136;140;157;140 01:33:37 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;171;172;172;170;172;171;171;171;173;177 01:33:37 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;68;68;69;68;69;68;69;68;68;69 01:33:37 INFO - PROCESS | 1657 | __end_tp_report 01:33:37 INFO - PROCESS | 1657 | __start_cc_report 01:33:37 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,2004 01:33:37 INFO - PROCESS | 1657 | __end_cc_report 01:33:37 INFO - PROCESS | 1657 | __startTimestamp1471422817382__endTimestamp 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | ------- Summary: start ------- 01:33:37 INFO - PROCESS | 1657 | Number of tests: 14 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:111.00 Median:113.00 stddev:3.68 (3.3%) stddev-sans-first:2.52 01:33:37 INFO - PROCESS | 1657 | Values: 103.0 114.0 113.0 114.0 106.0 112.0 110.0 113.0 113.0 112.0 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:134.50 stddev:26.44 (19.7%) stddev-sans-first:27.72 01:33:37 INFO - PROCESS | 1657 | Values: 143.0 115.0 126.0 195.0 140.0 107.0 129.0 110.0 143.0 108.0 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:183.50 Median:185.00 stddev:2.27 (1.2%) stddev-sans-first:2.22 01:33:37 INFO - PROCESS | 1657 | Values: 186.0 186.0 184.0 185.0 185.0 180.0 182.0 185.0 181.0 181.0 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:66.80 Median:64.00 stddev:11.96 (18.7%) stddev-sans-first:11.98 01:33:37 INFO - PROCESS | 1657 | Values: 78.0 58.0 59.0 87.0 58.0 58.0 67.0 61.0 85.0 57.0 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:71.00 stddev:14.31 (20.2%) stddev-sans-first:15.16 01:33:37 INFO - PROCESS | 1657 | Values: 83.0 69.0 103.0 71.0 80.0 69.0 97.0 71.0 68.0 102.0 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:89.00 stddev:1.89 (2.1%) stddev-sans-first:1.94 01:33:37 INFO - PROCESS | 1657 | Values: 89.0 86.0 89.0 87.0 89.0 85.0 90.0 86.0 90.0 86.0 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:97.80 Median:93.00 stddev:11.93 (12.8%) stddev-sans-first:12.60 01:33:37 INFO - PROCESS | 1657 | Values: 101.0 131.0 94.0 94.0 93.0 93.0 93.0 94.0 92.0 93.0 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:86.00 stddev:1.70 (2.0%) stddev-sans-first:1.79 01:33:37 INFO - PROCESS | 1657 | Values: 86.0 86.0 84.0 87.0 82.0 83.0 86.0 86.0 87.0 86.0 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:57.00 stddev:1.14 (2.0%) stddev-sans-first:1.00 01:33:37 INFO - PROCESS | 1657 | Values: 58.0 57.0 56.0 55.0 57.0 57.0 55.0 55.0 57.0 55.0 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:3.84 (5.5%) stddev-sans-first:3.61 01:33:37 INFO - PROCESS | 1657 | Values: 65.0 65.0 75.0 77.0 72.0 69.0 69.0 69.0 69.0 71.0 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:1.91 (2.2%) stddev-sans-first:1.87 01:33:37 INFO - PROCESS | 1657 | Values: 88.0 88.0 85.0 85.0 84.0 87.0 84.0 85.0 84.0 89.0 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:142.60 Median:142.50 stddev:8.86 (6.2%) stddev-sans-first:9.35 01:33:37 INFO - PROCESS | 1657 | Values: 145.0 131.0 152.0 153.0 133.0 139.0 136.0 140.0 157.0 140.0 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.00 stddev:1.94 (1.1%) stddev-sans-first:2.03 01:33:37 INFO - PROCESS | 1657 | Values: 171.0 172.0 172.0 170.0 172.0 171.0 171.0 171.0 173.0 177.0 01:33:37 INFO - PROCESS | 1657 | 01:33:37 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 01:33:37 INFO - PROCESS | 1657 | Values: 68.0 68.0 69.0 68.0 69.0 68.0 69.0 68.0 68.0 69.0 01:33:37 INFO - PROCESS | 1657 | -------- Summary: end -------- 01:33:37 INFO - PROCESS | 1657 | 01:33:38 INFO - TEST-INFO | 1657: exit 0 01:33:38 INFO - TEST-OK | kraken | took 59004ms 01:33:38 INFO - SUITE-END | took 1176s 01:33:38 INFO - Completed test suite (00:19:36) 01:33:38 INFO - javascript benchmark 01:33:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.105191598268, 3341.732661387089, 3344.3311337732453, 3361.932761344775, 3399.1672040350104, 5527.115661494162, 5601.383847776747, 5651.802186923458, 5699.629524080932, 5702.173184888189, 5637.943620563793, 5688.203651488795, 5695.74369153388, 5696.0, 5700.087985922243, 5153.69077855328, 5188.0, 5202.401723801773, 5222.869428264305, 5269.262303277545, 4032.6572241359518, 5198.45416231296, 5207.661502002376, 5226.242194881759, 5240.528352448279, 5138.383393992707, 5162.251473536335, 5188.610854185932, 5207.765650545734, 5226.7647955841885, 5234.607404444644, 5256.526912577886, 5264.473552644743, 5264.710440925747, 5313.309269794902, 5072.0870243356185, 5093.0577843099145, 5093.847184584469, 5187.559057480119, 5208.218767184915, 5598.916016259759, 5622.746976386073, 5628.605997580171, 5630.465105814982, 5646.20953066571, 6202.224721909762, 6205.5345849061505, 6212.81361559154, 6214.875702485925, 6226.533010024221, 6063.291643431861, 6191.2570491540855, 6213.409726076015, 6278.277998030239, 6280.183576135073, 5821.417858214145, 5831.183634291203, 5853.560982926298, 5858.765649373977, 5862.472377485961, 6387.0, 6395.360463953567, 6396.776112836028, 6409.551331406757, 6415.486761059104, 5900.468957793733, 5999.280086389661, 6073.331933487313, 6074.75700971965, 6092.268843234487, 6214.036824292242, 6241.656708881055, 6245.094461303085, 6251.937480625226, 6252.531060170414, 6102.7558897644485, 6141.447269745744, 6158.846028849314, 6163.952128138228, 6166.0, 5982.371850955674, 6028.156058151862, 6034.577579569388, 6181.84545386369, 6188.969055154786, 4893.168161412568, 4910.116179087799, 4930.6795058321095, 4931.137051016058, 4935.21036634144, 4345.587169218919, 4448.888777780581, 4461.24158892989, 4494.842680506166, 4525.502194758574, 5626.803061892814, 5631.324241091095, 5657.32112146545, 5671.177679236487, 5729.427057294237, 6215.160953271251, 6297.874042519124, 6301.0, 6305.5901366411035, 6319.431251187415, 5539.390667026624, 5598.664080155204, 5607.495325420732, 5660.405657405913, 5670.603057785998, 5366.168243922199, 5377.973110134502, 5388.676679399248, 5395.05586522357, 5407.134858422633, 6333.714982825876, 6378.712957916812, 6384.32964538726, 6394.840128996812, 6408.327125651739, 5788.710564471844, 5878.647281163144, 6098.0852872069545, 6152.969235153795, 6276.278228003838, 6343.016832390987, 6368.108464814837, 6379.808605741835, 6383.5212359074185, 6392.3927226913365, 6150.415710507495, 6179.0, 6181.721822518088, 6193.907091393543, 6199.752009919553, 6066.757329706762, 6163.568550201443, 6217.316095229611, 6231.594946328474, 6297.992321228581, 6039.456448919618, 6108.847278818065, 6110.26676798787, 6113.5414843886, 6137.140800287874, 6092.086187071975, 6102.908456373247, 6103.969480152571, 6115.847103822262, 6125.019996800491, 5041.495850414929, 5567.610267281251, 5658.349289831722, 5699.202111704448, 5715.685637289989, 4859.2954021667365, 5883.146943693226, 5891.675957822361, 5894.941050589439, 5924.229850119629, 5696.088625819849, 5733.885322293448, 5747.166660834072, 5750.338711048115, 5750.5112065474905], "value": 5652.345851648086, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.23090900922034, 503.65021741732164, 510.0411226893442, 523.0611053159578, 526.9710165940874, 31253.687463125363, 32952.0, 41216.0, 42182.367264491055, 42374.57625423745, 43761.0, 44035.0, 44188.0, 44233.89415264612, 44261.336079958826, 9728.70813875583, 9883.604655813759, 9898.010198980117, 9901.059399357086, 9905.20758339331, 8751.212390884819, 8951.552422378887, 8968.775780605505, 8978.685745998891, 9634.75913102171, 8968.686095986643, 11866.821997670042, 12206.45070971804, 12236.143469957107, 12461.750764984696, 12067.456964436622, 12193.39033048353, 12193.695157621041, 12197.329146896916, 12222.877771222351, 12021.218620789708, 12070.637880863587, 12081.758364832654, 12092.093093018058, 12104.636860894187, 40654.39018414726, 40999.0, 41036.1792764143, 41057.973550661176, 41063.384049239285, 3389.1018879996823, 3399.847006884696, 3416.0, 3423.9144021399416, 3621.257642183346, 31767.84116079428, 32039.359212815612, 32945.83527082373, 33299.33401331984, 34391.14022149441, 2871.310885387513, 3249.9187520311943, 3292.0782180989363, 3314.4696848504122, 3384.4415671414185, 473264.0, 480221.0, 481829.0, 483791.0, 488528.5573572145, 62186.689066554376, 62683.0, 62789.68605157037, 62827.6858615704, 62914.68542657257, 34022.48966265508, 34471.82764086164, 34768.0, 65982.0, 66300.0, 16348.75476867848, 16835.158242087848, 16840.9895406276, 16846.66306673884, 16847.41034063802, 12830.294333811544, 12949.676258093434, 12959.157654752411, 12971.610851674464, 12983.221006739626, 16945.661086778196, 17270.481885543453, 19403.223871045, 19499.8050019498, 19516.707249390987, 6880.965595172092, 6942.444604431634, 7579.696812127563, 7713.884291735629, 7752.224777522316, 889.3241136736127, 983.0, 1006.7030226083323, 1012.3925644613173, 1025.5436330832708, 30466.695333046828, 30611.234719131753, 30959.69040309568, 31148.0, 31611.683883160873, 1081.1458947431597, 1093.420487141816, 1100.1858624617726, 1138.9066496163775, 1140.4126874659557, 15604.531864044096, 15701.528954131394, 15946.60133496672, 16053.839461605468, 16088.0, 609429.0, 612839.0, 622623.0, 627462.0, 632232.0, 51904.22143667848, 58989.0, 59643.70178149168, 59841.700791495765, 60189.39810601838, 1182.1901997131993, 1343.5499107798996, 1395.0304538345752, 1396.5461225101678, 1398.321813920248, 30199.09402717922, 31197.53203701901, 31198.0, 31727.84136079305, 32207.35585288328, 51533.7423312881, 51991.0, 52011.21983170331, 52037.7398113007, 52202.21696674629, 539654.0, 863942.0, 884728.0, 886689.0, 887070.0, 42868.0, 42892.78553607212, 43110.35334470048, 43351.0, 43858.56141438545, 47174.0, 47717.0, 48726.0, 48734.512654873, 48815.5118448811, 38591.0, 38920.80539597284, 39201.411978820914, 39795.0, 40496.79751601223, 35354.58581656705, 36695.02669960913, 39674.0, 39692.0, 40338.0, 38401.847944561705, 38441.0, 38704.03239919025, 39100.02249943774, 39222.60777392304, 32727.018189454353, 32918.835405822814, 34138.65861341454, 34435.4834677475, 34602.13494662654, 22492.887535562873, 25035.749642503342, 25083.122090726738, 25619.6157057648, 25746.0], "value": 20813.026994919503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.5644728038904, 347.04735501049623, 367.86572900891184, 372.7614326830828, 398.2353880549345, 15200.543983680493, 17456.650866982654, 20255.797442025574, 20517.179312827488, 20955.580888382225, 16241.593960151002, 20736.89631551844, 20748.688769668468, 20981.16075356984, 21232.681509777365, 4948.886500537386, 5437.483439073291, 5653.745581448824, 5664.830055098354, 5673.914891276634, 3969.563348031714, 4174.77038762868, 6114.113453549233, 6144.5084393248435, 6206.038064100049, 6609.504287178457, 6921.342472465108, 6947.166340039203, 6956.478264130185, 6987.965060174692, 6579.144711187539, 6781.152355955505, 6819.897701534481, 6835.07726456927, 6920.861582768342, 5306.92039619406, 6015.518758499309, 6024.126501657235, 6029.095635654687, 6030.788922387739, 13241.404136813866, 13905.165690058528, 13907.304634768221, 13919.652008699763, 18099.366522171662, 2172.6415141501634, 2212.192549719357, 2300.2064287820676, 2305.216226483004, 2951.3359494113865, 9131.26949844011, 9918.206543476505, 10014.24893133018, 10071.5467803949, 14579.781303280459, 1495.461633811827, 1704.6675898199856, 1738.1048759888668, 1776.8450507170442, 1841.2542920117373, 96041.0, 120008.0, 125532.37233813864, 129218.35390822985, 130445.0, 10874.130069594414, 11429.485673144729, 11517.827232591519, 11713.0, 11917.940410297893, 12151.635450936486, 14669.853301466848, 14671.33978970949, 14709.485168019282, 14716.117032978056, 7764.572948487775, 8222.958885205655, 8445.57772111392, 8723.956380218058, 8841.911580884238, 7039.612821294775, 7116.964415177891, 8718.258947989365, 8718.302535797122, 8895.822083558292, 4468.79890404926, 4567.2464043432465, 4569.840055598038, 4646.117237724821, 4659.720416775004, 1771.16755125091, 1821.9908900455414, 1892.2241880828794, 1914.7406060848332, 1931.4355372148605, 819.6885183630183, 905.3210092430677, 927.4157280912982, 958.726762872592, 1027.6249169053242, 20163.19347226124, 21499.738851443715, 21719.67420488694, 21759.347219583437, 21895.562088758135, 908.1145882764253, 935.5696379665294, 970.8106919150839, 977.4917043137528, 1003.4681618742078, 9953.900460995443, 11351.772964540829, 11524.596639117759, 11542.769144617228, 11561.132915031407, 613935.0, 616836.0, 623730.6440403397, 630254.0, 635979.0, 127090.0, 128408.35795821148, 146281.5371846268, 148702.0, 150534.0, 979.294907666479, 982.9655962041294, 1019.6686077024997, 1022.0392830739081, 1025.0364657222187, 11059.557617695202, 18262.634747305245, 18811.24755009839, 20085.58545047316, 20140.79859201448, 57242.634987911726, 57333.0, 57793.9772107991, 57798.0, 58410.12384814146, 60103.39896600978, 76280.0, 78543.0, 80943.59528202322, 82180.0, 7862.52824830512, 7981.760547183594, 8048.1147073823, 8341.749747507585, 8560.101189375026, 11986.220895641756, 12945.417456214305, 13088.0, 13458.0, 13533.661658458617, 8963.59663815143, 9936.751581210528, 10821.593192884875, 11810.881891180978, 11864.822027669765, 10580.259381843505, 10928.726781830517, 10934.56261749521, 11270.267432616854, 11524.250923689933, 11520.769584608428, 11612.709682258012, 11682.0, 11994.280343179436, 12035.277883327028, 8009.399295053011, 8069.636866341146, 8268.932766808299, 8309.418340716093, 8462.746117616482, 8445.831083378174, 10908.672739817817, 11160.162987776112, 11244.144716122075, 11493.770124597628], "value": 9484.281675058866, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.8369487508935, 1497.393555609978, 1638.7787648667434, 1794.7128459446492, 1826.6164105537837, 8432.494050356983, 8924.241439477635, 8931.776705582364, 8935.419197752142, 8979.236764874993, 7829.608519574027, 8079.515229086259, 8326.209010144043, 8653.394262401634, 8710.782230444242, 2329.4176455886027, 2381.785639292463, 2381.8928148233285, 2381.988090059547, 2384.3204686664303, 2345.64815277708, 2359.6785799951995, 2386.9761302387014, 2394.162043284845, 2398.3524448399007, 2360.3980984848927, 2382.332946774906, 2391.0794344177443, 2394.221877889684, 2396.508715713275, 2317.617593097137, 2325.2210509479346, 2334.159702507096, 2338.3101984914492, 2362.350353652742, 2338.088145623208, 2365.065799009382, 2366.420227044368, 2368.052778888441, 2370.383700237933, 8125.959370203171, 8196.42625016249, 8197.139300373494, 8204.8359032819, 8212.917870821275, 5141.357330333708, 5294.52349288562, 5299.099153143936, 5304.0, 5320.733963301858, 3252.918677033093, 3305.5537502437105, 3328.73370130389, 3359.748018898568, 3613.1509095362567, 1057.1278695076517, 1059.1262208677795, 1068.9679309620724, 1082.0, 1086.5708045322053, 9640.276979226586, 11408.714782130513, 11657.183997120204, 11667.183297169202, 11698.0, 4604.700694454849, 4662.790174442158, 4868.172410690191, 4882.438519570295, 4885.438174609894, 10049.145822605014, 10059.64791232318, 10061.993800620026, 10063.949680251699, 10068.194544436428, 5410.567154627621, 5419.539339156216, 5421.159720243369, 5424.213489044067, 5424.484673955968, 4406.27296496081, 4597.931031034537, 4789.544993225638, 4904.558589726942, 4946.060248552763, 3890.0, 3952.150287688103, 3996.300647386696, 4040.939385909214, 4059.9797001014804, 1286.395394164741, 1314.3625341709455, 1314.7962065879804, 1325.509561462265, 1330.6427444007059, 772.559641004622, 907.3195103672246, 912.3031162038603, 915.1626261970223, 916.7937214126769, 5592.5805564582815, 5685.0, 5788.102844059177, 5801.027650598817, 6027.156198132265, 441.5209497694973, 452.6582430265129, 452.75098695717224, 457.1884904294837, 458.28049961560697, 3888.3778595424596, 3939.625735555118, 3993.880183594497, 3997.960020399759, 4027.0536423940353, 7763.301302882654, 10700.250982431155, 10816.0, 10825.83761243582, 10830.350178989129, 10375.066244038073, 10751.784964300827, 10754.73113172177, 10764.085052770446, 10779.461026948622, 8062.314703250172, 8251.669933202606, 8253.174682531819, 8256.504609723435, 8304.83390332202, 5288.233206185005, 5704.0588302929555, 5736.4550367715, 5741.827745167651, 5805.854853628524, 9802.0, 10020.549075291483, 10064.345817521838, 10104.393736375841, 10157.746056348651, 8592.957035214784, 9650.903490965282, 10155.593776248867, 10157.644482443078, 10233.74415639615, 6929.757458488929, 7173.0675012248075, 7308.451866110169, 7491.438142139253, 7671.808204794925, 8175.79560510992, 8484.830303394021, 8498.872516912128, 8499.617517211616, 8506.532140732319, 7331.890021649786, 7424.0, 7466.25337466249, 7548.773536793905, 7570.9242907570215, 7269.491135620456, 7279.818004549928, 7292.234315396807, 7408.518446300973, 7500.062492188476, 6844.794656160323, 7016.19313778922, 7025.0, 7028.578285302899, 7057.7176912922905, 4898.657094003385, 4944.752762361795, 4973.129702302011, 5015.473375295687, 5082.313887625123, 4792.616590672807, 4883.229283495286, 4900.779464924016, 5125.1799712045895, 5156.097682905402], "value": 4475.795252300383, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.61058182036066, 302.4857741838874, 312.10114869176766, 314.50779530035504, 316.38147421790404, 4609.966279505433, 5030.245463180525, 5215.217717342401, 5233.86915327117, 5294.523492885644, 4463.152001119785, 4580.5419458054175, 4768.783960090181, 4850.447856685862, 5188.351456067991, 3283.456775315604, 3842.3852183650483, 3995.8002099895034, 3999.300122478569, 4015.0765323975356, 4009.5589485156756, 4011.8595849145286, 4018.1361007383407, 4023.5574086850424, 4044.4631040204827, 3679.797611131387, 3944.2900277950102, 3956.76259424434, 3988.5213774346976, 3997.2804895118866, 3254.658260882609, 3269.673032696735, 3629.237860049393, 3957.56466788653, 3960.425738267964, 3409.3010932758725, 3423.2811109667, 3429.7652844975787, 3435.5362026126654, 3438.381091403546, 4912.214140587138, 5084.56781173597, 5097.617678674077, 5116.718580478072, 5124.538791508745, 3693.3905905525558, 4361.171377438277, 4456.994352541369, 4520.344550040226, 4533.863984080483, 4504.617107545862, 4939.753012349404, 5461.754221060062, 5500.28496295483, 5520.171974203861, 3788.7726736395903, 3792.563855156665, 3797.9810100949594, 3799.848006079781, 3806.809659517013, 4388.05656783793, 4790.281457781326, 5594.929875945885, 5608.915866262009, 5742.186328698949, 3081.845907704606, 3361.4453615153716, 3821.3885778275344, 3821.38857782759, 3836.506270923922, 3210.0, 3566.0728210665416, 3887.2031233597045, 3895.182011777502, 3906.980465097656, 3961.16815468749, 4186.518550366747, 4227.894302642397, 4488.214562451558, 4549.7042692224895, 5243.898781255979, 5496.532794712414, 5510.586705997066, 5513.04286978125, 5543.780368318963, 1118.8265818797936, 1170.5961443302047, 1327.1638867513404, 1328.2827273272517, 1333.9666508337175, 644.6679959820696, 745.7949064007333, 814.9470284431493, 815.8409110223569, 831.5364957674416, 3403.217260030207, 4034.455348527911, 4162.812673429703, 4278.908878236092, 4342.717723347972, 4074.7758873262255, 4390.868273951786, 4656.2517173675515, 4740.525947405232, 4759.6668233223345, 3750.3811871041516, 3978.5225772906856, 3999.420084087791, 4318.654507639444, 4339.414179085846, 2214.490667146565, 2225.7662945390825, 2281.243442549228, 2488.8008959283216, 2500.312414086141, 4332.26351520236, 4884.972736314461, 4897.824522114738, 4905.0, 4921.8523444296725, 4189.853355132555, 4332.631726303236, 4552.860155726803, 4820.421549414023, 4851.908320627901, 4672.696274742131, 4739.763011849463, 4930.728809915489, 5882.852928676817, 5981.461668449686, 5685.555211259199, 5700.657960522382, 5706.714664266853, 5708.429157084258, 5768.682722450306, 5050.823221187241, 5204.583633309402, 5718.3702644746045, 5727.570432217683, 5747.482726554463, 5094.592432605308, 5612.410696876769, 5685.175649530877, 5923.881522369442, 5925.466707996301, 3500.0724807925412, 3828.3109040373, 3853.3834586466032, 3862.1889403224513, 3869.303525365461, 4605.953940460552, 5377.516023557899, 5619.538919880943, 5716.628419152742, 5736.856578585569, 4820.734859582757, 4992.675476094042, 5040.243963405518, 5270.657407268515, 5288.709120998382, 4777.976110119427, 4780.665353425227, 5555.666660000413, 5573.275474188492, 5616.6068375213345, 4933.925991110208, 5228.0, 5449.0, 5470.699111548903, 5495.818399044225, 5511.905475919125, 5525.254090697705, 5536.446355364431, 5552.305961754781, 5579.656544251343, 4034.4150098236178, 5430.51125398716, 5442.401335853132, 5500.477454641803, 5502.312210973629], "value": 3842.132512704822, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.3087836386433, 787.8969442780107, 790.8497385496755, 814.767791179514, 828.9046759622645, 15290.46483373082, 15698.529044128665, 16290.592735181626, 16334.18329083547, 16372.508824735278, 12337.629871103858, 14897.776533351982, 15088.396464141448, 15127.621809454742, 15128.24358782062, 676.6751959059654, 837.4054421360826, 849.2229609906927, 851.8764779107025, 852.1563651984521, 692.8891377379621, 835.5738573327586, 854.2055888024136, 862.4135587800293, 862.9439086459391, 912.7809325761802, 915.7847905742178, 920.7652048727565, 921.5898924978387, 922.1884741427534, 716.7742161219252, 898.0839543665458, 898.8022635020252, 898.9595468203946, 899.4018977380034, 651.7914267434423, 666.4035688059208, 666.4868051600289, 676.2797620534164, 676.546713701821, 15082.849171508255, 15123.319450624638, 15144.924275378553, 15147.924260378737, 15171.772423413657, 14180.50368237117, 14367.928160359132, 14385.568432946924, 14435.422583096664, 14586.70826583473, 11999.100067494886, 12846.679081315953, 13308.93345533266, 13389.263590502518, 13695.657608559866, 4639.870246819602, 4712.764361781898, 4741.5732584067255, 4757.931134418281, 4867.8783030424165, 117477.0, 119570.4021479887, 120217.39891300575, 120378.39810800977, 120500.0, 10995.560177592806, 11052.392118433403, 11172.273802202993, 11292.943535282435, 11625.18623696333, 22759.0, 22811.973461194288, 22910.65634015491, 22971.88514057419, 23114.0, 7861.882071768928, 8001.599920003977, 8072.273495385443, 8096.595170241464, 8184.2224988625985, 4298.656107511454, 4327.978360108243, 4367.847125350598, 4401.449818772653, 4500.954990450119, 3440.9311813763584, 3562.5724913010604, 3566.037169964147, 3568.37553428149, 3571.8928432147077, 501.0905207049194, 504.32672382369947, 505.2043032224262, 532.430299579454, 563.8054871069556, 514.7477735909453, 536.549298589187, 581.1776336483828, 598.9031657724321, 604.1753007145215, 7372.926270737331, 8091.878621820678, 8520.105388934197, 8589.52757598338, 8681.088485709037, 522.8954209158184, 538.8356551251827, 550.7686771555956, 553.8283132229022, 574.8936446757364, 4158.972220567498, 4251.914961700749, 4270.615644592001, 4302.3546468030045, 4330.696851220448, 138353.3082334582, 138485.0, 154968.0, 156099.0, 156645.0, 137075.0, 137288.0, 140705.0, 140958.0, 144487.2775636115, 29121.0, 29199.270018249288, 29219.56170657442, 29242.41515169685, 74414.62792686219, 7985.121636619851, 8086.231807978233, 8116.350691944748, 8139.267465928095, 8407.285380742705, 46412.30381544212, 53752.1623053927, 54356.456435436725, 56170.8765824673, 56249.0, 70272.0, 81170.18829811626, 87955.56022219847, 88082.0, 89778.10221897959, 11721.531138754355, 11924.701882453008, 12194.854407658697, 12479.750404992032, 12498.312862734556, 14331.35508902081, 14509.492167774077, 14662.633434163805, 14675.165604299462, 15121.548006732126, 9964.302498825302, 13503.39234734459, 13505.397692021343, 13859.722805544034, 13904.652383690489, 10999.890001100206, 13141.0, 13299.601011969657, 13661.86338136606, 13784.241866697428, 12231.87768122343, 12582.758432295692, 12868.613941581767, 13072.673183170496, 13250.204987700768, 11105.389203593557, 11276.469424104427, 11291.774164516499, 11291.943540282246, 11348.602798901999, 9239.214666753402, 9437.292203084658, 10893.727656808325, 11176.217664763388, 11186.552537898393], "value": 7453.540124602938, "unit": "score"}], "name": "dromaeo_css", "value": 7231.651811577455, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 113.0, 114.0, 106.0, 112.0, 110.0, 113.0, 113.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 126.0, 195.0, 140.0, 107.0, 129.0, 110.0, 143.0, 108.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 184.0, 185.0, 185.0, 180.0, 182.0, 185.0, 181.0, 181.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 59.0, 87.0, 58.0, 58.0, 67.0, 61.0, 85.0, 57.0], "value": 66.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 69.0, 103.0, 71.0, 80.0, 69.0, 97.0, 71.0, 68.0, 102.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 89.0, 85.0, 90.0, 86.0, 90.0, 86.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 131.0, 94.0, 94.0, 93.0, 93.0, 93.0, 94.0, 92.0, 93.0], "value": 97.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 84.0, 87.0, 82.0, 83.0, 86.0, 86.0, 87.0, 86.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 56.0, 55.0, 57.0, 57.0, 55.0, 55.0, 57.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 75.0, 77.0, 72.0, 69.0, 69.0, 69.0, 69.0, 71.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 85.0, 85.0, 84.0, 87.0, 84.0, 85.0, 84.0, 89.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 131.0, 152.0, 153.0, 133.0, 139.0, 136.0, 140.0, 157.0, 140.0], "value": 142.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 172.0, 170.0, 172.0, 171.0, 171.0, 171.0, 173.0, 177.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 69.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1440.2, "alertThreshold": 2.0}]} 01:33:38 INFO - Return code: 0 01:33:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:33:38 INFO - # TBPL SUCCESS # 01:33:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:33:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:33:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:33:38 INFO - 2016-08-17 01:33:38.719 screenresolution[1661:10177] starting screenresolution argv=screenresolution get 01:33:38 INFO - 2016-08-17 01:33:38.722 screenresolution[1661:10177] Display 0: 1600x1200x32@60 01:33:38 INFO - 2016-08-17 01:33:38.728 screenresolution[1662:10181] starting screenresolution argv=screenresolution list 01:33:38 INFO - Available Modes on Display 0 01:33:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:33:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:33:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:33:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:33:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:33:38 INFO - Intel Iris: 01:33:38 INFO - Chipset Model: Intel Iris 01:33:38 INFO - Type: GPU 01:33:38 INFO - Bus: Built-In 01:33:38 INFO - VRAM (Dynamic, Max): 1536 MB 01:33:38 INFO - Vendor: Intel (0x8086) 01:33:38 INFO - Device ID: 0x0a2e 01:33:38 INFO - Revision ID: 0x0009 01:33:38 INFO - Displays: 01:33:38 INFO - Display: 01:33:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:33:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:33:38 INFO - Display Serial Number: 1600x1200 60 01:33:38 INFO - Main Display: Yes 01:33:38 INFO - Mirror: Off 01:33:38 INFO - Online: Yes 01:33:38 INFO - Rotation: Supported 01:33:38 INFO - Return code: 0 01:33:38 INFO - Running post-action listener: _resource_record_post_action 01:33:38 INFO - [mozharness: 2016-08-17 08:33:38.966481Z] Finished run-tests step (success) 01:33:38 INFO - Running post-run listener: _resource_record_post_run 01:33:39 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 33176576; Write bytes: 705822720; Read time: 311; Write time: 2090 01:33:39 INFO - TinderboxPrint: CPU usage
53.6% 01:33:39 INFO - TinderboxPrint: I/O read bytes / time
33,176,576 / 311 01:33:39 INFO - TinderboxPrint: I/O write bytes / time
705,822,720 / 2,090 01:33:39 INFO - TinderboxPrint: CPU idle
2,248.1 (46.4%) 01:33:39 INFO - TinderboxPrint: CPU system
969.4 (20.0%) 01:33:39 INFO - TinderboxPrint: CPU user
1,628.2 (33.6%) 01:33:39 INFO - TinderboxPrint: Swap in / out
434,655,232 / 0 01:33:39 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402770432; Write bytes: 398083584; Read time: 29777; Write time: 797 01:33:39 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 29207552; Write bytes: 295811584; Read time: 281; Write time: 1259 01:33:39 INFO - Running post-run listener: _upload_blobber_files 01:33:39 INFO - Blob upload gear active. 01:33:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:33:39 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 01:33:39 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:33:39 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:33:39 INFO - (blobuploader) - INFO - Open directory for files ... 01:33:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:33:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:33:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:33:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:33:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:33:40 INFO - (blobuploader) - INFO - Done attempting. 01:33:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:33:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:33:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:33:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:33:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:33:41 INFO - (blobuploader) - INFO - Done attempting. 01:33:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:33:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:33:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:33:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:33:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:33:44 INFO - (blobuploader) - INFO - Done attempting. 01:33:44 INFO - (blobuploader) - INFO - Iteration through files over. 01:33:44 INFO - Return code: 0 01:33:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:33:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:33:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f959bc5e7c80a39fcf6a403e002fb66fe50336e582c557df034b5135e11629534db5051e76d15c01e42627f23c2e5bd8e76703750a4529864917d5815704afa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d91eeadee9a1c6a3ba5db8af1500d962c1b9b6a76a4a9f7220e4950c11ac74343529c19bc17ff517133340c8af148991962981e76ad466c922156666e83307fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68b13cffa5d9b317c7e708a1ac777595cab5352de65b9d1e1d7447f8dc16bf617b49c937d464a17d021a187fc740bb7b98ed65e2ae6edf83cb015d36cef9dadf"} 01:33:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:33:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:33:44 INFO - Contents: 01:33:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f959bc5e7c80a39fcf6a403e002fb66fe50336e582c557df034b5135e11629534db5051e76d15c01e42627f23c2e5bd8e76703750a4529864917d5815704afa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d91eeadee9a1c6a3ba5db8af1500d962c1b9b6a76a4a9f7220e4950c11ac74343529c19bc17ff517133340c8af148991962981e76ad466c922156666e83307fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68b13cffa5d9b317c7e708a1ac777595cab5352de65b9d1e1d7447f8dc16bf617b49c937d464a17d021a187fc740bb7b98ed65e2ae6edf83cb015d36cef9dadf"} 01:33:44 INFO - Running post-run listener: copy_logs_to_upload_dir 01:33:44 INFO - Copying logs to upload dir... 01:33:44 INFO - mkdir: /builds/slave/test/build/upload/logs 01:33:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.337276 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-08-17 01:33:44.721069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 01:33:44.725574) ========= 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.OieBWXGF42/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.6xy09G0H0H/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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/Fx-Team/sha512/f959bc5e7c80a39fcf6a403e002fb66fe50336e582c557df034b5135e11629534db5051e76d15c01e42627f23c2e5bd8e76703750a4529864917d5815704afa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d91eeadee9a1c6a3ba5db8af1500d962c1b9b6a76a4a9f7220e4950c11ac74343529c19bc17ff517133340c8af148991962981e76ad466c922156666e83307fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68b13cffa5d9b317c7e708a1ac777595cab5352de65b9d1e1d7447f8dc16bf617b49c937d464a17d021a187fc740bb7b98ed65e2ae6edf83cb015d36cef9dadf"} build_url:https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011026 build_url: 'https://queue.taskcluster.net/v1/task/bM0FK-CnTYytizWi9aqdLA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f959bc5e7c80a39fcf6a403e002fb66fe50336e582c557df034b5135e11629534db5051e76d15c01e42627f23c2e5bd8e76703750a4529864917d5815704afa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d91eeadee9a1c6a3ba5db8af1500d962c1b9b6a76a4a9f7220e4950c11ac74343529c19bc17ff517133340c8af148991962981e76ad466c922156666e83307fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68b13cffa5d9b317c7e708a1ac777595cab5352de65b9d1e1d7447f8dc16bf617b49c937d464a17d021a187fc740bb7b98ed65e2ae6edf83cb015d36cef9dadf"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 01:33:44.769334) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 01:33:44.769679) ========= 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.OieBWXGF42/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.6xy09G0H0H/Listeners TMPDIR=/var/folders/mz/ztxs6sw15fq60c9skn1bw95r00000w/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.004566 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 01:33:44.818855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 01:33:44.819181) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 01:33:44.819510) ========= ========= Total master_lag: 0.23 =========