builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0085 starttime: 1468324634.14 results: success (0) buildid: 20160712030624 builduid: 89e5261475c24fce978b6690bf08fbe4 revision: 173d493da6f57a15facef6dbf18f4be49e1c6bb4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:14.139134) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:14.139584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:14.139874) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:14.162822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:14.163093) ========= 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.saWrIQYfro/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.rrfZNg8xFI/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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-07-12 04:57:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 80.4M=0s 2016-07-12 04:57:14 (80.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105093 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:14.290020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:14.290360) ========= 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.saWrIQYfro/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.rrfZNg8xFI/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.020770 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:14.338256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-07-12 04:57:14.338720) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 173d493da6f57a15facef6dbf18f4be49e1c6bb4 --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 173d493da6f57a15facef6dbf18f4be49e1c6bb4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.saWrIQYfro/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.rrfZNg8xFI/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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-07-12 04:57:14,414 truncating revision to first 12 chars 2016-07-12 04:57:14,414 Setting DEBUG logging. 2016-07-12 04:57:14,414 attempt 1/10 2016-07-12 04:57:14,415 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/173d493da6f5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 04:57:16,674 unpacking tar archive at: fx-team-173d493da6f5/testing/mozharness/ program finished with exit code 0 elapsedTime=2.524508 ========= master_lag: 1.70 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-07-12 04:57:18.565669) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:18.565998) ========= script_repo_revision: 173d493da6f57a15facef6dbf18f4be49e1c6bb4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:18.566374) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:18.566636) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 04:57:18.586235) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-12 04:57:18.586571) ========= /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.saWrIQYfro/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.rrfZNg8xFI/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:57:18 INFO - MultiFileLogger online at 20160712 04:57:18 in /builds/slave/test 04:57:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:57:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:57:18 INFO - {'append_to_log': False, 04:57:18 INFO - 'base_work_dir': '/builds/slave/test', 04:57:18 INFO - 'blob_upload_branch': 'Fx-Team', 04:57:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:57:18 INFO - 'branch': 'Fx-Team', 04:57:18 INFO - 'buildbot_json_path': 'buildprops.json', 04:57:18 INFO - 'config_files': ('talos/mac_config.py',), 04:57:18 INFO - 'default_actions': ('clobber', 04:57:18 INFO - 'read-buildbot-config', 04:57:18 INFO - 'download-and-extract', 04:57:18 INFO - 'populate-webroot', 04:57:18 INFO - 'create-virtualenv', 04:57:18 INFO - 'install', 04:57:18 INFO - 'run-tests'), 04:57:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:57:18 INFO - 'download_minidump_stackwalk': True, 04:57:18 INFO - 'download_symbols': 'ondemand', 04:57:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:57:18 INFO - 'tooltool.py': '/tools/tooltool.py', 04:57:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:57:18 INFO - '/tools/misc-python/virtualenv.py')}, 04:57:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:57:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:57:18 INFO - 'installer_path': 'installer.exe', 04:57:18 INFO - 'log_level': 'info', 04:57:18 INFO - 'log_name': 'talos', 04:57:18 INFO - 'log_to_console': True, 04:57:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:57:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:57:18 INFO - 'opt_config_files': (), 04:57:18 INFO - 'pip_index': False, 04:57:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:57:18 INFO - 'cmd': ('bash', 04:57:18 INFO - '-c', 04:57:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:57:18 INFO - 'enabled': True, 04:57:18 INFO - 'halt_on_failure': False, 04:57:18 INFO - 'name': 'check_screen_resolution'},), 04:57:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:57:18 INFO - 'cmd': ('bash', 04:57:18 INFO - '-c', 04:57:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:57:18 INFO - 'enabled': True, 04:57:18 INFO - 'halt_on_failure': False, 04:57:18 INFO - 'name': 'check_screen_resolution'},), 04:57:18 INFO - 'run_cmd_checks_enabled': True, 04:57:18 INFO - 'sps_profile': False, 04:57:18 INFO - 'sps_profile_interval': 0, 04:57:18 INFO - 'suite': 'dromaeojs', 04:57:18 INFO - 'system_bits': '32', 04:57:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:57:18 INFO - 'title': 't-yosemite-r7-0085', 04:57:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:57:18 INFO - 'use_talos_json': True, 04:57:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:57:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:57:18 INFO - 'work_dir': 'build'} 04:57:18 INFO - ##### 04:57:18 INFO - ##### Running clobber step. 04:57:18 INFO - ##### 04:57:18 INFO - Running pre-action listener: _resource_record_pre_action 04:57:18 INFO - Running main action method: clobber 04:57:18 INFO - rmtree: /builds/slave/test/build 04:57:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:57:20 INFO - Running post-action listener: _resource_record_post_action 04:57:20 INFO - ##### 04:57:20 INFO - ##### Finished clobber step (success) 04:57:20 INFO - ##### 04:57:20 INFO - ##### 04:57:20 INFO - ##### Running read-buildbot-config step. 04:57:20 INFO - ##### 04:57:20 INFO - Running pre-action listener: _resource_record_pre_action 04:57:20 INFO - Running main action method: read_buildbot_config 04:57:20 INFO - Using buildbot properties: 04:57:20 INFO - { 04:57:20 INFO - "project": "", 04:57:20 INFO - "product": "firefox", 04:57:20 INFO - "script_repo_revision": "production", 04:57:20 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:57:20 INFO - "repository": "", 04:57:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:57:20 INFO - "buildid": "20160712030624", 04:57:20 INFO - "pgo_build": "False", 04:57:20 INFO - "basedir": "/builds/slave/test", 04:57:20 INFO - "buildnumber": 80, 04:57:20 INFO - "slavename": "t-yosemite-r7-0085", 04:57:20 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:57:20 INFO - "platform": "yosemite_r7", 04:57:20 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:57:20 INFO - "branch": "fx-team", 04:57:20 INFO - "repo_path": "integration/fx-team", 04:57:20 INFO - "revision": "173d493da6f57a15facef6dbf18f4be49e1c6bb4", 04:57:20 INFO - "stage_platform": "macosx64", 04:57:20 INFO - "builduid": "89e5261475c24fce978b6690bf08fbe4", 04:57:20 INFO - "slavebuilddir": "test" 04:57:20 INFO - } 04:57:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 04:57:20 INFO - Running post-action listener: _resource_record_post_action 04:57:20 INFO - ##### 04:57:20 INFO - ##### Finished read-buildbot-config step (success) 04:57:20 INFO - ##### 04:57:20 INFO - ##### 04:57:20 INFO - ##### Running download-and-extract step. 04:57:20 INFO - ##### 04:57:20 INFO - Running pre-action listener: _resource_record_pre_action 04:57:20 INFO - Running main action method: download_and_extract 04:57:20 INFO - mkdir: /builds/slave/test/build/tests 04:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:20 INFO - https://queue.taskcluster.net/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:57:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 04:57:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 04:57:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 04:57:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 04:57:21 INFO - Downloaded 1199 bytes. 04:57:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 04:57:21 INFO - Using the following test package requirements: 04:57:21 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 04:57:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:57:21 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 04:57:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:57:21 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 04:57:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:57:21 INFO - u'jsshell-mac.zip'], 04:57:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:57:21 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 04:57:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 04:57:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:57:21 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 04:57:21 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:57:21 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 04:57:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:57:21 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 04:57:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:57:21 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 04:57:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:21 INFO - https://queue.taskcluster.net/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:57:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:57:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:57:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:57:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:57:23 INFO - Downloaded 18772442 bytes. 04:57:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:57:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:57:26 INFO - Return code: 0 04:57:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:26 INFO - https://queue.taskcluster.net/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:57:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:57:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:57:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:57:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:57:27 INFO - Downloaded 18772442 bytes. 04:57:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:57:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:57:31 INFO - Return code: 0 04:57:31 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:31 INFO - https://queue.taskcluster.net/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:57:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 04:57:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 04:57:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 04:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:57:32 INFO - Downloaded 14403317 bytes. 04:57:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:57:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:57:32 INFO - Return code: 0 04:57:32 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:32 INFO - https://queue.taskcluster.net/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:57:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:57:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:57:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 04:57:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 04:57:35 INFO - Downloaded 112425344 bytes. 04:57:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:57:35 INFO - mkdir: /builds/slave/test/properties 04:57:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:57:35 INFO - Writing to file /builds/slave/test/properties/build_url 04:57:35 INFO - Contents: 04:57:35 INFO - build_url:https://queue.taskcluster.net/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:57:36 INFO - Running post-action listener: _resource_record_post_action 04:57:36 INFO - Running post-action listener: set_extra_try_arguments 04:57:36 INFO - ##### 04:57:36 INFO - ##### Finished download-and-extract step (success) 04:57:36 INFO - ##### 04:57:36 INFO - ##### 04:57:36 INFO - ##### Running populate-webroot step. 04:57:36 INFO - ##### 04:57:36 INFO - Running pre-action listener: _resource_record_pre_action 04:57:36 INFO - Running main action method: populate_webroot 04:57:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:57:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:57:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:57:36 INFO - '--tppagecycles', 04:57:36 INFO - '7'], 04:57:36 INFO - 'tests': ['tsvgm']}}, 04:57:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:57:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:57:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:57:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:57:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:57:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:57:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:36 INFO - 'talos_options': ['--disable-e10s'], 04:57:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:36 INFO - 'talos_options': ['--disable-e10s'], 04:57:36 INFO - 'tests': ['damp', 'tps']}, 04:57:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:36 INFO - 'tests': ['damp', 'tps']}, 04:57:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:57:36 INFO - 'tests': ['dromaeo_dom']}, 04:57:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:57:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:57:36 INFO - 'tests': ['basic_compositor_video']}, 04:57:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:57:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:57:36 INFO - 'tests': ['a11yr', 04:57:36 INFO - 'ts_paint', 04:57:36 INFO - 'tpaint', 04:57:36 INFO - 'sessionrestore', 04:57:36 INFO - 'sessionrestore_no_auto_restore', 04:57:36 INFO - 'tabpaint']}, 04:57:36 INFO - 'other-e10s': {'tests': ['a11yr', 04:57:36 INFO - 'ts_paint', 04:57:36 INFO - 'tpaint', 04:57:36 INFO - 'sessionrestore', 04:57:36 INFO - 'sessionrestore_no_auto_restore', 04:57:36 INFO - 'tabpaint']}, 04:57:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:57:36 INFO - 'ts_paint', 04:57:36 INFO - 'tpaint', 04:57:36 INFO - 'sessionrestore', 04:57:36 INFO - 'sessionrestore_no_auto_restore', 04:57:36 INFO - 'tabpaint']}, 04:57:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:57:36 INFO - 'ts_paint', 04:57:36 INFO - 'tpaint', 04:57:36 INFO - 'sessionrestore', 04:57:36 INFO - 'sessionrestore_no_auto_restore', 04:57:36 INFO - 'tabpaint']}, 04:57:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:57:36 INFO - 'tests': ['a11yr', 04:57:36 INFO - 'ts_paint', 04:57:36 INFO - 'tpaint', 04:57:36 INFO - 'sessionrestore', 04:57:36 INFO - 'sessionrestore_no_auto_restore', 04:57:36 INFO - 'tabpaint']}, 04:57:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:57:36 INFO - 'tests': ['a11yr', 04:57:36 INFO - 'ts_paint', 04:57:36 INFO - 'tpaint', 04:57:36 INFO - 'sessionrestore', 04:57:36 INFO - 'sessionrestore_no_auto_restore', 04:57:36 INFO - 'tabpaint']}, 04:57:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:57:36 INFO - 'tests': ['tsvgx', 04:57:36 INFO - 'tsvgr_opacity', 04:57:36 INFO - 'tart', 04:57:36 INFO - 'tscrollx', 04:57:36 INFO - 'cart']}, 04:57:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:57:36 INFO - 'tsvgr_opacity', 04:57:36 INFO - 'tart', 04:57:36 INFO - 'tscrollx', 04:57:36 INFO - 'cart']}, 04:57:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:36 INFO - 'talos_options': ['--disable-e10s'], 04:57:36 INFO - 'tests': ['tp5o']}, 04:57:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:36 INFO - 'tests': ['tp5o']}, 04:57:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:36 INFO - 'talos_options': ['--disable-e10s', 04:57:36 INFO - '--xperf_path', 04:57:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:36 INFO - 'tests': ['tp5n']}, 04:57:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:36 INFO - 'talos_options': ['--xperf_path', 04:57:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:36 INFO - 'tests': ['tp5n']}}, 04:57:36 INFO - 'talos.zip': {'path': '', 04:57:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:57:36 INFO - Running post-action listener: _resource_record_post_action 04:57:36 INFO - ##### 04:57:36 INFO - ##### Finished populate-webroot step (success) 04:57:36 INFO - ##### 04:57:36 INFO - ##### 04:57:36 INFO - ##### Running create-virtualenv step. 04:57:36 INFO - ##### 04:57:36 INFO - Running pre-action listener: _resource_record_pre_action 04:57:36 INFO - Running main action method: create_virtualenv 04:57:36 INFO - Creating virtualenv /builds/slave/test/build/venv 04:57:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:57:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:57:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:57:36 INFO - Using real prefix '/tools/python27' 04:57:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:57:37 INFO - Installing distribute.............................................................................................................................................................................................done. 04:57:40 INFO - Installing pip.................done. 04:57:40 INFO - Return code: 0 04:57:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d13fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0e3d7ddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a3d30>, '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 0x10ce08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09bb20>, '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.saWrIQYfro/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.rrfZNg8xFI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:57:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:57:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.saWrIQYfro/Render', 04:57:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:40 INFO - 'HOME': '/Users/cltbld', 04:57:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:40 INFO - 'LOGNAME': 'cltbld', 04:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:40 INFO - 'MOZ_NO_REMOTE': '1', 04:57:40 INFO - 'NO_EM_RESTART': '1', 04:57:40 INFO - 'PAGER': '/bin/cat', 04:57:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:40 INFO - 'PWD': '/builds/slave/test', 04:57:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:40 INFO - 'SHELL': '/bin/bash', 04:57:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rrfZNg8xFI/Listeners', 04:57:40 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:57:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:40 INFO - 'USER': 'cltbld', 04:57:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:40 INFO - 'XPC_FLAGS': '0x0', 04:57:40 INFO - 'XPC_SERVICE_NAME': '0', 04:57:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:57:40 INFO - Cleaning up... 04:57:40 INFO - Return code: 0 04:57:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d13fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0e3d7ddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a3d30>, '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 0x10ce08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09bb20>, '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.saWrIQYfro/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.rrfZNg8xFI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:57:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:57:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.saWrIQYfro/Render', 04:57:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:40 INFO - 'HOME': '/Users/cltbld', 04:57:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:40 INFO - 'LOGNAME': 'cltbld', 04:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:40 INFO - 'MOZ_NO_REMOTE': '1', 04:57:40 INFO - 'NO_EM_RESTART': '1', 04:57:40 INFO - 'PAGER': '/bin/cat', 04:57:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:40 INFO - 'PWD': '/builds/slave/test', 04:57:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:40 INFO - 'SHELL': '/bin/bash', 04:57:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rrfZNg8xFI/Listeners', 04:57:40 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:57:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:40 INFO - 'USER': 'cltbld', 04:57:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:40 INFO - 'XPC_FLAGS': '0x0', 04:57:40 INFO - 'XPC_SERVICE_NAME': '0', 04:57:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:40 INFO - Downloading/unpacking psutil>=3.1.1 04:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:57:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:43 INFO - Installing collected packages: psutil 04:57:43 INFO - Running setup.py install for psutil 04:57:43 INFO - building 'psutil._psutil_osx' extension 04:57:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:57:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:57:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:57:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:57:44 INFO - building 'psutil._psutil_posix' extension 04:57:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:57:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:57:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:57:44 INFO - ^ 04:57:44 INFO - 1 warning generated. 04:57:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:57:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:44 INFO - Successfully installed psutil 04:57:44 INFO - Cleaning up... 04:57:44 INFO - Return code: 0 04:57:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d13fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0e3d7ddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a3d30>, '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 0x10ce08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09bb20>, '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.saWrIQYfro/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.rrfZNg8xFI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:57: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:57: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 mozsystemmonitor==0.3 04:57:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.saWrIQYfro/Render', 04:57:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:44 INFO - 'HOME': '/Users/cltbld', 04:57:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:44 INFO - 'LOGNAME': 'cltbld', 04:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:44 INFO - 'MOZ_NO_REMOTE': '1', 04:57:44 INFO - 'NO_EM_RESTART': '1', 04:57:44 INFO - 'PAGER': '/bin/cat', 04:57:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:44 INFO - 'PWD': '/builds/slave/test', 04:57:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:44 INFO - 'SHELL': '/bin/bash', 04:57:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rrfZNg8xFI/Listeners', 04:57:44 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:57:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:44 INFO - 'USER': 'cltbld', 04:57:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:44 INFO - 'XPC_FLAGS': '0x0', 04:57:44 INFO - 'XPC_SERVICE_NAME': '0', 04:57:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:57:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:57:47 INFO - Installing collected packages: mozsystemmonitor 04:57:47 INFO - Running setup.py install for mozsystemmonitor 04:57:47 INFO - Successfully installed mozsystemmonitor 04:57:47 INFO - Cleaning up... 04:57:47 INFO - Return code: 0 04:57:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:57:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:47 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 0x10d13fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0e3d7ddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a3d30>, '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 0x10ce08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09bb20>, '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.saWrIQYfro/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.rrfZNg8xFI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:57:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:57:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.saWrIQYfro/Render', 04:57:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:47 INFO - 'HOME': '/Users/cltbld', 04:57:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:47 INFO - 'LOGNAME': 'cltbld', 04:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:47 INFO - 'MOZ_NO_REMOTE': '1', 04:57:47 INFO - 'NO_EM_RESTART': '1', 04:57:47 INFO - 'PAGER': '/bin/cat', 04:57:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:47 INFO - 'PWD': '/builds/slave/test', 04:57:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:47 INFO - 'SHELL': '/bin/bash', 04:57:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rrfZNg8xFI/Listeners', 04:57:47 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:57:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:47 INFO - 'USER': 'cltbld', 04:57:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:47 INFO - 'XPC_FLAGS': '0x0', 04:57:47 INFO - 'XPC_SERVICE_NAME': '0', 04:57:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:47 INFO - Downloading/unpacking jsonschema==2.5.1 04:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:57:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:50 INFO - Downloading functools32-3.2.3-2.tar.gz 04:57:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:57:50 INFO - warning: no files found matching '*.txt' 04:57:50 INFO - no previously-included directories found matching 'build' 04:57:50 INFO - no previously-included directories found matching 'dist' 04:57:50 INFO - no previously-included directories found matching '.git*' 04:57:50 INFO - Installing collected packages: jsonschema, functools32 04:57:50 INFO - Running setup.py install for functools32 04:57:50 INFO - warning: no files found matching '*.txt' 04:57:50 INFO - no previously-included directories found matching 'build' 04:57:50 INFO - no previously-included directories found matching 'dist' 04:57:50 INFO - no previously-included directories found matching '.git*' 04:57:50 INFO - Successfully installed jsonschema functools32 04:57:50 INFO - Cleaning up... 04:57:50 INFO - Return code: 0 04:57:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:50 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 0x10d13fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0e3d7ddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a3d30>, '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 0x10ce08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09bb20>, '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.saWrIQYfro/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.rrfZNg8xFI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:57:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:57:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:57:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.saWrIQYfro/Render', 04:57:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:50 INFO - 'HOME': '/Users/cltbld', 04:57:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:50 INFO - 'LOGNAME': 'cltbld', 04:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:50 INFO - 'MOZ_NO_REMOTE': '1', 04:57:50 INFO - 'NO_EM_RESTART': '1', 04:57:50 INFO - 'PAGER': '/bin/cat', 04:57:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:50 INFO - 'PWD': '/builds/slave/test', 04:57:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:50 INFO - 'SHELL': '/bin/bash', 04:57:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rrfZNg8xFI/Listeners', 04:57:50 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:57:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:50 INFO - 'USER': 'cltbld', 04:57:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:50 INFO - 'XPC_FLAGS': '0x0', 04:57:50 INFO - 'XPC_SERVICE_NAME': '0', 04:57:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:51 INFO - Downloading/unpacking blobuploader==1.2.4 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:53 INFO - Downloading blobuploader-1.2.4.tar.gz 04:57:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:57:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:57:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:54 INFO - Downloading docopt-0.6.1.tar.gz 04:57:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:57:54 INFO - Installing collected packages: blobuploader, requests, docopt 04:57:54 INFO - Running setup.py install for blobuploader 04:57:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:57:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:57:55 INFO - Running setup.py install for requests 04:57:55 INFO - Running setup.py install for docopt 04:57:55 INFO - Successfully installed blobuploader requests docopt 04:57:55 INFO - Cleaning up... 04:57:55 INFO - Return code: 0 04:57:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:55 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 0x10d13fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0e3d7ddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a3d30>, '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 0x10ce08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09bb20>, '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.saWrIQYfro/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.rrfZNg8xFI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:57:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:57:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:57:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.saWrIQYfro/Render', 04:57:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:55 INFO - 'HOME': '/Users/cltbld', 04:57:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:55 INFO - 'LOGNAME': 'cltbld', 04:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:55 INFO - 'MOZ_NO_REMOTE': '1', 04:57:55 INFO - 'NO_EM_RESTART': '1', 04:57:55 INFO - 'PAGER': '/bin/cat', 04:57:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:55 INFO - 'PWD': '/builds/slave/test', 04:57:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:55 INFO - 'SHELL': '/bin/bash', 04:57:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rrfZNg8xFI/Listeners', 04:57:55 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:57:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:55 INFO - 'USER': 'cltbld', 04:57:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:55 INFO - 'XPC_FLAGS': '0x0', 04:57:55 INFO - 'XPC_SERVICE_NAME': '0', 04:57:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:56 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-GNGMkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:56 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-NMAUan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:56 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-sSJIHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:56 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-DX529h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:56 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-MYvkQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:56 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-1UWopa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:56 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-KTYpFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:56 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-E4ASAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:56 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Mncpqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-gnOvME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-7VCIyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-3Yxq03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-79wILi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Rhz4zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-I87Srf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-0BGmUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:57 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-7Lqewa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:57:57 INFO - Running setup.py install for manifestparser 04:57:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:57:58 INFO - Running setup.py install for mozcrash 04:57:58 INFO - Running setup.py install for mozdebug 04:57:58 INFO - Running setup.py install for mozdevice 04:57:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:57:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:57:58 INFO - Running setup.py install for mozfile 04:57:58 INFO - Running setup.py install for mozhttpd 04:57:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:57:58 INFO - Running setup.py install for mozinfo 04:57:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:57:58 INFO - Running setup.py install for mozInstall 04:57:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:57:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:57:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:57:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:57:59 INFO - Running setup.py install for mozleak 04:57:59 INFO - Running setup.py install for mozlog 04:57:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:57:59 INFO - Running setup.py install for moznetwork 04:57:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:57:59 INFO - Running setup.py install for mozprocess 04:57:59 INFO - Running setup.py install for mozprofile 04:57:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:57:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:57:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:57:59 INFO - Running setup.py install for mozrunner 04:57:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:57:59 INFO - Running setup.py install for mozscreenshot 04:58:00 INFO - Running setup.py install for moztest 04:58:00 INFO - Running setup.py install for mozversion 04:58:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:58:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:58:00 INFO - Cleaning up... 04:58:00 INFO - Return code: 0 04:58:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:00 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:00 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 0x10d13fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0e3d7ddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a3d30>, '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 0x10ce08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09bb20>, '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.saWrIQYfro/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.rrfZNg8xFI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:58:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.saWrIQYfro/Render', 04:58:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:00 INFO - 'HOME': '/Users/cltbld', 04:58:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:00 INFO - 'LOGNAME': 'cltbld', 04:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:00 INFO - 'MOZ_NO_REMOTE': '1', 04:58:00 INFO - 'NO_EM_RESTART': '1', 04:58:00 INFO - 'PAGER': '/bin/cat', 04:58:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:00 INFO - 'PWD': '/builds/slave/test', 04:58:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:00 INFO - 'SHELL': '/bin/bash', 04:58:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rrfZNg8xFI/Listeners', 04:58:00 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:58:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:00 INFO - 'USER': 'cltbld', 04:58:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:00 INFO - 'XPC_FLAGS': '0x0', 04:58:00 INFO - 'XPC_SERVICE_NAME': '0', 04:58:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:00 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-TtaCgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:00 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-nQrU8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:00 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)) 04:58:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:00 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Vz0zX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Jk7JNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:01 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)) 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-SUb2Xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-OCPls0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-48VEQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-hvPlz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-YOktKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-wrnoTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-UZzouc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:01 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-VZK1KA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:02 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)) 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-okCv7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-BASuFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:02 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)) 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-nk2Wts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-Uzlvn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:02 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)) 04:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:02 INFO - Running setup.py (path:/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/pip-yo6skJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:58:02 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)) 04:58:02 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)) 04:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:58:02 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)) 04:58:02 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)) 04:58:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:04 INFO - Downloading blessings-1.6.tar.gz 04:58:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:58:05 INFO - Installing collected packages: blessings 04:58:05 INFO - Running setup.py install for blessings 04:58:05 INFO - Successfully installed blessings 04:58:05 INFO - Cleaning up... 04:58:05 INFO - Return code: 0 04:58:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:58:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:05 INFO - Reading from file tmpfile_stdout 04:58:05 INFO - Current package versions: 04:58:05 INFO - blessings == 1.6 04:58:05 INFO - blobuploader == 1.2.4 04:58:05 INFO - docopt == 0.6.1 04:58:05 INFO - functools32 == 3.2.3-2 04:58:05 INFO - jsonschema == 2.5.1 04:58:05 INFO - manifestparser == 1.1 04:58:05 INFO - mozInstall == 1.12 04:58:05 INFO - mozcrash == 0.17 04:58:05 INFO - mozdebug == 0.1 04:58:05 INFO - mozdevice == 0.48 04:58:05 INFO - mozfile == 1.2 04:58:05 INFO - mozhttpd == 0.7 04:58:05 INFO - mozinfo == 0.9 04:58:05 INFO - mozleak == 0.1 04:58:05 INFO - mozlog == 3.2 04:58:05 INFO - moznetwork == 0.27 04:58:05 INFO - mozprocess == 0.23 04:58:05 INFO - mozprofile == 0.28 04:58:05 INFO - mozrunner == 6.12 04:58:05 INFO - mozscreenshot == 0.1 04:58:05 INFO - mozsystemmonitor == 0.3 04:58:05 INFO - moztest == 0.7 04:58:05 INFO - mozversion == 1.4 04:58:05 INFO - psutil == 3.1.1 04:58:05 INFO - requests == 1.2.3 04:58:05 INFO - wsgiref == 0.1.2 04:58:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:05 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 0x10d13fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0e3d7ddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a3d30>, '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 0x10ce08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09bb20>, '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.saWrIQYfro/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.rrfZNg8xFI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:58:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.saWrIQYfro/Render', 04:58:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:05 INFO - 'HOME': '/Users/cltbld', 04:58:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:05 INFO - 'LOGNAME': 'cltbld', 04:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:05 INFO - 'MOZ_NO_REMOTE': '1', 04:58:05 INFO - 'NO_EM_RESTART': '1', 04:58:05 INFO - 'PAGER': '/bin/cat', 04:58:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:05 INFO - 'PWD': '/builds/slave/test', 04:58:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:05 INFO - 'SHELL': '/bin/bash', 04:58:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rrfZNg8xFI/Listeners', 04:58:05 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:58:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:05 INFO - 'USER': 'cltbld', 04:58:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:05 INFO - 'XPC_FLAGS': '0x0', 04:58:05 INFO - 'XPC_SERVICE_NAME': '0', 04:58:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:58:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:58:05 INFO - Cleaning up... 04:58:05 INFO - Return code: 0 04:58:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:58:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:05 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 0x10d13fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1d4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0e3d7ddc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d0a3d30>, '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 0x10ce08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09bb20>, '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.saWrIQYfro/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.rrfZNg8xFI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:58:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.saWrIQYfro/Render', 04:58:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:05 INFO - 'HOME': '/Users/cltbld', 04:58:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:05 INFO - 'LOGNAME': 'cltbld', 04:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:05 INFO - 'MOZ_NO_REMOTE': '1', 04:58:05 INFO - 'NO_EM_RESTART': '1', 04:58:05 INFO - 'PAGER': '/bin/cat', 04:58:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:05 INFO - 'PWD': '/builds/slave/test', 04:58:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:05 INFO - 'SHELL': '/bin/bash', 04:58:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rrfZNg8xFI/Listeners', 04:58:05 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:58:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:05 INFO - 'USER': 'cltbld', 04:58:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:05 INFO - 'XPC_FLAGS': '0x0', 04:58:05 INFO - 'XPC_SERVICE_NAME': '0', 04:58:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:58:06 INFO - Cleaning up... 04:58:06 INFO - Return code: 0 04:58:06 INFO - Running post-action listener: _resource_record_post_action 04:58:06 INFO - Running post-action listener: _start_resource_monitoring 04:58:06 INFO - Starting resource monitoring. 04:58:06 INFO - ##### 04:58:06 INFO - ##### Finished create-virtualenv step (success) 04:58:06 INFO - ##### 04:58:06 INFO - ##### 04:58:06 INFO - ##### Running install step. 04:58:06 INFO - ##### 04:58:06 INFO - Running pre-action listener: _resource_record_pre_action 04:58:06 INFO - Running main action method: install 04:58:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:06 INFO - Reading from file tmpfile_stdout 04:58:06 INFO - Detecting whether we're running mozinstall >=1.0... 04:58:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:58:06 INFO - Reading from file tmpfile_stdout 04:58:06 INFO - Output received: 04:58:06 INFO - Usage: mozinstall [options] installer 04:58:06 INFO - Options: 04:58:06 INFO - -h, --help show this help message and exit 04:58:06 INFO - -d DEST, --destination=DEST 04:58:06 INFO - Directory to install application into. [default: 04:58:06 INFO - "/builds/slave/test"] 04:58:06 INFO - --app=APP Application being installed. [default: firefox] 04:58:06 INFO - mkdir: /builds/slave/test/build/application 04:58:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:58:40 INFO - Reading from file tmpfile_stdout 04:58:40 INFO - Output received: 04:58:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:58:40 INFO - Running post-action listener: _resource_record_post_action 04:58:40 INFO - ##### 04:58:40 INFO - ##### Finished install step (success) 04:58:40 INFO - ##### 04:58:40 INFO - ##### 04:58:40 INFO - ##### Running run-tests step. 04:58:40 INFO - ##### 04:58:40 INFO - Running pre-action listener: _resource_record_pre_action 04:58:40 INFO - Running main action method: run_tests 04:58:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:58:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:58:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:58:40 INFO - 2016-07-12 04:58:40.480 screenresolution[1924:10845] starting screenresolution argv=screenresolution get 04:58:40 INFO - 2016-07-12 04:58:40.482 screenresolution[1924:10845] Display 0: 1600x1200x32@60 04:58:40 INFO - 2016-07-12 04:58:40.489 screenresolution[1925:10848] starting screenresolution argv=screenresolution list 04:58:40 INFO - Available Modes on Display 0 04:58:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:58:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:58:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:58:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:58:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:58:40 INFO - Intel Iris: 04:58:40 INFO - Chipset Model: Intel Iris 04:58:40 INFO - Type: GPU 04:58:40 INFO - Bus: Built-In 04:58:40 INFO - VRAM (Dynamic, Max): 1536 MB 04:58:40 INFO - Vendor: Intel (0x8086) 04:58:40 INFO - Device ID: 0x0a2e 04:58:40 INFO - Revision ID: 0x0009 04:58:40 INFO - Displays: 04:58:40 INFO - Display: 04:58:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:58:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:58:40 INFO - Display Serial Number: 1600x1200 60 04:58:40 INFO - Main Display: Yes 04:58:40 INFO - Mirror: Off 04:58:40 INFO - Online: Yes 04:58:40 INFO - Rotation: Supported 04:58:40 INFO - Return code: 0 04:58:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:58:40 INFO - Python 2.7.3 04:58:40 INFO - Return code: 0 04:58:40 INFO - grabbing minidump binary from tooltool 04:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:40 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 0x10d0a3d30>, '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 0x10ce08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d09bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:58:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:58:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:58:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:58:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:58:40 INFO - Return code: 0 04:58:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:58:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:58:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:58:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:58:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:58:40 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/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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 04:58:40 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/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0085 --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 04:58:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.saWrIQYfro/Render', 04:58:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:40 INFO - 'HOME': '/Users/cltbld', 04:58:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:40 INFO - 'LOGNAME': 'cltbld', 04:58:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:58:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:40 INFO - 'MOZ_NO_REMOTE': '1', 04:58:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:58:40 INFO - 'NO_EM_RESTART': '1', 04:58:40 INFO - 'PAGER': '/bin/cat', 04:58:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:40 INFO - 'PWD': '/builds/slave/test', 04:58:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:58:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:40 INFO - 'SHELL': '/bin/bash', 04:58:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rrfZNg8xFI/Listeners', 04:58:40 INFO - 'TMPDIR': '/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/', 04:58:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:40 INFO - 'USER': 'cltbld', 04:58:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:40 INFO - 'XPC_FLAGS': '0x0', 04:58:40 INFO - 'XPC_SERVICE_NAME': '0', 04:58:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:40 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/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0085', '--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 04:58:41 INFO - mozversion application_buildid: 20160712030624 04:58:41 INFO - mozversion application_changeset: 173d493da6f57a15facef6dbf18f4be49e1c6bb4 04:58:41 INFO - mozversion application_display_name: Nightly 04:58:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:58:41 INFO - mozversion application_name: Firefox 04:58:41 INFO - mozversion application_remotingname: firefox 04:58:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:58:41 INFO - mozversion application_vendor: Mozilla 04:58:41 INFO - mozversion application_version: 50.0a1 04:58:41 INFO - mozversion platform_buildid: 20160712030624 04:58:41 INFO - mozversion platform_changeset: 173d493da6f57a15facef6dbf18f4be49e1c6bb4 04:58:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:58:41 INFO - mozversion platform_version: 50.0a1 04:58:41 INFO - using testdate: 1468324721 04:58:41 INFO - actual date: 1468324721 04:58:41 INFO - starting webserver on 'localhost:50334' 04:58:41 INFO - SUITE-START | Running 2 tests 04:58:41 INFO - TEST-START | dromaeo_css 04:58:41 INFO - operating with platform_type : mac_ 04:58:41 INFO - Initialising browser for dromaeo_css test... 04:58:41 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpG0UgSG/profile http://localhost:50334/getInfo.html) 04:58:43 INFO - PROCESS | 1935 | __metrics Screen width/height:1600/1200 04:58:43 INFO - PROCESS | 1935 | colorDepth:24 04:58:43 INFO - PROCESS | 1935 | Browser inner width/height: 1024/689 04:58:43 INFO - PROCESS | 1935 | __metrics 04:58:43 INFO - PROCESS | 1935 | 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" 04:58:43 INFO - PROCESS | 1935 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:58:44 INFO - TEST-INFO | 1935: exit 0 04:58:44 INFO - Browser initialized. 04:58:44 INFO - Running cycle 1/1 for dromaeo_css test... 04:58:44 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmpG0UgSG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:56 INFO - PROCESS | 1937 | RSS: Main: 243527680 04:58:56 INFO - PROCESS | 1937 | 04:59:47 INFO - PROCESS | 1937 | 1468324787195 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] 05:01:58 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50334/tests/dromaeo/cssquery-ext.html) 05:02:00 INFO - PROCESS | 1937 | RSS: Main: 369291264 05:02:00 INFO - PROCESS | 1937 | 05:05:03 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-ext.html (next: http://localhost:50334/tests/dromaeo/cssquery-jquery.html) 05:05:04 INFO - PROCESS | 1937 | RSS: Main: 381104128 05:05:04 INFO - PROCESS | 1937 | 05:08:06 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50334/tests/dromaeo/cssquery-mootools.html) 05:08:06 INFO - PROCESS | 1937 | RSS: Main: 372248576 05:08:06 INFO - PROCESS | 1937 | 05:11:09 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50334/tests/dromaeo/cssquery-prototype.html) 05:11:09 INFO - PROCESS | 1937 | RSS: Main: 368230400 05:11:09 INFO - PROCESS | 1937 | 05:14:13 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50334/tests/dromaeo/cssquery-yui.html) 05:14:13 INFO - PROCESS | 1937 | RSS: Main: 334868480 05:14:13 INFO - PROCESS | 1937 | 05:17:17 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:50334/tests/dromaeo/cssquery-yui.html (next: http://localhost:50334/tests/dromaeo/cssquery-dojo.html) 05:17:17 INFO - PROCESS | 1937 | RSS: Main: 381603840 05:17:17 INFO - PROCESS | 1937 | 05:17:17 INFO - PROCESS | 1937 | __start_tp_report 05:17:17 INFO - PROCESS | 1937 | _x_x_mozilla_page_load 05:17:17 INFO - PROCESS | 1937 | _x_x_mozilla_page_load_details 05:17:17 INFO - PROCESS | 1937 | |i|pagename|runs| 05:17:17 INFO - PROCESS | 1937 | |0;dojo.html;3251.2684645954655;3369.0061431877607;3396.167938854981;3396.6942975132242;3437.7624055340075;5599.272094627693;5678.290213723285;5687.573431992597;5769.336526299477;5771.855703607417;4825.420949486058;5695.515881150107;5726.284214473191;5805.767769289223;5824.301083869942;5160.122779127539;5168.379794424655;5204.9479505204845;5221.21681747739;5221.425643179247;5209.453007434222;5226.7909283628605;5257.342832145981;5293.417724050351;5316.9202461963105;5139.640225184201;5192.766325515361;5194.844154675328;5237.2144178373355;5265.973670131644;5223;5223.973880130613;5238.161894096965;5242.606804489678;5246.134387826042;5141.485851414866;5182.196759502283;5195.558377537914;5203.765830537635;5217.321748172713;5681.034224181858;5698.34469036062;5720.656760594336;5734.967705812952;5759.942400575983;6122.510199184055;6185.907211391833;6186.257649082094;6254.249490061176;6319.273283572356;6272.686365681698;6279.8744025119695;6318.526110541682;6339.1442155308905;6351.809445716636;5675.971620141873;5737.225474560881;5856.94143058564;5860.677662728548;5873.7944171954205;6292.087647291117;6311.905321420182;6327.651979141099;6355.841103972438;6363.872722545523;6139.894818932546;6157.1072194532435;6159.938400616026;6161.8459538511;6170.382961703884;6103.155845961327;6179.62922224668;6242.843928901813;6277;6294.8111556653375;6228.377162283736;6233.252009758858;6234.314225435199;6236.6258024518675;6255.374462553799;6257.436830685169;6270.529710271748;6271.372862713783;6272.341404152589;6305.3379395163765;4897.2654101885;4948;4950.801967921243;4985.296455253549;4993.4756850530175;4474.194644963938;4486.977565112154;4497.033137875373;4498.617617502484;4523.411956445641;5608.943910560843;5659.179418984224;5684.687342196136;5695.088785794253;5695.658260504383;6103.337669688843;6162.137300777895;6165.260168779685;6184.845378865474;6220.657863817443;5609.8597535061135;5668.943310566841;5674.602777805597;5679.5172410345585;5684.687342196219;5424;5433.886053359052;5451.754671039813;5452.727363631802;5459.481349271813;6258.405451482102;6270.216222972129;6336.144620476269;6337.65142917144;6341.143945567382;6242.500599951902;6315.336889626523;6323.399277068671;6323.494120470444;6328.177336946167;6253.405926436982;6278.968605156945;6318.6840657965995;6324.209473815773;6327.209098862642;5307.9469205309;6050.667213303311;6106.582013105306;6206.875862482635;6226.3151053385;6262.874742505215;6312.43188113072;6325.778597749057;6331.810045698637;6334.6832658365975;6129.2032035835055;6129.877402451837;6131.540134489842;6149.600275982047;6149.661768602769;5136.691798492103;5919.881602367843;6032.095185722177;6085.208922840003;6133.172021777182;5964.671943043174;5983.760649573968;5988.28140623128;6002.129691194665;6050.2437195350585;5684.232628595252;5810.099434587646;6135.263768347827;6137.570370074052;6159.876802464015;5617.606767526398;5867.354590994902;5920.674362910081;5966.254218222723;5967.194428752063 05:17:17 INFO - PROCESS | 1937 | |1;ext.html;470.8469747332117;479.2523663085588;520.973951302435;531.8856445864138;553.5129086403969;30312.848435757816;41538.792306038464;42700;42732.222405543616;42780.786096069554;43765;44078.33882491765;44153.8961525962;44158.55841441585;44289.11421771563;8763.036066032731;9765.804683906335;9937.205023598095;9951.950240248789;9953.701388958307;8766.430182038148;9951.800963980717;11921.225120367148;12101.757964840697;12241.632751017483;12051.638450846489;12075.09436792244;12106.213096148766;12108.27350358977;12111.152219344649;8780.165884240987;11623.59317423886;11972.64082077539;12042.397880106048;12075.939620301842;11622.941885290604;11900;11904.107191960638;11911.927926486658;11932.642020739391;41525;41866;41909.161816763495;41941;41953.79023104895;3804.9809750951345;3807.5240594925635;4284.721493102969;4294.26997410441;4483.417155769762;31622;32690.855820046185;32772.6722732772;32933.01200963975;32963.50554741681;3269.9019029429155;3323.7341012718925;3442.294329662413;3468.739844511672;3469.444888817802;503195;503722;504085;505354.4732276352;505665.471672643;62616.37383626105;62842.37157628457;62917;62918;62946;65223.347766522675;65763;65844;65845.67077164583;65993;16835.242414091394;17092.48722538326;17100.973941563298;17102.401415950382;17115.572110697332;11351.148663850245;11889.643310700692;11933.940330298294;13239.073264871558;13342;17191.742123868153;17224;17230.483085507454;17237.051962142203;17264.395746149075;5953.9878220702585;7063.717451301993;7232.602206878567;7236.054019394908;7376.299251571092;695.6553576904179;958.8513780364054;1029.624187171692;1051.348164138239;1073.9087177589993;28355;28476.43047139087;29014.564781528294;30024.84987575092;31172.376552468824;1090.53323280188;1097.4512743628186;1173.1494666366816;1240.8510978682616;1270.0728468218254;15831.050136991817;15855;15960;16143.354265829235;16249.350025999063;631501;636679;644022;648562.7571862205;648709;58681;59122.11316830251;59135.81728365408;59147.704261478415;59192.704036480405;1290.6708789258678;1424.6794471243886;1425.1449130521812;1450.108183467139;1462.203099310878;32432.675673242964;32485.83757081294;32602.83698581492;32673.34653306873;33477.16307092342;42929.35605965975;51995.48004519907;52404.21393679021;52536;52647.21029184642;530994;534281.3285933546;534683;537115;537331;35572.288554229286;42075.368869467595;42826.92932676708;42854;44109.33835992398;49894.75052624714;50111.24833127579;50443.747781262326;50903.74548127236;51485;40589.59410405976;41264.1747165049;41347.1730565381;42190;42460;40393.798031009654;40570.9857253571;40900.79549602352;41502.584974149875;41670.58329416667;39567;39796.40305395479;39937;39953;40192.598074020054;34621.826890865384;35044.82477587596;35793.46309805407;36751;36842.63157368392;25632.487350253265;26186.476270474104;26337;26590.468190635693;26924.865375672995 05:17:17 INFO - PROCESS | 1937 | |2;jquery.html;365.7403243696975;386;393.744066356868;394.9526056873174;418.90784027513934;15857.682846343067;18078.186481608325;21026.684599731016;22160.335189944286;22246.110155593797;20913.477163070893;21822.563548729016;22189.445263868412;22215.555688886212;22217.2223972161;5740.282464691913;5753.884922301551;6004.069369247752;6050.183225264577;6054.788082417116;5802.216700745409;5869.090291004901;5870.823875283727;5871.823845284648;5884.588078834483;4894.926576101344;5479.835604931858;5609.775608975636;5734.885302293952;5829.941700583004;5766.82699519013;5780.450857168562;5797.101449275369;5819.039858423355;5819.039858423376;4954.232094025396;5025.522575355335;5097.9490205097845;5100.744962751847;5105.004524117799;27206.183814485597;27219.863900680568;27270.181894543;27450.45099098007;27530.17409477719;2248.5390494948497;2487.6517287579754;2630.302969713028;2883.6972117927526;3109.3314937288364;15270.618234544114;16021.679566408724;16244.269007894673;16525.66948661032;16526.752098718407;1849.1955999140416;1881.7741870975433;1898.1742941820214;1928.421473557927;1929.6430160420366;97862;97959.53060704024;120163;124048.5190296189;124484.9999999991;10028.498575071217;10551.261411701107;10872;11000.504977276041;11532.25040372373;13123.868761312264;13717.862821371658;13753.587392378246;14130.010899236955;14155.221462819643;7246.746363877239;8594.054653988056;8825.470471771585;8841.204291613656;8921.866172007425;7241.89137162943;8892.066333035067;8896.733098007071;8942;9041.18629323364;6751.704420497054;6862.519623626298;6869.076658535618;6878.69045892936;6967.825804354931;1825.1201262699442;1864.7482589850197;1867.561123136062;1869.6167285706397;1913.8277555020115;848.6972497216742;960.846264597661;990.3117333453181;1086.5979587552656;1093.1965005720947;20708.96455177235;22384.104635814387;23361.649575256386;23405.531889362457;23435.7656423437;942.1144124522926;945.1871390604075;979.8187335342984;1012.8632634594383;1072.6192201768415;10645.627403040857;11757.412129393497;12036.097292703082;12157.452914618863;12339.93830030844;572278.1386093043;594381;597835;608224;611338;108263.83472330667;109068;109215.90784092057;112594;123150;884.6992022712309;1022.5500779656927;1024.9743756406149;1026.6560702164709;1030.5781413677946;20194.99025048771;20387.286444974354;20532.870692112076;20545.075471604112;20572.794272057086;40221.59778402295;43599.78200109106;49971.25043124429;52658.736706316224;53456.46543534515;70025;71445.92831107434;72118.63940680263;72452;72569;6071.817845464643;6830.487713421613;6877.759278425231;8214.876776848472;8278.71024514139;11996.340201289013;12870.613881583567;13334;13339.66650833737;13663.590092297247;5204.9590081983;11123.293132662022;11250.887491124984;11773.47019384147;12047;11705.356205408443;11737.647870563897;11831.585894493652;11870.228435151688;12125.333106679218;11767.470463828977;11969.102317326062;12070.27578345267;12117.636470905887;12140.575079872162;6776.593404395752;8463.915360846559;8574.056853745959;8656.437331573428;8765.60554775024;11202.15983801202;11744.823827642764;11957.342346170695;11979.940100299442;12004.519819207135 05:17:17 INFO - PROCESS | 1937 | |3;mootools.html;1539.0304108411704;1586.5557643859715;1769.929202831886;1905.1331644101936;1914.4448110048086;8417.410781245315;8724.781880452992;8899.288056955444;8900.599473023705;8901.910980890189;7812.609369531529;8039.678412863493;8420.873686894702;8652.30781537477;8704.782380440492;2349.224755830576;2378.774016468433;2383.165891937825;2384.475415408607;2384.618461046233;2359.1271229645054;2359.4573248152933;2389.940251493718;2392.928212153638;2398.5442765874427;2103.2533450625037;2171.381156370435;2316.559853627814;2381.1070848431837;2382.940426489343;2349.4361353275262;2354.7409784923643;2376.239603326936;2378.2865140457793;2386.2841147655636;2350.247920665388;2352.388379021467;2359.8702071386065;2362.1850461590725;2364.7280562735164;8831.60257788401;8896.332775041834;8899.243564297043;8916.15296546827;8942.821143577092;4723.527647235249;5223.320968274138;5378.300820893298;5381.031414345416;5396.325459317585;3469.4102002659356;3560.6973407260416;3623;3646.32542979547;3650.3794354959455;1082.0315817343433;1101.6915263726169;1104.2877344113083;1108.1245815805503;1123.208138262531;11609.941950290278;11624.59313924017;11629.476673549627;11642.24325418845;11665.416729163593;4520.62121053082;4580.541945805393;4758.357621721093;4759.28720629238;4769.570738633471;9916.900830991743;9917.950410247902;9925.851112233322;9932.553035113437;9933.453660048623;5324.121519949165;5343.919841202385;5344.091504444254;5348.277982472394;5348.9465105348445;4729.36153619257;4871.074495845778;4886.584640305543;4897.118518666674;4927.5811556017425;3785.2240290740333;3788.4885540452237;3812.5234345706785;3860.189360234382;3864.516935383077;1099.6151347028476;1103.624767579027;1168.7720894425674;1174.9353785541707;1178.2282604893808;805.3384705520202;842.9915700843036;946.2902822882838;963.7446076789656;978.500964508106;6013.248343957005;6030.517558595302;6083.7870674526175;6197.225346831646;6213.844653883689;915.0940568836936;934.458014351688;938.8732521109563;948.6632245552729;981.3179840011123;3983.48214732083;4069.8168582413864;4073.918521629551;4121.175764847043;4144.79276036197;10528.526216320284;10615.946920265504;10833.241673082966;10845.457727113613;10914.945425272981;9866.062724041205;10781.730456738644;10782.568697252022;10799.082078023455;10824.458777061116;7475.43934204926;7883.093444253869;8178.7955301117945;8204.753857384288;8327.750167494985;6072.848178795565;6188.44304012641;6192.380761923771;6237.7193026314835;6300.0234963580715;8239.670413183405;9736.9026309736;9940.403575785187;9979.900200998187;9992.700218993441;9234.676786312715;10091.495425228855;10098.192144628265;10327.380357178594;10331.896681033093;6973.093497845248;7023.929760702327;7087.043249161504;7216.242294558996;7615.162332143571;8481.194286543016;8491.259291845281;8516.318694504302;8524.957375213084;8530.146985301668;7242.782716518513;7352.264773522605;7394.038774959436;7468.365188958999;7497.887531687138;7051.753188638373;7163.997040414451;7248.311410416002;7300.269973002657;7496.062992125984;6991.021257024123;7087.397571206299;7091.964540177266;7100.893486597808;7102.822429439098;4889.63327750413;4986.775595098156;5031.899362012812;5045.217991211368;5102.336696229615;4912.70523768575;4969.503049695146;5072.644914855925;5100.362454693163;5126 05:17:17 INFO - PROCESS | 1937 | |4;prototype.html;312.63421796498096;314.090707402071;319.17493279871536;322.247551966159;324.13456072286994;5468.917966230505;5469;5488;5489.533389661883;5646.74589643466;4225.408442818008;4671.112488627158;5245.921311180326;5292.788288468466;5356.276902618145;3431.5538979932576;3846.942295865564;3984.422258772476;4049.683852747854;4089.8159582818694;3603.297357015383;3990.8004599770043;4109.486314210723;4112.938305925399;4159.750414975111;3551.4252167178847;3957.4657421248194;4036.688076375175;4051.372037334203;4103.322951712964;3251.9674803252137;3925.7644541327327;4116.867861338141;4117.796978616456;4127.133302006568;3219.2434777827425;3239.88224062698;3375.0718552398043;3539.203679172191;3583.695385892176;4205.621494065549;5079.746012699387;5096.413912400084;5127.359080114986;5185.351831021122;3814.923701525982;4084.8774536763945;4543.182227199103;4630.050839577879;4666.673332866701;5113.463086375951;5524.364698059734;5526.972365138189;5545.225527831055;5672.716364181774;3871.5160604924386;3916.686665066788;3936.2877148440234;3938.9625633725373;3943.507061617298;4807.783649735736;5608.5793565482345;5630.6058575900115;5745.511631511326;5781.710914454303;3972.6492992382728;4011.939820902689;4044.4337792709043;4053.533843608023;4072.185562887375;3519.363495974384;4100;4104.589541045932;4117.526484454326;4133.132042271097;4503.301988191835;4701.78841952113;4703.459102203222;4706.176419126639;4755.19302664992;5533.557315414757;5553.72231388437;5566.415526369754;5615.2700148980375;5625.184348269478;1351.709382482771;1378.676011137382;1379.4206433298039;1388.3405382443461;1397.811295475098;722.1622917415773;787.8851425233345;843.20317300152;848.2323497235012;856.9228769410782;3539.805330683149;4018.7588744675413;4188.141431006637;4321.611055005064;4368.170047690928;4538.591526762607;4839.612830973514;4842.297866809364;4921.2106677858565;4928.275103713671;3716.2162162162313;4009.1380353224195;4029.4560234367987;4318.287482565404;4398.846040388571;2409.0005295604606;2700.7164247754095;2704.986475067612;3097.6127984002;3099.5195744659163;5496.422875598085;5714.885387463843;6040.516758659297;6060.484858786965;6100.444386681368;4978.551930326215;5294.735263236823;5524.861878452991;6025.15647809307;6037;4996.500349964975;5175.560077393388;5394.811181608625;6008.716687658662;6040.577159598786;5745.540356771532;5815.389384114607;5836.270466191726;5848.385919478394;5879.176915231957;4483.529229430993;5389.568834493152;5660.632058916157;5720.169545745322;5779.2775903012125;4636.982912433103;5766.365699772938;5779.092899343291;5793.536517078539;5809.535237180931;3274.541564181064;3644.7448678592245;3767.698584113319;3910.393888947218;3911.1395492991496;4649.628029757679;5086.18621020635;5205.271262023395;5669.829905102853;5891.558133139946;4799.496052914534;4820.758962051954;5184.844454666366;5626.971865140648;5731.3122425307565;4970.478099799469;5480.561555075664;5656.9717151415625;5675.262215911905;5707.514861236841;4731.526847315241;4958.950410495849;5309.920351194813;5562.332520097452;5597;5633.3521645009705;5665.781856900786;5687.744051517609;5712.400197979318;5715.742791574472;4851.58761505276;4870.853874383774;5564.944350556442;5579.2746942897165;5604.719764011865 05:17:17 INFO - PROCESS | 1937 | |5;yui.html;672.0893189727922;720.3624792059029;754.9811254718632;787.9913710450621;859.3254295378127;13469.663258418532;15100.169490678009;16145.354185832568;16412.26144823483;16431;12338.93830530846;14823.777643335332;15001.699966000673;15004.849951500482;15006;706.8020954132838;895.3821862914568;922.7139586728135;926.5182105305271;926.9629214831399;894.0880302091863;907.4419232172199;909.3270979475207;909.8453262945316;910.7996240827008;971.1017308989192;972.4700038479045;972.8297547929119;973.4305431322684;974.4786539201529;763.4808330335342;947.3889341374844;966.333230071252;973.2749101919045;975.5658731864323;721.1706537481886;724.1744411371042;724.5507785173227;725.1624373848214;725.4740313272888;15022.624434389229;15024.248787560578;15052;15056.924715376463;15070.095794252271;14080.15519068859;14214.715705685829;14222.644433889132;14232.003759736823;14287.714245715131;12983.805242921364;13132.540361087316;13299;13389.531366402227;13399.464021439131;4506.143832671782;4628.6991345562765;4652.697574657636;4732.834350797705;4780.80876764929;89824;112029;112714;113799.43100284446;114022;11273;11516.53933842637;11693.006094481894;11734.765304693858;11902.583409580797;22878.542429151323;23017.19439819598;23031.539369212856;23054.42363940915;23060.76939230586;8024.277814996678;8196.139405362352;8234.094249632535;8274.958625206835;8287.8342433151;4465.307877279027;4561.749103799323;4584.931226031612;4650.4186976627925;4706.1528924793865;3538.1862171700136;3658.122050707811;3658.4695219193068;3659.2315613720884;3662.1210909381557;639.4181295021508;663.4360793325635;666.7699643622942;675.9797206083825;678.9966050169817;559.5663360895257;587.3451102021215;620.8199622109628;631.3560168627973;634.8444631065327;8539.117704178376;8776.956115219384;8856.24721898633;8883.33374996865;8958.910410895938;521.2233771680245;593.6279302933862;617.9938200617936;642.133120287608;653.5327241022596;4109.753414795122;4196.793852808205;4355.237833379146;4475.507694153641;4526;124330;127339.3633031829;129734;143304;144480.83278750826;126626;127502;127654;128303;129425.35287323502;111248.44375778231;112871.43564282126;113578.43210783893;116506;118134;9476.33665643426;9751.3661611995;9805.019498050138;9809.705708828747;9835.60657573689;47277.81805454753;54543.64852717027;58382.708086460996;60903.69548152231;61239.08141377794;85072.57463712642;88373.37199710176;92359;93949.36303821793;94157;13537.255450950292;13670.52153174634;13830.65423364424;13925.651858703613;14258.71482570322;12867.613971580868;14266;14869.925650371679;15097.24513774285;15682.988029237946;10412.27114102036;13355;14154.575362739135;14504.34730437154;14524.20116893581;13033.47866085384;14126.223057731924;14475.059121157092;14494.05788623736;14720.337584808494;13585.231759465145;13781.675343019779;13802.171869687449;14152.43390264419;14423.92788036053;11438.370889601152;11908.583199587973;11938.940305298418;12042.337671428155;12218.938905305416;11660.941695291469;11712.297262164297;11735.242218078574;11884.643460696192;11888.762224755283 05:17:17 INFO - PROCESS | 1937 | __end_tp_report 05:17:17 INFO - PROCESS | 1937 | __start_cc_report 05:17:17 INFO - PROCESS | 1937 | _x_x_mozilla_cycle_collect,1269 05:17:17 INFO - PROCESS | 1937 | __end_cc_report 05:17:17 INFO - PROCESS | 1937 | __startTimestamp1468325837461__endTimestamp 05:17:17 INFO - PROCESS | 1937 | 05:17:17 INFO - PROCESS | 1937 | ------- Summary: start ------- 05:17:17 INFO - PROCESS | 1937 | Number of tests: 6 05:17:17 INFO - PROCESS | 1937 | 05:17:17 INFO - PROCESS | 1937 | [#0] dojo.html Cycles:165 Average:5740.99 Median:5920.67 stddev:640.58 (10.8%) stddev-sans-first:612.04 05:17:17 INFO - PROCESS | 1937 | Values: 3251.3 3369.0 3396.2 3396.7 3437.8 5599.3 5678.3 5687.6 5769.3 5771.9 4825.4 5695.5 5726.3 5805.8 5824.3 5160.1 5168.4 5204.9 5221.2 5221.4 5209.5 5226.8 5257.3 5293.4 5316.9 5139.6 5192.8 5194.8 5237.2 5266.0 5223.0 5224.0 5238.2 5242.6 5246.1 5141.5 5182.2 5195.6 5203.8 5217.3 5681.0 5698.3 5720.7 5735.0 5759.9 6122.5 6185.9 6186.3 6254.2 6319.3 6272.7 6279.9 6318.5 6339.1 6351.8 5676.0 5737.2 5856.9 5860.7 5873.8 6292.1 6311.9 6327.7 6355.8 6363.9 6139.9 6157.1 6159.9 6161.8 6170.4 6103.2 6179.6 6242.8 6277.0 6294.8 6228.4 6233.3 6234.3 6236.6 6255.4 6257.4 6270.5 6271.4 6272.3 6305.3 4897.3 4948.0 4950.8 4985.3 4993.5 4474.2 4487.0 4497.0 4498.6 4523.4 5608.9 5659.2 5684.7 5695.1 5695.7 6103.3 6162.1 6165.3 6184.8 6220.7 5609.9 5668.9 5674.6 5679.5 5684.7 5424.0 5433.9 5451.8 5452.7 5459.5 6258.4 6270.2 6336.1 6337.7 6341.1 6242.5 6315.3 6323.4 6323.5 6328.2 6253.4 6279.0 6318.7 6324.2 6327.2 5307.9 6050.7 6106.6 6206.9 6226.3 6262.9 6312.4 6325.8 6331.8 6334.7 6129.2 6129.9 6131.5 6149.6 6149.7 5136.7 5919.9 6032.1 6085.2 6133.2 5964.7 5983.8 5988.3 6002.1 6050.2 5684.2 5810.1 6135.3 6137.6 6159.9 5617.6 5867.4 5920.7 5966.3 5967.2 05:17:17 INFO - PROCESS | 1937 | 05:17:17 INFO - PROCESS | 1937 | [#1] ext.html Cycles:180 Average:70938.35 Median:40580.29 stddev:150145.43 (370.0%) stddev-sans-first:150473.41 05:17:17 INFO - PROCESS | 1937 | Values: 470.8 479.3 521.0 531.9 553.5 30312.8 41538.8 42700.0 42732.2 42780.8 43765.0 44078.3 44153.9 44158.6 44289.1 8763.0 9765.8 9937.2 9952.0 9953.7 8766.4 9951.8 11921.2 12101.8 12241.6 12051.6 12075.1 12106.2 12108.3 12111.2 8780.2 11623.6 11972.6 12042.4 12075.9 11622.9 11900.0 11904.1 11911.9 11932.6 41525.0 41866.0 41909.2 41941.0 41953.8 3805.0 3807.5 4284.7 4294.3 4483.4 31622.0 32690.9 32772.7 32933.0 32963.5 3269.9 3323.7 3442.3 3468.7 3469.4 503195.0 503722.0 504085.0 505354.5 505665.5 62616.4 62842.4 62917.0 62918.0 62946.0 65223.3 65763.0 65844.0 65845.7 65993.0 16835.2 17092.5 17101.0 17102.4 17115.6 11351.1 11889.6 11933.9 13239.1 13342.0 17191.7 17224.0 17230.5 17237.1 17264.4 5954.0 7063.7 7232.6 7236.1 7376.3 695.7 958.9 1029.6 1051.3 1073.9 28355.0 28476.4 29014.6 30024.8 31172.4 1090.5 1097.5 1173.1 1240.9 1270.1 15831.1 15855.0 15960.0 16143.4 16249.4 631501.0 636679.0 644022.0 648562.8 648709.0 58681.0 59122.1 59135.8 59147.7 59192.7 1290.7 1424.7 1425.1 1450.1 1462.2 32432.7 32485.8 32602.8 32673.3 33477.2 42929.4 51995.5 52404.2 52536.0 52647.2 530994.0 534281.3 534683.0 537115.0 537331.0 35572.3 42075.4 42826.9 42854.0 44109.3 49894.8 50111.2 50443.7 50903.7 51485.0 40589.6 41264.2 41347.2 42190.0 42460.0 40393.8 40571.0 40900.8 41502.6 41670.6 39567.0 39796.4 39937.0 39953.0 40192.6 34621.8 35044.8 35793.5 36751.0 36842.6 25632.5 26186.5 26337.0 26590.5 26924.9 05:17:17 INFO - PROCESS | 1937 | 05:17:17 INFO - PROCESS | 1937 | [#2] jquery.html Cycles:180 Average:34525.58 Median:12961.71 stddev:99014.26 (763.9%) stddev-sans-first:99258.80 05:17:17 INFO - PROCESS | 1937 | Values: 365.7 386.0 393.7 395.0 418.9 15857.7 18078.2 21026.7 22160.3 22246.1 20913.5 21822.6 22189.4 22215.6 22217.2 5740.3 5753.9 6004.1 6050.2 6054.8 5802.2 5869.1 5870.8 5871.8 5884.6 4894.9 5479.8 5609.8 5734.9 5829.9 5766.8 5780.5 5797.1 5819.0 5819.0 4954.2 5025.5 5097.9 5100.7 5105.0 27206.2 27219.9 27270.2 27450.5 27530.2 2248.5 2487.7 2630.3 2883.7 3109.3 15270.6 16021.7 16244.3 16525.7 16526.8 1849.2 1881.8 1898.2 1928.4 1929.6 97862.0 97959.5 120163.0 124048.5 124485.0 10028.5 10551.3 10872.0 11000.5 11532.3 13123.9 13717.9 13753.6 14130.0 14155.2 7246.7 8594.1 8825.5 8841.2 8921.9 7241.9 8892.1 8896.7 8942.0 9041.2 6751.7 6862.5 6869.1 6878.7 6967.8 1825.1 1864.7 1867.6 1869.6 1913.8 848.7 960.8 990.3 1086.6 1093.2 20709.0 22384.1 23361.6 23405.5 23435.8 942.1 945.2 979.8 1012.9 1072.6 10645.6 11757.4 12036.1 12157.5 12339.9 572278.1 594381.0 597835.0 608224.0 611338.0 108263.8 109068.0 109215.9 112594.0 123150.0 884.7 1022.6 1025.0 1026.7 1030.6 20195.0 20387.3 20532.9 20545.1 20572.8 40221.6 43599.8 49971.3 52658.7 53456.5 70025.0 71445.9 72118.6 72452.0 72569.0 6071.8 6830.5 6877.8 8214.9 8278.7 11996.3 12870.6 13334.0 13339.7 13663.6 5205.0 11123.3 11250.9 11773.5 12047.0 11705.4 11737.6 11831.6 11870.2 12125.3 11767.5 11969.1 12070.3 12117.6 12140.6 6776.6 8463.9 8574.1 8656.4 8765.6 11202.2 11744.8 11957.3 11979.9 12004.5 05:17:17 INFO - PROCESS | 1937 | 05:17:17 INFO - PROCESS | 1937 | [#3] mootools.html Cycles:180 Average:5707.56 Median:5086.50 stddev:3171.14 (62.3%) stddev-sans-first:3164.56 05:17:17 INFO - PROCESS | 1937 | Values: 1539.0 1586.6 1769.9 1905.1 1914.4 8417.4 8724.8 8899.3 8900.6 8901.9 7812.6 8039.7 8420.9 8652.3 8704.8 2349.2 2378.8 2383.2 2384.5 2384.6 2359.1 2359.5 2389.9 2392.9 2398.5 2103.3 2171.4 2316.6 2381.1 2382.9 2349.4 2354.7 2376.2 2378.3 2386.3 2350.2 2352.4 2359.9 2362.2 2364.7 8831.6 8896.3 8899.2 8916.2 8942.8 4723.5 5223.3 5378.3 5381.0 5396.3 3469.4 3560.7 3623.0 3646.3 3650.4 1082.0 1101.7 1104.3 1108.1 1123.2 11609.9 11624.6 11629.5 11642.2 11665.4 4520.6 4580.5 4758.4 4759.3 4769.6 9916.9 9918.0 9925.9 9932.6 9933.5 5324.1 5343.9 5344.1 5348.3 5348.9 4729.4 4871.1 4886.6 4897.1 4927.6 3785.2 3788.5 3812.5 3860.2 3864.5 1099.6 1103.6 1168.8 1174.9 1178.2 805.3 843.0 946.3 963.7 978.5 6013.2 6030.5 6083.8 6197.2 6213.8 915.1 934.5 938.9 948.7 981.3 3983.5 4069.8 4073.9 4121.2 4144.8 10528.5 10615.9 10833.2 10845.5 10914.9 9866.1 10781.7 10782.6 10799.1 10824.5 7475.4 7883.1 8178.8 8204.8 8327.8 6072.8 6188.4 6192.4 6237.7 6300.0 8239.7 9736.9 9940.4 9979.9 9992.7 9234.7 10091.5 10098.2 10327.4 10331.9 6973.1 7023.9 7087.0 7216.2 7615.2 8481.2 8491.3 8516.3 8525.0 8530.1 7242.8 7352.3 7394.0 7468.4 7497.9 7051.8 7164.0 7248.3 7300.3 7496.1 6991.0 7087.4 7092.0 7100.9 7102.8 4889.6 4986.8 5031.9 5045.2 5102.3 4912.7 4969.5 5072.6 5100.4 5126.0 05:17:17 INFO - PROCESS | 1937 | 05:17:17 INFO - PROCESS | 1937 | [#4] prototype.html Cycles:180 Average:4446.68 Median:4830.19 stddev:1377.83 (28.5%) stddev-sans-first:1346.30 05:17:17 INFO - PROCESS | 1937 | Values: 312.6 314.1 319.2 322.2 324.1 5468.9 5469.0 5488.0 5489.5 5646.7 4225.4 4671.1 5245.9 5292.8 5356.3 3431.6 3846.9 3984.4 4049.7 4089.8 3603.3 3990.8 4109.5 4112.9 4159.8 3551.4 3957.5 4036.7 4051.4 4103.3 3252.0 3925.8 4116.9 4117.8 4127.1 3219.2 3239.9 3375.1 3539.2 3583.7 4205.6 5079.7 5096.4 5127.4 5185.4 3814.9 4084.9 4543.2 4630.1 4666.7 5113.5 5524.4 5527.0 5545.2 5672.7 3871.5 3916.7 3936.3 3939.0 3943.5 4807.8 5608.6 5630.6 5745.5 5781.7 3972.6 4011.9 4044.4 4053.5 4072.2 3519.4 4100.0 4104.6 4117.5 4133.1 4503.3 4701.8 4703.5 4706.2 4755.2 5533.6 5553.7 5566.4 5615.3 5625.2 1351.7 1378.7 1379.4 1388.3 1397.8 722.2 787.9 843.2 848.2 856.9 3539.8 4018.8 4188.1 4321.6 4368.2 4538.6 4839.6 4842.3 4921.2 4928.3 3716.2 4009.1 4029.5 4318.3 4398.8 2409.0 2700.7 2705.0 3097.6 3099.5 5496.4 5714.9 6040.5 6060.5 6100.4 4978.6 5294.7 5524.9 6025.2 6037.0 4996.5 5175.6 5394.8 6008.7 6040.6 5745.5 5815.4 5836.3 5848.4 5879.2 4483.5 5389.6 5660.6 5720.2 5779.3 4637.0 5766.4 5779.1 5793.5 5809.5 3274.5 3644.7 3767.7 3910.4 3911.1 4649.6 5086.2 5205.3 5669.8 5891.6 4799.5 4820.8 5184.8 5627.0 5731.3 4970.5 5480.6 5657.0 5675.3 5707.5 4731.5 4959.0 5309.9 5562.3 5597.0 5633.4 5665.8 5687.7 5712.4 5715.7 4851.6 4870.9 5564.9 5579.3 5604.7 05:17:17 INFO - PROCESS | 1937 | 05:17:17 INFO - PROCESS | 1937 | [#5] yui.html Cycles:180 Average:24544.72 Median:3658.30 stddev:38254.76 (1045.7%) stddev-sans-first:38320.08 05:17:17 INFO - PROCESS | 1937 | Values: 672.1 720.4 755.0 788.0 859.3 13469.7 15100.2 16145.4 16412.3 16431.0 12338.9 14823.8 15001.7 15004.8 15006.0 706.8 895.4 922.7 926.5 927.0 894.1 907.4 909.3 909.8 910.8 971.1 972.5 972.8 973.4 974.5 763.5 947.4 966.3 973.3 975.6 721.2 724.2 724.6 725.2 725.5 15022.6 15024.2 15052.0 15056.9 15070.1 14080.2 14214.7 14222.6 14232.0 14287.7 12983.8 13132.5 13299.0 13389.5 13399.5 4506.1 4628.7 4652.7 4732.8 4780.8 89824.0 112029.0 112714.0 113799.4 114022.0 11273.0 11516.5 11693.0 11734.8 11902.6 22878.5 23017.2 23031.5 23054.4 23060.8 8024.3 8196.1 8234.1 8275.0 8287.8 4465.3 4561.7 4584.9 4650.4 4706.2 3538.2 3658.1 3658.5 3659.2 3662.1 639.4 663.4 666.8 676.0 679.0 559.6 587.3 620.8 631.4 634.8 8539.1 8777.0 8856.2 8883.3 8958.9 521.2 593.6 618.0 642.1 653.5 4109.8 4196.8 4355.2 4475.5 4526.0 124330.0 127339.4 129734.0 143304.0 144480.8 126626.0 127502.0 127654.0 128303.0 129425.4 111248.4 112871.4 113578.4 116506.0 118134.0 9476.3 9751.4 9805.0 9809.7 9835.6 47277.8 54543.6 58382.7 60903.7 61239.1 85072.6 88373.4 92359.0 93949.4 94157.0 13537.3 13670.5 13830.7 13925.7 14258.7 12867.6 14266.0 14869.9 15097.2 15683.0 10412.3 13355.0 14154.6 14504.3 14524.2 13033.5 14126.2 14475.1 14494.1 14720.3 13585.2 13781.7 13802.2 14152.4 14423.9 11438.4 11908.6 11938.9 12042.3 12218.9 11660.9 11712.3 11735.2 11884.6 11888.8 05:17:17 INFO - PROCESS | 1937 | -------- Summary: end -------- 05:17:17 INFO - PROCESS | 1937 | 05:17:18 INFO - TEST-INFO | 1937: exit 0 05:17:18 INFO - TEST-OK | dromaeo_css | took 1117009ms 05:17:18 INFO - TEST-START | kraken 05:17:18 INFO - operating with platform_type : mac_ 05:17:18 INFO - Initialising browser for kraken test... 05:17:18 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmptzHU4X/profile http://localhost:50334/getInfo.html) 05:17:20 INFO - PROCESS | 1941 | __metrics Screen width/height:1600/1200 05:17:20 INFO - PROCESS | 1941 | colorDepth:24 05:17:20 INFO - PROCESS | 1941 | Browser inner width/height: 1024/689 05:17:20 INFO - PROCESS | 1941 | __metrics 05:17:20 INFO - PROCESS | 1941 | 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" 05:17:20 INFO - PROCESS | 1941 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:17:20 INFO - TEST-INFO | 1941: exit 0 05:17:20 INFO - Browser initialized. 05:17:20 INFO - Running cycle 1/1 for kraken test... 05:17:21 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gh/t76btwz501jcblhsxv28_zf400000w/T/tmptzHU4X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:32 INFO - PROCESS | 1942 | RSS: Main: 243408896 05:17:32 INFO - PROCESS | 1942 | 05:17:35 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50334/tests/kraken/driver.html?testName=audio-beat-detection) 05:17:36 INFO - PROCESS | 1942 | RSS: Main: 294170624 05:17:36 INFO - PROCESS | 1942 | 05:17:38 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50334/tests/kraken/driver.html?testName=audio-dft) 05:17:39 INFO - PROCESS | 1942 | RSS: Main: 304386048 05:17:39 INFO - PROCESS | 1942 | 05:17:43 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50334/tests/kraken/driver.html?testName=audio-fft) 05:17:43 INFO - PROCESS | 1942 | RSS: Main: 386072576 05:17:43 INFO - PROCESS | 1942 | 05:17:45 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50334/tests/kraken/driver.html?testName=audio-oscillator) 05:17:46 INFO - PROCESS | 1942 | RSS: Main: 288862208 05:17:46 INFO - PROCESS | 1942 | 05:17:48 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50334/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:17:48 INFO - PROCESS | 1942 | RSS: Main: 292655104 05:17:48 INFO - PROCESS | 1942 | 05:17:51 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50334/tests/kraken/driver.html?testName=imaging-darkroom) 05:17:52 INFO - PROCESS | 1942 | RSS: Main: 328744960 05:17:52 INFO - PROCESS | 1942 | 05:17:55 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50334/tests/kraken/driver.html?testName=imaging-desaturate) 05:17:55 INFO - PROCESS | 1942 | RSS: Main: 330416128 05:17:55 INFO - PROCESS | 1942 | 05:17:58 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50334/tests/kraken/driver.html?testName=json-parse-financial) 05:17:59 INFO - PROCESS | 1942 | RSS: Main: 331837440 05:17:59 INFO - PROCESS | 1942 | 05:18:00 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50334/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:18:01 INFO - PROCESS | 1942 | RSS: Main: 311525376 05:18:01 INFO - PROCESS | 1942 | 05:18:03 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:18:03 INFO - PROCESS | 1942 | RSS: Main: 318128128 05:18:03 INFO - PROCESS | 1942 | 05:18:06 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:18:06 INFO - PROCESS | 1942 | RSS: Main: 315604992 05:18:06 INFO - PROCESS | 1942 | 05:18:09 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:18:10 INFO - PROCESS | 1942 | RSS: Main: 324927488 05:18:10 INFO - PROCESS | 1942 | 05:18:12 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:18:13 INFO - PROCESS | 1942 | RSS: Main: 326434816 05:18:13 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | Cycle 1(1): loaded http://localhost:50334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50334/tests/kraken/driver.html?testName=ai-astar) 05:18:15 INFO - PROCESS | 1942 | RSS: Main: 370053120 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | __start_tp_report 05:18:15 INFO - PROCESS | 1942 | _x_x_mozilla_page_load 05:18:15 INFO - PROCESS | 1942 | _x_x_mozilla_page_load_details 05:18:15 INFO - PROCESS | 1942 | |i|pagename|runs| 05:18:15 INFO - PROCESS | 1942 | |0;ai-astar;101;114;112;111;113;111;113;113;112;111 05:18:15 INFO - PROCESS | 1942 | |1;audio-beat-detection;141;109;106;157;106;108;125;106;139;106 05:18:15 INFO - PROCESS | 1942 | |2;audio-dft;183;185;185;185;184;185;179;182;184;183 05:18:15 INFO - PROCESS | 1942 | |3;audio-fft;79;73;57;108;57;56;62;63;97;75 05:18:15 INFO - PROCESS | 1942 | |4;audio-oscillator;88;85;90;71;71;68;97;70;68;101 05:18:15 INFO - PROCESS | 1942 | |5;imaging-gaussian-blur;86;84;87;84;87;83;87;83;86;84 05:18:15 INFO - PROCESS | 1942 | |6;imaging-darkroom;91;92;92;93;92;93;93;92;92;91 05:18:15 INFO - PROCESS | 1942 | |7;imaging-desaturate;87;87;85;85;84;85;86;86;86;87 05:18:15 INFO - PROCESS | 1942 | |8;json-parse-financial;57;52;54;55;56;55;54;55;54;54 05:18:15 INFO - PROCESS | 1942 | |9;json-stringify-tinderbox;66;71;79;74;74;71;69;70;70;73 05:18:15 INFO - PROCESS | 1942 | |10;stanford-crypto-aes;83;83;96;101;82;84;85;82;83;85 05:18:15 INFO - PROCESS | 1942 | |11;stanford-crypto-ccm;136;128;152;150;129;134;137;133;177;144 05:18:15 INFO - PROCESS | 1942 | |12;stanford-crypto-pbkdf2;162;164;162;164;162;163;160;160;162;160 05:18:15 INFO - PROCESS | 1942 | |13;stanford-crypto-sha256-iterative;67;66;67;66;66;65;66;66;64;63 05:18:15 INFO - PROCESS | 1942 | __end_tp_report 05:18:15 INFO - PROCESS | 1942 | __start_cc_report 05:18:15 INFO - PROCESS | 1942 | _x_x_mozilla_cycle_collect,1997 05:18:15 INFO - PROCESS | 1942 | __end_cc_report 05:18:15 INFO - PROCESS | 1942 | __startTimestamp1468325895565__endTimestamp 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | ------- Summary: start ------- 05:18:15 INFO - PROCESS | 1942 | Number of tests: 14 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.50 stddev:3.70 (3.3%) stddev-sans-first:1.09 05:18:15 INFO - PROCESS | 1942 | Values: 101.0 114.0 112.0 111.0 113.0 111.0 113.0 113.0 112.0 111.0 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | [#1] audio-beat-detection Cycles:10 Average:120.30 Median:117.00 stddev:18.99 (16.2%) stddev-sans-first:18.60 05:18:15 INFO - PROCESS | 1942 | Values: 141.0 109.0 106.0 157.0 106.0 108.0 125.0 106.0 139.0 106.0 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.50 stddev:1.90 (1.0%) stddev-sans-first:2.01 05:18:15 INFO - PROCESS | 1942 | Values: 183.0 185.0 185.0 185.0 184.0 185.0 179.0 182.0 184.0 183.0 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | [#3] audio-fft Cycles:10 Average:72.70 Median:68.00 stddev:17.83 (26.2%) stddev-sans-first:18.77 05:18:15 INFO - PROCESS | 1942 | Values: 79.0 73.0 57.0 108.0 57.0 56.0 62.0 63.0 97.0 75.0 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | [#4] audio-oscillator Cycles:10 Average:80.90 Median:78.00 stddev:12.74 (16.3%) stddev-sans-first:13.25 05:18:15 INFO - PROCESS | 1942 | Values: 88.0 85.0 90.0 71.0 71.0 68.0 97.0 70.0 68.0 101.0 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.66 (1.9%) stddev-sans-first:1.73 05:18:15 INFO - PROCESS | 1942 | Values: 86.0 84.0 87.0 84.0 87.0 83.0 87.0 83.0 86.0 84.0 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | [#6] imaging-darkroom Cycles:10 Average:92.10 Median:92.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 05:18:15 INFO - PROCESS | 1942 | Values: 91.0 92.0 92.0 93.0 92.0 93.0 93.0 92.0 92.0 91.0 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.03 (1.2%) stddev-sans-first:1.00 05:18:15 INFO - PROCESS | 1942 | Values: 87.0 87.0 85.0 85.0 84.0 85.0 86.0 86.0 86.0 87.0 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.35 (2.5%) stddev-sans-first:1.12 05:18:15 INFO - PROCESS | 1942 | Values: 57.0 52.0 54.0 55.0 56.0 55.0 54.0 55.0 54.0 54.0 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.00 stddev:3.53 (4.9%) stddev-sans-first:3.08 05:18:15 INFO - PROCESS | 1942 | Values: 66.0 71.0 79.0 74.0 74.0 71.0 69.0 70.0 70.0 73.0 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:83.50 stddev:6.57 (7.9%) stddev-sans-first:6.85 05:18:15 INFO - PROCESS | 1942 | Values: 83.0 83.0 96.0 101.0 82.0 84.0 85.0 82.0 83.0 85.0 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:140.50 stddev:14.77 (10.5%) stddev-sans-first:15.51 05:18:15 INFO - PROCESS | 1942 | Values: 136.0 128.0 152.0 150.0 129.0 134.0 137.0 133.0 177.0 144.0 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:1.52 (0.9%) stddev-sans-first:1.62 05:18:15 INFO - PROCESS | 1942 | Values: 162.0 164.0 162.0 164.0 162.0 163.0 160.0 160.0 162.0 160.0 05:18:15 INFO - PROCESS | 1942 | 05:18:15 INFO - PROCESS | 1942 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.26 (1.9%) stddev-sans-first:1.24 05:18:15 INFO - PROCESS | 1942 | Values: 67.0 66.0 67.0 66.0 66.0 65.0 66.0 66.0 64.0 63.0 05:18:15 INFO - PROCESS | 1942 | -------- Summary: end -------- 05:18:15 INFO - PROCESS | 1942 | 05:18:16 INFO - TEST-INFO | 1942: exit 0 05:18:16 INFO - TEST-OK | kraken | took 58309ms 05:18:16 INFO - SUITE-END | took 1175s 05:18:16 INFO - Completed test suite (00:19:35) 05:18:16 INFO - javascript benchmark 05:18:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3251.2684645954655, 3369.0061431877607, 3396.167938854981, 3396.6942975132242, 3437.7624055340075, 5599.272094627693, 5678.290213723285, 5687.573431992597, 5769.336526299477, 5771.855703607417, 4825.420949486058, 5695.515881150107, 5726.284214473191, 5805.767769289223, 5824.301083869942, 5160.122779127539, 5168.379794424655, 5204.9479505204845, 5221.21681747739, 5221.425643179247, 5209.453007434222, 5226.7909283628605, 5257.342832145981, 5293.417724050351, 5316.9202461963105, 5139.640225184201, 5192.766325515361, 5194.844154675328, 5237.2144178373355, 5265.973670131644, 5223.0, 5223.973880130613, 5238.161894096965, 5242.606804489678, 5246.134387826042, 5141.485851414866, 5182.196759502283, 5195.558377537914, 5203.765830537635, 5217.321748172713, 5681.034224181858, 5698.34469036062, 5720.656760594336, 5734.967705812952, 5759.942400575983, 6122.510199184055, 6185.907211391833, 6186.257649082094, 6254.249490061176, 6319.273283572356, 6272.686365681698, 6279.8744025119695, 6318.526110541682, 6339.1442155308905, 6351.809445716636, 5675.971620141873, 5737.225474560881, 5856.94143058564, 5860.677662728548, 5873.7944171954205, 6292.087647291117, 6311.905321420182, 6327.651979141099, 6355.841103972438, 6363.872722545523, 6139.894818932546, 6157.1072194532435, 6159.938400616026, 6161.8459538511, 6170.382961703884, 6103.155845961327, 6179.62922224668, 6242.843928901813, 6277.0, 6294.8111556653375, 6228.377162283736, 6233.252009758858, 6234.314225435199, 6236.6258024518675, 6255.374462553799, 6257.436830685169, 6270.529710271748, 6271.372862713783, 6272.341404152589, 6305.3379395163765, 4897.2654101885, 4948.0, 4950.801967921243, 4985.296455253549, 4993.4756850530175, 4474.194644963938, 4486.977565112154, 4497.033137875373, 4498.617617502484, 4523.411956445641, 5608.943910560843, 5659.179418984224, 5684.687342196136, 5695.088785794253, 5695.658260504383, 6103.337669688843, 6162.137300777895, 6165.260168779685, 6184.845378865474, 6220.657863817443, 5609.8597535061135, 5668.943310566841, 5674.602777805597, 5679.5172410345585, 5684.687342196219, 5424.0, 5433.886053359052, 5451.754671039813, 5452.727363631802, 5459.481349271813, 6258.405451482102, 6270.216222972129, 6336.144620476269, 6337.65142917144, 6341.143945567382, 6242.500599951902, 6315.336889626523, 6323.399277068671, 6323.494120470444, 6328.177336946167, 6253.405926436982, 6278.968605156945, 6318.6840657965995, 6324.209473815773, 6327.209098862642, 5307.9469205309, 6050.667213303311, 6106.582013105306, 6206.875862482635, 6226.3151053385, 6262.874742505215, 6312.43188113072, 6325.778597749057, 6331.810045698637, 6334.6832658365975, 6129.2032035835055, 6129.877402451837, 6131.540134489842, 6149.600275982047, 6149.661768602769, 5136.691798492103, 5919.881602367843, 6032.095185722177, 6085.208922840003, 6133.172021777182, 5964.671943043174, 5983.760649573968, 5988.28140623128, 6002.129691194665, 6050.2437195350585, 5684.232628595252, 5810.099434587646, 6135.263768347827, 6137.570370074052, 6159.876802464015, 5617.606767526398, 5867.354590994902, 5920.674362910081, 5966.254218222723, 5967.194428752063], "value": 5700.349118391711, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.8469747332117, 479.2523663085588, 520.973951302435, 531.8856445864138, 553.5129086403969, 30312.848435757816, 41538.792306038464, 42700.0, 42732.222405543616, 42780.786096069554, 43765.0, 44078.33882491765, 44153.8961525962, 44158.55841441585, 44289.11421771563, 8763.036066032731, 9765.804683906335, 9937.205023598095, 9951.950240248789, 9953.701388958307, 8766.430182038148, 9951.800963980717, 11921.225120367148, 12101.757964840697, 12241.632751017483, 12051.638450846489, 12075.09436792244, 12106.213096148766, 12108.27350358977, 12111.152219344649, 8780.165884240987, 11623.59317423886, 11972.64082077539, 12042.397880106048, 12075.939620301842, 11622.941885290604, 11900.0, 11904.107191960638, 11911.927926486658, 11932.642020739391, 41525.0, 41866.0, 41909.161816763495, 41941.0, 41953.79023104895, 3804.9809750951345, 3807.5240594925635, 4284.721493102969, 4294.26997410441, 4483.417155769762, 31622.0, 32690.855820046185, 32772.6722732772, 32933.01200963975, 32963.50554741681, 3269.9019029429155, 3323.7341012718925, 3442.294329662413, 3468.739844511672, 3469.444888817802, 503195.0, 503722.0, 504085.0, 505354.4732276352, 505665.471672643, 62616.37383626105, 62842.37157628457, 62917.0, 62918.0, 62946.0, 65223.347766522675, 65763.0, 65844.0, 65845.67077164583, 65993.0, 16835.242414091394, 17092.48722538326, 17100.973941563298, 17102.401415950382, 17115.572110697332, 11351.148663850245, 11889.643310700692, 11933.940330298294, 13239.073264871558, 13342.0, 17191.742123868153, 17224.0, 17230.483085507454, 17237.051962142203, 17264.395746149075, 5953.9878220702585, 7063.717451301993, 7232.602206878567, 7236.054019394908, 7376.299251571092, 695.6553576904179, 958.8513780364054, 1029.624187171692, 1051.348164138239, 1073.9087177589993, 28355.0, 28476.43047139087, 29014.564781528294, 30024.84987575092, 31172.376552468824, 1090.53323280188, 1097.4512743628186, 1173.1494666366816, 1240.8510978682616, 1270.0728468218254, 15831.050136991817, 15855.0, 15960.0, 16143.354265829235, 16249.350025999063, 631501.0, 636679.0, 644022.0, 648562.7571862205, 648709.0, 58681.0, 59122.11316830251, 59135.81728365408, 59147.704261478415, 59192.704036480405, 1290.6708789258678, 1424.6794471243886, 1425.1449130521812, 1450.108183467139, 1462.203099310878, 32432.675673242964, 32485.83757081294, 32602.83698581492, 32673.34653306873, 33477.16307092342, 42929.35605965975, 51995.48004519907, 52404.21393679021, 52536.0, 52647.21029184642, 530994.0, 534281.3285933546, 534683.0, 537115.0, 537331.0, 35572.288554229286, 42075.368869467595, 42826.92932676708, 42854.0, 44109.33835992398, 49894.75052624714, 50111.24833127579, 50443.747781262326, 50903.74548127236, 51485.0, 40589.59410405976, 41264.1747165049, 41347.1730565381, 42190.0, 42460.0, 40393.798031009654, 40570.9857253571, 40900.79549602352, 41502.584974149875, 41670.58329416667, 39567.0, 39796.40305395479, 39937.0, 39953.0, 40192.598074020054, 34621.826890865384, 35044.82477587596, 35793.46309805407, 36751.0, 36842.63157368392, 25632.487350253265, 26186.476270474104, 26337.0, 26590.468190635693, 26924.865375672995], "value": 21171.029343657803, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.7403243696975, 386.0, 393.744066356868, 394.9526056873174, 418.90784027513934, 15857.682846343067, 18078.186481608325, 21026.684599731016, 22160.335189944286, 22246.110155593797, 20913.477163070893, 21822.563548729016, 22189.445263868412, 22215.555688886212, 22217.2223972161, 5740.282464691913, 5753.884922301551, 6004.069369247752, 6050.183225264577, 6054.788082417116, 5802.216700745409, 5869.090291004901, 5870.823875283727, 5871.823845284648, 5884.588078834483, 4894.926576101344, 5479.835604931858, 5609.775608975636, 5734.885302293952, 5829.941700583004, 5766.82699519013, 5780.450857168562, 5797.101449275369, 5819.039858423355, 5819.039858423376, 4954.232094025396, 5025.522575355335, 5097.9490205097845, 5100.744962751847, 5105.004524117799, 27206.183814485597, 27219.863900680568, 27270.181894543, 27450.45099098007, 27530.17409477719, 2248.5390494948497, 2487.6517287579754, 2630.302969713028, 2883.6972117927526, 3109.3314937288364, 15270.618234544114, 16021.679566408724, 16244.269007894673, 16525.66948661032, 16526.752098718407, 1849.1955999140416, 1881.7741870975433, 1898.1742941820214, 1928.421473557927, 1929.6430160420366, 97862.0, 97959.53060704024, 120163.0, 124048.5190296189, 124484.9999999991, 10028.498575071217, 10551.261411701107, 10872.0, 11000.504977276041, 11532.25040372373, 13123.868761312264, 13717.862821371658, 13753.587392378246, 14130.010899236955, 14155.221462819643, 7246.746363877239, 8594.054653988056, 8825.470471771585, 8841.204291613656, 8921.866172007425, 7241.89137162943, 8892.066333035067, 8896.733098007071, 8942.0, 9041.18629323364, 6751.704420497054, 6862.519623626298, 6869.076658535618, 6878.69045892936, 6967.825804354931, 1825.1201262699442, 1864.7482589850197, 1867.561123136062, 1869.6167285706397, 1913.8277555020115, 848.6972497216742, 960.846264597661, 990.3117333453181, 1086.5979587552656, 1093.1965005720947, 20708.96455177235, 22384.104635814387, 23361.649575256386, 23405.531889362457, 23435.7656423437, 942.1144124522926, 945.1871390604075, 979.8187335342984, 1012.8632634594383, 1072.6192201768415, 10645.627403040857, 11757.412129393497, 12036.097292703082, 12157.452914618863, 12339.93830030844, 572278.1386093043, 594381.0, 597835.0, 608224.0, 611338.0, 108263.83472330667, 109068.0, 109215.90784092057, 112594.0, 123150.0, 884.6992022712309, 1022.5500779656927, 1024.9743756406149, 1026.6560702164709, 1030.5781413677946, 20194.99025048771, 20387.286444974354, 20532.870692112076, 20545.075471604112, 20572.794272057086, 40221.59778402295, 43599.78200109106, 49971.25043124429, 52658.736706316224, 53456.46543534515, 70025.0, 71445.92831107434, 72118.63940680263, 72452.0, 72569.0, 6071.817845464643, 6830.487713421613, 6877.759278425231, 8214.876776848472, 8278.71024514139, 11996.340201289013, 12870.613881583567, 13334.0, 13339.66650833737, 13663.590092297247, 5204.9590081983, 11123.293132662022, 11250.887491124984, 11773.47019384147, 12047.0, 11705.356205408443, 11737.647870563897, 11831.585894493652, 11870.228435151688, 12125.333106679218, 11767.470463828977, 11969.102317326062, 12070.27578345267, 12117.636470905887, 12140.575079872162, 6776.593404395752, 8463.915360846559, 8574.056853745959, 8656.437331573428, 8765.60554775024, 11202.15983801202, 11744.823827642764, 11957.342346170695, 11979.940100299442, 12004.519819207135], "value": 9841.81634791008, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1539.0304108411704, 1586.5557643859715, 1769.929202831886, 1905.1331644101936, 1914.4448110048086, 8417.410781245315, 8724.781880452992, 8899.288056955444, 8900.599473023705, 8901.910980890189, 7812.609369531529, 8039.678412863493, 8420.873686894702, 8652.30781537477, 8704.782380440492, 2349.224755830576, 2378.774016468433, 2383.165891937825, 2384.475415408607, 2384.618461046233, 2359.1271229645054, 2359.4573248152933, 2389.940251493718, 2392.928212153638, 2398.5442765874427, 2103.2533450625037, 2171.381156370435, 2316.559853627814, 2381.1070848431837, 2382.940426489343, 2349.4361353275262, 2354.7409784923643, 2376.239603326936, 2378.2865140457793, 2386.2841147655636, 2350.247920665388, 2352.388379021467, 2359.8702071386065, 2362.1850461590725, 2364.7280562735164, 8831.60257788401, 8896.332775041834, 8899.243564297043, 8916.15296546827, 8942.821143577092, 4723.527647235249, 5223.320968274138, 5378.300820893298, 5381.031414345416, 5396.325459317585, 3469.4102002659356, 3560.6973407260416, 3623.0, 3646.32542979547, 3650.3794354959455, 1082.0315817343433, 1101.6915263726169, 1104.2877344113083, 1108.1245815805503, 1123.208138262531, 11609.941950290278, 11624.59313924017, 11629.476673549627, 11642.24325418845, 11665.416729163593, 4520.62121053082, 4580.541945805393, 4758.357621721093, 4759.28720629238, 4769.570738633471, 9916.900830991743, 9917.950410247902, 9925.851112233322, 9932.553035113437, 9933.453660048623, 5324.121519949165, 5343.919841202385, 5344.091504444254, 5348.277982472394, 5348.9465105348445, 4729.36153619257, 4871.074495845778, 4886.584640305543, 4897.118518666674, 4927.5811556017425, 3785.2240290740333, 3788.4885540452237, 3812.5234345706785, 3860.189360234382, 3864.516935383077, 1099.6151347028476, 1103.624767579027, 1168.7720894425674, 1174.9353785541707, 1178.2282604893808, 805.3384705520202, 842.9915700843036, 946.2902822882838, 963.7446076789656, 978.500964508106, 6013.248343957005, 6030.517558595302, 6083.7870674526175, 6197.225346831646, 6213.844653883689, 915.0940568836936, 934.458014351688, 938.8732521109563, 948.6632245552729, 981.3179840011123, 3983.48214732083, 4069.8168582413864, 4073.918521629551, 4121.175764847043, 4144.79276036197, 10528.526216320284, 10615.946920265504, 10833.241673082966, 10845.457727113613, 10914.945425272981, 9866.062724041205, 10781.730456738644, 10782.568697252022, 10799.082078023455, 10824.458777061116, 7475.43934204926, 7883.093444253869, 8178.7955301117945, 8204.753857384288, 8327.750167494985, 6072.848178795565, 6188.44304012641, 6192.380761923771, 6237.7193026314835, 6300.0234963580715, 8239.670413183405, 9736.9026309736, 9940.403575785187, 9979.900200998187, 9992.700218993441, 9234.676786312715, 10091.495425228855, 10098.192144628265, 10327.380357178594, 10331.896681033093, 6973.093497845248, 7023.929760702327, 7087.043249161504, 7216.242294558996, 7615.162332143571, 8481.194286543016, 8491.259291845281, 8516.318694504302, 8524.957375213084, 8530.146985301668, 7242.782716518513, 7352.264773522605, 7394.038774959436, 7468.365188958999, 7497.887531687138, 7051.753188638373, 7163.997040414451, 7248.311410416002, 7300.269973002657, 7496.062992125984, 6991.021257024123, 7087.397571206299, 7091.964540177266, 7100.893486597808, 7102.822429439098, 4889.63327750413, 4986.775595098156, 5031.899362012812, 5045.217991211368, 5102.336696229615, 4912.70523768575, 4969.503049695146, 5072.644914855925, 5100.362454693163, 5126.0], "value": 4596.126569060682, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.63421796498096, 314.090707402071, 319.17493279871536, 322.247551966159, 324.13456072286994, 5468.917966230505, 5469.0, 5488.0, 5489.533389661883, 5646.74589643466, 4225.408442818008, 4671.112488627158, 5245.921311180326, 5292.788288468466, 5356.276902618145, 3431.5538979932576, 3846.942295865564, 3984.422258772476, 4049.683852747854, 4089.8159582818694, 3603.297357015383, 3990.8004599770043, 4109.486314210723, 4112.938305925399, 4159.750414975111, 3551.4252167178847, 3957.4657421248194, 4036.688076375175, 4051.372037334203, 4103.322951712964, 3251.9674803252137, 3925.7644541327327, 4116.867861338141, 4117.796978616456, 4127.133302006568, 3219.2434777827425, 3239.88224062698, 3375.0718552398043, 3539.203679172191, 3583.695385892176, 4205.621494065549, 5079.746012699387, 5096.413912400084, 5127.359080114986, 5185.351831021122, 3814.923701525982, 4084.8774536763945, 4543.182227199103, 4630.050839577879, 4666.673332866701, 5113.463086375951, 5524.364698059734, 5526.972365138189, 5545.225527831055, 5672.716364181774, 3871.5160604924386, 3916.686665066788, 3936.2877148440234, 3938.9625633725373, 3943.507061617298, 4807.783649735736, 5608.5793565482345, 5630.6058575900115, 5745.511631511326, 5781.710914454303, 3972.6492992382728, 4011.939820902689, 4044.4337792709043, 4053.533843608023, 4072.185562887375, 3519.363495974384, 4100.0, 4104.589541045932, 4117.526484454326, 4133.132042271097, 4503.301988191835, 4701.78841952113, 4703.459102203222, 4706.176419126639, 4755.19302664992, 5533.557315414757, 5553.72231388437, 5566.415526369754, 5615.2700148980375, 5625.184348269478, 1351.709382482771, 1378.676011137382, 1379.4206433298039, 1388.3405382443461, 1397.811295475098, 722.1622917415773, 787.8851425233345, 843.20317300152, 848.2323497235012, 856.9228769410782, 3539.805330683149, 4018.7588744675413, 4188.141431006637, 4321.611055005064, 4368.170047690928, 4538.591526762607, 4839.612830973514, 4842.297866809364, 4921.2106677858565, 4928.275103713671, 3716.2162162162313, 4009.1380353224195, 4029.4560234367987, 4318.287482565404, 4398.846040388571, 2409.0005295604606, 2700.7164247754095, 2704.986475067612, 3097.6127984002, 3099.5195744659163, 5496.422875598085, 5714.885387463843, 6040.516758659297, 6060.484858786965, 6100.444386681368, 4978.551930326215, 5294.735263236823, 5524.861878452991, 6025.15647809307, 6037.0, 4996.500349964975, 5175.560077393388, 5394.811181608625, 6008.716687658662, 6040.577159598786, 5745.540356771532, 5815.389384114607, 5836.270466191726, 5848.385919478394, 5879.176915231957, 4483.529229430993, 5389.568834493152, 5660.632058916157, 5720.169545745322, 5779.2775903012125, 4636.982912433103, 5766.365699772938, 5779.092899343291, 5793.536517078539, 5809.535237180931, 3274.541564181064, 3644.7448678592245, 3767.698584113319, 3910.393888947218, 3911.1395492991496, 4649.628029757679, 5086.18621020635, 5205.271262023395, 5669.829905102853, 5891.558133139946, 4799.496052914534, 4820.758962051954, 5184.844454666366, 5626.971865140648, 5731.3122425307565, 4970.478099799469, 5480.561555075664, 5656.9717151415625, 5675.262215911905, 5707.514861236841, 4731.526847315241, 4958.950410495849, 5309.920351194813, 5562.332520097452, 5597.0, 5633.3521645009705, 5665.781856900786, 5687.744051517609, 5712.400197979318, 5715.742791574472, 4851.58761505276, 4870.853874383774, 5564.944350556442, 5579.2746942897165, 5604.719764011865], "value": 4014.3532579677744, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.0893189727922, 720.3624792059029, 754.9811254718632, 787.9913710450621, 859.3254295378127, 13469.663258418532, 15100.169490678009, 16145.354185832568, 16412.26144823483, 16431.0, 12338.93830530846, 14823.777643335332, 15001.699966000673, 15004.849951500482, 15006.0, 706.8020954132838, 895.3821862914568, 922.7139586728135, 926.5182105305271, 926.9629214831399, 894.0880302091863, 907.4419232172199, 909.3270979475207, 909.8453262945316, 910.7996240827008, 971.1017308989192, 972.4700038479045, 972.8297547929119, 973.4305431322684, 974.4786539201529, 763.4808330335342, 947.3889341374844, 966.333230071252, 973.2749101919045, 975.5658731864323, 721.1706537481886, 724.1744411371042, 724.5507785173227, 725.1624373848214, 725.4740313272888, 15022.624434389229, 15024.248787560578, 15052.0, 15056.924715376463, 15070.095794252271, 14080.15519068859, 14214.715705685829, 14222.644433889132, 14232.003759736823, 14287.714245715131, 12983.805242921364, 13132.540361087316, 13299.0, 13389.531366402227, 13399.464021439131, 4506.143832671782, 4628.6991345562765, 4652.697574657636, 4732.834350797705, 4780.80876764929, 89824.0, 112029.0, 112714.0, 113799.43100284446, 114022.0, 11273.0, 11516.53933842637, 11693.006094481894, 11734.765304693858, 11902.583409580797, 22878.542429151323, 23017.19439819598, 23031.539369212856, 23054.42363940915, 23060.76939230586, 8024.277814996678, 8196.139405362352, 8234.094249632535, 8274.958625206835, 8287.8342433151, 4465.307877279027, 4561.749103799323, 4584.931226031612, 4650.4186976627925, 4706.1528924793865, 3538.1862171700136, 3658.122050707811, 3658.4695219193068, 3659.2315613720884, 3662.1210909381557, 639.4181295021508, 663.4360793325635, 666.7699643622942, 675.9797206083825, 678.9966050169817, 559.5663360895257, 587.3451102021215, 620.8199622109628, 631.3560168627973, 634.8444631065327, 8539.117704178376, 8776.956115219384, 8856.24721898633, 8883.33374996865, 8958.910410895938, 521.2233771680245, 593.6279302933862, 617.9938200617936, 642.133120287608, 653.5327241022596, 4109.753414795122, 4196.793852808205, 4355.237833379146, 4475.507694153641, 4526.0, 124330.0, 127339.3633031829, 129734.0, 143304.0, 144480.83278750826, 126626.0, 127502.0, 127654.0, 128303.0, 129425.35287323502, 111248.44375778231, 112871.43564282126, 113578.43210783893, 116506.0, 118134.0, 9476.33665643426, 9751.3661611995, 9805.019498050138, 9809.705708828747, 9835.60657573689, 47277.81805454753, 54543.64852717027, 58382.708086460996, 60903.69548152231, 61239.08141377794, 85072.57463712642, 88373.37199710176, 92359.0, 93949.36303821793, 94157.0, 13537.255450950292, 13670.52153174634, 13830.65423364424, 13925.651858703613, 14258.71482570322, 12867.613971580868, 14266.0, 14869.925650371679, 15097.24513774285, 15682.988029237946, 10412.27114102036, 13355.0, 14154.575362739135, 14504.34730437154, 14524.20116893581, 13033.47866085384, 14126.223057731924, 14475.059121157092, 14494.05788623736, 14720.337584808494, 13585.231759465145, 13781.675343019779, 13802.171869687449, 14152.43390264419, 14423.92788036053, 11438.370889601152, 11908.583199587973, 11938.940305298418, 12042.337671428155, 12218.938905305416, 11660.941695291469, 11712.297262164297, 11735.242218078574, 11884.643460696192, 11888.762224755283], "value": 7994.977511635792, "unit": "score"}], "name": "dromaeo_css", "value": 7480.526435166389, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 114.0, 112.0, 111.0, 113.0, 111.0, 113.0, 113.0, 112.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 106.0, 157.0, 106.0, 108.0, 125.0, 106.0, 139.0, 106.0], "value": 120.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 185.0, 185.0, 184.0, 185.0, 179.0, 182.0, 184.0, 183.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 57.0, 108.0, 57.0, 56.0, 62.0, 63.0, 97.0, 75.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 90.0, 71.0, 71.0, 68.0, 97.0, 70.0, 68.0, 101.0], "value": 80.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 84.0, 87.0, 83.0, 87.0, 83.0, 86.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 92.0, 93.0, 92.0, 93.0, 93.0, 92.0, 92.0, 91.0], "value": 92.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 85.0, 85.0, 84.0, 85.0, 86.0, 86.0, 86.0, 87.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 54.0, 55.0, 56.0, 55.0, 54.0, 55.0, 54.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 79.0, 74.0, 74.0, 71.0, 69.0, 70.0, 70.0, 73.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 96.0, 101.0, 82.0, 84.0, 85.0, 82.0, 83.0, 85.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 128.0, 152.0, 150.0, 129.0, 134.0, 137.0, 133.0, 177.0, 144.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 164.0, 162.0, 163.0, 160.0, 160.0, 162.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 66.0, 65.0, 66.0, 66.0, 64.0, 63.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1413.7, "alertThreshold": 2.0}]} 05:18:16 INFO - Return code: 0 05:18:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:18:16 INFO - # TBPL SUCCESS # 05:18:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:18:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:18:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:18:16 INFO - 2016-07-12 05:18:16.882 screenresolution[1946:12757] starting screenresolution argv=screenresolution get 05:18:16 INFO - 2016-07-12 05:18:16.884 screenresolution[1946:12757] Display 0: 1600x1200x32@60 05:18:16 INFO - 2016-07-12 05:18:16.890 screenresolution[1947:12760] starting screenresolution argv=screenresolution list 05:18:16 INFO - Available Modes on Display 0 05:18:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:18:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:18:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:18:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:18:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:18:17 INFO - Intel Iris: 05:18:17 INFO - Chipset Model: Intel Iris 05:18:17 INFO - Type: GPU 05:18:17 INFO - Bus: Built-In 05:18:17 INFO - VRAM (Dynamic, Max): 1536 MB 05:18:17 INFO - Vendor: Intel (0x8086) 05:18:17 INFO - Device ID: 0x0a2e 05:18:17 INFO - Revision ID: 0x0009 05:18:17 INFO - Displays: 05:18:17 INFO - Display: 05:18:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:18:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:18:17 INFO - Display Serial Number: 1600x1200 60 05:18:17 INFO - Main Display: Yes 05:18:17 INFO - Mirror: Off 05:18:17 INFO - Online: Yes 05:18:17 INFO - Rotation: Supported 05:18:17 INFO - Return code: 0 05:18:17 INFO - Running post-action listener: _resource_record_post_action 05:18:17 INFO - ##### 05:18:17 INFO - ##### Finished run-tests step (success) 05:18:17 INFO - ##### 05:18:17 INFO - Running post-run listener: _resource_record_post_run 05:18:17 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 1122304; Write bytes: 704412160; Read time: 13; Write time: 2448 05:18:17 INFO - TinderboxPrint: CPU usage
53.6% 05:18:17 INFO - TinderboxPrint: I/O read bytes / time
1,122,304 / 13 05:18:17 INFO - TinderboxPrint: I/O write bytes / time
704,412,160 / 2,448 05:18:17 INFO - TinderboxPrint: CPU idle
2,246.4 (46.4%) 05:18:17 INFO - TinderboxPrint: CPU system
969.3 (20.0%) 05:18:17 INFO - TinderboxPrint: CPU user
1,626.0 (33.6%) 05:18:17 INFO - TinderboxPrint: Swap in / out
407,785,472 / 0 05:18:17 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402057728; Write bytes: 398149120; Read time: 29705; Write time: 801 05:18:17 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1081344; Write bytes: 292602880; Read time: 12; Write time: 1613 05:18:17 INFO - Running post-run listener: _upload_blobber_files 05:18:17 INFO - Blob upload gear active. 05:18:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:18: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 05:18: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'] 05:18: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 05:18:17 INFO - (blobuploader) - INFO - Open directory for files ... 05:18:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:18:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:18:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:18 INFO - (blobuploader) - INFO - Done attempting. 05:18:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:18:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:18:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:19 INFO - (blobuploader) - INFO - Done attempting. 05:18:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:18:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:18:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:21 INFO - (blobuploader) - INFO - Done attempting. 05:18:21 INFO - (blobuploader) - INFO - Iteration through files over. 05:18:21 INFO - Return code: 0 05:18:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:18:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:18:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2015b4a8d253868704df8122eb951b510db7971eaf1603dec726d2cc0194d6c5a9ab98246a27688dd250f42c8cf593177a086a86f511700e3df1de55a6a63212", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0013808004a801a82408018e281efb93d0b450ac638561ebae887ad6c646a7e970d70e484577ea9d358e64588eb4e86943d64ba803270d5482718177b84737d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83b13ee5fbf6e66be7158195be861a178e2a47fc161c91244d5ef56fef9eaaf6417e547e44bd95923e99b158ff5b81d968d30aaba0767fdaf25791908c703e5f"} 05:18:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:18:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:18:21 INFO - Contents: 05:18:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2015b4a8d253868704df8122eb951b510db7971eaf1603dec726d2cc0194d6c5a9ab98246a27688dd250f42c8cf593177a086a86f511700e3df1de55a6a63212", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0013808004a801a82408018e281efb93d0b450ac638561ebae887ad6c646a7e970d70e484577ea9d358e64588eb4e86943d64ba803270d5482718177b84737d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83b13ee5fbf6e66be7158195be861a178e2a47fc161c91244d5ef56fef9eaaf6417e547e44bd95923e99b158ff5b81d968d30aaba0767fdaf25791908c703e5f"} 05:18:21 INFO - Running post-run listener: copy_logs_to_upload_dir 05:18:21 INFO - Copying logs to upload dir... 05:18:21 INFO - mkdir: /builds/slave/test/build/upload/logs 05:18:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.358556 ========= master_lag: 3.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-12 05:18:25.024776) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 05:18:25.028126) ========= 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.saWrIQYfro/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.rrfZNg8xFI/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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/2015b4a8d253868704df8122eb951b510db7971eaf1603dec726d2cc0194d6c5a9ab98246a27688dd250f42c8cf593177a086a86f511700e3df1de55a6a63212", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0013808004a801a82408018e281efb93d0b450ac638561ebae887ad6c646a7e970d70e484577ea9d358e64588eb4e86943d64ba803270d5482718177b84737d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83b13ee5fbf6e66be7158195be861a178e2a47fc161c91244d5ef56fef9eaaf6417e547e44bd95923e99b158ff5b81d968d30aaba0767fdaf25791908c703e5f"} build_url:https://queue.taskcluster.net/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011705 build_url: 'https://queue.taskcluster.net/v1/task/OjBCpoOTSnefwhoFLjNZKQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2015b4a8d253868704df8122eb951b510db7971eaf1603dec726d2cc0194d6c5a9ab98246a27688dd250f42c8cf593177a086a86f511700e3df1de55a6a63212", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0013808004a801a82408018e281efb93d0b450ac638561ebae887ad6c646a7e970d70e484577ea9d358e64588eb4e86943d64ba803270d5482718177b84737d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/83b13ee5fbf6e66be7158195be861a178e2a47fc161c91244d5ef56fef9eaaf6417e547e44bd95923e99b158ff5b81d968d30aaba0767fdaf25791908c703e5f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 05:18:25.071134) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:18:25.071916) ========= 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.saWrIQYfro/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.rrfZNg8xFI/Listeners TMPDIR=/var/folders/gh/t76btwz501jcblhsxv28_zf400000w/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.005075 ========= master_lag: 0.94 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:18:26.021459) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 05:18:26.021841) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 05:18:26.022874) ========= ========= Total master_lag: 5.81 =========