builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0115 starttime: 1474635546.94 results: success (0) buildid: 20160923035101 builduid: 37e55f9ffeab43dca78129a05f79ccec revision: 60cc643978c7020926fe4145761e26945fcd5c37 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 05:59:06.942901) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 05:59:06.943323) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 05:59:06.943617) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 05:59:06.974815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:59:06.975100) ========= 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.rZOb6wmAxp/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.jPpAP57rg2/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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-09-23 05:59:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.2M=0s 2016-09-23 05:59:07 (26.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135888 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:59:07.133476) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:59:07.133752) ========= 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.rZOb6wmAxp/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.jPpAP57rg2/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.028462 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:59:07.185637) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 05:59:07.185950) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 60cc643978c7020926fe4145761e26945fcd5c37 --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 60cc643978c7020926fe4145761e26945fcd5c37 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rZOb6wmAxp/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.jPpAP57rg2/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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-09-23 05:59:07,182 truncating revision to first 12 chars 2016-09-23 05:59:07,182 Setting DEBUG logging. 2016-09-23 05:59:07,182 attempt 1/10 2016-09-23 05:59:07,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/60cc643978c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 05:59:08,122 unpacking tar archive at: fx-team-60cc643978c7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.197432 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 05:59:08.411431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 05:59:08.411755) ========= script_repo_revision: 60cc643978c7020926fe4145761e26945fcd5c37 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 05:59:08.412137) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 05:59:08.412408) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 05:59:08.431478) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-23 05:59:08.431755) ========= /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.rZOb6wmAxp/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.jPpAP57rg2/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 05:59:08 INFO - MultiFileLogger online at 20160923 05:59:08 in /builds/slave/test 05:59:08 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 05:59:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:59:08 INFO - {'append_to_log': False, 05:59:08 INFO - 'base_work_dir': '/builds/slave/test', 05:59:08 INFO - 'blob_upload_branch': 'Fx-Team', 05:59:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:59:08 INFO - 'branch': 'Fx-Team', 05:59:08 INFO - 'buildbot_json_path': 'buildprops.json', 05:59:08 INFO - 'config_files': ('talos/mac_config.py',), 05:59:08 INFO - 'default_actions': ('clobber', 05:59:08 INFO - 'read-buildbot-config', 05:59:08 INFO - 'download-and-extract', 05:59:08 INFO - 'populate-webroot', 05:59:08 INFO - 'create-virtualenv', 05:59:08 INFO - 'install', 05:59:08 INFO - 'run-tests'), 05:59:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:59:08 INFO - 'download_minidump_stackwalk': True, 05:59:08 INFO - 'download_symbols': 'ondemand', 05:59:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:59:08 INFO - 'tooltool.py': '/tools/tooltool.py', 05:59:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:59:08 INFO - '/tools/misc-python/virtualenv.py')}, 05:59:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:59:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:59:08 INFO - 'installer_path': 'installer.exe', 05:59:08 INFO - 'log_level': 'info', 05:59:08 INFO - 'log_name': 'talos', 05:59:08 INFO - 'log_to_console': True, 05:59:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:59:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:59:08 INFO - 'opt_config_files': (), 05:59:08 INFO - 'pip_index': False, 05:59:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:59:08 INFO - 'cmd': ('bash', 05:59:08 INFO - '-c', 05:59:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:59:08 INFO - 'enabled': True, 05:59:08 INFO - 'halt_on_failure': False, 05:59:08 INFO - 'name': 'check_screen_resolution'},), 05:59:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:59:08 INFO - 'cmd': ('bash', 05:59:08 INFO - '-c', 05:59:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:59:08 INFO - 'enabled': True, 05:59:08 INFO - 'halt_on_failure': False, 05:59:08 INFO - 'name': 'check_screen_resolution'},), 05:59:08 INFO - 'run_cmd_checks_enabled': True, 05:59:08 INFO - 'sps_profile': False, 05:59:08 INFO - 'sps_profile_interval': 0, 05:59:08 INFO - 'suite': 'dromaeojs', 05:59:08 INFO - 'system_bits': '32', 05:59:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:59:08 INFO - 'title': 't-yosemite-r7-0115', 05:59:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:59:08 INFO - 'use_talos_json': True, 05:59:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:59:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:59:08 INFO - 'work_dir': 'build'} 05:59:08 INFO - [mozharness: 2016-09-23 12:59:08.560500Z] Running clobber step. 05:59:08 INFO - Running pre-action listener: _resource_record_pre_action 05:59:08 INFO - Running main action method: clobber 05:59:08 INFO - rmtree: /builds/slave/test/build 05:59:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:59:10 INFO - Running post-action listener: _resource_record_post_action 05:59:10 INFO - [mozharness: 2016-09-23 12:59:10.823859Z] Finished clobber step (success) 05:59:10 INFO - [mozharness: 2016-09-23 12:59:10.823978Z] Running read-buildbot-config step. 05:59:10 INFO - Running pre-action listener: _resource_record_pre_action 05:59:10 INFO - Running main action method: read_buildbot_config 05:59:10 INFO - Using buildbot properties: 05:59:10 INFO - { 05:59:10 INFO - "project": "", 05:59:10 INFO - "product": "firefox", 05:59:10 INFO - "script_repo_revision": "production", 05:59:10 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:59:10 INFO - "repository": "", 05:59:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:59:10 INFO - "buildid": "20160923035101", 05:59:10 INFO - "pgo_build": "False", 05:59:10 INFO - "basedir": "/builds/slave/test", 05:59:10 INFO - "buildnumber": 174, 05:59:10 INFO - "slavename": "t-yosemite-r7-0115", 05:59:10 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:59:10 INFO - "platform": "yosemite_r7", 05:59:10 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:59:10 INFO - "branch": "fx-team", 05:59:10 INFO - "repo_path": "integration/fx-team", 05:59:10 INFO - "revision": "60cc643978c7020926fe4145761e26945fcd5c37", 05:59:10 INFO - "stage_platform": "macosx64", 05:59:10 INFO - "builduid": "37e55f9ffeab43dca78129a05f79ccec", 05:59:10 INFO - "slavebuilddir": "test" 05:59:10 INFO - } 05:59:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:59:10 INFO - Running post-action listener: _resource_record_post_action 05:59:10 INFO - [mozharness: 2016-09-23 12:59:10.827213Z] Finished read-buildbot-config step (success) 05:59:10 INFO - [mozharness: 2016-09-23 12:59:10.827353Z] Running download-and-extract step. 05:59:10 INFO - Running pre-action listener: _resource_record_pre_action 05:59:10 INFO - Running main action method: download_and_extract 05:59:10 INFO - mkdir: /builds/slave/test/build/tests 05:59:10 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')]} 05:59:10 INFO - trying https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:59:10 INFO - Downloading https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:59:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:59:11 INFO - Downloaded 1199 bytes. 05:59:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:59:11 INFO - Using the following test package requirements: 05:59:11 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:59:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:59:11 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:59:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:59:11 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:59:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:59:11 INFO - u'jsshell-mac.zip'], 05:59:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:59:11 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:59:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:59:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:59:11 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:59:11 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:59:11 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:59:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:59:11 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:59:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:59:11 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:59:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:59:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:59:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:59:11 INFO - Fetch https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:59:12 INFO - Expected file size: 16438933 05:59:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:59:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:59:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:59:19 INFO - Fetch https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:59:20 INFO - Expected file size: 16438933 05:59:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:59:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:59:26 INFO - Fetch https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:59:28 INFO - Expected file size: 14414059 05:59: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')]} 05:59:29 INFO - trying https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:59:29 INFO - Downloading https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:59:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:59:32 INFO - Downloaded 111561537 bytes. 05:59:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:59:32 INFO - mkdir: /builds/slave/test/properties 05:59:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:59:32 INFO - Writing to file /builds/slave/test/properties/build_url 05:59:32 INFO - Contents: 05:59:32 INFO - build_url:https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:59:32 INFO - Running post-action listener: _resource_record_post_action 05:59:32 INFO - Running post-action listener: set_extra_try_arguments 05:59:32 INFO - [mozharness: 2016-09-23 12:59:32.965238Z] Finished download-and-extract step (success) 05:59:32 INFO - [mozharness: 2016-09-23 12:59:32.965381Z] Running populate-webroot step. 05:59:32 INFO - Running pre-action listener: _resource_record_pre_action 05:59:32 INFO - Running main action method: populate_webroot 05:59:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:59:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:59:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:59:32 INFO - '--tppagecycles', 05:59:32 INFO - '7'], 05:59:32 INFO - 'tests': ['tsvgm']}}, 05:59:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:59:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:59:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:59:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:59:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:59:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:59:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:32 INFO - 'talos_options': ['--disable-e10s'], 05:59:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:59:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:32 INFO - 'talos_options': ['--disable-e10s'], 05:59:32 INFO - 'tests': ['damp', 'tps']}, 05:59:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:32 INFO - 'tests': ['damp', 'tps']}, 05:59:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:59:32 INFO - 'tests': ['dromaeo_dom']}, 05:59:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:59:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:59:32 INFO - 'tests': ['basic_compositor_video']}, 05:59:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:59:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:59:32 INFO - 'tests': ['a11yr', 05:59:32 INFO - 'ts_paint', 05:59:32 INFO - 'tpaint', 05:59:32 INFO - 'sessionrestore', 05:59:32 INFO - 'sessionrestore_no_auto_restore', 05:59:32 INFO - 'tabpaint']}, 05:59:32 INFO - 'other-e10s': {'tests': ['a11yr', 05:59:32 INFO - 'ts_paint', 05:59:32 INFO - 'tpaint', 05:59:32 INFO - 'sessionrestore', 05:59:32 INFO - 'sessionrestore_no_auto_restore', 05:59:32 INFO - 'tabpaint']}, 05:59:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:59:32 INFO - 'ts_paint', 05:59:32 INFO - 'tpaint', 05:59:32 INFO - 'sessionrestore', 05:59:32 INFO - 'sessionrestore_no_auto_restore', 05:59:32 INFO - 'tabpaint']}, 05:59:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:59:32 INFO - 'ts_paint', 05:59:32 INFO - 'tpaint', 05:59:32 INFO - 'sessionrestore', 05:59:32 INFO - 'sessionrestore_no_auto_restore', 05:59:32 INFO - 'tabpaint']}, 05:59:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:59:32 INFO - 'tests': ['a11yr', 05:59:32 INFO - 'ts_paint', 05:59:32 INFO - 'tpaint', 05:59:32 INFO - 'sessionrestore', 05:59:32 INFO - 'sessionrestore_no_auto_restore', 05:59:32 INFO - 'tabpaint']}, 05:59:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:59:32 INFO - 'tests': ['a11yr', 05:59:32 INFO - 'ts_paint', 05:59:32 INFO - 'tpaint', 05:59:32 INFO - 'sessionrestore', 05:59:32 INFO - 'sessionrestore_no_auto_restore', 05:59:32 INFO - 'tabpaint']}, 05:59:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:59:32 INFO - 'tests': ['tsvgx', 05:59:32 INFO - 'tsvgr_opacity', 05:59:32 INFO - 'tart', 05:59:32 INFO - 'tscrollx', 05:59:32 INFO - 'cart']}, 05:59:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:59:32 INFO - 'tsvgr_opacity', 05:59:32 INFO - 'tart', 05:59:32 INFO - 'tscrollx', 05:59:32 INFO - 'cart']}, 05:59:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:32 INFO - 'talos_options': ['--disable-e10s'], 05:59:32 INFO - 'tests': ['tp5o']}, 05:59:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:32 INFO - 'tests': ['tp5o']}, 05:59:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:32 INFO - 'talos_options': ['--disable-e10s', 05:59:32 INFO - '--xperf_path', 05:59:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:32 INFO - 'tests': ['tp5n']}, 05:59:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:59:32 INFO - 'talos_options': ['--xperf_path', 05:59:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:59:32 INFO - 'tests': ['tp5n']}}, 05:59:32 INFO - 'talos.zip': {'path': '', 05:59:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:59:32 INFO - Running post-action listener: _resource_record_post_action 05:59:32 INFO - [mozharness: 2016-09-23 12:59:32.984313Z] Finished populate-webroot step (success) 05:59:32 INFO - [mozharness: 2016-09-23 12:59:32.984444Z] Running create-virtualenv step. 05:59:32 INFO - Running pre-action listener: _resource_record_pre_action 05:59:32 INFO - Running main action method: create_virtualenv 05:59:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:59:32 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 05:59:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:59:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:59:33 INFO - Using real prefix '/tools/python27' 05:59:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:59:33 INFO - Installing distribute.............................................................................................................................................................................................done. 05:59:36 INFO - Installing pip.................done. 05:59:36 INFO - Return code: 0 05:59:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:59: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')]} 05:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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')]} 05:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:36 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 0x10d65a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0acac510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d46ed30>, '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 0x10d294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d466b20>, '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.rZOb6wmAxp/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.jPpAP57rg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 05:59:36 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 05:59:36 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 05:59:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZOb6wmAxp/Render', 05:59:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:36 INFO - 'HOME': '/Users/cltbld', 05:59:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:36 INFO - 'LOGNAME': 'cltbld', 05:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:36 INFO - 'MOZ_NO_REMOTE': '1', 05:59:36 INFO - 'NO_EM_RESTART': '1', 05:59:36 INFO - 'PAGER': '/bin/cat', 05:59:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:36 INFO - 'PWD': '/builds/slave/test', 05:59:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:36 INFO - 'SHELL': '/bin/bash', 05:59:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jPpAP57rg2/Listeners', 05:59:36 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 05:59:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:36 INFO - 'USER': 'cltbld', 05:59:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:36 INFO - 'XPC_FLAGS': '0x0', 05:59:36 INFO - 'XPC_SERVICE_NAME': '0', 05:59:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:36 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 05:59:36 INFO - Cleaning up... 05:59:36 INFO - Return code: 0 05:59:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:59: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')]} 05:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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')]} 05:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:36 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 0x10d65a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0acac510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d46ed30>, '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 0x10d294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d466b20>, '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.rZOb6wmAxp/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.jPpAP57rg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 05:59:36 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 05:59:36 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 05:59:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZOb6wmAxp/Render', 05:59:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:36 INFO - 'HOME': '/Users/cltbld', 05:59:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:36 INFO - 'LOGNAME': 'cltbld', 05:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:36 INFO - 'MOZ_NO_REMOTE': '1', 05:59:36 INFO - 'NO_EM_RESTART': '1', 05:59:36 INFO - 'PAGER': '/bin/cat', 05:59:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:36 INFO - 'PWD': '/builds/slave/test', 05:59:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:36 INFO - 'SHELL': '/bin/bash', 05:59:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jPpAP57rg2/Listeners', 05:59:36 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 05:59:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:36 INFO - 'USER': 'cltbld', 05:59:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:36 INFO - 'XPC_FLAGS': '0x0', 05:59:36 INFO - 'XPC_SERVICE_NAME': '0', 05:59:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:37 INFO - Downloading/unpacking psutil>=3.1.1 05:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:59:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:40 INFO - Installing collected packages: psutil 05:59:40 INFO - Running setup.py install for psutil 05:59:40 INFO - building 'psutil._psutil_osx' extension 05:59:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:59:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:59:41 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 05:59:41 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 05:59:41 INFO - building 'psutil._psutil_posix' extension 05:59:41 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 05:59:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:59:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:59:41 INFO - ^ 05:59:41 INFO - 1 warning generated. 05:59:41 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 05:59:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:41 INFO - Successfully installed psutil 05:59:41 INFO - Cleaning up... 05:59:41 INFO - Return code: 0 05:59:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d65a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0acac510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d46ed30>, '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 0x10d294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d466b20>, '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.rZOb6wmAxp/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.jPpAP57rg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 05:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:59:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZOb6wmAxp/Render', 05:59:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:41 INFO - 'HOME': '/Users/cltbld', 05:59:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:41 INFO - 'LOGNAME': 'cltbld', 05:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:41 INFO - 'MOZ_NO_REMOTE': '1', 05:59:41 INFO - 'NO_EM_RESTART': '1', 05:59:41 INFO - 'PAGER': '/bin/cat', 05:59:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:41 INFO - 'PWD': '/builds/slave/test', 05:59:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:41 INFO - 'SHELL': '/bin/bash', 05:59:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jPpAP57rg2/Listeners', 05:59:41 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 05:59:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:41 INFO - 'USER': 'cltbld', 05:59:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:41 INFO - 'XPC_FLAGS': '0x0', 05:59:41 INFO - 'XPC_SERVICE_NAME': '0', 05:59:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:59:41 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 05:59:41 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 05:59:41 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 05:59:41 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 05:59:41 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 05:59:41 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 05:59:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:59:44 INFO - Installing collected packages: mozsystemmonitor 05:59:44 INFO - Running setup.py install for mozsystemmonitor 05:59:44 INFO - Successfully installed mozsystemmonitor 05:59:44 INFO - Cleaning up... 05:59:44 INFO - Return code: 0 05:59:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d65a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0acac510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d46ed30>, '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 0x10d294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d466b20>, '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.rZOb6wmAxp/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.jPpAP57rg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 05:59:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZOb6wmAxp/Render', 05:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:44 INFO - 'HOME': '/Users/cltbld', 05:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:44 INFO - 'LOGNAME': 'cltbld', 05:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:44 INFO - 'MOZ_NO_REMOTE': '1', 05:59:44 INFO - 'NO_EM_RESTART': '1', 05:59:44 INFO - 'PAGER': '/bin/cat', 05:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:44 INFO - 'PWD': '/builds/slave/test', 05:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:44 INFO - 'SHELL': '/bin/bash', 05:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jPpAP57rg2/Listeners', 05:59:44 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 05:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:44 INFO - 'USER': 'cltbld', 05:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:44 INFO - 'XPC_FLAGS': '0x0', 05:59:44 INFO - 'XPC_SERVICE_NAME': '0', 05:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:44 INFO - Downloading/unpacking jsonschema==2.5.1 05:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:59:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:47 INFO - Downloading functools32-3.2.3-2.tar.gz 05:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:59:47 INFO - warning: no files found matching '*.txt' 05:59:47 INFO - no previously-included directories found matching 'build' 05:59:47 INFO - no previously-included directories found matching 'dist' 05:59:47 INFO - no previously-included directories found matching '.git*' 05:59:47 INFO - Installing collected packages: jsonschema, functools32 05:59:47 INFO - Running setup.py install for functools32 05:59:48 INFO - warning: no files found matching '*.txt' 05:59:48 INFO - no previously-included directories found matching 'build' 05:59:48 INFO - no previously-included directories found matching 'dist' 05:59:48 INFO - no previously-included directories found matching '.git*' 05:59:48 INFO - Successfully installed jsonschema functools32 05:59:48 INFO - Cleaning up... 05:59:48 INFO - Return code: 0 05:59:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d65a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0acac510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d46ed30>, '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 0x10d294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d466b20>, '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.rZOb6wmAxp/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.jPpAP57rg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 05:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:59:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZOb6wmAxp/Render', 05:59:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:48 INFO - 'HOME': '/Users/cltbld', 05:59:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:48 INFO - 'LOGNAME': 'cltbld', 05:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:48 INFO - 'MOZ_NO_REMOTE': '1', 05:59:48 INFO - 'NO_EM_RESTART': '1', 05:59:48 INFO - 'PAGER': '/bin/cat', 05:59:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:48 INFO - 'PWD': '/builds/slave/test', 05:59:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:48 INFO - 'SHELL': '/bin/bash', 05:59:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jPpAP57rg2/Listeners', 05:59:48 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 05:59:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:48 INFO - 'USER': 'cltbld', 05:59:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:48 INFO - 'XPC_FLAGS': '0x0', 05:59:48 INFO - 'XPC_SERVICE_NAME': '0', 05:59:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:59:48 INFO - Cleaning up... 05:59:48 INFO - Return code: 0 05:59:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d65a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0acac510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d46ed30>, '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 0x10d294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d466b20>, '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.rZOb6wmAxp/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.jPpAP57rg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 05:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:59:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZOb6wmAxp/Render', 05:59:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:48 INFO - 'HOME': '/Users/cltbld', 05:59:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:48 INFO - 'LOGNAME': 'cltbld', 05:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:48 INFO - 'MOZ_NO_REMOTE': '1', 05:59:48 INFO - 'NO_EM_RESTART': '1', 05:59:48 INFO - 'PAGER': '/bin/cat', 05:59:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:48 INFO - 'PWD': '/builds/slave/test', 05:59:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:48 INFO - 'SHELL': '/bin/bash', 05:59:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jPpAP57rg2/Listeners', 05:59:48 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 05:59:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:48 INFO - 'USER': 'cltbld', 05:59:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:48 INFO - 'XPC_FLAGS': '0x0', 05:59:48 INFO - 'XPC_SERVICE_NAME': '0', 05:59:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:59:48 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 05:59:48 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 05:59:48 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 05:59:48 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 05:59:48 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 05:59:48 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 05:59:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:59:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:59: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 05:59: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 05:59: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 05:59: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 05:59: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 05:59: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 05:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:59:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:59: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 05:59: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 05:59: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 05:59: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 05:59: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 05:59: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 05:59:52 INFO - Downloading docopt-0.6.1.tar.gz 05:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:59:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:59:52 INFO - Running setup.py install for blobuploader 05:59:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:59:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:59:52 INFO - Running setup.py install for requests 05:59:52 INFO - Running setup.py install for docopt 05:59:53 INFO - Successfully installed blobuploader requests docopt 05:59:53 INFO - Cleaning up... 05:59:53 INFO - Return code: 0 05:59:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:53 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')]} 05:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:53 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')]} 05:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:53 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 0x10d65a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0acac510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d46ed30>, '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 0x10d294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d466b20>, '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.rZOb6wmAxp/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.jPpAP57rg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 05:59:53 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 05:59:53 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 05:59:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZOb6wmAxp/Render', 05:59:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:53 INFO - 'HOME': '/Users/cltbld', 05:59:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:53 INFO - 'LOGNAME': 'cltbld', 05:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:53 INFO - 'MOZ_NO_REMOTE': '1', 05:59:53 INFO - 'NO_EM_RESTART': '1', 05:59:53 INFO - 'PAGER': '/bin/cat', 05:59:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:53 INFO - 'PWD': '/builds/slave/test', 05:59:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:53 INFO - 'SHELL': '/bin/bash', 05:59:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jPpAP57rg2/Listeners', 05:59:53 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 05:59:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:53 INFO - 'USER': 'cltbld', 05:59:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:53 INFO - 'XPC_FLAGS': '0x0', 05:59:53 INFO - 'XPC_SERVICE_NAME': '0', 05:59:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:53 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-0YCpzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:53 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-LjfCcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:53 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-dDcCNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:53 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-F9jA5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:53 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-dVBmcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:54 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-sdeEIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:54 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-wgGaxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:54 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-3IKfYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:54 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-ZQI7aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:54 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-yyxa5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:54 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-03HlX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:54 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-L0Gon5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:54 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-WG_9lO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:54 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-a7CXbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:54 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-6C8PMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:55 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-ZRCgdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:55 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-X67zYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:59:55 INFO - Running setup.py install for manifestparser 05:59:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:59:55 INFO - Running setup.py install for mozcrash 05:59:55 INFO - Running setup.py install for mozdebug 05:59:55 INFO - Running setup.py install for mozdevice 05:59:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:59:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:59:55 INFO - Running setup.py install for mozfile 05:59:55 INFO - Running setup.py install for mozhttpd 05:59:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:59:56 INFO - Running setup.py install for mozinfo 05:59:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:59:56 INFO - Running setup.py install for mozInstall 05:59:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:59:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:59:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:59:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:59:56 INFO - Running setup.py install for mozleak 05:59:56 INFO - Running setup.py install for mozlog 05:59:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:59:56 INFO - Running setup.py install for moznetwork 05:59:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:59:56 INFO - Running setup.py install for mozprocess 05:59:57 INFO - Running setup.py install for mozprofile 05:59:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:59:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:59:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:59:57 INFO - Running setup.py install for mozrunner 05:59:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:59:57 INFO - Running setup.py install for mozscreenshot 05:59:57 INFO - Running setup.py install for moztest 05:59:57 INFO - Running setup.py install for mozversion 05:59:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:59:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:59:57 INFO - Cleaning up... 05:59:57 INFO - Return code: 0 05:59:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59: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')]} 05:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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')]} 05:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:57 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 0x10d65a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0acac510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d46ed30>, '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 0x10d294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d466b20>, '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.rZOb6wmAxp/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.jPpAP57rg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 05:59:57 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 05:59:57 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 05:59:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZOb6wmAxp/Render', 05:59:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:59:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:59:57 INFO - 'HOME': '/Users/cltbld', 05:59:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:59:57 INFO - 'LOGNAME': 'cltbld', 05:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:57 INFO - 'MOZ_NO_REMOTE': '1', 05:59:57 INFO - 'NO_EM_RESTART': '1', 05:59:57 INFO - 'PAGER': '/bin/cat', 05:59:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:57 INFO - 'PWD': '/builds/slave/test', 05:59:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:59:57 INFO - 'SHELL': '/bin/bash', 05:59:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jPpAP57rg2/Listeners', 05:59:57 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 05:59:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:59:57 INFO - 'USER': 'cltbld', 05:59:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:59:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:57 INFO - 'XPC_FLAGS': '0x0', 05:59:57 INFO - 'XPC_SERVICE_NAME': '0', 05:59:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:58 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-7EOtkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:58 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)) 05:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:58 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-NY8Lc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:58 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)) 05:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:58 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-uxy3wH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:58 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)) 05:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:58 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-4dwtKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:58 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)) 05:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:58 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-rFQyuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:58 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)) 05:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:58 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-uL91uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:58 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)) 05:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:58 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-igl99f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:58 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)) 05:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:58 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-A6FoHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:58 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)) 05:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:58 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-K58FTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:59 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-LmhgG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:59 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-vA8hqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:59 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)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:59 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-U9qYUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:59 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)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:59 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-GnTzxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:59 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)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:59 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-Gkow1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:59 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)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:59 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-d8TkaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:59 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)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:59 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-toUVm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:59 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)) 05:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:59 INFO - Running setup.py (path:/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/pip-OOimGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:59 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)) 05:59:59 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)) 05:59:59 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)) 05:59:59 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)) 05:59:59 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)) 05:59:59 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)) 05:59:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:59:59 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 05:59:59 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 05:59:59 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 05:59:59 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 05:59:59 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 05:59:59 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 06:00:02 INFO - Downloading blessings-1.6.tar.gz 06:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:00:02 INFO - Installing collected packages: blessings 06:00:02 INFO - Running setup.py install for blessings 06:00:02 INFO - Successfully installed blessings 06:00:02 INFO - Cleaning up... 06:00:02 INFO - Return code: 0 06:00:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:00:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:00:03 INFO - Reading from file tmpfile_stdout 06:00:03 INFO - Current package versions: 06:00:03 INFO - blessings == 1.6 06:00:03 INFO - blobuploader == 1.2.4 06:00:03 INFO - docopt == 0.6.1 06:00:03 INFO - functools32 == 3.2.3-2 06:00:03 INFO - jsonschema == 2.5.1 06:00:03 INFO - manifestparser == 1.1 06:00:03 INFO - mozInstall == 1.12 06:00:03 INFO - mozcrash == 0.17 06:00:03 INFO - mozdebug == 0.1 06:00:03 INFO - mozdevice == 0.48 06:00:03 INFO - mozfile == 1.2 06:00:03 INFO - mozhttpd == 0.7 06:00:03 INFO - mozinfo == 0.9 06:00:03 INFO - mozleak == 0.1 06:00:03 INFO - mozlog == 3.4 06:00:03 INFO - moznetwork == 0.27 06:00:03 INFO - mozprocess == 0.23 06:00:03 INFO - mozprofile == 0.28 06:00:03 INFO - mozrunner == 6.12 06:00:03 INFO - mozscreenshot == 0.1 06:00:03 INFO - mozsystemmonitor == 0.3 06:00:03 INFO - moztest == 0.7 06:00:03 INFO - mozversion == 1.4 06:00:03 INFO - psutil == 3.1.1 06:00:03 INFO - requests == 1.2.3 06:00:03 INFO - wsgiref == 0.1.2 06:00:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:03 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 0x10d65a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0acac510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d46ed30>, '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 0x10d294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d466b20>, '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.rZOb6wmAxp/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.jPpAP57rg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 06:00:03 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 06:00:03 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 06:00:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZOb6wmAxp/Render', 06:00:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:03 INFO - 'HOME': '/Users/cltbld', 06:00:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:03 INFO - 'LOGNAME': 'cltbld', 06:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:03 INFO - 'MOZ_NO_REMOTE': '1', 06:00:03 INFO - 'NO_EM_RESTART': '1', 06:00:03 INFO - 'PAGER': '/bin/cat', 06:00:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:03 INFO - 'PWD': '/builds/slave/test', 06:00:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:03 INFO - 'SHELL': '/bin/bash', 06:00:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jPpAP57rg2/Listeners', 06:00:03 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 06:00:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:03 INFO - 'USER': 'cltbld', 06:00:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:03 INFO - 'XPC_FLAGS': '0x0', 06:00:03 INFO - 'XPC_SERVICE_NAME': '0', 06:00:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:03 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)) 06:00:03 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)) 06:00:03 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)) 06:00:03 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)) 06:00:03 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)) 06:00:03 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)) 06:00:03 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)) 06:00:03 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)) 06:00:03 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)) 06:00:03 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)) 06:00:03 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)) 06:00:03 INFO - Cleaning up... 06:00:03 INFO - Return code: 0 06:00:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:00: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')]} 06:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00: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')]} 06:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:00:03 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 0x10d65a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0acac510>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d46ed30>, '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 0x10d294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d466b20>, '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.rZOb6wmAxp/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.jPpAP57rg2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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 06:00:03 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 06:00:03 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 06:00:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZOb6wmAxp/Render', 06:00:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:03 INFO - 'HOME': '/Users/cltbld', 06:00:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:03 INFO - 'LOGNAME': 'cltbld', 06:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:03 INFO - 'MOZ_NO_REMOTE': '1', 06:00:03 INFO - 'NO_EM_RESTART': '1', 06:00:03 INFO - 'PAGER': '/bin/cat', 06:00:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:03 INFO - 'PWD': '/builds/slave/test', 06:00:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:03 INFO - 'SHELL': '/bin/bash', 06:00:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jPpAP57rg2/Listeners', 06:00:03 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 06:00:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:03 INFO - 'USER': 'cltbld', 06:00:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:03 INFO - 'XPC_FLAGS': '0x0', 06:00:03 INFO - 'XPC_SERVICE_NAME': '0', 06:00:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:00:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:00:03 INFO - Cleaning up... 06:00:03 INFO - Return code: 0 06:00:03 INFO - Running post-action listener: _resource_record_post_action 06:00:03 INFO - Running post-action listener: _start_resource_monitoring 06:00:03 INFO - Starting resource monitoring. 06:00:03 INFO - [mozharness: 2016-09-23 13:00:03.610399Z] Finished create-virtualenv step (success) 06:00:03 INFO - [mozharness: 2016-09-23 13:00:03.611419Z] Running install step. 06:00:03 INFO - Running pre-action listener: _resource_record_pre_action 06:00:03 INFO - Running main action method: install 06:00:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:00:03 INFO - Reading from file tmpfile_stdout 06:00:03 INFO - Detecting whether we're running mozinstall >=1.0... 06:00:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:00:03 INFO - Reading from file tmpfile_stdout 06:00:03 INFO - Output received: 06:00:03 INFO - Usage: mozinstall [options] installer 06:00:03 INFO - Options: 06:00:03 INFO - -h, --help show this help message and exit 06:00:03 INFO - -d DEST, --destination=DEST 06:00:03 INFO - Directory to install application into. [default: 06:00:03 INFO - "/builds/slave/test"] 06:00:03 INFO - --app=APP Application being installed. [default: firefox] 06:00:03 INFO - mkdir: /builds/slave/test/build/application 06:00:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:00:37 INFO - Reading from file tmpfile_stdout 06:00:37 INFO - Output received: 06:00:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:00:37 INFO - Running post-action listener: _resource_record_post_action 06:00:37 INFO - [mozharness: 2016-09-23 13:00:37.910618Z] Finished install step (success) 06:00:37 INFO - [mozharness: 2016-09-23 13:00:37.910783Z] Running run-tests step. 06:00:37 INFO - Running pre-action listener: _resource_record_pre_action 06:00:37 INFO - Running main action method: run_tests 06:00:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:00:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:00:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:00:37 INFO - 2016-09-23 06:00:37.925 screenresolution[1642:8172] starting screenresolution argv=screenresolution get 06:00:37 INFO - 2016-09-23 06:00:37.928 screenresolution[1642:8172] Display 0: 1600x1200x32@60 06:00:37 INFO - 2016-09-23 06:00:37.934 screenresolution[1643:8174] starting screenresolution argv=screenresolution list 06:00:37 INFO - Available Modes on Display 0 06:00:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:00:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:00:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:00:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:00:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:00:38 INFO - Intel Iris: 06:00:38 INFO - Chipset Model: Intel Iris 06:00:38 INFO - Type: GPU 06:00:38 INFO - Bus: Built-In 06:00:38 INFO - VRAM (Dynamic, Max): 1536 MB 06:00:38 INFO - Vendor: Intel (0x8086) 06:00:38 INFO - Device ID: 0x0a2e 06:00:38 INFO - Revision ID: 0x0009 06:00:38 INFO - Displays: 06:00:38 INFO - Display: 06:00:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:00:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:00:38 INFO - Display Serial Number: 1600x1200 60 06:00:38 INFO - Main Display: Yes 06:00:38 INFO - Mirror: Off 06:00:38 INFO - Online: Yes 06:00:38 INFO - Rotation: Supported 06:00:38 INFO - Return code: 0 06:00:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:00:38 INFO - Python 2.7.3 06:00:38 INFO - Return code: 0 06:00:38 INFO - grabbing minidump binary from tooltool 06:00: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')]} 06:00:38 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 0x10d46ed30>, '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 0x10d294db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d466b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:00:38 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 06:00:38 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 06:00:38 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 06:00:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:00:38 INFO - Return code: 0 06:00:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:00:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:00:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:00:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:00:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:00:38 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/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0115', '--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 06:00:38 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/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0115 --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 06:00:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rZOb6wmAxp/Render', 06:00:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:00:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:00:38 INFO - 'HOME': '/Users/cltbld', 06:00:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:00:38 INFO - 'LOGNAME': 'cltbld', 06:00:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:00:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:00:38 INFO - 'MOZ_NO_REMOTE': '1', 06:00:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:00:38 INFO - 'NO_EM_RESTART': '1', 06:00:38 INFO - 'PAGER': '/bin/cat', 06:00:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:00:38 INFO - 'PWD': '/builds/slave/test', 06:00:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:00:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:00:38 INFO - 'SHELL': '/bin/bash', 06:00:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jPpAP57rg2/Listeners', 06:00:38 INFO - 'TMPDIR': '/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/', 06:00:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:00:38 INFO - 'USER': 'cltbld', 06:00:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:00:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:00:38 INFO - 'XPC_FLAGS': '0x0', 06:00:38 INFO - 'XPC_SERVICE_NAME': '0', 06:00:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:00:38 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/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0115', '--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 06:00:38 INFO - mozversion application_buildid: 20160923035101 06:00:38 INFO - mozversion application_changeset: 60cc643978c7020926fe4145761e26945fcd5c37 06:00:38 INFO - mozversion application_display_name: Nightly 06:00:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:00:38 INFO - mozversion application_name: Firefox 06:00:38 INFO - mozversion application_remotingname: firefox 06:00:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:00:38 INFO - mozversion application_vendor: Mozilla 06:00:38 INFO - mozversion application_version: 52.0a1 06:00:38 INFO - mozversion platform_buildid: 20160923035101 06:00:38 INFO - mozversion platform_changeset: 60cc643978c7020926fe4145761e26945fcd5c37 06:00:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:00:38 INFO - mozversion platform_version: 52.0a1 06:00:38 INFO - using testdate: 1474635638 06:00:38 INFO - actual date: 1474635638 06:00:38 INFO - starting webserver on 'localhost:49271' 06:00:38 INFO - SUITE-START | Running 2 tests 06:00:38 INFO - TEST-START | dromaeo_css 06:00:38 INFO - operating with platform_type : mac_ 06:00:38 INFO - Initialising browser for dromaeo_css test... 06:00:38 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmp8AR6La/profile http://localhost:49271/getInfo.html) 06:00:40 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 06:00:40 INFO - PROCESS | 1653 | colorDepth:24 06:00:40 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 06:00:40 INFO - PROCESS | 1653 | __metrics 06:00:40 INFO - PROCESS | 1653 | 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" 06:00:40 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:00:41 INFO - TEST-INFO | 1653: exit 0 06:00:41 INFO - Browser initialized. 06:00:41 INFO - Running cycle 1/1 for dromaeo_css test... 06:00:41 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmp8AR6La/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:53 INFO - PROCESS | 1656 | RSS: Main: 235483136 06:00:53 INFO - PROCESS | 1656 | 06:01:45 INFO - PROCESS | 1656 | 1474635705007 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] 06:03:56 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 06:03:58 INFO - PROCESS | 1656 | RSS: Main: 409788416 06:03:58 INFO - PROCESS | 1656 | 06:07:01 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 06:07:02 INFO - PROCESS | 1656 | RSS: Main: 370610176 06:07:02 INFO - PROCESS | 1656 | 06:10:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 06:10:05 INFO - PROCESS | 1656 | RSS: Main: 334471168 06:10:05 INFO - PROCESS | 1656 | 06:13:07 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 06:13:08 INFO - PROCESS | 1656 | RSS: Main: 328159232 06:13:08 INFO - PROCESS | 1656 | 06:16:11 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 06:16:12 INFO - PROCESS | 1656 | RSS: Main: 325894144 06:16:12 INFO - PROCESS | 1656 | 06:19:15 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 06:19:16 INFO - PROCESS | 1656 | RSS: Main: 480821248 06:19:16 INFO - PROCESS | 1656 | 06:19:16 INFO - PROCESS | 1656 | __start_tp_report 06:19:16 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 06:19:16 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 06:19:16 INFO - PROCESS | 1656 | |i|pagename|runs| 06:19:16 INFO - PROCESS | 1656 | |0;dojo.html;3224.983875080625;3240.2871368298975;3260.7717459777796;3272.885449009282;3313.5526703894966;5385.138377859544;5432.565394768419;5497.285352904127;5497.780088796449;5500.807471738485;5480.7533660985255;5538;5539.169124631308;5553.333599968009;5587.106063029916;4125.855595054174;4986;5004.424491183506;5028.723420211887;5037.722925239111;5076.695398276115;5111.1566591512355;5148.2020286855595;5154.690718556899;5216.321878155834;5109.335786347751;5112.514311140436;5115.437301896788;5148.922766158511;5200;4959.603231741452;5021.748912554358;5038.143515602356;5077.5684066854365;5088.1350170471105;5007.123753343187;5039.72281524516;5044.722540260284;5074.467180945984;5085.288059671649;5491.890162196733;5521.558275337963;5534.972325138348;5545;5556.055470569972;5967.254093238345;5971.61184523009;5973.1936188614845;5975.641461512279;5989.431004054608;6069.211002569682;6073.908891366633;6075.574709770318;6080.695965201767;6093.634381937098;5489.286392768954;5542.334919809648;5566.359868615161;5619.550435965113;5654.123610840285;6160.414760597736;6176.382361763787;6177.351378105324;6181.165542651775;6192.133101365813;4774.761261936958;5743.6266642668925;5772.220750198753;5900.4984576310635;5916.970415147983;5954.523638108941;6003.489703375175;6031.849203769941;6125.479334256549;6129.172561704113;5985.40145985398;5985.551083668743;6021.397860213943;6030.819075427744;6057.787977420858;5826.126081087786;6022.1870047543025;6037.6679282639;6046.972014757502;6063.060225665029;4741.881452963704;4758.238681810963;4788.401449818773;4811.735354555463;4814.277858321209;4297.011687311936;4315.180115777992;4321.567843215653;4336.3278691802825;4364.716293440916;4675.345451636774;5549.750261238173;5559.805406810742;5575.498205161555;5578.832635020955;5908.763649454059;5989.131575921554;5994.670293133832;6037.396260373927;6118.510519158456;5550.91673624896;5576.553875689935;5597.496225339658;5604.887902242014;5647.37878833328;5227.686338819683;5239.187925871496;5239.607029472729;5247.055530004636;5254.238135470336;6090.878182436415;6110.072772100023;6193;6210.782622608187;6212.72042758077;5903.970480147572;5931.6441013539325;5968.253968253968;5989.610675306091;6072.453479186895;6112.564273424362;6134.384052390125;6167;6168.660723660242;6170.629762214281;5291.576673866004;5786.450287222707;5819.6508209507565;5868.94131058684;5904.704764761659;5879.911801322898;5964.612300200473;5976.043832986701;6064.545159112996;6083.148359229623;5793.507551858139;5804.216430781959;5820.010598198402;5835.79574714883;5931.377205393372;5074.629849940569;5668.858278543069;5864.091065884794;5873.823785286449;5878.030125029322;5674.177244299636;5740.282464691913;5740.684262365443;5745.683987380734;5748.080307150836;4752.500987396274;4799;5706.400827913176;5771.192033115283;5772.9711351442975;5387.676739395492;5408.59435542328;5575.9163612545035;5610.214569960127;5705.828825135252 06:19:16 INFO - PROCESS | 1656 | |1;ext.html;439.8570464599005;464.0324922536511;468.18769435030214;522.7725939216443;523.6753213007936;30857.845710771442;32297;32321.191970200758;32493.837530812343;39652.405213921746;31124.53313200304;43388.56611433885;43406.13187736244;43474.13051738971;43618.36678581243;8358.289545388649;9672.08115229052;9765.023497650214;9826.410415375065;9831.115199632031;8707.695230666928;8938.597763100675;9603.4718090505;9741.512924353789;11767.352795596238;11785.587504437346;12010.0992425568;12010.159288849783;12037.458314375874;12230.205036672587;11967.58113466029;12024.639260822189;12027.759444811054;12052.698682532962;12060.336681482515;11906.46420911061;11970.281783092954;12007.3395963222;12015.519379224821;12020.69948251292;40523.59476405228;40763.184736305106;40839.59160408388;40895.59104408947;40923.7953810232;2982.7017298270216;3264.5103234514777;3285.655006224336;3465.8960231193105;3503.019154636706;23447.648285275736;29069.70930290691;29380.55929161043;31370.05889823309;31672.841635791672;3116.781825272232;3206.3587282543353;3258.85335159916;3344.7491438142238;3374.4263475209273;476717;481072;481251;484540;493224.5338773319;32879.506807397906;33637;59756.40243597596;60180.699096505115;60219.69890150521;34481;34690.30619387598;34694.82652586771;34701.65298347035;34705.82647086799;14211.715765684628;14356.282185890872;14360.425582976774;14362.994590378783;14369.712605747827;12195.939020304842;12287.324197169242;12287.815682764765;12294.569690060805;12295.938520307342;7093.467989900778;7211.278872112747;7219.855602887913;7583.886241706379;7630.236976302325;2940.941181176407;3162.6204855417495;3261.836908154583;3263.4009335425944;3292.3909076820864;841.3143288220081;844.0715213265358;872.925801306896;944.5041353289578;974.8927617962019;22854.542909141725;28215.57676634852;28481.857590712327;28904.132876013755;28978.7102128976;1056.4031322302874;1081.8269076947652;1082.6697857153486;1088.3469918049107;1104.3539529375246;13028.674283142807;14612.780808287884;14672.119672819665;14778;14933.477328293458;670715;676136;676995;677064;679568;48663.756681216364;48965;55632.16551751727;57625.55936101547;58088.70955645279;1329.2622594460167;1364.4746772492663;1379.8965077619018;1382.6819831438825;1384.5154196031308;23251.76748232564;30086.849565752906;30927.84536077305;31774;32552.51171232386;55914.72042639761;56593.43406565882;56674.7166264166;56777.432225678866;56812.715936420056;455069;460795.69602151774;460827;460936;461444;39939;40515.79742101271;40861.38707919443;40910.386344204264;41330.52016878997;45375.319370210134;46236.220472440946;46459.53540464552;46611.53388466072;46838.76580617075;36922;37738;37802.810985944896;38469.6153038466;38917.80541097277;37082.88751337464;37379;38667.419988700756;39157.8042109799;39569.812905612875;32369.35261294714;35900.281994359444;36845.63154368529;37197.25605487929;37642.623573763914;32200.838995804872;33745.83127084349;33751.66248337485;33914.49128263127;33936;24619.63070553979;24713.629295560942;24882.253532393333;25481.617775733008;25522.744772552036 06:19:16 INFO - PROCESS | 1656 | |2;jquery.html;352.5980382364107;371.5318698439967;375.0904057660174;384.4886301219378;406.076176698012;15208.467703630362;15519.456819011337;17377.56556086097;20699.06854191561;21155;19904.70142947857;20348;20618.793812061875;20890.373288801362;21169.68245476315;5998.730057147439;6049.758009679618;6212;6221.720022598971;6262.248530176385;6077.513798896078;6156.5998210116195;6212.78255261066;6215.968920155393;6227.190465239535;4200.243956087903;4407.008423104808;5321.8403447896435;6935.930640693604;6977.89533157003;6841.315868413169;6910.861782764342;7005.159380874276;7019.684114214872;7026.789196324118;6106.572539922207;6109.877802443926;6120.969395152996;6123.112148738408;6125.050617154348;27460.313492162655;27491.725082749115;27900.441991160267;27937.16188514348;28290.575641365394;2183.9344819655435;2191.7589065202815;2234.3297010896667;2258.031000925184;2317.721873375189;13589.388477518536;15299.464518741903;16266.918665406716;16500.504984850475;16647.583810404714;1864.1518109260253;1869.9252029918787;1946.980530194694;1950.1711772496633;1964.2339487599847;122075;135199.97200042006;135854.58399364093;136496;139434.3028284852;10784.299020563638;10900.40047797363;11021.008109270204;11453.427328633536;11586.826197607043;13816.861831381759;13944.30278486092;14233.074850134708;14303.713925721635;14351.641208969859;8598.39811213209;8751.081136480705;8775.912240877637;8788.121187881161;8922.375433719577;8764.079771624016;8786.02314479237;8789.604467798965;8959.372843900865;8980.46117232968;6840.3501667341525;6847.175343073305;6912.965435172892;6927.099477067949;7067.717291308393;1601.9519414417352;1827.2964908510053;1878.9060546972596;1900.363378268268;1917.4343568647282;780.8711562592109;853.4665833853842;916.6910028658979;950.7718147644515;991.4200192887241;21498.57002859934;22407.439814004454;23366.7663323368;23483.70839603804;23594.29217123489;893.6068130022769;965.7295957132014;979.345972414764;989.50030234731;1000.9340052843698;10984.121270298358;11272.027395205807;11343.881993307781;11498.310101393943;11513.424328783527;561374;575253;584619.0769046127;589136;593583;134778.32610836884;135303.32348338392;136639.31680341534;137710;140631;971;1015.4516561056946;1045.153425725165;1046.1630695443766;1047.0105750066114;18978.620427591093;19156.61686766229;19305.51736206606;19388.903055484632;19459.8054019458;39361.40957885577;49495.50504494909;58395.832083358946;58958.70520647369;59349.406505934385;69423.30576694169;70044.6497767508;79494;81412.59293703493;84118.57940710257;11169;11245.437728113398;12165.391730413266;12535.749285014066;12812.487500499876;8596.699115530926;13214.942804575803;13820.585382438543;14069.859301406856;14121.717565648423;10335.689929302132;11398;11560.884391156318;11732.002779763474;12246.693832654255;11607.76784464289;11860.466279017292;11926.940365298466;12143.332116733665;12245.020398368288;10775.676729698122;10995.230333876552;11666.358350290477;12114.394280286127;12275.69310767238;12135.817962730744;12233.816492752794;12339.321337326533;12342.729176767984;12370.381480925738;11678.6496405108;11725.530978760755;11977.760444791229;12025.63923082309;12065.939670301592 06:19:16 INFO - PROCESS | 1656 | |3;mootools.html;1530.18899983009;1552.666176771994;1781.4388467632696;1919.7600299962505;1930.4884205685487;7558.811029724246;8429.66281348746;8926;8932.59803308851;8940.73177804666;7826.295633392993;8103.351731861451;8387.203215694499;8643.611037503311;8646.308295336374;2183.727034120739;2371.454565449939;2376.8692721900375;2377.1204654277853;2379.167291447988;2034.8372130229545;2334.7781960713705;2342.1919437793936;2345.7536958619357;2376.821738369629;2344.812415006795;2359.23324919401;2367.775061369176;2379.2505360811288;2384.95230095398;1931.6040211756626;2341.356127065054;2351.576716191085;2353.423411264234;2358.8230882683697;2339.847909885852;2345.495718420531;2351.482673811776;2352.094443639211;2354.9411264718347;8768.254698350584;8792.648294068229;8915.643374265022;8916.554172291424;8928.776780580472;4800.735959522225;5312.946870531323;5321.574274058066;5333.333333333333;5334.119870221409;3472.28818092293;3559.2169722660974;3673.522442082512;3686.5391826021746;3691;1051.1380667852363;1083.7615724540588;1090.6019302954444;1105.2649987758132;1106.4799544214206;11478.139139564566;11581.131415143898;11600.709982250426;11608.709782255426;11642.417879106011;4433;4539.591436770706;4710.411198600175;4736.218523943511;4744.525547445297;9776.608935642495;9779.951100244596;9780.266480013885;9781.804363912825;9785.972472890386;5264.473552644705;5297;5299.311089558333;5299.364076310867;5301.708406037705;4390.8902277442685;4476.619487343547;4566.13243483737;4877.707337559757;4899.902001959941;3767.604401537854;3801.334766415866;3866.96133038666;3907.7069219808627;3911.5697273299916;1246.8067449545335;1249.419020155614;1251.7183633682348;1264.7849865522883;1270.6124631987147;839.5634270179472;847.737201467547;896.2158111652304;896.6682327538722;919.5448253114618;5591.3569939456665;5796.710164491758;5834.504067154339;5906.497947674496;5974.641521508724;920.5213289089636;926.0878035135386;930.2976252928995;945.1682519382899;970.5292932927524;3812.218495208476;3973.2848087344555;3974.1654252607277;4078.8164532596106;4128.91742165155;9856.50717464124;10480.109190718722;10540.262181647211;10608.522616482276;10617.416042117758;10191.235657325582;10429;10443.477826108816;10605.681829545127;10613.469326533643;7839.843203135905;8055.154208808108;8068.394870384627;8128.309093726981;8152.673893044212;5094.388673359221;5734.971325143348;5824.854378640398;5909.881802363842;6039.667818270037;8126.715564955198;9642.71071867845;9862.950685246527;9897.604095836086;9948.054934781185;8821.2060914518;9105.226055785068;9939.254555908192;10021.699349019542;10151.94924025375;7252.709891604277;7397.8150546236775;7491.513051651626;7506.211847755907;7613.010308659839;8292;8307.6676932922;8379.916200838157;8388.832223355377;8397.992240931128;7281.5631062136445;7361;7482.625868706652;7551.546907185587;7613.733519326797;6056.757729690763;7247.420206383371;7289.271072892669;7298.4526160539235;7400.888986665312;6761.695723692347;6774.559653622498;6830.282820303995;6832.555883867532;6838.14523184602;3758.567764707094;4873.1959226727195;4950.702957822542;4974.427940786856;5090.643654944119;4253.3832594273035;4613.953860461353;4888.486708895657;4902.975485122552;5050.217216331474 06:19:16 INFO - PROCESS | 1656 | |4;prototype.html;296.96881827408123;299.266796348945;306.54784193314856;311.67430035612784;313.9089663997441;4489.124620698965;4972.87567810804;5191.19536471847;5222.268882356473;5268.31511903453;4344.63070638996;5075.746212689369;5117.411497677759;5150.896982060356;5193.1171700810955;3622.8625111184397;3680.7607505512124;3762.341590221714;3958.188571342868;3981.243563722883;2840.460312540621;3987.541432735229;4017.718759686823;4031.1983171695683;4038.3952350733757;3214.698047290851;3796.4874741909766;3897.9805100974454;3922.921541569181;3972.09339517032;3186.9681303186903;3554.382755846084;3633.2370202257557;3684.410494320896;3921.607839216084;3212.213007813077;3411.5053317269103;3424.4692072728767;3427.280271143063;3443.517907492953;4717.504662010474;4959.900801983977;4976.377952755905;4982.825601103944;5072.315237442935;4418.072204836988;4430.712003719748;4439.911201775979;4453.53237910018;4461.665375096881;4483.551644835523;4674.672772905898;5409.6213265071465;5412.859162740507;5413.729313534347;3067.6165479315086;3676.3015027144756;3690.3910854708943;3697.796621185834;3704.148045949447;4870.902581948377;4871.4154301483695;5573.470520300565;5621;5671.908809698724;3332.783369081002;3627.8186090695885;3762.097096696773;3767.095896984759;3821.6687820429515;3664.2121943782213;3797.7721336719887;3833.2333533292895;3849.711271654637;3895.2014836958356;3964.960350396517;4124.948138224733;4131.772752498581;4184.790760461965;4482.901689086129;5416.348013855733;5426.457354264542;5451.454854514596;5533.170024496358;5593.776248950077;920.7559996600907;1204.4700331853956;1218.0986070308086;1221.1879100398135;1283.3198404845448;858.013284722574;869.6825658634552;879.564615515324;885.3359980014989;886.0430734806394;4712.69367491112;5050.722210278396;5068.59451243907;5073.315102461121;5098.97450512745;4356.607905288539;5489.917651235235;5491.862703432366;5497.5601951843755;5509.724513774296;4405.3612226227015;4558.316252562142;5076.334924164843;5099.719515426613;5102.719350435762;2047.764507081675;2055.1573854719495;2120.0283736125243;2387.594109001474;2467.642191882167;3733.434569985657;3963.544192417909;4803.447603525569;4806.95193048072;4930.457649658535;3850.09420336935;4253.511271055106;4706.694064885772;4730.2431610942085;4757.905681693161;4166.66666666666;4497.527759585197;4683.9063218734755;4766.4280286365165;4870.853874383774;3988.90027749297;4164.75011499311;4629;4633.822103611297;4650.441946966385;3963.3262345400776;3963.6630886374983;4547.681662283609;4577.924187815927;4670.719756814602;4116.567760385116;4187.797902764538;4453.866384008485;4503.1537069801225;4779.856604301876;2901.3036871151194;2901.8247609718096;3247.9837600811843;3258.837058147036;3277.3445310938387;3884.902877428087;4726.26742854858;4751.762411879323;4841.322214889989;5111.539961403491;4687.226607609706;4786.827227329327;4847.079054979543;4976.676516026447;5076.121834921103;4993.5755460784785;5085.694858308513;5142.434332223377;5189.429162792166;5522.30971128609;4620.445546534437;4781.680884770953;5045.5459008689395;5447.622474065946;5457.6179667424485;5464.535514481314;5473.67157970523;5481.287432633732;5482.39693633708;5503.504684578407;4635.7218566886095;5348.652337598043;5360.41035486104;5372.516473517402;5423.322084739408 06:19:16 INFO - PROCESS | 1656 | |5;yui.html;710.733474946895;733.6038539188838;760.6767123972311;808.3573559020585;836.1554829622082;15304.387824487021;15541.989770664899;16023.519294421158;16055.59861003474;16381.508554743377;14025.719485610281;14032.929835350835;14047.36786844592;14216.502422415217;14346.139231646108;679.8096532970776;691.2810676896047;696.1055044268116;835.1982097186708;850.9531975741347;852.1052894460822;863.4171933944593;866.57537806475;867.657275376226;870.6125774030559;915.7573243090586;917.4678686361927;917.7659696777346;918.3433844800966;918.5774543709902;704.8484575816173;716.6380977606327;910.1853840812436;911.6444586611227;914.2822884036033;672.5124284893462;682.2324884504932;682.576802382526;686.3273991488369;687.60806340386;14388.424463021467;14417.711645767025;14436.206008669518;14440.205788681618;14474.565763027125;12092.939535302266;12232.003159225958;12281.508739650404;12462;12722.982161427064;12217.633470995885;12298.323592202425;12320.691982700415;12362.134650574464;12584.74830503394;4321.654267658611;4423.203823311803;4504.414426124583;4542.364069030338;4589.1968905441745;111154.44422777915;116987.83012169854;117360;117753.41123294414;118176.99999999914;8285.544295063708;10257.769067711923;10374.688759337232;10529.36823790575;10530.31552949056;19993.400197994084;20667.379978600366;20876.686849697267;20882.47793805167;20890.47773805667;7640.274173953466;7746.612669366509;7759.107702614158;7805.180456052146;7806.297433231037;4278.978605107017;4289.442372491556;4315.676324275629;4338.652907767371;4421.226285400042;2978.9851050744605;3392.4402473592077;3510.754247202671;3511.631278715749;3521.2253304273017;594.9762009519658;652.5823472977204;662.8110988368292;673.5049738442241;681.1689738518999;592.6118392452864;621.9813405597839;626.6490765171427;628.3119983617931;637.1716768201412;8700.434471759441;8954.373193876367;9005.755110140875;9149;9228.446293222429;571.5199232644599;599.1731410653358;617.7683368736724;626.7618305044055;644.9355064493607;3782.6973842092566;4078.57174996627;4219.852305169305;4226.598473145046;4281.250781113293;134571;147770;167715;169506.15246923687;173631.55973943608;97694;100257.49871250743;101114.49442752739;103389.48305258575;148700.2564987168;97462;99369.50315248377;113651.86348136578;115310.12693032593;117832.41083794527;9473.52632368365;9676;9875.950620246853;9924.40453572788;9944.850827237742;54868.90262194654;58966.70516647389;62300.37699623127;63476;64272.67863660652;82606;88876;93321.60017599606;96702;98014.0198598005;12767.680807979876;12949.611511654666;13067.607971760863;13090.934545327213;13307.001974851732;14329.355179017179;14562.708745825235;14756.33596488182;14790.704185916436;14865;13415.463381464631;13783.173009619455;13940.024198306426;13961;14275.928620356832;13467.932660336635;13515.12151710175;13620.65948351299;13781.104228225535;14038.922155688622;12998.350082495648;13273.33633318311;13639.727205456034;13787.67733807408;14051.016428849882;10684.89315106839;11223.66329010131;11271.323720576791;11368.431578421212;11663.300201987908;10373.896261037293;11203.439828008404;11431.828522572001;11567.421628918688;11570.595029174276 06:19:16 INFO - PROCESS | 1656 | __end_tp_report 06:19:16 INFO - PROCESS | 1656 | __start_cc_report 06:19:16 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1664 06:19:16 INFO - PROCESS | 1656 | __end_cc_report 06:19:16 INFO - PROCESS | 1656 | __startTimestamp1474636756037__endTimestamp 06:19:16 INFO - PROCESS | 1656 | 06:19:16 INFO - PROCESS | 1656 | ------- Summary: start ------- 06:19:16 INFO - PROCESS | 1656 | Number of tests: 6 06:19:16 INFO - PROCESS | 1656 | 06:19:16 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5514.71 Median:5647.38 stddev:622.15 (11.0%) stddev-sans-first:597.56 06:19:16 INFO - PROCESS | 1656 | Values: 3225.0 3240.3 3260.8 3272.9 3313.6 5385.1 5432.6 5497.3 5497.8 5500.8 5480.8 5538.0 5539.2 5553.3 5587.1 4125.9 4986.0 5004.4 5028.7 5037.7 5076.7 5111.2 5148.2 5154.7 5216.3 5109.3 5112.5 5115.4 5148.9 5200.0 4959.6 5021.7 5038.1 5077.6 5088.1 5007.1 5039.7 5044.7 5074.5 5085.3 5491.9 5521.6 5535.0 5545.0 5556.1 5967.3 5971.6 5973.2 5975.6 5989.4 6069.2 6073.9 6075.6 6080.7 6093.6 5489.3 5542.3 5566.4 5619.6 5654.1 6160.4 6176.4 6177.4 6181.2 6192.1 4774.8 5743.6 5772.2 5900.5 5917.0 5954.5 6003.5 6031.8 6125.5 6129.2 5985.4 5985.6 6021.4 6030.8 6057.8 5826.1 6022.2 6037.7 6047.0 6063.1 4741.9 4758.2 4788.4 4811.7 4814.3 4297.0 4315.2 4321.6 4336.3 4364.7 4675.3 5549.8 5559.8 5575.5 5578.8 5908.8 5989.1 5994.7 6037.4 6118.5 5550.9 5576.6 5597.5 5604.9 5647.4 5227.7 5239.2 5239.6 5247.1 5254.2 6090.9 6110.1 6193.0 6210.8 6212.7 5904.0 5931.6 5968.3 5989.6 6072.5 6112.6 6134.4 6167.0 6168.7 6170.6 5291.6 5786.5 5819.7 5868.9 5904.7 5879.9 5964.6 5976.0 6064.5 6083.1 5793.5 5804.2 5820.0 5835.8 5931.4 5074.6 5668.9 5864.1 5873.8 5878.0 5674.2 5740.3 5740.7 5745.7 5748.1 4752.5 4799.0 5706.4 5771.2 5773.0 5387.7 5408.6 5575.9 5610.2 5705.8 06:19:16 INFO - PROCESS | 1656 | 06:19:16 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:66395.04 Median:34698.24 stddev:146798.49 (423.1%) stddev-sans-first:147126.77 06:19:16 INFO - PROCESS | 1656 | Values: 439.9 464.0 468.2 522.8 523.7 30857.8 32297.0 32321.2 32493.8 39652.4 31124.5 43388.6 43406.1 43474.1 43618.4 8358.3 9672.1 9765.0 9826.4 9831.1 8707.7 8938.6 9603.5 9741.5 11767.4 11785.6 12010.1 12010.2 12037.5 12230.2 11967.6 12024.6 12027.8 12052.7 12060.3 11906.5 11970.3 12007.3 12015.5 12020.7 40523.6 40763.2 40839.6 40895.6 40923.8 2982.7 3264.5 3285.7 3465.9 3503.0 23447.6 29069.7 29380.6 31370.1 31672.8 3116.8 3206.4 3258.9 3344.7 3374.4 476717.0 481072.0 481251.0 484540.0 493224.5 32879.5 33637.0 59756.4 60180.7 60219.7 34481.0 34690.3 34694.8 34701.7 34705.8 14211.7 14356.3 14360.4 14363.0 14369.7 12195.9 12287.3 12287.8 12294.6 12295.9 7093.5 7211.3 7219.9 7583.9 7630.2 2940.9 3162.6 3261.8 3263.4 3292.4 841.3 844.1 872.9 944.5 974.9 22854.5 28215.6 28481.9 28904.1 28978.7 1056.4 1081.8 1082.7 1088.3 1104.4 13028.7 14612.8 14672.1 14778.0 14933.5 670715.0 676136.0 676995.0 677064.0 679568.0 48663.8 48965.0 55632.2 57625.6 58088.7 1329.3 1364.5 1379.9 1382.7 1384.5 23251.8 30086.8 30927.8 31774.0 32552.5 55914.7 56593.4 56674.7 56777.4 56812.7 455069.0 460795.7 460827.0 460936.0 461444.0 39939.0 40515.8 40861.4 40910.4 41330.5 45375.3 46236.2 46459.5 46611.5 46838.8 36922.0 37738.0 37802.8 38469.6 38917.8 37082.9 37379.0 38667.4 39157.8 39569.8 32369.4 35900.3 36845.6 37197.3 37642.6 32200.8 33745.8 33751.7 33914.5 33936.0 24619.6 24713.6 24882.3 25481.6 25522.7 06:19:16 INFO - PROCESS | 1656 | 06:19:16 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:35863.43 Median:20794.72 stddev:97631.97 (469.5%) stddev-sans-first:97869.45 06:19:16 INFO - PROCESS | 1656 | Values: 352.6 371.5 375.1 384.5 406.1 15208.5 15519.5 17377.6 20699.1 21155.0 19904.7 20348.0 20618.8 20890.4 21169.7 5998.7 6049.8 6212.0 6221.7 6262.2 6077.5 6156.6 6212.8 6216.0 6227.2 4200.2 4407.0 5321.8 6935.9 6977.9 6841.3 6910.9 7005.2 7019.7 7026.8 6106.6 6109.9 6121.0 6123.1 6125.1 27460.3 27491.7 27900.4 27937.2 28290.6 2183.9 2191.8 2234.3 2258.0 2317.7 13589.4 15299.5 16266.9 16500.5 16647.6 1864.2 1869.9 1947.0 1950.2 1964.2 122075.0 135200.0 135854.6 136496.0 139434.3 10784.3 10900.4 11021.0 11453.4 11586.8 13816.9 13944.3 14233.1 14303.7 14351.6 8598.4 8751.1 8775.9 8788.1 8922.4 8764.1 8786.0 8789.6 8959.4 8980.5 6840.4 6847.2 6913.0 6927.1 7067.7 1602.0 1827.3 1878.9 1900.4 1917.4 780.9 853.5 916.7 950.8 991.4 21498.6 22407.4 23366.8 23483.7 23594.3 893.6 965.7 979.3 989.5 1000.9 10984.1 11272.0 11343.9 11498.3 11513.4 561374.0 575253.0 584619.1 589136.0 593583.0 134778.3 135303.3 136639.3 137710.0 140631.0 971.0 1015.5 1045.2 1046.2 1047.0 18978.6 19156.6 19305.5 19388.9 19459.8 39361.4 49495.5 58395.8 58958.7 59349.4 69423.3 70044.6 79494.0 81412.6 84118.6 11169.0 11245.4 12165.4 12535.7 12812.5 8596.7 13214.9 13820.6 14069.9 14121.7 10335.7 11398.0 11560.9 11732.0 12246.7 11607.8 11860.5 11926.9 12143.3 12245.0 10775.7 10995.2 11666.4 12114.4 12275.7 12135.8 12233.8 12339.3 12342.7 12370.4 11678.6 11725.5 11977.8 12025.6 12065.9 06:19:16 INFO - PROCESS | 1656 | 06:19:16 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5612.24 Median:5070.43 stddev:3124.45 (61.6%) stddev-sans-first:3118.16 06:19:16 INFO - PROCESS | 1656 | Values: 1530.2 1552.7 1781.4 1919.8 1930.5 7558.8 8429.7 8926.0 8932.6 8940.7 7826.3 8103.4 8387.2 8643.6 8646.3 2183.7 2371.5 2376.9 2377.1 2379.2 2034.8 2334.8 2342.2 2345.8 2376.8 2344.8 2359.2 2367.8 2379.3 2385.0 1931.6 2341.4 2351.6 2353.4 2358.8 2339.8 2345.5 2351.5 2352.1 2354.9 8768.3 8792.6 8915.6 8916.6 8928.8 4800.7 5312.9 5321.6 5333.3 5334.1 3472.3 3559.2 3673.5 3686.5 3691.0 1051.1 1083.8 1090.6 1105.3 1106.5 11478.1 11581.1 11600.7 11608.7 11642.4 4433.0 4539.6 4710.4 4736.2 4744.5 9776.6 9780.0 9780.3 9781.8 9786.0 5264.5 5297.0 5299.3 5299.4 5301.7 4390.9 4476.6 4566.1 4877.7 4899.9 3767.6 3801.3 3867.0 3907.7 3911.6 1246.8 1249.4 1251.7 1264.8 1270.6 839.6 847.7 896.2 896.7 919.5 5591.4 5796.7 5834.5 5906.5 5974.6 920.5 926.1 930.3 945.2 970.5 3812.2 3973.3 3974.2 4078.8 4128.9 9856.5 10480.1 10540.3 10608.5 10617.4 10191.2 10429.0 10443.5 10605.7 10613.5 7839.8 8055.2 8068.4 8128.3 8152.7 5094.4 5735.0 5824.9 5909.9 6039.7 8126.7 9642.7 9863.0 9897.6 9948.1 8821.2 9105.2 9939.3 10021.7 10151.9 7252.7 7397.8 7491.5 7506.2 7613.0 8292.0 8307.7 8379.9 8388.8 8398.0 7281.6 7361.0 7482.6 7551.5 7613.7 6056.8 7247.4 7289.3 7298.5 7400.9 6761.7 6774.6 6830.3 6832.6 6838.1 3758.6 4873.2 4950.7 4974.4 5090.6 4253.4 4614.0 4888.5 4903.0 5050.2 06:19:16 INFO - PROCESS | 1656 | 06:19:16 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4133.07 Median:4568.12 stddev:1278.81 (28.0%) stddev-sans-first:1249.57 06:19:16 INFO - PROCESS | 1656 | Values: 297.0 299.3 306.5 311.7 313.9 4489.1 4972.9 5191.2 5222.3 5268.3 4344.6 5075.7 5117.4 5150.9 5193.1 3622.9 3680.8 3762.3 3958.2 3981.2 2840.5 3987.5 4017.7 4031.2 4038.4 3214.7 3796.5 3898.0 3922.9 3972.1 3187.0 3554.4 3633.2 3684.4 3921.6 3212.2 3411.5 3424.5 3427.3 3443.5 4717.5 4959.9 4976.4 4982.8 5072.3 4418.1 4430.7 4439.9 4453.5 4461.7 4483.6 4674.7 5409.6 5412.9 5413.7 3067.6 3676.3 3690.4 3697.8 3704.1 4870.9 4871.4 5573.5 5621.0 5671.9 3332.8 3627.8 3762.1 3767.1 3821.7 3664.2 3797.8 3833.2 3849.7 3895.2 3965.0 4124.9 4131.8 4184.8 4482.9 5416.3 5426.5 5451.5 5533.2 5593.8 920.8 1204.5 1218.1 1221.2 1283.3 858.0 869.7 879.6 885.3 886.0 4712.7 5050.7 5068.6 5073.3 5099.0 4356.6 5489.9 5491.9 5497.6 5509.7 4405.4 4558.3 5076.3 5099.7 5102.7 2047.8 2055.2 2120.0 2387.6 2467.6 3733.4 3963.5 4803.4 4807.0 4930.5 3850.1 4253.5 4706.7 4730.2 4757.9 4166.7 4497.5 4683.9 4766.4 4870.9 3988.9 4164.8 4629.0 4633.8 4650.4 3963.3 3963.7 4547.7 4577.9 4670.7 4116.6 4187.8 4453.9 4503.2 4779.9 2901.3 2901.8 3248.0 3258.8 3277.3 3884.9 4726.3 4751.8 4841.3 5111.5 4687.2 4786.8 4847.1 4976.7 5076.1 4993.6 5085.7 5142.4 5189.4 5522.3 4620.4 4781.7 5045.5 5447.6 5457.6 5464.5 5473.7 5481.3 5482.4 5503.5 4635.7 5348.7 5360.4 5372.5 5423.3 06:19:16 INFO - PROCESS | 1656 | 06:19:16 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:24644.08 Median:3651.96 stddev:39783.61 (1089.4%) stddev-sans-first:39854.63 06:19:16 INFO - PROCESS | 1656 | Values: 710.7 733.6 760.7 808.4 836.2 15304.4 15542.0 16023.5 16055.6 16381.5 14025.7 14032.9 14047.4 14216.5 14346.1 679.8 691.3 696.1 835.2 851.0 852.1 863.4 866.6 867.7 870.6 915.8 917.5 917.8 918.3 918.6 704.8 716.6 910.2 911.6 914.3 672.5 682.2 682.6 686.3 687.6 14388.4 14417.7 14436.2 14440.2 14474.6 12092.9 12232.0 12281.5 12462.0 12723.0 12217.6 12298.3 12320.7 12362.1 12584.7 4321.7 4423.2 4504.4 4542.4 4589.2 111154.4 116987.8 117360.0 117753.4 118177.0 8285.5 10257.8 10374.7 10529.4 10530.3 19993.4 20667.4 20876.7 20882.5 20890.5 7640.3 7746.6 7759.1 7805.2 7806.3 4279.0 4289.4 4315.7 4338.7 4421.2 2979.0 3392.4 3510.8 3511.6 3521.2 595.0 652.6 662.8 673.5 681.2 592.6 622.0 626.6 628.3 637.2 8700.4 8954.4 9005.8 9149.0 9228.4 571.5 599.2 617.8 626.8 644.9 3782.7 4078.6 4219.9 4226.6 4281.3 134571.0 147770.0 167715.0 169506.2 173631.6 97694.0 100257.5 101114.5 103389.5 148700.3 97462.0 99369.5 113651.9 115310.1 117832.4 9473.5 9676.0 9876.0 9924.4 9944.9 54868.9 58966.7 62300.4 63476.0 64272.7 82606.0 88876.0 93321.6 96702.0 98014.0 12767.7 12949.6 13067.6 13090.9 13307.0 14329.4 14562.7 14756.3 14790.7 14865.0 13415.5 13783.2 13940.0 13961.0 14275.9 13467.9 13515.1 13620.7 13781.1 14038.9 12998.4 13273.3 13639.7 13787.7 14051.0 10684.9 11223.7 11271.3 11368.4 11663.3 10373.9 11203.4 11431.8 11567.4 11570.6 06:19:16 INFO - PROCESS | 1656 | -------- Summary: end -------- 06:19:16 INFO - PROCESS | 1656 | 06:19:16 INFO - TEST-INFO | 1656: exit 0 06:19:16 INFO - TEST-OK | dromaeo_css | took 1118142ms 06:19:16 INFO - TEST-START | kraken 06:19:16 INFO - operating with platform_type : mac_ 06:19:16 INFO - Initialising browser for kraken test... 06:19:16 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmp7FaKX1/profile http://localhost:49271/getInfo.html) 06:19:19 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 06:19:19 INFO - PROCESS | 1661 | colorDepth:24 06:19:19 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 06:19:19 INFO - PROCESS | 1661 | __metrics 06:19:19 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" 06:19:19 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] 06:19:19 INFO - TEST-INFO | 1661: exit 0 06:19:19 INFO - Browser initialized. 06:19:19 INFO - Running cycle 1/1 for kraken test... 06:19:19 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/T/tmp7FaKX1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:19:31 INFO - PROCESS | 1662 | RSS: Main: 235556864 06:19:31 INFO - PROCESS | 1662 | 06:19:34 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 06:19:35 INFO - PROCESS | 1662 | RSS: Main: 293773312 06:19:35 INFO - PROCESS | 1662 | 06:19:38 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 06:19:38 INFO - PROCESS | 1662 | RSS: Main: 291811328 06:19:38 INFO - PROCESS | 1662 | 06:19:42 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 06:19:42 INFO - PROCESS | 1662 | RSS: Main: 382906368 06:19:42 INFO - PROCESS | 1662 | 06:19:44 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 06:19:45 INFO - PROCESS | 1662 | RSS: Main: 284102656 06:19:45 INFO - PROCESS | 1662 | 06:19:47 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:19:48 INFO - PROCESS | 1662 | RSS: Main: 288227328 06:19:48 INFO - PROCESS | 1662 | 06:19:50 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 06:19:51 INFO - PROCESS | 1662 | RSS: Main: 326590464 06:19:51 INFO - PROCESS | 1662 | 06:19:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 06:19:55 INFO - PROCESS | 1662 | RSS: Main: 326647808 06:19:55 INFO - PROCESS | 1662 | 06:19:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 06:19:58 INFO - PROCESS | 1662 | RSS: Main: 324263936 06:19:58 INFO - PROCESS | 1662 | 06:20:00 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:20:00 INFO - PROCESS | 1662 | RSS: Main: 303136768 06:20:00 INFO - PROCESS | 1662 | 06:20:02 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:20:03 INFO - PROCESS | 1662 | RSS: Main: 303779840 06:20:03 INFO - PROCESS | 1662 | 06:20:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:20:06 INFO - PROCESS | 1662 | RSS: Main: 305451008 06:20:06 INFO - PROCESS | 1662 | 06:20:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:20:09 INFO - PROCESS | 1662 | RSS: Main: 314867712 06:20:09 INFO - PROCESS | 1662 | 06:20:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:20:13 INFO - PROCESS | 1662 | RSS: Main: 316801024 06:20:13 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 06:20:15 INFO - PROCESS | 1662 | RSS: Main: 361410560 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | __start_tp_report 06:20:15 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 06:20:15 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 06:20:15 INFO - PROCESS | 1662 | |i|pagename|runs| 06:20:15 INFO - PROCESS | 1662 | |0;ai-astar;113;113;124;169;143;113;112;113;111;114 06:20:15 INFO - PROCESS | 1662 | |1;audio-beat-detection;145;109;110;141;101;109;94;131;177;143 06:20:15 INFO - PROCESS | 1662 | |2;audio-dft;181;185;183;182;183;184;183;180;182;181 06:20:15 INFO - PROCESS | 1662 | |3;audio-fft;80;57;60;87;62;61;57;60;81;58 06:20:15 INFO - PROCESS | 1662 | |4;audio-oscillator;87;71;90;70;68;68;91;67;69;91 06:20:15 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;87;84;87;84;87;84;87;83;86;84 06:20:15 INFO - PROCESS | 1662 | |6;imaging-darkroom;92;92;92;93;92;92;121;149;92;93 06:20:15 INFO - PROCESS | 1662 | |7;imaging-desaturate;84;83;101;135;83;100;141;139;84;82 06:20:15 INFO - PROCESS | 1662 | |8;json-parse-financial;58;58;58;57;58;59;59;60;57;58 06:20:15 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;64;69;71;74;71;68;70;70;69;71 06:20:15 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;85;84;86;85;87;85;88;85;84;93 06:20:15 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;134;140;141;136;136;139;122;168;245;152 06:20:15 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;169;168;169;174;236;204;170;173;170;169 06:20:15 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;69;68;68;66;68;67;68;68;66;69 06:20:15 INFO - PROCESS | 1662 | __end_tp_report 06:20:15 INFO - PROCESS | 1662 | __start_cc_report 06:20:15 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2095 06:20:15 INFO - PROCESS | 1662 | __end_cc_report 06:20:15 INFO - PROCESS | 1662 | __startTimestamp1474636815594__endTimestamp 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | ------- Summary: start ------- 06:20:15 INFO - PROCESS | 1662 | Number of tests: 14 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:122.50 Median:113.50 stddev:19.03 (16.8%) stddev-sans-first:19.88 06:20:15 INFO - PROCESS | 1662 | Values: 113.0 113.0 124.0 169.0 143.0 113.0 112.0 113.0 111.0 114.0 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:126.00 Median:142.00 stddev:25.79 (18.2%) stddev-sans-first:26.42 06:20:15 INFO - PROCESS | 1662 | Values: 145.0 109.0 110.0 141.0 101.0 109.0 94.0 131.0 177.0 143.0 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:182.40 Median:183.00 stddev:1.51 (0.8%) stddev-sans-first:1.51 06:20:15 INFO - PROCESS | 1662 | Values: 181.0 185.0 183.0 182.0 183.0 184.0 183.0 180.0 182.0 181.0 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:66.30 Median:61.50 stddev:11.55 (18.8%) stddev-sans-first:11.13 06:20:15 INFO - PROCESS | 1662 | Values: 80.0 57.0 60.0 87.0 62.0 61.0 57.0 60.0 81.0 58.0 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:79.00 stddev:10.91 (13.8%) stddev-sans-first:10.98 06:20:15 INFO - PROCESS | 1662 | Values: 87.0 71.0 90.0 70.0 68.0 68.0 91.0 67.0 69.0 91.0 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:85.30 Median:86.50 stddev:1.64 (1.9%) stddev-sans-first:1.62 06:20:15 INFO - PROCESS | 1662 | Values: 87.0 84.0 87.0 84.0 87.0 84.0 87.0 83.0 86.0 84.0 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:100.80 Median:92.00 stddev:19.20 (20.9%) stddev-sans-first:20.10 06:20:15 INFO - PROCESS | 1662 | Values: 92.0 92.0 92.0 93.0 92.0 92.0 121.0 149.0 92.0 93.0 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:103.20 Median:82.50 stddev:25.25 (30.6%) stddev-sans-first:25.81 06:20:15 INFO - PROCESS | 1662 | Values: 84.0 83.0 101.0 135.0 83.0 100.0 141.0 139.0 84.0 82.0 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:0.92 (1.6%) stddev-sans-first:0.97 06:20:15 INFO - PROCESS | 1662 | Values: 58.0 58.0 58.0 57.0 58.0 59.0 59.0 60.0 57.0 58.0 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.50 stddev:2.58 (3.7%) stddev-sans-first:1.73 06:20:15 INFO - PROCESS | 1662 | Values: 64.0 69.0 71.0 74.0 71.0 68.0 70.0 70.0 69.0 71.0 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.50 stddev:2.70 (3.2%) stddev-sans-first:2.83 06:20:15 INFO - PROCESS | 1662 | Values: 85.0 84.0 86.0 85.0 87.0 85.0 88.0 85.0 84.0 93.0 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:151.30 Median:140.50 stddev:35.07 (25.0%) stddev-sans-first:36.64 06:20:15 INFO - PROCESS | 1662 | Values: 134.0 140.0 141.0 136.0 136.0 139.0 122.0 168.0 245.0 152.0 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.20 Median:171.50 stddev:22.37 (13.0%) stddev-sans-first:23.36 06:20:15 INFO - PROCESS | 1662 | Values: 169.0 168.0 169.0 174.0 236.0 204.0 170.0 173.0 170.0 169.0 06:20:15 INFO - PROCESS | 1662 | 06:20:15 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.06 (1.6%) stddev-sans-first:1.01 06:20:15 INFO - PROCESS | 1662 | Values: 69.0 68.0 68.0 66.0 68.0 67.0 68.0 68.0 66.0 69.0 06:20:15 INFO - PROCESS | 1662 | -------- Summary: end -------- 06:20:15 INFO - PROCESS | 1662 | 06:20:16 INFO - TEST-INFO | 1662: exit 0 06:20:16 INFO - TEST-OK | kraken | took 59914ms 06:20:16 INFO - SUITE-END | took 1178s 06:20:16 INFO - Completed test suite (00:19:38) 06:20:16 INFO - javascript benchmark 06:20:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3224.983875080625, 3240.2871368298975, 3260.7717459777796, 3272.885449009282, 3313.5526703894966, 5385.138377859544, 5432.565394768419, 5497.285352904127, 5497.780088796449, 5500.807471738485, 5480.7533660985255, 5538.0, 5539.169124631308, 5553.333599968009, 5587.106063029916, 4125.855595054174, 4986.0, 5004.424491183506, 5028.723420211887, 5037.722925239111, 5076.695398276115, 5111.1566591512355, 5148.2020286855595, 5154.690718556899, 5216.321878155834, 5109.335786347751, 5112.514311140436, 5115.437301896788, 5148.922766158511, 5200.0, 4959.603231741452, 5021.748912554358, 5038.143515602356, 5077.5684066854365, 5088.1350170471105, 5007.123753343187, 5039.72281524516, 5044.722540260284, 5074.467180945984, 5085.288059671649, 5491.890162196733, 5521.558275337963, 5534.972325138348, 5545.0, 5556.055470569972, 5967.254093238345, 5971.61184523009, 5973.1936188614845, 5975.641461512279, 5989.431004054608, 6069.211002569682, 6073.908891366633, 6075.574709770318, 6080.695965201767, 6093.634381937098, 5489.286392768954, 5542.334919809648, 5566.359868615161, 5619.550435965113, 5654.123610840285, 6160.414760597736, 6176.382361763787, 6177.351378105324, 6181.165542651775, 6192.133101365813, 4774.761261936958, 5743.6266642668925, 5772.220750198753, 5900.4984576310635, 5916.970415147983, 5954.523638108941, 6003.489703375175, 6031.849203769941, 6125.479334256549, 6129.172561704113, 5985.40145985398, 5985.551083668743, 6021.397860213943, 6030.819075427744, 6057.787977420858, 5826.126081087786, 6022.1870047543025, 6037.6679282639, 6046.972014757502, 6063.060225665029, 4741.881452963704, 4758.238681810963, 4788.401449818773, 4811.735354555463, 4814.277858321209, 4297.011687311936, 4315.180115777992, 4321.567843215653, 4336.3278691802825, 4364.716293440916, 4675.345451636774, 5549.750261238173, 5559.805406810742, 5575.498205161555, 5578.832635020955, 5908.763649454059, 5989.131575921554, 5994.670293133832, 6037.396260373927, 6118.510519158456, 5550.91673624896, 5576.553875689935, 5597.496225339658, 5604.887902242014, 5647.37878833328, 5227.686338819683, 5239.187925871496, 5239.607029472729, 5247.055530004636, 5254.238135470336, 6090.878182436415, 6110.072772100023, 6193.0, 6210.782622608187, 6212.72042758077, 5903.970480147572, 5931.6441013539325, 5968.253968253968, 5989.610675306091, 6072.453479186895, 6112.564273424362, 6134.384052390125, 6167.0, 6168.660723660242, 6170.629762214281, 5291.576673866004, 5786.450287222707, 5819.6508209507565, 5868.94131058684, 5904.704764761659, 5879.911801322898, 5964.612300200473, 5976.043832986701, 6064.545159112996, 6083.148359229623, 5793.507551858139, 5804.216430781959, 5820.010598198402, 5835.79574714883, 5931.377205393372, 5074.629849940569, 5668.858278543069, 5864.091065884794, 5873.823785286449, 5878.030125029322, 5674.177244299636, 5740.282464691913, 5740.684262365443, 5745.683987380734, 5748.080307150836, 4752.500987396274, 4799.0, 5706.400827913176, 5771.192033115283, 5772.9711351442975, 5387.676739395492, 5408.59435542328, 5575.9163612545035, 5610.214569960127, 5705.828825135252], "value": 5476.379781260884, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.8570464599005, 464.0324922536511, 468.18769435030214, 522.7725939216443, 523.6753213007936, 30857.845710771442, 32297.0, 32321.191970200758, 32493.837530812343, 39652.405213921746, 31124.53313200304, 43388.56611433885, 43406.13187736244, 43474.13051738971, 43618.36678581243, 8358.289545388649, 9672.08115229052, 9765.023497650214, 9826.410415375065, 9831.115199632031, 8707.695230666928, 8938.597763100675, 9603.4718090505, 9741.512924353789, 11767.352795596238, 11785.587504437346, 12010.0992425568, 12010.159288849783, 12037.458314375874, 12230.205036672587, 11967.58113466029, 12024.639260822189, 12027.759444811054, 12052.698682532962, 12060.336681482515, 11906.46420911061, 11970.281783092954, 12007.3395963222, 12015.519379224821, 12020.69948251292, 40523.59476405228, 40763.184736305106, 40839.59160408388, 40895.59104408947, 40923.7953810232, 2982.7017298270216, 3264.5103234514777, 3285.655006224336, 3465.8960231193105, 3503.019154636706, 23447.648285275736, 29069.70930290691, 29380.55929161043, 31370.05889823309, 31672.841635791672, 3116.781825272232, 3206.3587282543353, 3258.85335159916, 3344.7491438142238, 3374.4263475209273, 476717.0, 481072.0, 481251.0, 484540.0, 493224.5338773319, 32879.506807397906, 33637.0, 59756.40243597596, 60180.699096505115, 60219.69890150521, 34481.0, 34690.30619387598, 34694.82652586771, 34701.65298347035, 34705.82647086799, 14211.715765684628, 14356.282185890872, 14360.425582976774, 14362.994590378783, 14369.712605747827, 12195.939020304842, 12287.324197169242, 12287.815682764765, 12294.569690060805, 12295.938520307342, 7093.467989900778, 7211.278872112747, 7219.855602887913, 7583.886241706379, 7630.236976302325, 2940.941181176407, 3162.6204855417495, 3261.836908154583, 3263.4009335425944, 3292.3909076820864, 841.3143288220081, 844.0715213265358, 872.925801306896, 944.5041353289578, 974.8927617962019, 22854.542909141725, 28215.57676634852, 28481.857590712327, 28904.132876013755, 28978.7102128976, 1056.4031322302874, 1081.8269076947652, 1082.6697857153486, 1088.3469918049107, 1104.3539529375246, 13028.674283142807, 14612.780808287884, 14672.119672819665, 14778.0, 14933.477328293458, 670715.0, 676136.0, 676995.0, 677064.0, 679568.0, 48663.756681216364, 48965.0, 55632.16551751727, 57625.55936101547, 58088.70955645279, 1329.2622594460167, 1364.4746772492663, 1379.8965077619018, 1382.6819831438825, 1384.5154196031308, 23251.76748232564, 30086.849565752906, 30927.84536077305, 31774.0, 32552.51171232386, 55914.72042639761, 56593.43406565882, 56674.7166264166, 56777.432225678866, 56812.715936420056, 455069.0, 460795.69602151774, 460827.0, 460936.0, 461444.0, 39939.0, 40515.79742101271, 40861.38707919443, 40910.386344204264, 41330.52016878997, 45375.319370210134, 46236.220472440946, 46459.53540464552, 46611.53388466072, 46838.76580617075, 36922.0, 37738.0, 37802.810985944896, 38469.6153038466, 38917.80541097277, 37082.88751337464, 37379.0, 38667.419988700756, 39157.8042109799, 39569.812905612875, 32369.35261294714, 35900.281994359444, 36845.63154368529, 37197.25605487929, 37642.623573763914, 32200.838995804872, 33745.83127084349, 33751.66248337485, 33914.49128263127, 33936.0, 24619.63070553979, 24713.629295560942, 24882.253532393333, 25481.617775733008, 25522.744772552036], "value": 18661.44868079964, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.5980382364107, 371.5318698439967, 375.0904057660174, 384.4886301219378, 406.076176698012, 15208.467703630362, 15519.456819011337, 17377.56556086097, 20699.06854191561, 21155.0, 19904.70142947857, 20348.0, 20618.793812061875, 20890.373288801362, 21169.68245476315, 5998.730057147439, 6049.758009679618, 6212.0, 6221.720022598971, 6262.248530176385, 6077.513798896078, 6156.5998210116195, 6212.78255261066, 6215.968920155393, 6227.190465239535, 4200.243956087903, 4407.008423104808, 5321.8403447896435, 6935.930640693604, 6977.89533157003, 6841.315868413169, 6910.861782764342, 7005.159380874276, 7019.684114214872, 7026.789196324118, 6106.572539922207, 6109.877802443926, 6120.969395152996, 6123.112148738408, 6125.050617154348, 27460.313492162655, 27491.725082749115, 27900.441991160267, 27937.16188514348, 28290.575641365394, 2183.9344819655435, 2191.7589065202815, 2234.3297010896667, 2258.031000925184, 2317.721873375189, 13589.388477518536, 15299.464518741903, 16266.918665406716, 16500.504984850475, 16647.583810404714, 1864.1518109260253, 1869.9252029918787, 1946.980530194694, 1950.1711772496633, 1964.2339487599847, 122075.0, 135199.97200042006, 135854.58399364093, 136496.0, 139434.3028284852, 10784.299020563638, 10900.40047797363, 11021.008109270204, 11453.427328633536, 11586.826197607043, 13816.861831381759, 13944.30278486092, 14233.074850134708, 14303.713925721635, 14351.641208969859, 8598.39811213209, 8751.081136480705, 8775.912240877637, 8788.121187881161, 8922.375433719577, 8764.079771624016, 8786.02314479237, 8789.604467798965, 8959.372843900865, 8980.46117232968, 6840.3501667341525, 6847.175343073305, 6912.965435172892, 6927.099477067949, 7067.717291308393, 1601.9519414417352, 1827.2964908510053, 1878.9060546972596, 1900.363378268268, 1917.4343568647282, 780.8711562592109, 853.4665833853842, 916.6910028658979, 950.7718147644515, 991.4200192887241, 21498.57002859934, 22407.439814004454, 23366.7663323368, 23483.70839603804, 23594.29217123489, 893.6068130022769, 965.7295957132014, 979.345972414764, 989.50030234731, 1000.9340052843698, 10984.121270298358, 11272.027395205807, 11343.881993307781, 11498.310101393943, 11513.424328783527, 561374.0, 575253.0, 584619.0769046127, 589136.0, 593583.0, 134778.32610836884, 135303.32348338392, 136639.31680341534, 137710.0, 140631.0, 971.0, 1015.4516561056946, 1045.153425725165, 1046.1630695443766, 1047.0105750066114, 18978.620427591093, 19156.61686766229, 19305.51736206606, 19388.903055484632, 19459.8054019458, 39361.40957885577, 49495.50504494909, 58395.832083358946, 58958.70520647369, 59349.406505934385, 69423.30576694169, 70044.6497767508, 79494.0, 81412.59293703493, 84118.57940710257, 11169.0, 11245.437728113398, 12165.391730413266, 12535.749285014066, 12812.487500499876, 8596.699115530926, 13214.942804575803, 13820.585382438543, 14069.859301406856, 14121.717565648423, 10335.689929302132, 11398.0, 11560.884391156318, 11732.002779763474, 12246.693832654255, 11607.76784464289, 11860.466279017292, 11926.940365298466, 12143.332116733665, 12245.020398368288, 10775.676729698122, 10995.230333876552, 11666.358350290477, 12114.394280286127, 12275.69310767238, 12135.817962730744, 12233.816492752794, 12339.321337326533, 12342.729176767984, 12370.381480925738, 11678.6496405108, 11725.530978760755, 11977.760444791229, 12025.63923082309, 12065.939670301592], "value": 10258.238209728657, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.18899983009, 1552.666176771994, 1781.4388467632696, 1919.7600299962505, 1930.4884205685487, 7558.811029724246, 8429.66281348746, 8926.0, 8932.59803308851, 8940.73177804666, 7826.295633392993, 8103.351731861451, 8387.203215694499, 8643.611037503311, 8646.308295336374, 2183.727034120739, 2371.454565449939, 2376.8692721900375, 2377.1204654277853, 2379.167291447988, 2034.8372130229545, 2334.7781960713705, 2342.1919437793936, 2345.7536958619357, 2376.821738369629, 2344.812415006795, 2359.23324919401, 2367.775061369176, 2379.2505360811288, 2384.95230095398, 1931.6040211756626, 2341.356127065054, 2351.576716191085, 2353.423411264234, 2358.8230882683697, 2339.847909885852, 2345.495718420531, 2351.482673811776, 2352.094443639211, 2354.9411264718347, 8768.254698350584, 8792.648294068229, 8915.643374265022, 8916.554172291424, 8928.776780580472, 4800.735959522225, 5312.946870531323, 5321.574274058066, 5333.333333333333, 5334.119870221409, 3472.28818092293, 3559.2169722660974, 3673.522442082512, 3686.5391826021746, 3691.0, 1051.1380667852363, 1083.7615724540588, 1090.6019302954444, 1105.2649987758132, 1106.4799544214206, 11478.139139564566, 11581.131415143898, 11600.709982250426, 11608.709782255426, 11642.417879106011, 4433.0, 4539.591436770706, 4710.411198600175, 4736.218523943511, 4744.525547445297, 9776.608935642495, 9779.951100244596, 9780.266480013885, 9781.804363912825, 9785.972472890386, 5264.473552644705, 5297.0, 5299.311089558333, 5299.364076310867, 5301.708406037705, 4390.8902277442685, 4476.619487343547, 4566.13243483737, 4877.707337559757, 4899.902001959941, 3767.604401537854, 3801.334766415866, 3866.96133038666, 3907.7069219808627, 3911.5697273299916, 1246.8067449545335, 1249.419020155614, 1251.7183633682348, 1264.7849865522883, 1270.6124631987147, 839.5634270179472, 847.737201467547, 896.2158111652304, 896.6682327538722, 919.5448253114618, 5591.3569939456665, 5796.710164491758, 5834.504067154339, 5906.497947674496, 5974.641521508724, 920.5213289089636, 926.0878035135386, 930.2976252928995, 945.1682519382899, 970.5292932927524, 3812.218495208476, 3973.2848087344555, 3974.1654252607277, 4078.8164532596106, 4128.91742165155, 9856.50717464124, 10480.109190718722, 10540.262181647211, 10608.522616482276, 10617.416042117758, 10191.235657325582, 10429.0, 10443.477826108816, 10605.681829545127, 10613.469326533643, 7839.843203135905, 8055.154208808108, 8068.394870384627, 8128.309093726981, 8152.673893044212, 5094.388673359221, 5734.971325143348, 5824.854378640398, 5909.881802363842, 6039.667818270037, 8126.715564955198, 9642.71071867845, 9862.950685246527, 9897.604095836086, 9948.054934781185, 8821.2060914518, 9105.226055785068, 9939.254555908192, 10021.699349019542, 10151.94924025375, 7252.709891604277, 7397.8150546236775, 7491.513051651626, 7506.211847755907, 7613.010308659839, 8292.0, 8307.6676932922, 8379.916200838157, 8388.832223355377, 8397.992240931128, 7281.5631062136445, 7361.0, 7482.625868706652, 7551.546907185587, 7613.733519326797, 6056.757729690763, 7247.420206383371, 7289.271072892669, 7298.4526160539235, 7400.888986665312, 6761.695723692347, 6774.559653622498, 6830.282820303995, 6832.555883867532, 6838.14523184602, 3758.567764707094, 4873.1959226727195, 4950.702957822542, 4974.427940786856, 5090.643654944119, 4253.3832594273035, 4613.953860461353, 4888.486708895657, 4902.975485122552, 5050.217216331474], "value": 4530.7112753687325, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.96881827408123, 299.266796348945, 306.54784193314856, 311.67430035612784, 313.9089663997441, 4489.124620698965, 4972.87567810804, 5191.19536471847, 5222.268882356473, 5268.31511903453, 4344.63070638996, 5075.746212689369, 5117.411497677759, 5150.896982060356, 5193.1171700810955, 3622.8625111184397, 3680.7607505512124, 3762.341590221714, 3958.188571342868, 3981.243563722883, 2840.460312540621, 3987.541432735229, 4017.718759686823, 4031.1983171695683, 4038.3952350733757, 3214.698047290851, 3796.4874741909766, 3897.9805100974454, 3922.921541569181, 3972.09339517032, 3186.9681303186903, 3554.382755846084, 3633.2370202257557, 3684.410494320896, 3921.607839216084, 3212.213007813077, 3411.5053317269103, 3424.4692072728767, 3427.280271143063, 3443.517907492953, 4717.504662010474, 4959.900801983977, 4976.377952755905, 4982.825601103944, 5072.315237442935, 4418.072204836988, 4430.712003719748, 4439.911201775979, 4453.53237910018, 4461.665375096881, 4483.551644835523, 4674.672772905898, 5409.6213265071465, 5412.859162740507, 5413.729313534347, 3067.6165479315086, 3676.3015027144756, 3690.3910854708943, 3697.796621185834, 3704.148045949447, 4870.902581948377, 4871.4154301483695, 5573.470520300565, 5621.0, 5671.908809698724, 3332.783369081002, 3627.8186090695885, 3762.097096696773, 3767.095896984759, 3821.6687820429515, 3664.2121943782213, 3797.7721336719887, 3833.2333533292895, 3849.711271654637, 3895.2014836958356, 3964.960350396517, 4124.948138224733, 4131.772752498581, 4184.790760461965, 4482.901689086129, 5416.348013855733, 5426.457354264542, 5451.454854514596, 5533.170024496358, 5593.776248950077, 920.7559996600907, 1204.4700331853956, 1218.0986070308086, 1221.1879100398135, 1283.3198404845448, 858.013284722574, 869.6825658634552, 879.564615515324, 885.3359980014989, 886.0430734806394, 4712.69367491112, 5050.722210278396, 5068.59451243907, 5073.315102461121, 5098.97450512745, 4356.607905288539, 5489.917651235235, 5491.862703432366, 5497.5601951843755, 5509.724513774296, 4405.3612226227015, 4558.316252562142, 5076.334924164843, 5099.719515426613, 5102.719350435762, 2047.764507081675, 2055.1573854719495, 2120.0283736125243, 2387.594109001474, 2467.642191882167, 3733.434569985657, 3963.544192417909, 4803.447603525569, 4806.95193048072, 4930.457649658535, 3850.09420336935, 4253.511271055106, 4706.694064885772, 4730.2431610942085, 4757.905681693161, 4166.66666666666, 4497.527759585197, 4683.9063218734755, 4766.4280286365165, 4870.853874383774, 3988.90027749297, 4164.75011499311, 4629.0, 4633.822103611297, 4650.441946966385, 3963.3262345400776, 3963.6630886374983, 4547.681662283609, 4577.924187815927, 4670.719756814602, 4116.567760385116, 4187.797902764538, 4453.866384008485, 4503.1537069801225, 4779.856604301876, 2901.3036871151194, 2901.8247609718096, 3247.9837600811843, 3258.837058147036, 3277.3445310938387, 3884.902877428087, 4726.26742854858, 4751.762411879323, 4841.322214889989, 5111.539961403491, 4687.226607609706, 4786.827227329327, 4847.079054979543, 4976.676516026447, 5076.121834921103, 4993.5755460784785, 5085.694858308513, 5142.434332223377, 5189.429162792166, 5522.30971128609, 4620.445546534437, 4781.680884770953, 5045.5459008689395, 5447.622474065946, 5457.6179667424485, 5464.535514481314, 5473.67157970523, 5481.287432633732, 5482.39693633708, 5503.504684578407, 4635.7218566886095, 5348.652337598043, 5360.41035486104, 5372.516473517402, 5423.322084739408], "value": 3736.840280328092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.733474946895, 733.6038539188838, 760.6767123972311, 808.3573559020585, 836.1554829622082, 15304.387824487021, 15541.989770664899, 16023.519294421158, 16055.59861003474, 16381.508554743377, 14025.719485610281, 14032.929835350835, 14047.36786844592, 14216.502422415217, 14346.139231646108, 679.8096532970776, 691.2810676896047, 696.1055044268116, 835.1982097186708, 850.9531975741347, 852.1052894460822, 863.4171933944593, 866.57537806475, 867.657275376226, 870.6125774030559, 915.7573243090586, 917.4678686361927, 917.7659696777346, 918.3433844800966, 918.5774543709902, 704.8484575816173, 716.6380977606327, 910.1853840812436, 911.6444586611227, 914.2822884036033, 672.5124284893462, 682.2324884504932, 682.576802382526, 686.3273991488369, 687.60806340386, 14388.424463021467, 14417.711645767025, 14436.206008669518, 14440.205788681618, 14474.565763027125, 12092.939535302266, 12232.003159225958, 12281.508739650404, 12462.0, 12722.982161427064, 12217.633470995885, 12298.323592202425, 12320.691982700415, 12362.134650574464, 12584.74830503394, 4321.654267658611, 4423.203823311803, 4504.414426124583, 4542.364069030338, 4589.1968905441745, 111154.44422777915, 116987.83012169854, 117360.0, 117753.41123294414, 118176.99999999914, 8285.544295063708, 10257.769067711923, 10374.688759337232, 10529.36823790575, 10530.31552949056, 19993.400197994084, 20667.379978600366, 20876.686849697267, 20882.47793805167, 20890.47773805667, 7640.274173953466, 7746.612669366509, 7759.107702614158, 7805.180456052146, 7806.297433231037, 4278.978605107017, 4289.442372491556, 4315.676324275629, 4338.652907767371, 4421.226285400042, 2978.9851050744605, 3392.4402473592077, 3510.754247202671, 3511.631278715749, 3521.2253304273017, 594.9762009519658, 652.5823472977204, 662.8110988368292, 673.5049738442241, 681.1689738518999, 592.6118392452864, 621.9813405597839, 626.6490765171427, 628.3119983617931, 637.1716768201412, 8700.434471759441, 8954.373193876367, 9005.755110140875, 9149.0, 9228.446293222429, 571.5199232644599, 599.1731410653358, 617.7683368736724, 626.7618305044055, 644.9355064493607, 3782.6973842092566, 4078.57174996627, 4219.852305169305, 4226.598473145046, 4281.250781113293, 134571.0, 147770.0, 167715.0, 169506.15246923687, 173631.55973943608, 97694.0, 100257.49871250743, 101114.49442752739, 103389.48305258575, 148700.2564987168, 97462.0, 99369.50315248377, 113651.86348136578, 115310.12693032593, 117832.41083794527, 9473.52632368365, 9676.0, 9875.950620246853, 9924.40453572788, 9944.850827237742, 54868.90262194654, 58966.70516647389, 62300.37699623127, 63476.0, 64272.67863660652, 82606.0, 88876.0, 93321.60017599606, 96702.0, 98014.0198598005, 12767.680807979876, 12949.611511654666, 13067.607971760863, 13090.934545327213, 13307.001974851732, 14329.355179017179, 14562.708745825235, 14756.33596488182, 14790.704185916436, 14865.0, 13415.463381464631, 13783.173009619455, 13940.024198306426, 13961.0, 14275.928620356832, 13467.932660336635, 13515.12151710175, 13620.65948351299, 13781.104228225535, 14038.922155688622, 12998.350082495648, 13273.33633318311, 13639.727205456034, 13787.67733807408, 14051.016428849882, 10684.89315106839, 11223.66329010131, 11271.323720576791, 11368.431578421212, 11663.300201987908, 10373.896261037293, 11203.439828008404, 11431.828522572001, 11567.421628918688, 11570.595029174276], "value": 7729.368837563205, "unit": "score"}], "name": "dromaeo_css", "value": 7181.736983152725, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 124.0, 169.0, 143.0, 113.0, 112.0, 113.0, 111.0, 114.0], "value": 122.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 110.0, 141.0, 101.0, 109.0, 94.0, 131.0, 177.0, 143.0], "value": 126.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 185.0, 183.0, 182.0, 183.0, 184.0, 183.0, 180.0, 182.0, 181.0], "value": 182.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 60.0, 87.0, 62.0, 61.0, 57.0, 60.0, 81.0, 58.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 90.0, 70.0, 68.0, 68.0, 91.0, 67.0, 69.0, 91.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 87.0, 84.0, 87.0, 83.0, 86.0, 84.0], "value": 85.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 92.0, 93.0, 92.0, 92.0, 121.0, 149.0, 92.0, 93.0], "value": 100.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 101.0, 135.0, 83.0, 100.0, 141.0, 139.0, 84.0, 82.0], "value": 103.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 57.0, 58.0, 59.0, 59.0, 60.0, 57.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 71.0, 74.0, 71.0, 68.0, 70.0, 70.0, 69.0, 71.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 86.0, 85.0, 87.0, 85.0, 88.0, 85.0, 84.0, 93.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 140.0, 141.0, 136.0, 136.0, 139.0, 122.0, 168.0, 245.0, 152.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 169.0, 174.0, 236.0, 204.0, 170.0, 173.0, 170.0, 169.0], "value": 180.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 66.0, 68.0, 67.0, 68.0, 68.0, 66.0, 69.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1477.0, "alertThreshold": 2.0}]} 06:20:16 INFO - Return code: 0 06:20:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:20:16 INFO - # TBPL SUCCESS # 06:20:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:20:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:20:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:20:16 INFO - 2016-09-23 06:20:16.938 screenresolution[1666:10323] starting screenresolution argv=screenresolution get 06:20:16 INFO - 2016-09-23 06:20:16.942 screenresolution[1666:10323] Display 0: 1600x1200x32@60 06:20:16 INFO - 2016-09-23 06:20:16.948 screenresolution[1667:10326] starting screenresolution argv=screenresolution list 06:20:16 INFO - Available Modes on Display 0 06:20:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:20:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:20:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:20:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:20:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:20:17 INFO - Intel Iris: 06:20:17 INFO - Chipset Model: Intel Iris 06:20:17 INFO - Type: GPU 06:20:17 INFO - Bus: Built-In 06:20:17 INFO - VRAM (Dynamic, Max): 1536 MB 06:20:17 INFO - Vendor: Intel (0x8086) 06:20:17 INFO - Device ID: 0x0a2e 06:20:17 INFO - Revision ID: 0x0009 06:20:17 INFO - Displays: 06:20:17 INFO - Display: 06:20:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:20:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:20:17 INFO - Display Serial Number: 1600x1200 60 06:20:17 INFO - Main Display: Yes 06:20:17 INFO - Mirror: Off 06:20:17 INFO - Online: Yes 06:20:17 INFO - Rotation: Supported 06:20:17 INFO - Return code: 0 06:20:17 INFO - Running post-action listener: _resource_record_post_action 06:20:17 INFO - [mozharness: 2016-09-23 13:20:17.184104Z] Finished run-tests step (success) 06:20:17 INFO - Running post-run listener: _resource_record_post_run 06:20:17 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 31332352; Write bytes: 707593216; Read time: 301; Write time: 1883 06:20:17 INFO - TinderboxPrint: CPU usage
53.6% 06:20:17 INFO - TinderboxPrint: I/O read bytes / time
31,332,352 / 301 06:20:17 INFO - TinderboxPrint: I/O write bytes / time
707,593,216 / 1,883 06:20:17 INFO - TinderboxPrint: CPU idle
2,254.3 (46.4%) 06:20:17 INFO - TinderboxPrint: CPU system
969.6 (20.0%) 06:20:17 INFO - TinderboxPrint: CPU user
1,629.7 (33.6%) 06:20:17 INFO - TinderboxPrint: Swap in / out
435,589,120 / 0 06:20:17 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403429888; Write bytes: 396441088; Read time: 29899; Write time: 739 06:20:17 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 29243392; Write bytes: 297295360; Read time: 279; Write time: 1108 06:20:17 INFO - Running post-run listener: _upload_blobber_files 06:20:17 INFO - Blob upload gear active. 06:20:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:20:17 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 06:20:17 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'] 06:20:17 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 06:20:18 INFO - (blobuploader) - INFO - Open directory for files ... 06:20:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:20:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:20:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:19 INFO - (blobuploader) - INFO - Done attempting. 06:20:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:20:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:20:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:20 INFO - (blobuploader) - INFO - Done attempting. 06:20:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:20:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:20:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:20:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:20:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:20:22 INFO - (blobuploader) - INFO - Done attempting. 06:20:22 INFO - (blobuploader) - INFO - Iteration through files over. 06:20:22 INFO - Return code: 0 06:20:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:20:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:20:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/070188497708a1af4492d0f90acb2abf1e2401e1376cfe2786d9fdfa117f7f465eb46380868e7f795c0153ab3b691c6c0f0d159d85777377a27a064d3a5d39d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d32ceece6ce071f723ef2b0996566caa92360070ddb084fdce5fc9ec47f557b6d8339bf8d9c09a61c0c4e12915e2213e44cfcc7922e8bbd6a10d25a2cd6abe60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f0c1607f2de7d64804f6f629384af05c1513f2e6ccfda2abaa7770535781b91480cda4ecba29d4788becd6f57fc50fece0889583041c2078b3298e4c08cb2fe7"} 06:20:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:20:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:20:22 INFO - Contents: 06:20:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/070188497708a1af4492d0f90acb2abf1e2401e1376cfe2786d9fdfa117f7f465eb46380868e7f795c0153ab3b691c6c0f0d159d85777377a27a064d3a5d39d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d32ceece6ce071f723ef2b0996566caa92360070ddb084fdce5fc9ec47f557b6d8339bf8d9c09a61c0c4e12915e2213e44cfcc7922e8bbd6a10d25a2cd6abe60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f0c1607f2de7d64804f6f629384af05c1513f2e6ccfda2abaa7770535781b91480cda4ecba29d4788becd6f57fc50fece0889583041c2078b3298e4c08cb2fe7"} 06:20:22 INFO - Running post-run listener: copy_logs_to_upload_dir 06:20:22 INFO - Copying logs to upload dir... 06:20:22 INFO - mkdir: /builds/slave/test/build/upload/logs 06:20:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.958596 ========= master_lag: 0.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-23 06:20:22.858559) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 06:20:22.862796) ========= 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.rZOb6wmAxp/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.jPpAP57rg2/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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/070188497708a1af4492d0f90acb2abf1e2401e1376cfe2786d9fdfa117f7f465eb46380868e7f795c0153ab3b691c6c0f0d159d85777377a27a064d3a5d39d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d32ceece6ce071f723ef2b0996566caa92360070ddb084fdce5fc9ec47f557b6d8339bf8d9c09a61c0c4e12915e2213e44cfcc7922e8bbd6a10d25a2cd6abe60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f0c1607f2de7d64804f6f629384af05c1513f2e6ccfda2abaa7770535781b91480cda4ecba29d4788becd6f57fc50fece0889583041c2078b3298e4c08cb2fe7"} build_url:https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011022 build_url: 'https://queue.taskcluster.net/v1/task/UWzQ6t3mSDOqr35CW3rDsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/070188497708a1af4492d0f90acb2abf1e2401e1376cfe2786d9fdfa117f7f465eb46380868e7f795c0153ab3b691c6c0f0d159d85777377a27a064d3a5d39d2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d32ceece6ce071f723ef2b0996566caa92360070ddb084fdce5fc9ec47f557b6d8339bf8d9c09a61c0c4e12915e2213e44cfcc7922e8bbd6a10d25a2cd6abe60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f0c1607f2de7d64804f6f629384af05c1513f2e6ccfda2abaa7770535781b91480cda4ecba29d4788becd6f57fc50fece0889583041c2078b3298e4c08cb2fe7"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 06:20:22.926567) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 06:20:22.926967) ========= 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.rZOb6wmAxp/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.jPpAP57rg2/Listeners TMPDIR=/var/folders/vs/05tgb2r939n1hg2_z6mc78kw00000w/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.004940 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 06:20:22.981426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 06:20:22.981748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 06:20:22.982064) ========= ========= Total master_lag: 0.64 =========