builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0119 starttime: 1471462156.75 results: success (0) buildid: 20160817092314 builduid: a3127c4875d04af2b6ac3e298cba416f revision: 27d5ebc65560febb4e7baf7f2bcc79cb373e300e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 12:29:16.746859) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 12:29:16.747252) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 12:29:16.747535) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 12:29:16.771946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 12:29:16.772224) ========= 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.Txk97UcCUl/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.mKIbnFZxaq/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 12:29: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% 102M=0s 2016-08-17 12:29:16 (102 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135519 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 12:29:16.934131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 12:29:16.934887) ========= 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.Txk97UcCUl/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.mKIbnFZxaq/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.027733 ========= master_lag: 0.21 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 12:29:17.173215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 12:29:17.173562) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 27d5ebc65560febb4e7baf7f2bcc79cb373e300e --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 27d5ebc65560febb4e7baf7f2bcc79cb373e300e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Txk97UcCUl/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.mKIbnFZxaq/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 12:29:17,256 truncating revision to first 12 chars 2016-08-17 12:29:17,256 Setting DEBUG logging. 2016-08-17 12:29:17,256 attempt 1/10 2016-08-17 12:29:17,256 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/27d5ebc65560?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 12:29:17,815 unpacking tar archive at: fx-team-27d5ebc65560/testing/mozharness/ program finished with exit code 0 elapsedTime=0.811923 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 12:29:18.013868) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 12:29:18.017622) ========= script_repo_revision: 27d5ebc65560febb4e7baf7f2bcc79cb373e300e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 12:29:18.018117) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 12:29:18.018434) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 12:29:18.038485) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-17 12:29:18.038831) ========= /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.Txk97UcCUl/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.mKIbnFZxaq/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 12:29:18 INFO - MultiFileLogger online at 20160817 12:29:18 in /builds/slave/test 12:29:18 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 12:29:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:29:18 INFO - {'append_to_log': False, 12:29:18 INFO - 'base_work_dir': '/builds/slave/test', 12:29:18 INFO - 'blob_upload_branch': 'Fx-Team', 12:29:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:29:18 INFO - 'branch': 'Fx-Team', 12:29:18 INFO - 'buildbot_json_path': 'buildprops.json', 12:29:18 INFO - 'config_files': ('talos/mac_config.py',), 12:29:18 INFO - 'default_actions': ('clobber', 12:29:18 INFO - 'read-buildbot-config', 12:29:18 INFO - 'download-and-extract', 12:29:18 INFO - 'populate-webroot', 12:29:18 INFO - 'create-virtualenv', 12:29:18 INFO - 'install', 12:29:18 INFO - 'run-tests'), 12:29:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:29:18 INFO - 'download_minidump_stackwalk': True, 12:29:18 INFO - 'download_symbols': 'ondemand', 12:29:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:29:18 INFO - 'tooltool.py': '/tools/tooltool.py', 12:29:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:29:18 INFO - '/tools/misc-python/virtualenv.py')}, 12:29:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:29:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:29:18 INFO - 'installer_path': 'installer.exe', 12:29:18 INFO - 'log_level': 'info', 12:29:18 INFO - 'log_name': 'talos', 12:29:18 INFO - 'log_to_console': True, 12:29:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:29:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:29:18 INFO - 'opt_config_files': (), 12:29:18 INFO - 'pip_index': False, 12:29:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:29:18 INFO - 'cmd': ('bash', 12:29:18 INFO - '-c', 12:29:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:29:18 INFO - 'enabled': True, 12:29:18 INFO - 'halt_on_failure': False, 12:29:18 INFO - 'name': 'check_screen_resolution'},), 12:29:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:29:18 INFO - 'cmd': ('bash', 12:29:18 INFO - '-c', 12:29:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:29:18 INFO - 'enabled': True, 12:29:18 INFO - 'halt_on_failure': False, 12:29:18 INFO - 'name': 'check_screen_resolution'},), 12:29:18 INFO - 'run_cmd_checks_enabled': True, 12:29:18 INFO - 'sps_profile': False, 12:29:18 INFO - 'sps_profile_interval': 0, 12:29:18 INFO - 'suite': 'dromaeojs', 12:29:18 INFO - 'system_bits': '32', 12:29:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:29:18 INFO - 'title': 't-yosemite-r7-0119', 12:29:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:29:18 INFO - 'use_talos_json': True, 12:29:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:29:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:29:18 INFO - 'work_dir': 'build'} 12:29:18 INFO - [mozharness: 2016-08-17 19:29:18.244225Z] Running clobber step. 12:29:18 INFO - Running pre-action listener: _resource_record_pre_action 12:29:18 INFO - Running main action method: clobber 12:29:18 INFO - rmtree: /builds/slave/test/build 12:29:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:29:20 INFO - Running post-action listener: _resource_record_post_action 12:29:20 INFO - [mozharness: 2016-08-17 19:29:20.372210Z] Finished clobber step (success) 12:29:20 INFO - [mozharness: 2016-08-17 19:29:20.372339Z] Running read-buildbot-config step. 12:29:20 INFO - Running pre-action listener: _resource_record_pre_action 12:29:20 INFO - Running main action method: read_buildbot_config 12:29:20 INFO - Using buildbot properties: 12:29:20 INFO - { 12:29:20 INFO - "project": "", 12:29:20 INFO - "product": "firefox", 12:29:20 INFO - "script_repo_revision": "production", 12:29:20 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 12:29:20 INFO - "repository": "", 12:29:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 12:29:20 INFO - "buildid": "20160817092314", 12:29:20 INFO - "pgo_build": "False", 12:29:20 INFO - "basedir": "/builds/slave/test", 12:29:20 INFO - "buildnumber": 914, 12:29:20 INFO - "slavename": "t-yosemite-r7-0119", 12:29:20 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:29:20 INFO - "platform": "yosemite_r7", 12:29:20 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 12:29:20 INFO - "branch": "fx-team", 12:29:20 INFO - "repo_path": "integration/fx-team", 12:29:20 INFO - "revision": "27d5ebc65560febb4e7baf7f2bcc79cb373e300e", 12:29:20 INFO - "stage_platform": "macosx64", 12:29:20 INFO - "builduid": "a3127c4875d04af2b6ac3e298cba416f", 12:29:20 INFO - "slavebuilddir": "test" 12:29:20 INFO - } 12:29:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 12:29:20 INFO - Running post-action listener: _resource_record_post_action 12:29:20 INFO - [mozharness: 2016-08-17 19:29:20.375860Z] Finished read-buildbot-config step (success) 12:29:20 INFO - [mozharness: 2016-08-17 19:29:20.375997Z] Running download-and-extract step. 12:29:20 INFO - Running pre-action listener: _resource_record_pre_action 12:29:20 INFO - Running main action method: download_and_extract 12:29:20 INFO - mkdir: /builds/slave/test/build/tests 12:29: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')]} 12:29:20 INFO - trying https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 12:29:20 INFO - Downloading https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/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 12:29:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/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 12:29:21 INFO - Downloaded 1199 bytes. 12:29:21 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 12:29:21 INFO - Using the following test package requirements: 12:29:21 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 12:29:21 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:29:21 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 12:29:21 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:29:21 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 12:29:21 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:29:21 INFO - u'jsshell-mac.zip'], 12:29:21 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:29:21 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 12:29:21 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 12:29:21 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:29:21 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 12:29:21 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:29:21 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 12:29:21 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:29:21 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 12:29:21 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:29:21 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 12:29:21 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:29: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')]} 12:29:21 INFO - trying https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 12:29:21 INFO - Downloading https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/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 12:29:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/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 12:29:22 INFO - Downloaded 16336720 bytes. 12:29: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 12:29:29 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 12:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:29 INFO - trying https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 12:29:29 INFO - Downloading https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/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 12:29:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/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 12:29:30 INFO - Downloaded 16336720 bytes. 12:29:30 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 12:29: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')]} 12:29:36 INFO - trying https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 12:29:36 INFO - Downloading https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/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 12:29:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/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 12:29:37 INFO - Downloaded 14413981 bytes. 12:29:37 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 12:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:38 INFO - trying https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:29:38 INFO - Downloading https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 12:29:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/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 12:29:41 INFO - Downloaded 111244133 bytes. 12:29:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:29:41 INFO - mkdir: /builds/slave/test/properties 12:29:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:29:41 INFO - Writing to file /builds/slave/test/properties/build_url 12:29:41 INFO - Contents: 12:29:41 INFO - build_url:https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:29:42 INFO - Running post-action listener: _resource_record_post_action 12:29:42 INFO - Running post-action listener: set_extra_try_arguments 12:29:42 INFO - [mozharness: 2016-08-17 19:29:42.031244Z] Finished download-and-extract step (success) 12:29:42 INFO - [mozharness: 2016-08-17 19:29:42.031375Z] Running populate-webroot step. 12:29:42 INFO - Running pre-action listener: _resource_record_pre_action 12:29:42 INFO - Running main action method: populate_webroot 12:29:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:29:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:29:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:29:42 INFO - '--tppagecycles', 12:29:42 INFO - '7'], 12:29:42 INFO - 'tests': ['tsvgm']}}, 12:29:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:29:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:29:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:29:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:29:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:29:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:29:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:42 INFO - 'talos_options': ['--disable-e10s'], 12:29:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:29:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:29:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:42 INFO - 'talos_options': ['--disable-e10s'], 12:29:42 INFO - 'tests': ['damp', 'tps']}, 12:29:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:42 INFO - 'tests': ['damp', 'tps']}, 12:29:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:29:42 INFO - 'tests': ['dromaeo_dom']}, 12:29:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:29:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:29:42 INFO - 'tests': ['basic_compositor_video']}, 12:29:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:29:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:29:42 INFO - 'tests': ['a11yr', 12:29:42 INFO - 'ts_paint', 12:29:42 INFO - 'tpaint', 12:29:42 INFO - 'sessionrestore', 12:29:42 INFO - 'sessionrestore_no_auto_restore', 12:29:42 INFO - 'tabpaint']}, 12:29:42 INFO - 'other-e10s': {'tests': ['a11yr', 12:29:42 INFO - 'ts_paint', 12:29:42 INFO - 'tpaint', 12:29:42 INFO - 'sessionrestore', 12:29:42 INFO - 'sessionrestore_no_auto_restore', 12:29:42 INFO - 'tabpaint']}, 12:29:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:29:42 INFO - 'ts_paint', 12:29:42 INFO - 'tpaint', 12:29:42 INFO - 'sessionrestore', 12:29:42 INFO - 'sessionrestore_no_auto_restore', 12:29:42 INFO - 'tabpaint']}, 12:29:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:29:42 INFO - 'ts_paint', 12:29:42 INFO - 'tpaint', 12:29:42 INFO - 'sessionrestore', 12:29:42 INFO - 'sessionrestore_no_auto_restore', 12:29:42 INFO - 'tabpaint']}, 12:29:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:29:42 INFO - 'tests': ['a11yr', 12:29:42 INFO - 'ts_paint', 12:29:42 INFO - 'tpaint', 12:29:42 INFO - 'sessionrestore', 12:29:42 INFO - 'sessionrestore_no_auto_restore', 12:29:42 INFO - 'tabpaint']}, 12:29:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:29:42 INFO - 'tests': ['a11yr', 12:29:42 INFO - 'ts_paint', 12:29:42 INFO - 'tpaint', 12:29:42 INFO - 'sessionrestore', 12:29:42 INFO - 'sessionrestore_no_auto_restore', 12:29:42 INFO - 'tabpaint']}, 12:29:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:29:42 INFO - 'tests': ['tsvgx', 12:29:42 INFO - 'tsvgr_opacity', 12:29:42 INFO - 'tart', 12:29:42 INFO - 'tscrollx', 12:29:42 INFO - 'cart']}, 12:29:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:29:42 INFO - 'tsvgr_opacity', 12:29:42 INFO - 'tart', 12:29:42 INFO - 'tscrollx', 12:29:42 INFO - 'cart']}, 12:29:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:42 INFO - 'talos_options': ['--disable-e10s'], 12:29:42 INFO - 'tests': ['tp5o']}, 12:29:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:42 INFO - 'tests': ['tp5o']}, 12:29:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:42 INFO - 'talos_options': ['--disable-e10s', 12:29:42 INFO - '--xperf_path', 12:29:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:29:42 INFO - 'tests': ['tp5n']}, 12:29:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:29:42 INFO - 'talos_options': ['--xperf_path', 12:29:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:29:42 INFO - 'tests': ['tp5n']}}, 12:29:42 INFO - 'talos.zip': {'path': '', 12:29:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:29:42 INFO - Running post-action listener: _resource_record_post_action 12:29:42 INFO - [mozharness: 2016-08-17 19:29:42.050568Z] Finished populate-webroot step (success) 12:29:42 INFO - [mozharness: 2016-08-17 19:29:42.050699Z] Running create-virtualenv step. 12:29:42 INFO - Running pre-action listener: _resource_record_pre_action 12:29:42 INFO - Running main action method: create_virtualenv 12:29:42 INFO - Creating virtualenv /builds/slave/test/build/venv 12:29:42 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 12:29:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:29:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:29:42 INFO - Using real prefix '/tools/python27' 12:29:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:29:42 INFO - Installing distribute.............................................................................................................................................................................................done. 12:29:45 INFO - Installing pip.................done. 12:29:45 INFO - Return code: 0 12:29:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:29:45 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')]} 12:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:45 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')]} 12:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:45 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 0x108061a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39bdbd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc5d30>, '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 0x107d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fbdb20>, '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.Txk97UcCUl/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.mKIbnFZxaq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 12:29:45 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 12:29:45 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 12:29:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Txk97UcCUl/Render', 12:29:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:45 INFO - 'HOME': '/Users/cltbld', 12:29:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:45 INFO - 'LOGNAME': 'cltbld', 12:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:45 INFO - 'MOZ_NO_REMOTE': '1', 12:29:45 INFO - 'NO_EM_RESTART': '1', 12:29:45 INFO - 'PAGER': '/bin/cat', 12:29:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:45 INFO - 'PWD': '/builds/slave/test', 12:29:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:45 INFO - 'SHELL': '/bin/bash', 12:29:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mKIbnFZxaq/Listeners', 12:29:45 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 12:29:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:45 INFO - 'USER': 'cltbld', 12:29:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:45 INFO - 'XPC_FLAGS': '0x0', 12:29:45 INFO - 'XPC_SERVICE_NAME': '0', 12:29:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:46 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 12:29:46 INFO - Cleaning up... 12:29:46 INFO - Return code: 0 12:29:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108061a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39bdbd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc5d30>, '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 0x107d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fbdb20>, '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.Txk97UcCUl/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.mKIbnFZxaq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 12:29:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:29:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Txk97UcCUl/Render', 12:29:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:46 INFO - 'HOME': '/Users/cltbld', 12:29:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:46 INFO - 'LOGNAME': 'cltbld', 12:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:46 INFO - 'MOZ_NO_REMOTE': '1', 12:29:46 INFO - 'NO_EM_RESTART': '1', 12:29:46 INFO - 'PAGER': '/bin/cat', 12:29:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:46 INFO - 'PWD': '/builds/slave/test', 12:29:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:46 INFO - 'SHELL': '/bin/bash', 12:29:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mKIbnFZxaq/Listeners', 12:29:46 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 12:29:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:46 INFO - 'USER': 'cltbld', 12:29:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:46 INFO - 'XPC_FLAGS': '0x0', 12:29:46 INFO - 'XPC_SERVICE_NAME': '0', 12:29:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:46 INFO - Downloading/unpacking psutil>=3.1.1 12:29:46 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 12:29:46 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 12:29:46 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 12:29:46 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 12:29:46 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 12:29:46 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 12:29:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:29:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:29:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:29:50 INFO - Installing collected packages: psutil 12:29:50 INFO - Running setup.py install for psutil 12:29:50 INFO - building 'psutil._psutil_osx' extension 12:29:50 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 12:29:50 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 12:29:50 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 12:29:50 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 12:29:51 INFO - building 'psutil._psutil_posix' extension 12:29:51 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 12:29:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:29:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:29:51 INFO - ^ 12:29:51 INFO - 1 warning generated. 12:29:51 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 12:29:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:29:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:29:51 INFO - Successfully installed psutil 12:29:51 INFO - Cleaning up... 12:29:51 INFO - Return code: 0 12:29:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:29:51 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')]} 12:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:51 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')]} 12:29:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:51 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 0x108061a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39bdbd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc5d30>, '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 0x107d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fbdb20>, '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.Txk97UcCUl/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.mKIbnFZxaq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 12:29:51 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 12:29:51 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 12:29:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Txk97UcCUl/Render', 12:29:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:51 INFO - 'HOME': '/Users/cltbld', 12:29:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:51 INFO - 'LOGNAME': 'cltbld', 12:29:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:51 INFO - 'MOZ_NO_REMOTE': '1', 12:29:51 INFO - 'NO_EM_RESTART': '1', 12:29:51 INFO - 'PAGER': '/bin/cat', 12:29:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:51 INFO - 'PWD': '/builds/slave/test', 12:29:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:51 INFO - 'SHELL': '/bin/bash', 12:29:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mKIbnFZxaq/Listeners', 12:29:51 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 12:29:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:51 INFO - 'USER': 'cltbld', 12:29:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:51 INFO - 'XPC_FLAGS': '0x0', 12:29:51 INFO - 'XPC_SERVICE_NAME': '0', 12:29:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:29:51 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 12:29:51 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 12:29:51 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 12:29:51 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 12:29:51 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 12:29:51 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 12:29:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:29:54 INFO - Installing collected packages: mozsystemmonitor 12:29:54 INFO - Running setup.py install for mozsystemmonitor 12:29:54 INFO - Successfully installed mozsystemmonitor 12:29:54 INFO - Cleaning up... 12:29:54 INFO - Return code: 0 12:29:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:54 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 0x108061a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39bdbd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc5d30>, '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 0x107d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fbdb20>, '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.Txk97UcCUl/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.mKIbnFZxaq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 12:29:54 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 12:29:54 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 12:29:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Txk97UcCUl/Render', 12:29:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:54 INFO - 'HOME': '/Users/cltbld', 12:29:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:54 INFO - 'LOGNAME': 'cltbld', 12:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:54 INFO - 'MOZ_NO_REMOTE': '1', 12:29:54 INFO - 'NO_EM_RESTART': '1', 12:29:54 INFO - 'PAGER': '/bin/cat', 12:29:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:54 INFO - 'PWD': '/builds/slave/test', 12:29:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:54 INFO - 'SHELL': '/bin/bash', 12:29:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mKIbnFZxaq/Listeners', 12:29:54 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 12:29:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:54 INFO - 'USER': 'cltbld', 12:29:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:54 INFO - 'XPC_FLAGS': '0x0', 12:29:54 INFO - 'XPC_SERVICE_NAME': '0', 12:29:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:54 INFO - Downloading/unpacking jsonschema==2.5.1 12:29:54 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 12:29:54 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 12:29:54 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 12:29:54 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 12:29:54 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 12:29:54 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 12:29:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:29:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:29:57 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 12:29:57 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 12:29:57 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 12:29:57 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 12:29:57 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 12:29:57 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 12:29:57 INFO - Downloading functools32-3.2.3-2.tar.gz 12:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:29:57 INFO - warning: no files found matching '*.txt' 12:29:57 INFO - no previously-included directories found matching 'build' 12:29:57 INFO - no previously-included directories found matching 'dist' 12:29:57 INFO - no previously-included directories found matching '.git*' 12:29:57 INFO - Installing collected packages: jsonschema, functools32 12:29:57 INFO - Running setup.py install for functools32 12:29:57 INFO - warning: no files found matching '*.txt' 12:29:57 INFO - no previously-included directories found matching 'build' 12:29:57 INFO - no previously-included directories found matching 'dist' 12:29:57 INFO - no previously-included directories found matching '.git*' 12:29:57 INFO - Successfully installed jsonschema functools32 12:29:57 INFO - Cleaning up... 12:29:57 INFO - Return code: 0 12:29:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:29:57 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')]} 12:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:57 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')]} 12:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:57 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 0x108061a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39bdbd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc5d30>, '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 0x107d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fbdb20>, '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.Txk97UcCUl/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.mKIbnFZxaq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 12:29:57 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 12:29:57 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 12:29:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Txk97UcCUl/Render', 12:29:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:57 INFO - 'HOME': '/Users/cltbld', 12:29:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:57 INFO - 'LOGNAME': 'cltbld', 12:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:57 INFO - 'MOZ_NO_REMOTE': '1', 12:29:57 INFO - 'NO_EM_RESTART': '1', 12:29:57 INFO - 'PAGER': '/bin/cat', 12:29:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:57 INFO - 'PWD': '/builds/slave/test', 12:29:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:57 INFO - 'SHELL': '/bin/bash', 12:29:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mKIbnFZxaq/Listeners', 12:29:57 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 12:29:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:57 INFO - 'USER': 'cltbld', 12:29:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:57 INFO - 'XPC_FLAGS': '0x0', 12:29:57 INFO - 'XPC_SERVICE_NAME': '0', 12:29:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:29:58 INFO - Cleaning up... 12:29:58 INFO - Return code: 0 12:29:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:29: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')]} 12:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29: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')]} 12:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29: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', '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 0x108061a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39bdbd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc5d30>, '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 0x107d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fbdb20>, '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.Txk97UcCUl/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.mKIbnFZxaq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 12:29: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:29: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 blobuploader==1.2.4 12:29:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Txk97UcCUl/Render', 12:29:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:29:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:29:58 INFO - 'HOME': '/Users/cltbld', 12:29:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:29:58 INFO - 'LOGNAME': 'cltbld', 12:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:58 INFO - 'MOZ_NO_REMOTE': '1', 12:29:58 INFO - 'NO_EM_RESTART': '1', 12:29:58 INFO - 'PAGER': '/bin/cat', 12:29:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:58 INFO - 'PWD': '/builds/slave/test', 12:29:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:29:58 INFO - 'SHELL': '/bin/bash', 12:29:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mKIbnFZxaq/Listeners', 12:29:58 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 12:29:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:29:58 INFO - 'USER': 'cltbld', 12:29:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:29:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:58 INFO - 'XPC_FLAGS': '0x0', 12:29:58 INFO - 'XPC_SERVICE_NAME': '0', 12:29:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:58 INFO - Downloading/unpacking blobuploader==1.2.4 12:29: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 12:29: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 12:29: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 12:29: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 12:29: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 12:29: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 12:30:00 INFO - Downloading blobuploader-1.2.4.tar.gz 12:30:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:30:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:30:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:30:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:30:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:30:01 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 12:30:01 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 12:30:01 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 12:30:01 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 12:30:01 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 12:30:01 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 12:30:02 INFO - Downloading docopt-0.6.1.tar.gz 12:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:30:02 INFO - Installing collected packages: blobuploader, requests, docopt 12:30:02 INFO - Running setup.py install for blobuploader 12:30:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:30:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:30:02 INFO - Running setup.py install for requests 12:30:02 INFO - Running setup.py install for docopt 12:30:02 INFO - Successfully installed blobuploader requests docopt 12:30:02 INFO - Cleaning up... 12:30:03 INFO - Return code: 0 12:30:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:03 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 0x108061a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39bdbd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc5d30>, '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 0x107d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fbdb20>, '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.Txk97UcCUl/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.mKIbnFZxaq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 12:30:03 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 12:30:03 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 12:30:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Txk97UcCUl/Render', 12:30:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:30:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:30:03 INFO - 'HOME': '/Users/cltbld', 12:30:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:30:03 INFO - 'LOGNAME': 'cltbld', 12:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:03 INFO - 'MOZ_NO_REMOTE': '1', 12:30:03 INFO - 'NO_EM_RESTART': '1', 12:30:03 INFO - 'PAGER': '/bin/cat', 12:30:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:03 INFO - 'PWD': '/builds/slave/test', 12:30:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:30:03 INFO - 'SHELL': '/bin/bash', 12:30:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mKIbnFZxaq/Listeners', 12:30:03 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 12:30:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:30:03 INFO - 'USER': 'cltbld', 12:30:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:30:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:03 INFO - 'XPC_FLAGS': '0x0', 12:30:03 INFO - 'XPC_SERVICE_NAME': '0', 12:30:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:30:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-V8a2RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:30:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-wwhZQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:30:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-oZiIxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:30:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-ubVotA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:30:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-PvRCTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:30:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-2krqDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:30:03 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-DOxMcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:30:04 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-H89fM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:30:04 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-V2rz7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:30:04 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-D3DfYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:30:04 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-lB6xxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:30:04 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-uSSA4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:30:04 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-AeIKsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:30:04 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-JnPd4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:30:04 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-eR8vCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:30:04 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-ODwvRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:30:05 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-97F3cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:30:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:30:05 INFO - Running setup.py install for manifestparser 12:30:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:30:05 INFO - Running setup.py install for mozcrash 12:30:05 INFO - Running setup.py install for mozdebug 12:30:05 INFO - Running setup.py install for mozdevice 12:30:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:30:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:30:05 INFO - Running setup.py install for mozfile 12:30:05 INFO - Running setup.py install for mozhttpd 12:30:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:30:06 INFO - Running setup.py install for mozinfo 12:30:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:30:06 INFO - Running setup.py install for mozInstall 12:30:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:30:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:30:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:30:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:30:06 INFO - Running setup.py install for mozleak 12:30:06 INFO - Running setup.py install for mozlog 12:30:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:30:06 INFO - Running setup.py install for moznetwork 12:30:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:30:06 INFO - Running setup.py install for mozprocess 12:30:06 INFO - Running setup.py install for mozprofile 12:30:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:30:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:30:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:30:07 INFO - Running setup.py install for mozrunner 12:30:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:30:07 INFO - Running setup.py install for mozscreenshot 12:30:07 INFO - Running setup.py install for moztest 12:30:07 INFO - Running setup.py install for mozversion 12:30:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:30:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:30:07 INFO - Cleaning up... 12:30:07 INFO - Return code: 0 12:30:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:30: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')]} 12:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:08 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')]} 12:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:08 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 0x108061a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39bdbd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc5d30>, '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 0x107d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fbdb20>, '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.Txk97UcCUl/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.mKIbnFZxaq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 12:30:08 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 12:30:08 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 12:30:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Txk97UcCUl/Render', 12:30:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:30:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:30:08 INFO - 'HOME': '/Users/cltbld', 12:30:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:30:08 INFO - 'LOGNAME': 'cltbld', 12:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:08 INFO - 'MOZ_NO_REMOTE': '1', 12:30:08 INFO - 'NO_EM_RESTART': '1', 12:30:08 INFO - 'PAGER': '/bin/cat', 12:30:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:08 INFO - 'PWD': '/builds/slave/test', 12:30:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:30:08 INFO - 'SHELL': '/bin/bash', 12:30:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mKIbnFZxaq/Listeners', 12:30:08 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 12:30:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:30:08 INFO - 'USER': 'cltbld', 12:30:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:30:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:08 INFO - 'XPC_FLAGS': '0x0', 12:30:08 INFO - 'XPC_SERVICE_NAME': '0', 12:30:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:30:08 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-ed649G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:30:08 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)) 12:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:30:08 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-6YK8ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:30:08 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)) 12:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:30:08 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-q3w3vX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:30:08 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)) 12:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:30:08 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-K6QuYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:30:08 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)) 12:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:30:08 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-DfhtnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:30:08 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)) 12:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:30:08 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-zq_eTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:30:09 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)) 12:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:30:09 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-tIUK8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:30:09 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)) 12:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:30:09 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-W_BVEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:30:09 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)) 12:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:30:09 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-AYkI99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:30:09 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)) 12:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:30:09 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-mCvOkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:30:09 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)) 12:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:30:09 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-qHGKhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:30:09 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)) 12:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:30:09 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-50I9Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:30:09 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)) 12:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:30:09 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-JbQAdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:30:09 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)) 12:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:30:09 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-TBD5NV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:30:09 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)) 12:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:30:09 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Kup2wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:30:10 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)) 12:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:30:10 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-W9VnMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:30:10 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)) 12:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:30:10 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-RO58dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:30:10 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)) 12:30:10 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)) 12:30:10 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)) 12:30:10 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)) 12:30:10 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)) 12:30:10 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)) 12:30:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:30: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 12:30: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 12:30: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 12:30: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 12:30: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 12:30: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 12:30:13 INFO - Downloading blessings-1.6.tar.gz 12:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:30:13 INFO - Installing collected packages: blessings 12:30:13 INFO - Running setup.py install for blessings 12:30:13 INFO - Successfully installed blessings 12:30:13 INFO - Cleaning up... 12:30:13 INFO - Return code: 0 12:30:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:30:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:30:13 INFO - Reading from file tmpfile_stdout 12:30:13 INFO - Current package versions: 12:30:13 INFO - blessings == 1.6 12:30:13 INFO - blobuploader == 1.2.4 12:30:13 INFO - docopt == 0.6.1 12:30:13 INFO - functools32 == 3.2.3-2 12:30:13 INFO - jsonschema == 2.5.1 12:30:13 INFO - manifestparser == 1.1 12:30:13 INFO - mozInstall == 1.12 12:30:13 INFO - mozcrash == 0.17 12:30:13 INFO - mozdebug == 0.1 12:30:13 INFO - mozdevice == 0.48 12:30:13 INFO - mozfile == 1.2 12:30:13 INFO - mozhttpd == 0.7 12:30:13 INFO - mozinfo == 0.9 12:30:13 INFO - mozleak == 0.1 12:30:13 INFO - mozlog == 3.3 12:30:13 INFO - moznetwork == 0.27 12:30:13 INFO - mozprocess == 0.23 12:30:13 INFO - mozprofile == 0.28 12:30:13 INFO - mozrunner == 6.12 12:30:13 INFO - mozscreenshot == 0.1 12:30:13 INFO - mozsystemmonitor == 0.3 12:30:13 INFO - moztest == 0.7 12:30:13 INFO - mozversion == 1.4 12:30:13 INFO - psutil == 3.1.1 12:30:13 INFO - requests == 1.2.3 12:30:13 INFO - wsgiref == 0.1.2 12:30:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:13 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 0x108061a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39bdbd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc5d30>, '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 0x107d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fbdb20>, '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.Txk97UcCUl/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.mKIbnFZxaq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 12:30:13 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 12:30:13 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 12:30:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Txk97UcCUl/Render', 12:30:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:30:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:30:13 INFO - 'HOME': '/Users/cltbld', 12:30:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:30:13 INFO - 'LOGNAME': 'cltbld', 12:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:13 INFO - 'MOZ_NO_REMOTE': '1', 12:30:13 INFO - 'NO_EM_RESTART': '1', 12:30:13 INFO - 'PAGER': '/bin/cat', 12:30:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:13 INFO - 'PWD': '/builds/slave/test', 12:30:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:30:13 INFO - 'SHELL': '/bin/bash', 12:30:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mKIbnFZxaq/Listeners', 12:30:13 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 12:30:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:30:13 INFO - 'USER': 'cltbld', 12:30:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:30:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:13 INFO - 'XPC_FLAGS': '0x0', 12:30:13 INFO - 'XPC_SERVICE_NAME': '0', 12:30:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:14 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)) 12:30:14 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)) 12:30:14 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)) 12:30:14 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)) 12:30:14 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)) 12:30:14 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)) 12:30:14 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)) 12:30:14 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)) 12:30:14 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)) 12:30:14 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)) 12:30:14 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)) 12:30:14 INFO - Cleaning up... 12:30:14 INFO - Return code: 0 12:30:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:30:14 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')]} 12:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:30:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:14 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')]} 12:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:30:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:30:14 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 0x108061a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1080f6618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe39bdbd410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fc5d30>, '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 0x107d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fbdb20>, '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.Txk97UcCUl/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.mKIbnFZxaq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 12:30:14 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 12:30:14 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 12:30:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Txk97UcCUl/Render', 12:30:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:30:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:30:14 INFO - 'HOME': '/Users/cltbld', 12:30:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:30:14 INFO - 'LOGNAME': 'cltbld', 12:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:14 INFO - 'MOZ_NO_REMOTE': '1', 12:30:14 INFO - 'NO_EM_RESTART': '1', 12:30:14 INFO - 'PAGER': '/bin/cat', 12:30:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:14 INFO - 'PWD': '/builds/slave/test', 12:30:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:30:14 INFO - 'SHELL': '/bin/bash', 12:30:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mKIbnFZxaq/Listeners', 12:30:14 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 12:30:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:30:14 INFO - 'USER': 'cltbld', 12:30:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:30:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:14 INFO - 'XPC_FLAGS': '0x0', 12:30:14 INFO - 'XPC_SERVICE_NAME': '0', 12:30:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:30:14 INFO - Cleaning up... 12:30:14 INFO - Return code: 0 12:30:14 INFO - Running post-action listener: _resource_record_post_action 12:30:14 INFO - Running post-action listener: _start_resource_monitoring 12:30:14 INFO - Starting resource monitoring. 12:30:14 INFO - [mozharness: 2016-08-17 19:30:14.368536Z] Finished create-virtualenv step (success) 12:30:14 INFO - [mozharness: 2016-08-17 19:30:14.369557Z] Running install step. 12:30:14 INFO - Running pre-action listener: _resource_record_pre_action 12:30:14 INFO - Running main action method: install 12:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:30:14 INFO - Reading from file tmpfile_stdout 12:30:14 INFO - Detecting whether we're running mozinstall >=1.0... 12:30:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:30:14 INFO - Reading from file tmpfile_stdout 12:30:14 INFO - Output received: 12:30:14 INFO - Usage: mozinstall [options] installer 12:30:14 INFO - Options: 12:30:14 INFO - -h, --help show this help message and exit 12:30:14 INFO - -d DEST, --destination=DEST 12:30:14 INFO - Directory to install application into. [default: 12:30:14 INFO - "/builds/slave/test"] 12:30:14 INFO - --app=APP Application being installed. [default: firefox] 12:30:14 INFO - mkdir: /builds/slave/test/build/application 12:30:14 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'] 12:30:14 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 12:30:49 INFO - Reading from file tmpfile_stdout 12:30:49 INFO - Output received: 12:30:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:30:49 INFO - Running post-action listener: _resource_record_post_action 12:30:49 INFO - [mozharness: 2016-08-17 19:30:49.760976Z] Finished install step (success) 12:30:49 INFO - [mozharness: 2016-08-17 19:30:49.761130Z] Running run-tests step. 12:30:49 INFO - Running pre-action listener: _resource_record_pre_action 12:30:49 INFO - Running main action method: run_tests 12:30:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:30:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:30:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:30:49 INFO - 2016-08-17 12:30:49.775 screenresolution[1639:7522] starting screenresolution argv=screenresolution get 12:30:49 INFO - 2016-08-17 12:30:49.778 screenresolution[1639:7522] Display 0: 1600x1200x32@60 12:30:49 INFO - 2016-08-17 12:30:49.784 screenresolution[1640:7524] starting screenresolution argv=screenresolution list 12:30:49 INFO - Available Modes on Display 0 12:30:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:30:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:30:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:30:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:30:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:30:50 INFO - Intel Iris: 12:30:50 INFO - Chipset Model: Intel Iris 12:30:50 INFO - Type: GPU 12:30:50 INFO - Bus: Built-In 12:30:50 INFO - VRAM (Dynamic, Max): 1536 MB 12:30:50 INFO - Vendor: Intel (0x8086) 12:30:50 INFO - Device ID: 0x0a2e 12:30:50 INFO - Revision ID: 0x0009 12:30:50 INFO - Displays: 12:30:50 INFO - Display: 12:30:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:30:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:30:50 INFO - Display Serial Number: 1600x1200 60 12:30:50 INFO - Main Display: Yes 12:30:50 INFO - Mirror: Off 12:30:50 INFO - Online: Yes 12:30:50 INFO - Rotation: Supported 12:30:50 INFO - Return code: 0 12:30:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:30:50 INFO - Python 2.7.3 12:30:50 INFO - Return code: 0 12:30:50 INFO - grabbing minidump binary from tooltool 12:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:30:50 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 0x107fc5d30>, '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 0x107d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fbdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:30:50 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 12:30:50 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 12:30:50 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 12:30:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:30:50 INFO - Return code: 0 12:30:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:30:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:30:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:30:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:30:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:30:50 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/HfYyppbkRsGb0mUmgHBRrA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0119', '--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 12:30:50 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/HfYyppbkRsGb0mUmgHBRrA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0119 --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 12:30:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Txk97UcCUl/Render', 12:30:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:30:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:30:50 INFO - 'HOME': '/Users/cltbld', 12:30:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:30:50 INFO - 'LOGNAME': 'cltbld', 12:30:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:30:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:30:50 INFO - 'MOZ_NO_REMOTE': '1', 12:30:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:30:50 INFO - 'NO_EM_RESTART': '1', 12:30:50 INFO - 'PAGER': '/bin/cat', 12:30:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:30:50 INFO - 'PWD': '/builds/slave/test', 12:30:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:30:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:30:50 INFO - 'SHELL': '/bin/bash', 12:30:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mKIbnFZxaq/Listeners', 12:30:50 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 12:30:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:30:50 INFO - 'USER': 'cltbld', 12:30:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:30:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:30:50 INFO - 'XPC_FLAGS': '0x0', 12:30:50 INFO - 'XPC_SERVICE_NAME': '0', 12:30:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:30:50 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/HfYyppbkRsGb0mUmgHBRrA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0119', '--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 12:30:50 INFO - mozversion application_buildid: 20160817092314 12:30:50 INFO - mozversion application_changeset: 27d5ebc65560febb4e7baf7f2bcc79cb373e300e 12:30:50 INFO - mozversion application_display_name: Nightly 12:30:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:30:50 INFO - mozversion application_name: Firefox 12:30:50 INFO - mozversion application_remotingname: firefox 12:30:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:30:50 INFO - mozversion application_vendor: Mozilla 12:30:50 INFO - mozversion application_version: 51.0a1 12:30:50 INFO - mozversion platform_buildid: 20160817092314 12:30:50 INFO - mozversion platform_changeset: 27d5ebc65560febb4e7baf7f2bcc79cb373e300e 12:30:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:30:50 INFO - mozversion platform_version: 51.0a1 12:30:50 INFO - using testdate: 1471462250 12:30:50 INFO - actual date: 1471462250 12:30:50 INFO - starting webserver on 'localhost:49270' 12:30:50 INFO - SUITE-START | Running 2 tests 12:30:50 INFO - TEST-START | dromaeo_css 12:30:50 INFO - operating with platform_type : mac_ 12:30:50 INFO - Initialising browser for dromaeo_css test... 12:30:50 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpxY_VQh/profile http://localhost:49270/getInfo.html) 12:30:52 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 12:30:52 INFO - PROCESS | 1650 | colorDepth:24 12:30:52 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 12:30:52 INFO - PROCESS | 1650 | __metrics 12:30:52 INFO - PROCESS | 1650 | 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" 12:30:52 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:30:53 INFO - TEST-INFO | 1650: exit 0 12:30:53 INFO - Browser initialized. 12:30:53 INFO - Running cycle 1/1 for dromaeo_css test... 12:30:53 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpxY_VQh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:31:05 INFO - PROCESS | 1651 | RSS: Main: 227844096 12:31:05 INFO - PROCESS | 1651 | 12:31:56 INFO - PROCESS | 1651 | 1471462316979 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] 12:34:09 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 12:34:10 INFO - PROCESS | 1651 | RSS: Main: 343478272 12:34:10 INFO - PROCESS | 1651 | 12:37:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 12:37:14 INFO - PROCESS | 1651 | RSS: Main: 371834880 12:37:14 INFO - PROCESS | 1651 | 12:40:16 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 12:40:17 INFO - PROCESS | 1651 | RSS: Main: 349163520 12:40:17 INFO - PROCESS | 1651 | 12:43:19 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 12:43:20 INFO - PROCESS | 1651 | RSS: Main: 344420352 12:43:20 INFO - PROCESS | 1651 | 12:46:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 12:46:24 INFO - PROCESS | 1651 | RSS: Main: 330817536 12:46:24 INFO - PROCESS | 1651 | 12:49:28 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 12:49:28 INFO - PROCESS | 1651 | RSS: Main: 504762368 12:49:28 INFO - PROCESS | 1651 | 12:49:28 INFO - PROCESS | 1651 | __start_tp_report 12:49:28 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 12:49:28 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 12:49:28 INFO - PROCESS | 1651 | |i|pagename|runs| 12:49:28 INFO - PROCESS | 1651 | |0;dojo.html;3329.334133173365;3352;3360.7143392811618;3374.8481318340673;3381.594208694957;5545.584081193916;5627.127795191742;5667.206591077247;5675.659460432372;5683.261176047114;5632.662040277586;5683.630564013336;5693;5698.34469036061;5700.8859822803515;5157.174852023686;5180.430152683201;5201.271821944912;5219.373675158968;5261.736913154346;5189.766460509286;5227.111391063529;5233.869153271161;5243.580513558906;5283.233931079991;5157.871053223681;5177.896442071156;5194.584433245332;5214.270002199695;5221.634485586011;5269.973650131763;5272.340957380327;5273.841784746463;5280.867978300535;5326.440723723992;5099.36257967754;5130.71781052042;5135.12702840518;5198.376194856603;5214.296070030536;4628.5371462853445;5603.859903502404;5651.717414129277;5674.914876276818;5692.089265717506;6237.313895471494;6260.342664020258;6273.1531243282025;6273.62358258506;6273.62358258506;6146.078088286793;6215.813525594194;6252.812415627538;6278.121063051177;6319.0837328587095;5814.825555233349;5831.183634291203;5844.152597873284;5849.649021058707;5875.118732190205;6271.059341098871;6276.932921403372;6301.212348456443;6312.873742525216;6321.55749097568;6005.369436209223;6071.757129714851;6083.178770865965;6107.674343494518;6186.412290832363;6252.468540174045;6267.1539342189135;6285.9057114143325;6294.685265736694;6305.716242769086;6131.509479241739;6186.597871138361;6218.1916350875;6223.3465486123305;6227.314995350508;6107.522607572277;6114.541409394314;6136.427173609184;6212.47193988507;6248.562600618004;4902.8774280643265;4924.261360795909;4927.926081108786;4958;5002.799888004439;4423.5576442355505;4432.423784907941;4441.022974945507;4441.689081764245;4480.932786008212;5701.4298570142655;5703.914441283384;5711.3146422428745;5716.5140963017775;5764.106563482667;6126.295476020226;6209.2548894133;6216.191895053705;6272.905906411407;6283.465905398001;5637.548996080303;5648.181013753065;5679.602427830095;5702.600817942704;5703.54371650267;5422.91865622016;5435.42927992563;5437.048516509674;5443.727813609304;5477.780888764405;6283.120363149163;6291.96854015727;6320.367963203643;6324.557280990287;6324.936750632619;6122.123717501779;6189.566730328834;6208.534359923115;6279.811605651837;6310.11658367838;6303.716332765129;6304.338044505261;6305.432511074026;6315.968420158054;6319.778807741707;6080.969595151996;6166.260048794174;6175.320714721467;6189.473894718999;6222.377762223741;6138.447539721446;6177.382261773787;6282.3089460158435;6294.024426213944;6312.589681670676;6044.9395506044375;6133.570650054453;6138.449706860497;6148.661823599566;6184.5052395809125;6101.904600373152;6113.902014424272;6129.389354848411;6130.245269656939;6143.849652621547;5726.484616384545;5851.853703657443;5962.9105563415715;6004.219451471281;6008.218931538872;6010.459058684564;6095.451409373178;6107.46191531438;6108.297545782292;6111.7740652348275;5906.557008224487;5914.053751399755;5917.378675239038;5921.61509501881;5922.318933322723 12:49:28 INFO - PROCESS | 1651 | |1;ext.html;469.70408642555185;477.1292391385721;505.4465360430327;514.915039018562;528.9629725919187;30613.846930765343;40372.79813600932;41489.79255103728;41702;43592.12815743683;42831.571684283146;43181.568184318145;43227;43255;43264.78367608158;9764.658236961726;9933.503324833766;9948.054934781185;9953.004699530062;9956.900430995705;9824.312298139133;9902.702918912444;9911.851322230172;9912.702618921443;9913.058259465339;9886;9938;9939;9943.403395796275;9957;8913.440147974079;9405.648587853071;9918.652847150388;9919.603215871357;9925.354851934673;8232.50604963704;9763.170130538912;9774.755631109208;9775.462349570771;9779.41323520591;40075.79962100171;40458;40484.79757601223;40516.797416013025;40559;3554.8222588870453;3591.494877483377;3601.1897323102353;3675.8897233082785;3824.5028146341074;30856.53715194274;31193.22016949572;31900.680993190235;32045.87839425632;32411;3273.2307907641684;3285.4743241081314;3341.899743007714;3379.5268662387284;3416.829158542063;430709;431175.6882431167;436445;439035;440860;33169.50245746267;57698.13452798211;58036;58272.12591811126;58305;33711.15722106967;33768.64925403005;33799;33873.491897621556;33895.66104338925;14442.855571444152;14548.272586370851;14589.781153282709;14616.853831461549;14617.903657225537;12262.81605775914;12351.19717218378;12382.690432739253;12386.194897331825;12407.503699852085;7707.113681926538;7756;7801.414893882981;7811.140774514799;7811.843763124706;3164.7784655073924;3209.5185722141864;3224.6614105518584;3228.467302894996;3253.4622994064666;949.1125797379473;957.7988622389377;962.875469102766;997.5012493753123;1014.8883622801486;26037.349066273116;30386.84806575953;30432.54351184734;30835.845820771203;31127.844360778505;974.541965276319;987.6148302162162;998.6504723346916;1014.8883622801486;1122.1639878290725;15211.695766084616;15780.895337326278;15816.92091539558;15901.204939752966;16297.674046519003;168324;169721;170274.14862925606;536036;544958;42000;42329.57670423318;42343;42408;42462.63060540944;1238.3065483329185;1335.786274196124;1368.8699573540498;1380.4892189889806;1388.139353600774;30583.541246880868;31546.526802097527;31832;32177.839110804296;32347.514787277738;50547;51188.97622047464;51262.97474050573;51277.48722512727;51406.74296628493;357087;418944;419065;424921;425805;23666.93498792524;24329.39176520601;26907.865460672572;27132.879718832588;27146.72853271442;46517.302240465746;47140.528594713614;47348;47959.520404795505;48151;35912.46131308085;37766;38234.61765382311;39220.41169382518;40026.59973400229;38517.2296554073;39289.01777455586;39501.604983949794;39555.60444395519;40669;37677.434838477995;37927.62072379241;37944;38028.42957355586;38906;32441.35117297688;33901.3219735599;34398.48402274018;34468.138296542784;34647.48028779621;22090.33728988133;25245.621315679913;25401.87299063493;25891.611625826004;26168.8691556541 12:49:28 INFO - PROCESS | 1651 | |2;jquery.html;339.8012162884712;346.15710744337554;362.3694771098289;363.8744633101581;376.88881779874936;15286.464973725908;18108.547286317847;20588.588228235425;21223.68164477534;21341.253056143058;20759.79240207601;20815;21183;21357.786422135774;21367.465813354673;5852.209951656536;5890.2931648202275;6070.332263451017;6166.383361663842;6181.721822517998;4177.791110444481;6011.5190784737115;6100.7864724734645;6113.572049956505;6113.755449782004;4051.837926482952;4398.8020539075815;4421.801018954155;4423.469183697945;6836.521443498957;6801.829954251134;6830.999999999975;6842.315768423118;6847.2125705544;6850.794476165723;5682;5891.116332550109;5923.229980102602;5937.168796368512;5967.224260846062;27082.91668333264;27394.863025684943;27502.44995100107;27509.762060707315;27574.310642234104;2242.7196600424945;2275.670027845953;2303.4702018535663;2555.7827584655142;3048.71953779411;15129.940904136714;15813.367465301375;15983.600409989727;16141.435049773201;16247.756283655637;1616.4180894877834;1823.4803081121815;1862.2644055597964;1934.3764770267944;1978.268040824904;110589;112120;112613.87386126198;113519;117088;10362.481875906175;10649.680509584725;10888.564457421773;11366.829497557543;11414.258073225214;14136.222507762172;14142.43430262778;14172;14180.645483862985;14184.007119501743;7997.280244777881;8123.83752324962;8197.34421246299;8297.087320394752;8348.749537513884;7858.253465920729;7861.803454913558;7885.172056934054;8044.758657240292;8054.959725201336;5547.528460080938;6742.6628668567355;6820.9658951705915;6860.897086543706;6870.141232345957;1528.8776897848145;1541.7049678270082;1633.9869281045828;1640.2946732904727;1675.4554769699896;890.8841850559386;894.9373543851998;921.5944984206927;1004.8794144702537;1112.9387883666477;19845.206191752168;20497.48756281075;21411.571768564543;22470.440151837985;23097.53804923892;910.8178364327028;925.9259259259243;951.9619215231452;958.1328897347911;969.0503306759274;9562.760930976641;11193.578154612502;11589;11708.356040417859;11943.163978521594;470946;543800;546223;548352;549389.2530537322;126652.1002184968;129012;129702.35148824195;131415;134477;948.4546385828177;979.1383582447401;983.2036050798876;984;984.2962281968427;16874.74687879658;19103.904480477508;19928;20114.99425028772;20725.378238652866;53685;53742.19386709281;56161;57087;57758.422415775305;76076;76984;77414;78365.60817195878;82391.5880420594;5552.583556233218;7558.055243094614;8124.715634952749;8247.381446391664;8356.498610083172;12973.962083033146;13095.803562946754;13129;13362.665933351744;13694.52069177574;9520.761980950532;9682.951585242028;11372.147088968526;11504.712382190512;11631.360275184608;10882.129429645767;11243.60647377338;11311.604093856675;11561.132915031238;11702.765944680888;11435.656930292105;11693;11920.986716129226;11967.64097077089;11983.76032479363;8174.019117705913;8327.666893324442;8340.332773378237;8354.958225209079;8469.237768600855;11042.779144417227;11471;11601.809502386574;11662.94168529152;11775.705607359885 12:49:28 INFO - PROCESS | 1651 | |3;mootools.html;1375.7454870848887;1532.8237252715942;1562.6093476630845;1721.9741703874436;1859.3956963986707;7773.300402963732;8268.214519620642;8269.751907442778;8330.167363180091;8557.957210213955;8409.579521023956;8463.661453541867;8464.492130472161;8468.618912148953;8471.449355791885;2328.93013209604;2353.7763912428377;2357.8938947747392;2358.9999999999914;2361.456864921069;2287.611106111965;2325.03511042917;2344.7186337639423;2349.4713689419827;2357;2111.577684463106;2306.6078766609717;2332.8133749300014;2342.0514691549865;2346.671465994762;2178.5425060737266;2305.6887320211727;2324;2325.790678838904;2327.034280773477;2307.5038866643754;2315.4674424882205;2316.2587971849016;2319.6404557293645;2320;8491.830163396759;8534.658613655447;8552.187542183545;8558.61486233121;8561;5199.922001169985;5222.720433493781;5368.62419630626;5369.140937449989;5369.865753356197;2995.7453616442626;3059.5410688396696;3714.814259287025;3723.3670276052867;3737.1404576947452;1110.6057349640923;1117.3072694929197;1137.6302701621923;1146.2606618730872;1146.3236690352733;11661.591844285495;11751.7062073448;11757.706057348549;11764.764704705944;11813.173077884638;4072.2669919414197;4472.57510536505;4750.5249475052215;4856.757162141878;4957.281194226817;9107.134822191882;9185.173334399937;9189.90810091904;9191.540422978824;9195.770105747277;5292.44429334922;5295.867603309871;5296.179092240709;5297.841064768063;5301.522862942354;4077.1845630873945;4446.377507149002;4827.61379089672;4915.754212289371;4980.377452818398;3070.47801873682;3708.870189543353;3798;3834.539855217392;3836.769793812324;1162.7209469727204;1170.3387586013876;1172.9824052639217;1185.6146752305535;1186.7567148734488;742.3986570877606;833.4582521361164;874.156439036333;913.3241401363076;950.0831697411893;5739.62692424991;5800.854978625568;5950.8809823803285;6110.327863934964;6176.289726681399;910.5265262063822;938.9671361502315;949.2675866543585;951.8244967465175;1002.5688953749958;3898.688104951597;3934.7174198312714;4002.479677641888;4059.2490389278078;4077.938830917539;9994.150497207818;10860.402677852637;10982.505787239594;10984.340939543654;10992.725181870517;10454.895451045544;10914.017738403581;10921.399323037309;10926;10970.232083754061;8044.2760151586635;8261.545614991113;8264.049634292012;8265.214804593554;8270.710525131712;4847.3698419205275;5899;5929.703514824328;5999.730012149551;6033.461467325804;9913.206943444651;10122.291439599452;10192.643257485952;10193.43936083493;10220.284580079324;8443.831123377375;9952.452615106238;9965.40207587547;10187.541560629641;10425.322354046963;6867.793966181022;7078.787636370917;7149.892751608834;7164.641767911688;7167.211606723152;8209.220124088202;8314;8417.494950303002;8417.957910210655;8433.030201526903;6406.23125224976;7516.549007059594;7559.092908850973;7585.279398457138;7620.390368770596;7373.5575865448245;7389.187189409053;7415.888761668687;7453.701851926079;7463.3656139226605;6861.348171923659;6983.022376867344;6989.37095661393;6996;6999.47503937217;4856.635752318661;4969.577585905238;4987.877727511281;5026.195808670595;5152.330197074356;4900.926486102782;4958.776855041604;5042.773075211698;5053.216751403538;5164.7934082636275 12:49:28 INFO - PROCESS | 1651 | |4;prototype.html;278.0948014213734;292.4589509407596;296.51519765183923;305.0224031977512;309.54496889572334;5081.364829396325;5100.336956195699;5141.640085194038;5166.5608423283975;5173.379194496656;4289.463817022872;5102.285680004802;5275.388682602117;5334.439883812202;5345.625806193568;3706.4996225509617;3837.501124853779;4051.3315302974975;4078.8572399966006;4162.167566486714;3643.544556930384;4016.4376987221813;4104.343305071189;4128.956166697489;4142.130152667928;3490.127468132967;3752.624737526239;3804.182100848317;3814.313423583754;3918.7060970427333;3803.3344164771192;4001.4598029265967;4097.631213190797;4115.464989551369;4117.197146556423;2993.9550906736417;3551.9876835101873;3558.5018097466377;3558.928821423557;3566.5898421681577;4853.854384368439;5141.074606570815;5195.012947539955;5201.463005156492;5212.244224587414;4026.45642838216;4426.313921342197;4579.771011449414;4581.221192397267;4594.678372513926;5553.333599968029;5570.805021824257;5574.1917421973585;5604.131359639263;5631.465010823965;3205.7916235444623;3312.4825132898927;3649.197176621139;3794.90512737181;3813.9892928374;5367.087595108841;5644.585026059216;5815.098659707752;5832.795852145197;5839.7664093436215;3842.884713458545;3855.4602355670227;3862.6909847212155;3870.43878637596;3873.1479074603544;3479.7820762733345;3925.509311336083;3943.664788492953;3944.270309992603;3958.8416463341146;3600.837962291703;3962.663173630216;4085.937656209407;4184.979075104605;4551.362809206647;5358.27663265462;5593.888122237532;5608.083796425835;5624.3813180550105;5650.378458369576;1140.6463996161217;1229.2747279105192;1314.9802752958713;1334.946602135923;1343.993280033613;753.8605358008786;755.9168491465934;795.7214974758904;806.5563939833186;823.1685997142929;3971.5829837867186;4816.4220293564995;4995.501349595107;5123.23248479274;5168.767405466763;5309.761060752276;5424;5592.832215033555;5628.521575666115;5663.292088488939;4372.628326592276;4735.905281894343;4892.584130348961;5091.3126727892;5103.974480127576;2519.7354277800932;2586.9870650646626;2599.571070773339;2741.8080734348805;2984.9552256716165;4771;5781.82654520365;5800.50695690871;5802.564807639444;5807.477327040587;5507.614466987353;5767.740451679684;5783.219265399117;5792.739326730223;5815.680137592389;5780.306363236355;5797.24635797352;5811.476967072984;5817.272840894888;5870.442307980735;4881.9511804881495;5224.52979231871;5507.834764957058;5632.464915832989;5674.907175589231;4644.396228490275;5370.892582148257;5504.256925315031;5562.137868630369;5581.2744343236745;4846.636502262415;5397.8380648580605;5613.775448981995;5848.035074212878;5864.296284445893;3169;3228.176814912182;3771.226898485859;3795.715321350965;3835.3096442640594;5444.725890176351;5495.890082198253;5696.658200507983;5747.74135163927;5787.8553036174435;4830.4444988826735;5070.239464080418;5558.972205138948;5570.022641962045;5592.889226418661;5543.2793736815565;5553.862067931605;5571.526420254162;5580.437477506305;5604.915926261027;4631.606313463393;5000.974995125001;5426.647267927572;5498.642588231752;5499.477549632778;5576.65400759541;5601.327840659147;5604.495595396434;5605.103183490622;5621.381648018633;4530.0486897750525;5503.807366742145;5516.503514683698;5572.1054841354135;5582.944170558405 12:49:28 INFO - PROCESS | 1651 | |5;yui.html;697.6651207420438;702.2626242445434;711.1324184494914;715.3954908102654;746.6005686957476;13030;15300.081995080289;15605.687886242269;16105.436309729163;16148.03111813292;12004.639860804167;14840.925795371008;14871.256437178125;14878;14897.627559311022;663.4990582110499;833.1335411172389;846.6401779243797;849.5752123938031;849.9617517211709;690.3027941778814;825.3644693585935;848.2620120495178;851.2806678356809;857.9270761985239;742.5136535569184;744.3970383988986;883.8143989762158;884.0761404332455;885.8848349714528;699.6571679876823;879.0111124984393;881.8412685716569;881.9823603527893;883.8497455432592;532.5553163108809;536.2331865432469;536.4340620645218;537.4679067722926;637.1939496536885;14451.92774036123;14671.413143474356;14678.486252981202;14688;14701.338439770236;11399.658010259705;12972.286524241163;14141.29293535319;14194.290285485788;14271.00102992791;12701.047421443429;12746.235225886476;12870.22778633285;13416.329183540882;13430.798538021938;4512.255477846152;4571.908561828778;4573.108243892442;4768.833090841838;4769.737664428455;108011.45994270057;109073.90926090717;122425;124037.13944290843;126885.36557317247;10988.835167472495;11193.328400296008;11227.494762735696;11385.373804440835;11601.883981160248;21847.563048739255;21891.562168756853;21900.561988760135;21902.014409351617;21920.903954802197;7827.1390147083775;8054.838903221903;8095.150009249061;8105.635246413925;8165.346772258324;4394.36281739146;4409.823607055746;4469.128519938581;4591.586757191869;4608.124456353282;3103.007037747899;3401.3537427888623;3483.5819701635965;3494.965050349515;3544.2911417716045;624.2727222785495;626.2703949898317;628.7045088808253;633.965131917749;658.7648159700561;554.3043480432112;582.1820342418908;624.9133440291528;636.0903907412352;639.7472998165791;7227.385672217815;8300.667973281123;8952.8657070144;9755.756106097404;10283.434411107311;563.6026601246193;580.196427947296;616.6146158650844;647.690302553949;681.4276008153175;4255.97257790481;4462.977685111554;4619.953800461953;4621.168189725881;4632.837850675278;137756;144028;148521;149076;150639;76608.61695691486;102070;102735;128934.35532822275;133947;68026.65986670234;69535.65232173908;70211;97347.51326243323;104876;9392.624295028396;9587.424754514752;9700;9700.5149742514;9819.950900245452;58393.70803145957;60283;61211.69394153179;61511;61530.69234653798;55161;55364.44635553593;75887.71964906009;89958.1004189976;92187;11141.554337826396;12448.62654120378;12708.745825083262;13435.798463023259;13505.932470337979;14893.47872824446;15069.54791356261;15238.77141842851;15340.693186136437;15660.765088523909;13653.385597647932;13874.583762487142;14509.564713058626;14707.55877323682;14822.62943426423;11541.480633371351;13645.931770341085;14053.859461405254;14370.784438233644;14389.280535973368;13764.587062388144;13849.772246866758;13912.721745565235;14033;14455.927720361331;11055.502502387251;11282.548698052315;11348.829767553329;11489.942550287195;12007.939960300142;9621.9037809621;11099.72250693739;11447.542098315975;11519.827202592136;11652.88347116518 12:49:28 INFO - PROCESS | 1651 | __end_tp_report 12:49:28 INFO - PROCESS | 1651 | __start_cc_report 12:49:28 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1270 12:49:28 INFO - PROCESS | 1651 | __end_cc_report 12:49:28 INFO - PROCESS | 1651 | __startTimestamp1471463368273__endTimestamp 12:49:28 INFO - PROCESS | 1651 | 12:49:28 INFO - PROCESS | 1651 | ------- Summary: start ------- 12:49:28 INFO - PROCESS | 1651 | Number of tests: 6 12:49:28 INFO - PROCESS | 1651 | 12:49:28 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5740.78 Median:5962.91 stddev:640.67 (10.7%) stddev-sans-first:614.07 12:49:28 INFO - PROCESS | 1651 | Values: 3329.3 3352.0 3360.7 3374.8 3381.6 5545.6 5627.1 5667.2 5675.7 5683.3 5632.7 5683.6 5693.0 5698.3 5700.9 5157.2 5180.4 5201.3 5219.4 5261.7 5189.8 5227.1 5233.9 5243.6 5283.2 5157.9 5177.9 5194.6 5214.3 5221.6 5270.0 5272.3 5273.8 5280.9 5326.4 5099.4 5130.7 5135.1 5198.4 5214.3 4628.5 5603.9 5651.7 5674.9 5692.1 6237.3 6260.3 6273.2 6273.6 6273.6 6146.1 6215.8 6252.8 6278.1 6319.1 5814.8 5831.2 5844.2 5849.6 5875.1 6271.1 6276.9 6301.2 6312.9 6321.6 6005.4 6071.8 6083.2 6107.7 6186.4 6252.5 6267.2 6285.9 6294.7 6305.7 6131.5 6186.6 6218.2 6223.3 6227.3 6107.5 6114.5 6136.4 6212.5 6248.6 4902.9 4924.3 4927.9 4958.0 5002.8 4423.6 4432.4 4441.0 4441.7 4480.9 5701.4 5703.9 5711.3 5716.5 5764.1 6126.3 6209.3 6216.2 6272.9 6283.5 5637.5 5648.2 5679.6 5702.6 5703.5 5422.9 5435.4 5437.0 5443.7 5477.8 6283.1 6292.0 6320.4 6324.6 6324.9 6122.1 6189.6 6208.5 6279.8 6310.1 6303.7 6304.3 6305.4 6316.0 6319.8 6081.0 6166.3 6175.3 6189.5 6222.4 6138.4 6177.4 6282.3 6294.0 6312.6 6044.9 6133.6 6138.4 6148.7 6184.5 6101.9 6113.9 6129.4 6130.2 6143.8 5726.5 5851.9 5962.9 6004.2 6008.2 6010.5 6095.5 6107.5 6108.3 6111.8 5906.6 5914.1 5917.4 5921.6 5922.3 12:49:28 INFO - PROCESS | 1651 | 12:49:28 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:53352.19 Median:39528.60 stddev:107840.03 (272.8%) stddev-sans-first:108069.46 12:49:28 INFO - PROCESS | 1651 | Values: 469.7 477.1 505.4 514.9 529.0 30613.8 40372.8 41489.8 41702.0 43592.1 42831.6 43181.6 43227.0 43255.0 43264.8 9764.7 9933.5 9948.1 9953.0 9956.9 9824.3 9902.7 9911.9 9912.7 9913.1 9886.0 9938.0 9939.0 9943.4 9957.0 8913.4 9405.6 9918.7 9919.6 9925.4 8232.5 9763.2 9774.8 9775.5 9779.4 40075.8 40458.0 40484.8 40516.8 40559.0 3554.8 3591.5 3601.2 3675.9 3824.5 30856.5 31193.2 31900.7 32045.9 32411.0 3273.2 3285.5 3341.9 3379.5 3416.8 430709.0 431175.7 436445.0 439035.0 440860.0 33169.5 57698.1 58036.0 58272.1 58305.0 33711.2 33768.6 33799.0 33873.5 33895.7 14442.9 14548.3 14589.8 14616.9 14617.9 12262.8 12351.2 12382.7 12386.2 12407.5 7707.1 7756.0 7801.4 7811.1 7811.8 3164.8 3209.5 3224.7 3228.5 3253.5 949.1 957.8 962.9 997.5 1014.9 26037.3 30386.8 30432.5 30835.8 31127.8 974.5 987.6 998.7 1014.9 1122.2 15211.7 15780.9 15816.9 15901.2 16297.7 168324.0 169721.0 170274.1 536036.0 544958.0 42000.0 42329.6 42343.0 42408.0 42462.6 1238.3 1335.8 1368.9 1380.5 1388.1 30583.5 31546.5 31832.0 32177.8 32347.5 50547.0 51189.0 51263.0 51277.5 51406.7 357087.0 418944.0 419065.0 424921.0 425805.0 23666.9 24329.4 26907.9 27132.9 27146.7 46517.3 47140.5 47348.0 47959.5 48151.0 35912.5 37766.0 38234.6 39220.4 40026.6 38517.2 39289.0 39501.6 39555.6 40669.0 37677.4 37927.6 37944.0 38028.4 38906.0 32441.4 33901.3 34398.5 34468.1 34647.5 22090.3 25245.6 25401.9 25891.6 26168.9 12:49:28 INFO - PROCESS | 1651 | 12:49:28 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:33489.09 Median:27506.11 stddev:89476.71 (325.3%) stddev-sans-first:89693.09 12:49:28 INFO - PROCESS | 1651 | Values: 339.8 346.2 362.4 363.9 376.9 15286.5 18108.5 20588.6 21223.7 21341.3 20759.8 20815.0 21183.0 21357.8 21367.5 5852.2 5890.3 6070.3 6166.4 6181.7 4177.8 6011.5 6100.8 6113.6 6113.8 4051.8 4398.8 4421.8 4423.5 6836.5 6801.8 6831.0 6842.3 6847.2 6850.8 5682.0 5891.1 5923.2 5937.2 5967.2 27082.9 27394.9 27502.4 27509.8 27574.3 2242.7 2275.7 2303.5 2555.8 3048.7 15129.9 15813.4 15983.6 16141.4 16247.8 1616.4 1823.5 1862.3 1934.4 1978.3 110589.0 112120.0 112613.9 113519.0 117088.0 10362.5 10649.7 10888.6 11366.8 11414.3 14136.2 14142.4 14172.0 14180.6 14184.0 7997.3 8123.8 8197.3 8297.1 8348.7 7858.3 7861.8 7885.2 8044.8 8055.0 5547.5 6742.7 6821.0 6860.9 6870.1 1528.9 1541.7 1634.0 1640.3 1675.5 890.9 894.9 921.6 1004.9 1112.9 19845.2 20497.5 21411.6 22470.4 23097.5 910.8 925.9 952.0 958.1 969.1 9562.8 11193.6 11589.0 11708.4 11943.2 470946.0 543800.0 546223.0 548352.0 549389.3 126652.1 129012.0 129702.4 131415.0 134477.0 948.5 979.1 983.2 984.0 984.3 16874.7 19103.9 19928.0 20115.0 20725.4 53685.0 53742.2 56161.0 57087.0 57758.4 76076.0 76984.0 77414.0 78365.6 82391.6 5552.6 7558.1 8124.7 8247.4 8356.5 12974.0 13095.8 13129.0 13362.7 13694.5 9520.8 9683.0 11372.1 11504.7 11631.4 10882.1 11243.6 11311.6 11561.1 11702.8 11435.7 11693.0 11921.0 11967.6 11983.8 8174.0 8327.7 8340.3 8355.0 8469.2 11042.8 11471.0 11601.8 11662.9 11775.7 12:49:28 INFO - PROCESS | 1651 | 12:49:28 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5640.74 Median:4984.13 stddev:3173.00 (63.7%) stddev-sans-first:3165.71 12:49:28 INFO - PROCESS | 1651 | Values: 1375.7 1532.8 1562.6 1722.0 1859.4 7773.3 8268.2 8269.8 8330.2 8558.0 8409.6 8463.7 8464.5 8468.6 8471.4 2328.9 2353.8 2357.9 2359.0 2361.5 2287.6 2325.0 2344.7 2349.5 2357.0 2111.6 2306.6 2332.8 2342.1 2346.7 2178.5 2305.7 2324.0 2325.8 2327.0 2307.5 2315.5 2316.3 2319.6 2320.0 8491.8 8534.7 8552.2 8558.6 8561.0 5199.9 5222.7 5368.6 5369.1 5369.9 2995.7 3059.5 3714.8 3723.4 3737.1 1110.6 1117.3 1137.6 1146.3 1146.3 11661.6 11751.7 11757.7 11764.8 11813.2 4072.3 4472.6 4750.5 4856.8 4957.3 9107.1 9185.2 9189.9 9191.5 9195.8 5292.4 5295.9 5296.2 5297.8 5301.5 4077.2 4446.4 4827.6 4915.8 4980.4 3070.5 3708.9 3798.0 3834.5 3836.8 1162.7 1170.3 1173.0 1185.6 1186.8 742.4 833.5 874.2 913.3 950.1 5739.6 5800.9 5950.9 6110.3 6176.3 910.5 939.0 949.3 951.8 1002.6 3898.7 3934.7 4002.5 4059.2 4077.9 9994.2 10860.4 10982.5 10984.3 10992.7 10454.9 10914.0 10921.4 10926.0 10970.2 8044.3 8261.5 8264.0 8265.2 8270.7 4847.4 5899.0 5929.7 5999.7 6033.5 9913.2 10122.3 10192.6 10193.4 10220.3 8443.8 9952.5 9965.4 10187.5 10425.3 6867.8 7078.8 7149.9 7164.6 7167.2 8209.2 8314.0 8417.5 8418.0 8433.0 6406.2 7516.5 7559.1 7585.3 7620.4 7373.6 7389.2 7415.9 7453.7 7463.4 6861.3 6983.0 6989.4 6996.0 6999.5 4856.6 4969.6 4987.9 5026.2 5152.3 4900.9 4958.8 5042.8 5053.2 5164.8 12:49:28 INFO - PROCESS | 1651 | 12:49:28 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4472.30 Median:5103.13 stddev:1407.44 (27.6%) stddev-sans-first:1375.73 12:49:28 INFO - PROCESS | 1651 | Values: 278.1 292.5 296.5 305.0 309.5 5081.4 5100.3 5141.6 5166.6 5173.4 4289.5 5102.3 5275.4 5334.4 5345.6 3706.5 3837.5 4051.3 4078.9 4162.2 3643.5 4016.4 4104.3 4129.0 4142.1 3490.1 3752.6 3804.2 3814.3 3918.7 3803.3 4001.5 4097.6 4115.5 4117.2 2994.0 3552.0 3558.5 3558.9 3566.6 4853.9 5141.1 5195.0 5201.5 5212.2 4026.5 4426.3 4579.8 4581.2 4594.7 5553.3 5570.8 5574.2 5604.1 5631.5 3205.8 3312.5 3649.2 3794.9 3814.0 5367.1 5644.6 5815.1 5832.8 5839.8 3842.9 3855.5 3862.7 3870.4 3873.1 3479.8 3925.5 3943.7 3944.3 3958.8 3600.8 3962.7 4085.9 4185.0 4551.4 5358.3 5593.9 5608.1 5624.4 5650.4 1140.6 1229.3 1315.0 1334.9 1344.0 753.9 755.9 795.7 806.6 823.2 3971.6 4816.4 4995.5 5123.2 5168.8 5309.8 5424.0 5592.8 5628.5 5663.3 4372.6 4735.9 4892.6 5091.3 5104.0 2519.7 2587.0 2599.6 2741.8 2985.0 4771.0 5781.8 5800.5 5802.6 5807.5 5507.6 5767.7 5783.2 5792.7 5815.7 5780.3 5797.2 5811.5 5817.3 5870.4 4882.0 5224.5 5507.8 5632.5 5674.9 4644.4 5370.9 5504.3 5562.1 5581.3 4846.6 5397.8 5613.8 5848.0 5864.3 3169.0 3228.2 3771.2 3795.7 3835.3 5444.7 5495.9 5696.7 5747.7 5787.9 4830.4 5070.2 5559.0 5570.0 5592.9 5543.3 5553.9 5571.5 5580.4 5604.9 4631.6 5001.0 5426.6 5498.6 5499.5 5576.7 5601.3 5604.5 5605.1 5621.4 4530.0 5503.8 5516.5 5572.1 5582.9 12:49:28 INFO - PROCESS | 1651 | 12:49:28 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:23205.87 Median:4325.17 stddev:36517.55 (844.3%) stddev-sans-first:36580.89 12:49:28 INFO - PROCESS | 1651 | Values: 697.7 702.3 711.1 715.4 746.6 13030.0 15300.1 15605.7 16105.4 16148.0 12004.6 14840.9 14871.3 14878.0 14897.6 663.5 833.1 846.6 849.6 850.0 690.3 825.4 848.3 851.3 857.9 742.5 744.4 883.8 884.1 885.9 699.7 879.0 881.8 882.0 883.8 532.6 536.2 536.4 537.5 637.2 14451.9 14671.4 14678.5 14688.0 14701.3 11399.7 12972.3 14141.3 14194.3 14271.0 12701.0 12746.2 12870.2 13416.3 13430.8 4512.3 4571.9 4573.1 4768.8 4769.7 108011.5 109073.9 122425.0 124037.1 126885.4 10988.8 11193.3 11227.5 11385.4 11601.9 21847.6 21891.6 21900.6 21902.0 21920.9 7827.1 8054.8 8095.2 8105.6 8165.3 4394.4 4409.8 4469.1 4591.6 4608.1 3103.0 3401.4 3483.6 3495.0 3544.3 624.3 626.3 628.7 634.0 658.8 554.3 582.2 624.9 636.1 639.7 7227.4 8300.7 8952.9 9755.8 10283.4 563.6 580.2 616.6 647.7 681.4 4256.0 4463.0 4620.0 4621.2 4632.8 137756.0 144028.0 148521.0 149076.0 150639.0 76608.6 102070.0 102735.0 128934.4 133947.0 68026.7 69535.7 70211.0 97347.5 104876.0 9392.6 9587.4 9700.0 9700.5 9820.0 58393.7 60283.0 61211.7 61511.0 61530.7 55161.0 55364.4 75887.7 89958.1 92187.0 11141.6 12448.6 12708.7 13435.8 13505.9 14893.5 15069.5 15238.8 15340.7 15660.8 13653.4 13874.6 14509.6 14707.6 14822.6 11541.5 13645.9 14053.9 14370.8 14389.3 13764.6 13849.8 13912.7 14033.0 14455.9 11055.5 11282.5 11348.8 11489.9 12007.9 9621.9 11099.7 11447.5 11519.8 11652.9 12:49:28 INFO - PROCESS | 1651 | -------- Summary: end -------- 12:49:28 INFO - PROCESS | 1651 | 12:49:28 INFO - TEST-INFO | 1651: exit 0 12:49:28 INFO - TEST-OK | dromaeo_css | took 1118523ms 12:49:28 INFO - TEST-START | kraken 12:49:28 INFO - operating with platform_type : mac_ 12:49:28 INFO - Initialising browser for kraken test... 12:49:28 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpFNWeEN/profile http://localhost:49270/getInfo.html) 12:49:31 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 12:49:31 INFO - PROCESS | 1661 | colorDepth:24 12:49:31 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 12:49:31 INFO - PROCESS | 1661 | __metrics 12:49:31 INFO - PROCESS | 1661 | 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" 12:49:31 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:49:31 INFO - TEST-INFO | 1661: exit 0 12:49:31 INFO - Browser initialized. 12:49:31 INFO - Running cycle 1/1 for kraken test... 12:49:31 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpFNWeEN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:49:44 INFO - PROCESS | 1662 | RSS: Main: 228179968 12:49:44 INFO - PROCESS | 1662 | 12:49:46 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 12:49:47 INFO - PROCESS | 1662 | RSS: Main: 285069312 12:49:47 INFO - PROCESS | 1662 | 12:49:50 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 12:49:51 INFO - PROCESS | 1662 | RSS: Main: 292638720 12:49:51 INFO - PROCESS | 1662 | 12:49:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 12:49:55 INFO - PROCESS | 1662 | RSS: Main: 383528960 12:49:55 INFO - PROCESS | 1662 | 12:49:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 12:49:57 INFO - PROCESS | 1662 | RSS: Main: 288370688 12:49:57 INFO - PROCESS | 1662 | 12:49:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:50:00 INFO - PROCESS | 1662 | RSS: Main: 293675008 12:50:00 INFO - PROCESS | 1662 | 12:50:03 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 12:50:03 INFO - PROCESS | 1662 | RSS: Main: 330661888 12:50:03 INFO - PROCESS | 1662 | 12:50:06 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 12:50:07 INFO - PROCESS | 1662 | RSS: Main: 332324864 12:50:07 INFO - PROCESS | 1662 | 12:50:10 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 12:50:10 INFO - PROCESS | 1662 | RSS: Main: 330690560 12:50:10 INFO - PROCESS | 1662 | 12:50:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:50:13 INFO - PROCESS | 1662 | RSS: Main: 300609536 12:50:13 INFO - PROCESS | 1662 | 12:50:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:50:15 INFO - PROCESS | 1662 | RSS: Main: 307683328 12:50:15 INFO - PROCESS | 1662 | 12:50:17 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:50:18 INFO - PROCESS | 1662 | RSS: Main: 305348608 12:50:18 INFO - PROCESS | 1662 | 12:50:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:50:22 INFO - PROCESS | 1662 | RSS: Main: 313749504 12:50:22 INFO - PROCESS | 1662 | 12:50:25 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:50:25 INFO - PROCESS | 1662 | RSS: Main: 316145664 12:50:25 INFO - PROCESS | 1662 | 12:50:27 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 12:50:28 INFO - PROCESS | 1662 | RSS: Main: 359153664 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | __start_tp_report 12:50:28 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 12:50:28 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 12:50:28 INFO - PROCESS | 1662 | |i|pagename|runs| 12:50:28 INFO - PROCESS | 1662 | |0;ai-astar;103;113;161;167;113;113;107;114;113;113 12:50:28 INFO - PROCESS | 1662 | |1;audio-beat-detection;146;116;109;160;109;107;128;105;179;138 12:50:28 INFO - PROCESS | 1662 | |2;audio-dft;185;184;184;185;184;183;183;182;184;182 12:50:28 INFO - PROCESS | 1662 | |3;audio-fft;83;62;60;87;59;57;63;63;103;80 12:50:28 INFO - PROCESS | 1662 | |4;audio-oscillator;83;87;95;73;69;68;97;70;68;103 12:50:28 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;91;89;92;89;92;89;90;89;91;88 12:50:28 INFO - PROCESS | 1662 | |6;imaging-darkroom;95;98;97;96;96;96;96;97;102;95 12:50:28 INFO - PROCESS | 1662 | |7;imaging-desaturate;86;84;83;85;84;84;84;82;84;84 12:50:28 INFO - PROCESS | 1662 | |8;json-parse-financial;56;54;59;55;59;76;82;80;80;54 12:50:28 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;64;65;78;74;72;70;68;68;68;69 12:50:28 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;100;104;86;85;84;84;88;86;85;84 12:50:28 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;142;146;138;132;138;138;131;159;233;175 12:50:28 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;167;179;233;173;166;170;168;230;217;167 12:50:28 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;66;70;79;90;87;85;72;69;72;83 12:50:28 INFO - PROCESS | 1662 | __end_tp_report 12:50:28 INFO - PROCESS | 1662 | __start_cc_report 12:50:28 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2049 12:50:28 INFO - PROCESS | 1662 | __end_cc_report 12:50:28 INFO - PROCESS | 1662 | __startTimestamp1471463428108__endTimestamp 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | ------- Summary: start ------- 12:50:28 INFO - PROCESS | 1662 | Number of tests: 14 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:121.70 Median:113.00 stddev:22.61 (20.0%) stddev-sans-first:22.94 12:50:28 INFO - PROCESS | 1662 | Values: 103.0 113.0 161.0 167.0 113.0 113.0 107.0 114.0 113.0 113.0 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:129.70 Median:133.00 stddev:25.51 (19.2%) stddev-sans-first:26.36 12:50:28 INFO - PROCESS | 1662 | Values: 146.0 116.0 109.0 160.0 109.0 107.0 128.0 105.0 179.0 138.0 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:1.07 (0.6%) stddev-sans-first:1.01 12:50:28 INFO - PROCESS | 1662 | Values: 185.0 184.0 184.0 185.0 184.0 183.0 183.0 182.0 184.0 182.0 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:71.70 Median:63.00 stddev:15.53 (24.6%) stddev-sans-first:15.92 12:50:28 INFO - PROCESS | 1662 | Values: 83.0 62.0 60.0 87.0 59.0 57.0 63.0 63.0 103.0 80.0 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:78.00 stddev:13.51 (17.3%) stddev-sans-first:14.31 12:50:28 INFO - PROCESS | 1662 | Values: 83.0 87.0 95.0 73.0 69.0 68.0 97.0 70.0 68.0 103.0 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:90.50 stddev:1.41 (1.6%) stddev-sans-first:1.45 12:50:28 INFO - PROCESS | 1662 | Values: 91.0 89.0 92.0 89.0 92.0 89.0 90.0 89.0 91.0 88.0 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:96.80 Median:96.00 stddev:2.04 (2.1%) stddev-sans-first:2.06 12:50:28 INFO - PROCESS | 1662 | Values: 95.0 98.0 97.0 96.0 96.0 96.0 96.0 97.0 102.0 95.0 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.00 stddev:1.05 (1.3%) stddev-sans-first:0.83 12:50:28 INFO - PROCESS | 1662 | Values: 86.0 84.0 83.0 85.0 84.0 84.0 84.0 82.0 84.0 84.0 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:67.50 stddev:12.26 (18.2%) stddev-sans-first:12.51 12:50:28 INFO - PROCESS | 1662 | Values: 56.0 54.0 59.0 55.0 59.0 76.0 82.0 80.0 80.0 54.0 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.50 stddev:4.17 (6.0%) stddev-sans-first:3.90 12:50:28 INFO - PROCESS | 1662 | Values: 64.0 65.0 78.0 74.0 72.0 70.0 68.0 68.0 68.0 69.0 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:85.00 stddev:7.23 (8.5%) stddev-sans-first:6.38 12:50:28 INFO - PROCESS | 1662 | Values: 100.0 104.0 86.0 85.0 84.0 84.0 88.0 86.0 85.0 84.0 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:153.20 Median:144.00 stddev:31.07 (21.6%) stddev-sans-first:32.69 12:50:28 INFO - PROCESS | 1662 | Values: 142.0 146.0 138.0 132.0 138.0 138.0 131.0 159.0 233.0 175.0 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.00 Median:176.00 stddev:27.92 (15.9%) stddev-sans-first:28.66 12:50:28 INFO - PROCESS | 1662 | Values: 167.0 179.0 233.0 173.0 166.0 170.0 168.0 230.0 217.0 167.0 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.30 Median:81.00 stddev:8.54 (10.5%) stddev-sans-first:8.02 12:50:28 INFO - PROCESS | 1662 | Values: 66.0 70.0 79.0 90.0 87.0 85.0 72.0 69.0 72.0 83.0 12:50:28 INFO - PROCESS | 1662 | -------- Summary: end -------- 12:50:28 INFO - PROCESS | 1662 | 12:50:28 INFO - TEST-INFO | 1662: exit 0 12:50:29 INFO - TEST-OK | kraken | took 60111ms 12:50:29 INFO - SUITE-END | took 1178s 12:50:29 INFO - Completed test suite (00:19:38) 12:50:29 INFO - javascript benchmark 12:50:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.334133173365, 3352.0, 3360.7143392811618, 3374.8481318340673, 3381.594208694957, 5545.584081193916, 5627.127795191742, 5667.206591077247, 5675.659460432372, 5683.261176047114, 5632.662040277586, 5683.630564013336, 5693.0, 5698.34469036061, 5700.8859822803515, 5157.174852023686, 5180.430152683201, 5201.271821944912, 5219.373675158968, 5261.736913154346, 5189.766460509286, 5227.111391063529, 5233.869153271161, 5243.580513558906, 5283.233931079991, 5157.871053223681, 5177.896442071156, 5194.584433245332, 5214.270002199695, 5221.634485586011, 5269.973650131763, 5272.340957380327, 5273.841784746463, 5280.867978300535, 5326.440723723992, 5099.36257967754, 5130.71781052042, 5135.12702840518, 5198.376194856603, 5214.296070030536, 4628.5371462853445, 5603.859903502404, 5651.717414129277, 5674.914876276818, 5692.089265717506, 6237.313895471494, 6260.342664020258, 6273.1531243282025, 6273.62358258506, 6273.62358258506, 6146.078088286793, 6215.813525594194, 6252.812415627538, 6278.121063051177, 6319.0837328587095, 5814.825555233349, 5831.183634291203, 5844.152597873284, 5849.649021058707, 5875.118732190205, 6271.059341098871, 6276.932921403372, 6301.212348456443, 6312.873742525216, 6321.55749097568, 6005.369436209223, 6071.757129714851, 6083.178770865965, 6107.674343494518, 6186.412290832363, 6252.468540174045, 6267.1539342189135, 6285.9057114143325, 6294.685265736694, 6305.716242769086, 6131.509479241739, 6186.597871138361, 6218.1916350875, 6223.3465486123305, 6227.314995350508, 6107.522607572277, 6114.541409394314, 6136.427173609184, 6212.47193988507, 6248.562600618004, 4902.8774280643265, 4924.261360795909, 4927.926081108786, 4958.0, 5002.799888004439, 4423.5576442355505, 4432.423784907941, 4441.022974945507, 4441.689081764245, 4480.932786008212, 5701.4298570142655, 5703.914441283384, 5711.3146422428745, 5716.5140963017775, 5764.106563482667, 6126.295476020226, 6209.2548894133, 6216.191895053705, 6272.905906411407, 6283.465905398001, 5637.548996080303, 5648.181013753065, 5679.602427830095, 5702.600817942704, 5703.54371650267, 5422.91865622016, 5435.42927992563, 5437.048516509674, 5443.727813609304, 5477.780888764405, 6283.120363149163, 6291.96854015727, 6320.367963203643, 6324.557280990287, 6324.936750632619, 6122.123717501779, 6189.566730328834, 6208.534359923115, 6279.811605651837, 6310.11658367838, 6303.716332765129, 6304.338044505261, 6305.432511074026, 6315.968420158054, 6319.778807741707, 6080.969595151996, 6166.260048794174, 6175.320714721467, 6189.473894718999, 6222.377762223741, 6138.447539721446, 6177.382261773787, 6282.3089460158435, 6294.024426213944, 6312.589681670676, 6044.9395506044375, 6133.570650054453, 6138.449706860497, 6148.661823599566, 6184.5052395809125, 6101.904600373152, 6113.902014424272, 6129.389354848411, 6130.245269656939, 6143.849652621547, 5726.484616384545, 5851.853703657443, 5962.9105563415715, 6004.219451471281, 6008.218931538872, 6010.459058684564, 6095.451409373178, 6107.46191531438, 6108.297545782292, 6111.7740652348275, 5906.557008224487, 5914.053751399755, 5917.378675239038, 5921.61509501881, 5922.318933322723], "value": 5699.187057799118, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.70408642555185, 477.1292391385721, 505.4465360430327, 514.915039018562, 528.9629725919187, 30613.846930765343, 40372.79813600932, 41489.79255103728, 41702.0, 43592.12815743683, 42831.571684283146, 43181.568184318145, 43227.0, 43255.0, 43264.78367608158, 9764.658236961726, 9933.503324833766, 9948.054934781185, 9953.004699530062, 9956.900430995705, 9824.312298139133, 9902.702918912444, 9911.851322230172, 9912.702618921443, 9913.058259465339, 9886.0, 9938.0, 9939.0, 9943.403395796275, 9957.0, 8913.440147974079, 9405.648587853071, 9918.652847150388, 9919.603215871357, 9925.354851934673, 8232.50604963704, 9763.170130538912, 9774.755631109208, 9775.462349570771, 9779.41323520591, 40075.79962100171, 40458.0, 40484.79757601223, 40516.797416013025, 40559.0, 3554.8222588870453, 3591.494877483377, 3601.1897323102353, 3675.8897233082785, 3824.5028146341074, 30856.53715194274, 31193.22016949572, 31900.680993190235, 32045.87839425632, 32411.0, 3273.2307907641684, 3285.4743241081314, 3341.899743007714, 3379.5268662387284, 3416.829158542063, 430709.0, 431175.6882431167, 436445.0, 439035.0, 440860.0, 33169.50245746267, 57698.13452798211, 58036.0, 58272.12591811126, 58305.0, 33711.15722106967, 33768.64925403005, 33799.0, 33873.491897621556, 33895.66104338925, 14442.855571444152, 14548.272586370851, 14589.781153282709, 14616.853831461549, 14617.903657225537, 12262.81605775914, 12351.19717218378, 12382.690432739253, 12386.194897331825, 12407.503699852085, 7707.113681926538, 7756.0, 7801.414893882981, 7811.140774514799, 7811.843763124706, 3164.7784655073924, 3209.5185722141864, 3224.6614105518584, 3228.467302894996, 3253.4622994064666, 949.1125797379473, 957.7988622389377, 962.875469102766, 997.5012493753123, 1014.8883622801486, 26037.349066273116, 30386.84806575953, 30432.54351184734, 30835.845820771203, 31127.844360778505, 974.541965276319, 987.6148302162162, 998.6504723346916, 1014.8883622801486, 1122.1639878290725, 15211.695766084616, 15780.895337326278, 15816.92091539558, 15901.204939752966, 16297.674046519003, 168324.0, 169721.0, 170274.14862925606, 536036.0, 544958.0, 42000.0, 42329.57670423318, 42343.0, 42408.0, 42462.63060540944, 1238.3065483329185, 1335.786274196124, 1368.8699573540498, 1380.4892189889806, 1388.139353600774, 30583.541246880868, 31546.526802097527, 31832.0, 32177.839110804296, 32347.514787277738, 50547.0, 51188.97622047464, 51262.97474050573, 51277.48722512727, 51406.74296628493, 357087.0, 418944.0, 419065.0, 424921.0, 425805.0, 23666.93498792524, 24329.39176520601, 26907.865460672572, 27132.879718832588, 27146.72853271442, 46517.302240465746, 47140.528594713614, 47348.0, 47959.520404795505, 48151.0, 35912.46131308085, 37766.0, 38234.61765382311, 39220.41169382518, 40026.59973400229, 38517.2296554073, 39289.01777455586, 39501.604983949794, 39555.60444395519, 40669.0, 37677.434838477995, 37927.62072379241, 37944.0, 38028.42957355586, 38906.0, 32441.35117297688, 33901.3219735599, 34398.48402274018, 34468.138296542784, 34647.48028779621, 22090.33728988133, 25245.621315679913, 25401.87299063493, 25891.611625826004, 26168.8691556541], "value": 17948.978181014012, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.8012162884712, 346.15710744337554, 362.3694771098289, 363.8744633101581, 376.88881779874936, 15286.464973725908, 18108.547286317847, 20588.588228235425, 21223.68164477534, 21341.253056143058, 20759.79240207601, 20815.0, 21183.0, 21357.786422135774, 21367.465813354673, 5852.209951656536, 5890.2931648202275, 6070.332263451017, 6166.383361663842, 6181.721822517998, 4177.791110444481, 6011.5190784737115, 6100.7864724734645, 6113.572049956505, 6113.755449782004, 4051.837926482952, 4398.8020539075815, 4421.801018954155, 4423.469183697945, 6836.521443498957, 6801.829954251134, 6830.999999999975, 6842.315768423118, 6847.2125705544, 6850.794476165723, 5682.0, 5891.116332550109, 5923.229980102602, 5937.168796368512, 5967.224260846062, 27082.91668333264, 27394.863025684943, 27502.44995100107, 27509.762060707315, 27574.310642234104, 2242.7196600424945, 2275.670027845953, 2303.4702018535663, 2555.7827584655142, 3048.71953779411, 15129.940904136714, 15813.367465301375, 15983.600409989727, 16141.435049773201, 16247.756283655637, 1616.4180894877834, 1823.4803081121815, 1862.2644055597964, 1934.3764770267944, 1978.268040824904, 110589.0, 112120.0, 112613.87386126198, 113519.0, 117088.0, 10362.481875906175, 10649.680509584725, 10888.564457421773, 11366.829497557543, 11414.258073225214, 14136.222507762172, 14142.43430262778, 14172.0, 14180.645483862985, 14184.007119501743, 7997.280244777881, 8123.83752324962, 8197.34421246299, 8297.087320394752, 8348.749537513884, 7858.253465920729, 7861.803454913558, 7885.172056934054, 8044.758657240292, 8054.959725201336, 5547.528460080938, 6742.6628668567355, 6820.9658951705915, 6860.897086543706, 6870.141232345957, 1528.8776897848145, 1541.7049678270082, 1633.9869281045828, 1640.2946732904727, 1675.4554769699896, 890.8841850559386, 894.9373543851998, 921.5944984206927, 1004.8794144702537, 1112.9387883666477, 19845.206191752168, 20497.48756281075, 21411.571768564543, 22470.440151837985, 23097.53804923892, 910.8178364327028, 925.9259259259243, 951.9619215231452, 958.1328897347911, 969.0503306759274, 9562.760930976641, 11193.578154612502, 11589.0, 11708.356040417859, 11943.163978521594, 470946.0, 543800.0, 546223.0, 548352.0, 549389.2530537322, 126652.1002184968, 129012.0, 129702.35148824195, 131415.0, 134477.0, 948.4546385828177, 979.1383582447401, 983.2036050798876, 984.0, 984.2962281968427, 16874.74687879658, 19103.904480477508, 19928.0, 20114.99425028772, 20725.378238652866, 53685.0, 53742.19386709281, 56161.0, 57087.0, 57758.422415775305, 76076.0, 76984.0, 77414.0, 78365.60817195878, 82391.5880420594, 5552.583556233218, 7558.055243094614, 8124.715634952749, 8247.381446391664, 8356.498610083172, 12973.962083033146, 13095.803562946754, 13129.0, 13362.665933351744, 13694.52069177574, 9520.761980950532, 9682.951585242028, 11372.147088968526, 11504.712382190512, 11631.360275184608, 10882.129429645767, 11243.60647377338, 11311.604093856675, 11561.132915031238, 11702.765944680888, 11435.656930292105, 11693.0, 11920.986716129226, 11967.64097077089, 11983.76032479363, 8174.019117705913, 8327.666893324442, 8340.332773378237, 8354.958225209079, 8469.237768600855, 11042.779144417227, 11471.0, 11601.809502386574, 11662.94168529152, 11775.705607359885], "value": 9751.365072832432, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.7454870848887, 1532.8237252715942, 1562.6093476630845, 1721.9741703874436, 1859.3956963986707, 7773.300402963732, 8268.214519620642, 8269.751907442778, 8330.167363180091, 8557.957210213955, 8409.579521023956, 8463.661453541867, 8464.492130472161, 8468.618912148953, 8471.449355791885, 2328.93013209604, 2353.7763912428377, 2357.8938947747392, 2358.9999999999914, 2361.456864921069, 2287.611106111965, 2325.03511042917, 2344.7186337639423, 2349.4713689419827, 2357.0, 2111.577684463106, 2306.6078766609717, 2332.8133749300014, 2342.0514691549865, 2346.671465994762, 2178.5425060737266, 2305.6887320211727, 2324.0, 2325.790678838904, 2327.034280773477, 2307.5038866643754, 2315.4674424882205, 2316.2587971849016, 2319.6404557293645, 2320.0, 8491.830163396759, 8534.658613655447, 8552.187542183545, 8558.61486233121, 8561.0, 5199.922001169985, 5222.720433493781, 5368.62419630626, 5369.140937449989, 5369.865753356197, 2995.7453616442626, 3059.5410688396696, 3714.814259287025, 3723.3670276052867, 3737.1404576947452, 1110.6057349640923, 1117.3072694929197, 1137.6302701621923, 1146.2606618730872, 1146.3236690352733, 11661.591844285495, 11751.7062073448, 11757.706057348549, 11764.764704705944, 11813.173077884638, 4072.2669919414197, 4472.57510536505, 4750.5249475052215, 4856.757162141878, 4957.281194226817, 9107.134822191882, 9185.173334399937, 9189.90810091904, 9191.540422978824, 9195.770105747277, 5292.44429334922, 5295.867603309871, 5296.179092240709, 5297.841064768063, 5301.522862942354, 4077.1845630873945, 4446.377507149002, 4827.61379089672, 4915.754212289371, 4980.377452818398, 3070.47801873682, 3708.870189543353, 3798.0, 3834.539855217392, 3836.769793812324, 1162.7209469727204, 1170.3387586013876, 1172.9824052639217, 1185.6146752305535, 1186.7567148734488, 742.3986570877606, 833.4582521361164, 874.156439036333, 913.3241401363076, 950.0831697411893, 5739.62692424991, 5800.854978625568, 5950.8809823803285, 6110.327863934964, 6176.289726681399, 910.5265262063822, 938.9671361502315, 949.2675866543585, 951.8244967465175, 1002.5688953749958, 3898.688104951597, 3934.7174198312714, 4002.479677641888, 4059.2490389278078, 4077.938830917539, 9994.150497207818, 10860.402677852637, 10982.505787239594, 10984.340939543654, 10992.725181870517, 10454.895451045544, 10914.017738403581, 10921.399323037309, 10926.0, 10970.232083754061, 8044.2760151586635, 8261.545614991113, 8264.049634292012, 8265.214804593554, 8270.710525131712, 4847.3698419205275, 5899.0, 5929.703514824328, 5999.730012149551, 6033.461467325804, 9913.206943444651, 10122.291439599452, 10192.643257485952, 10193.43936083493, 10220.284580079324, 8443.831123377375, 9952.452615106238, 9965.40207587547, 10187.541560629641, 10425.322354046963, 6867.793966181022, 7078.787636370917, 7149.892751608834, 7164.641767911688, 7167.211606723152, 8209.220124088202, 8314.0, 8417.494950303002, 8417.957910210655, 8433.030201526903, 6406.23125224976, 7516.549007059594, 7559.092908850973, 7585.279398457138, 7620.390368770596, 7373.5575865448245, 7389.187189409053, 7415.888761668687, 7453.701851926079, 7463.3656139226605, 6861.348171923659, 6983.022376867344, 6989.37095661393, 6996.0, 6999.47503937217, 4856.635752318661, 4969.577585905238, 4987.877727511281, 5026.195808670595, 5152.330197074356, 4900.926486102782, 4958.776855041604, 5042.773075211698, 5053.216751403538, 5164.7934082636275], "value": 4530.872523365672, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.0948014213734, 292.4589509407596, 296.51519765183923, 305.0224031977512, 309.54496889572334, 5081.364829396325, 5100.336956195699, 5141.640085194038, 5166.5608423283975, 5173.379194496656, 4289.463817022872, 5102.285680004802, 5275.388682602117, 5334.439883812202, 5345.625806193568, 3706.4996225509617, 3837.501124853779, 4051.3315302974975, 4078.8572399966006, 4162.167566486714, 3643.544556930384, 4016.4376987221813, 4104.343305071189, 4128.956166697489, 4142.130152667928, 3490.127468132967, 3752.624737526239, 3804.182100848317, 3814.313423583754, 3918.7060970427333, 3803.3344164771192, 4001.4598029265967, 4097.631213190797, 4115.464989551369, 4117.197146556423, 2993.9550906736417, 3551.9876835101873, 3558.5018097466377, 3558.928821423557, 3566.5898421681577, 4853.854384368439, 5141.074606570815, 5195.012947539955, 5201.463005156492, 5212.244224587414, 4026.45642838216, 4426.313921342197, 4579.771011449414, 4581.221192397267, 4594.678372513926, 5553.333599968029, 5570.805021824257, 5574.1917421973585, 5604.131359639263, 5631.465010823965, 3205.7916235444623, 3312.4825132898927, 3649.197176621139, 3794.90512737181, 3813.9892928374, 5367.087595108841, 5644.585026059216, 5815.098659707752, 5832.795852145197, 5839.7664093436215, 3842.884713458545, 3855.4602355670227, 3862.6909847212155, 3870.43878637596, 3873.1479074603544, 3479.7820762733345, 3925.509311336083, 3943.664788492953, 3944.270309992603, 3958.8416463341146, 3600.837962291703, 3962.663173630216, 4085.937656209407, 4184.979075104605, 4551.362809206647, 5358.27663265462, 5593.888122237532, 5608.083796425835, 5624.3813180550105, 5650.378458369576, 1140.6463996161217, 1229.2747279105192, 1314.9802752958713, 1334.946602135923, 1343.993280033613, 753.8605358008786, 755.9168491465934, 795.7214974758904, 806.5563939833186, 823.1685997142929, 3971.5829837867186, 4816.4220293564995, 4995.501349595107, 5123.23248479274, 5168.767405466763, 5309.761060752276, 5424.0, 5592.832215033555, 5628.521575666115, 5663.292088488939, 4372.628326592276, 4735.905281894343, 4892.584130348961, 5091.3126727892, 5103.974480127576, 2519.7354277800932, 2586.9870650646626, 2599.571070773339, 2741.8080734348805, 2984.9552256716165, 4771.0, 5781.82654520365, 5800.50695690871, 5802.564807639444, 5807.477327040587, 5507.614466987353, 5767.740451679684, 5783.219265399117, 5792.739326730223, 5815.680137592389, 5780.306363236355, 5797.24635797352, 5811.476967072984, 5817.272840894888, 5870.442307980735, 4881.9511804881495, 5224.52979231871, 5507.834764957058, 5632.464915832989, 5674.907175589231, 4644.396228490275, 5370.892582148257, 5504.256925315031, 5562.137868630369, 5581.2744343236745, 4846.636502262415, 5397.8380648580605, 5613.775448981995, 5848.035074212878, 5864.296284445893, 3169.0, 3228.176814912182, 3771.226898485859, 3795.715321350965, 3835.3096442640594, 5444.725890176351, 5495.890082198253, 5696.658200507983, 5747.74135163927, 5787.8553036174435, 4830.4444988826735, 5070.239464080418, 5558.972205138948, 5570.022641962045, 5592.889226418661, 5543.2793736815565, 5553.862067931605, 5571.526420254162, 5580.437477506305, 5604.915926261027, 4631.606313463393, 5000.974995125001, 5426.647267927572, 5498.642588231752, 5499.477549632778, 5576.65400759541, 5601.327840659147, 5604.495595396434, 5605.103183490622, 5621.381648018633, 4530.0486897750525, 5503.807366742145, 5516.503514683698, 5572.1054841354135, 5582.944170558405], "value": 4012.5311006830684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.6651207420438, 702.2626242445434, 711.1324184494914, 715.3954908102654, 746.6005686957476, 13030.0, 15300.081995080289, 15605.687886242269, 16105.436309729163, 16148.03111813292, 12004.639860804167, 14840.925795371008, 14871.256437178125, 14878.0, 14897.627559311022, 663.4990582110499, 833.1335411172389, 846.6401779243797, 849.5752123938031, 849.9617517211709, 690.3027941778814, 825.3644693585935, 848.2620120495178, 851.2806678356809, 857.9270761985239, 742.5136535569184, 744.3970383988986, 883.8143989762158, 884.0761404332455, 885.8848349714528, 699.6571679876823, 879.0111124984393, 881.8412685716569, 881.9823603527893, 883.8497455432592, 532.5553163108809, 536.2331865432469, 536.4340620645218, 537.4679067722926, 637.1939496536885, 14451.92774036123, 14671.413143474356, 14678.486252981202, 14688.0, 14701.338439770236, 11399.658010259705, 12972.286524241163, 14141.29293535319, 14194.290285485788, 14271.00102992791, 12701.047421443429, 12746.235225886476, 12870.22778633285, 13416.329183540882, 13430.798538021938, 4512.255477846152, 4571.908561828778, 4573.108243892442, 4768.833090841838, 4769.737664428455, 108011.45994270057, 109073.90926090717, 122425.0, 124037.13944290843, 126885.36557317247, 10988.835167472495, 11193.328400296008, 11227.494762735696, 11385.373804440835, 11601.883981160248, 21847.563048739255, 21891.562168756853, 21900.561988760135, 21902.014409351617, 21920.903954802197, 7827.1390147083775, 8054.838903221903, 8095.150009249061, 8105.635246413925, 8165.346772258324, 4394.36281739146, 4409.823607055746, 4469.128519938581, 4591.586757191869, 4608.124456353282, 3103.007037747899, 3401.3537427888623, 3483.5819701635965, 3494.965050349515, 3544.2911417716045, 624.2727222785495, 626.2703949898317, 628.7045088808253, 633.965131917749, 658.7648159700561, 554.3043480432112, 582.1820342418908, 624.9133440291528, 636.0903907412352, 639.7472998165791, 7227.385672217815, 8300.667973281123, 8952.8657070144, 9755.756106097404, 10283.434411107311, 563.6026601246193, 580.196427947296, 616.6146158650844, 647.690302553949, 681.4276008153175, 4255.97257790481, 4462.977685111554, 4619.953800461953, 4621.168189725881, 4632.837850675278, 137756.0, 144028.0, 148521.0, 149076.0, 150639.0, 76608.61695691486, 102070.0, 102735.0, 128934.35532822275, 133947.0, 68026.65986670234, 69535.65232173908, 70211.0, 97347.51326243323, 104876.0, 9392.624295028396, 9587.424754514752, 9700.0, 9700.5149742514, 9819.950900245452, 58393.70803145957, 60283.0, 61211.69394153179, 61511.0, 61530.69234653798, 55161.0, 55364.44635553593, 75887.71964906009, 89958.1004189976, 92187.0, 11141.554337826396, 12448.62654120378, 12708.745825083262, 13435.798463023259, 13505.932470337979, 14893.47872824446, 15069.54791356261, 15238.77141842851, 15340.693186136437, 15660.765088523909, 13653.385597647932, 13874.583762487142, 14509.564713058626, 14707.55877323682, 14822.62943426423, 11541.480633371351, 13645.931770341085, 14053.859461405254, 14370.784438233644, 14389.280535973368, 13764.587062388144, 13849.772246866758, 13912.721745565235, 14033.0, 14455.927720361331, 11055.502502387251, 11282.548698052315, 11348.829767553329, 11489.942550287195, 12007.939960300142, 9621.9037809621, 11099.72250693739, 11447.542098315975, 11519.827202592136, 11652.88347116518], "value": 7638.557732740819, "unit": "score"}], "name": "dromaeo_css", "value": 7193.311748821295, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 161.0, 167.0, 113.0, 113.0, 107.0, 114.0, 113.0, 113.0], "value": 121.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 109.0, 160.0, 109.0, 107.0, 128.0, 105.0, 179.0, 138.0], "value": 129.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 185.0, 184.0, 183.0, 183.0, 182.0, 184.0, 182.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 62.0, 60.0, 87.0, 59.0, 57.0, 63.0, 63.0, 103.0, 80.0], "value": 71.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 95.0, 73.0, 69.0, 68.0, 97.0, 70.0, 68.0, 103.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 92.0, 89.0, 92.0, 89.0, 90.0, 89.0, 91.0, 88.0], "value": 90.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 102.0, 95.0], "value": 96.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 83.0, 85.0, 84.0, 84.0, 84.0, 82.0, 84.0, 84.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 59.0, 55.0, 59.0, 76.0, 82.0, 80.0, 80.0, 54.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 78.0, 74.0, 72.0, 70.0, 68.0, 68.0, 68.0, 69.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 104.0, 86.0, 85.0, 84.0, 84.0, 88.0, 86.0, 85.0, 84.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 146.0, 138.0, 132.0, 138.0, 138.0, 131.0, 159.0, 233.0, 175.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 179.0, 233.0, 173.0, 166.0, 170.0, 168.0, 230.0, 217.0, 167.0], "value": 187.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 79.0, 90.0, 87.0, 85.0, 72.0, 69.0, 72.0, 83.0], "value": 77.3, "unit": "score"}], "name": "kraken", "value": 1500.0, "alertThreshold": 2.0}]} 12:50:29 INFO - Return code: 0 12:50:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:50:29 INFO - # TBPL SUCCESS # 12:50:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:50:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:50:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:50:29 INFO - 2016-08-17 12:50:29.377 screenresolution[1666:9841] starting screenresolution argv=screenresolution get 12:50:29 INFO - 2016-08-17 12:50:29.379 screenresolution[1666:9841] Display 0: 1600x1200x32@60 12:50:29 INFO - 2016-08-17 12:50:29.386 screenresolution[1667:9844] starting screenresolution argv=screenresolution list 12:50:29 INFO - Available Modes on Display 0 12:50:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:50:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:50:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:50:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:50:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:50:29 INFO - Intel Iris: 12:50:29 INFO - Chipset Model: Intel Iris 12:50:29 INFO - Type: GPU 12:50:29 INFO - Bus: Built-In 12:50:29 INFO - VRAM (Dynamic, Max): 1536 MB 12:50:29 INFO - Vendor: Intel (0x8086) 12:50:29 INFO - Device ID: 0x0a2e 12:50:29 INFO - Revision ID: 0x0009 12:50:29 INFO - Displays: 12:50:29 INFO - Display: 12:50:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:50:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:50:29 INFO - Display Serial Number: 1600x1200 60 12:50:29 INFO - Main Display: Yes 12:50:29 INFO - Mirror: Off 12:50:29 INFO - Online: Yes 12:50:29 INFO - Rotation: Supported 12:50:29 INFO - Return code: 0 12:50:29 INFO - Running post-action listener: _resource_record_post_action 12:50:29 INFO - [mozharness: 2016-08-17 19:50:29.624169Z] Finished run-tests step (success) 12:50:29 INFO - Running post-run listener: _resource_record_post_run 12:50:29 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 36766720; Write bytes: 701569536; Read time: 369; Write time: 2015 12:50:29 INFO - TinderboxPrint: CPU usage
53.3% 12:50:29 INFO - TinderboxPrint: I/O read bytes / time
36,766,720 / 369 12:50:29 INFO - TinderboxPrint: I/O write bytes / time
701,569,536 / 2,015 12:50:29 INFO - TinderboxPrint: CPU idle
2,266.2 (46.7%) 12:50:29 INFO - TinderboxPrint: CPU system
970.2 (20.0%) 12:50:29 INFO - TinderboxPrint: CPU user
1,621.3 (33.4%) 12:50:29 INFO - TinderboxPrint: Swap in / out
442,269,696 / 0 12:50:29 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 400835072; Write bytes: 395503616; Read time: 30892; Write time: 753 12:50:29 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 34644992; Write bytes: 292061696; Read time: 344; Write time: 1226 12:50:30 INFO - Running post-run listener: _upload_blobber_files 12:50:30 INFO - Blob upload gear active. 12:50:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:50:30 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 12:50:30 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'] 12:50:30 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 12:50:30 INFO - (blobuploader) - INFO - Open directory for files ... 12:50:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:50:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:50:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:50:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:50:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:50:31 INFO - (blobuploader) - INFO - Done attempting. 12:50:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:50:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:50:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:50:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:50:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:50:32 INFO - (blobuploader) - INFO - Done attempting. 12:50:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:50:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:50:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:50:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:50:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:50:34 INFO - (blobuploader) - INFO - Done attempting. 12:50:34 INFO - (blobuploader) - INFO - Iteration through files over. 12:50:34 INFO - Return code: 0 12:50:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:50:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:50:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/59e236e2e4bd5edb65514cfc267eb5dba5c34cdb31ee4dc7e120703a94700cb17ba588e52b1f44823349b96b3c8a11cd1de1f8d24872582b3b3f334ff80e5578", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34231661c2c2544cc9fac013552ba2b594e30b5606fd1add0e0e116ad218dbf0db07f9708267c0efe25e7dfb5f65b6e09aca1e2646106f8d63bd51a52c9791a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b69e4e6d2c3644f45942dac4a909a5fcb5925ad37f8545ca7968b87a7b61be3d9d6c99294a6d36730f2b91456094cb70dbadaeb9bdf683ca1fef6d32088ae3a6"} 12:50:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:50:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:50:34 INFO - Contents: 12:50:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/59e236e2e4bd5edb65514cfc267eb5dba5c34cdb31ee4dc7e120703a94700cb17ba588e52b1f44823349b96b3c8a11cd1de1f8d24872582b3b3f334ff80e5578", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34231661c2c2544cc9fac013552ba2b594e30b5606fd1add0e0e116ad218dbf0db07f9708267c0efe25e7dfb5f65b6e09aca1e2646106f8d63bd51a52c9791a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b69e4e6d2c3644f45942dac4a909a5fcb5925ad37f8545ca7968b87a7b61be3d9d6c99294a6d36730f2b91456094cb70dbadaeb9bdf683ca1fef6d32088ae3a6"} 12:50:34 INFO - Running post-run listener: copy_logs_to_upload_dir 12:50:34 INFO - Copying logs to upload dir... 12:50:34 INFO - mkdir: /builds/slave/test/build/upload/logs 12:50:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.753696 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-17 12:50:34.835763) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 12:50:34.838853) ========= 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.Txk97UcCUl/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.mKIbnFZxaq/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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/59e236e2e4bd5edb65514cfc267eb5dba5c34cdb31ee4dc7e120703a94700cb17ba588e52b1f44823349b96b3c8a11cd1de1f8d24872582b3b3f334ff80e5578", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34231661c2c2544cc9fac013552ba2b594e30b5606fd1add0e0e116ad218dbf0db07f9708267c0efe25e7dfb5f65b6e09aca1e2646106f8d63bd51a52c9791a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b69e4e6d2c3644f45942dac4a909a5fcb5925ad37f8545ca7968b87a7b61be3d9d6c99294a6d36730f2b91456094cb70dbadaeb9bdf683ca1fef6d32088ae3a6"} build_url:https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/HfYyppbkRsGb0mUmgHBRrA/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/59e236e2e4bd5edb65514cfc267eb5dba5c34cdb31ee4dc7e120703a94700cb17ba588e52b1f44823349b96b3c8a11cd1de1f8d24872582b3b3f334ff80e5578", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34231661c2c2544cc9fac013552ba2b594e30b5606fd1add0e0e116ad218dbf0db07f9708267c0efe25e7dfb5f65b6e09aca1e2646106f8d63bd51a52c9791a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b69e4e6d2c3644f45942dac4a909a5fcb5925ad37f8545ca7968b87a7b61be3d9d6c99294a6d36730f2b91456094cb70dbadaeb9bdf683ca1fef6d32088ae3a6"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 12:50:34.876132) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 12:50:34.876888) ========= 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.Txk97UcCUl/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.mKIbnFZxaq/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.005073 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 12:50:34.929365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 12:50:34.929652) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 12:50:34.929939) ========= ========= Total master_lag: 0.38 =========