builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0191 starttime: 1469148190.11 results: success (0) buildid: 20160721160215 builduid: 310c3c5566594ecd92b2374eaf3701be revision: 126f8a174bda3faf9ecb206569656d2b820bf6b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 17:43:10.111203) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 17:43:10.111693) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 17:43:10.111974) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 17:43:10.136245) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 17:43:10.136586) ========= 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.sKxV5jXTwd/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.wn244lnyoR/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-21 17:43:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.4M=0.001s 2016-07-21 17:43:10 (15.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170130 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 17:43:10.328995) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 17:43:10.329309) ========= 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.sKxV5jXTwd/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.wn244lnyoR/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.037105 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 17:43:10.386477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 17:43:10.386843) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 126f8a174bda3faf9ecb206569656d2b820bf6b7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 126f8a174bda3faf9ecb206569656d2b820bf6b7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sKxV5jXTwd/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.wn244lnyoR/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-21 17:43:10,463 truncating revision to first 12 chars 2016-07-21 17:43:10,463 Setting DEBUG logging. 2016-07-21 17:43:10,463 attempt 1/10 2016-07-21 17:43:10,464 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/126f8a174bda?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 17:43:11,866 unpacking tar archive at: autoland-126f8a174bda/testing/mozharness/ program finished with exit code 0 elapsedTime=1.685868 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 17:43:12.094542) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 17:43:12.094890) ========= script_repo_revision: 126f8a174bda3faf9ecb206569656d2b820bf6b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 17:43:12.095281) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 17:43:12.095554) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 17:43:12.113818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-21 17:43:12.114219) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sKxV5jXTwd/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.wn244lnyoR/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 17:43:12 INFO - MultiFileLogger online at 20160721 17:43:12 in /builds/slave/test 17:43:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 17:43:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:43:12 INFO - {'append_to_log': False, 17:43:12 INFO - 'base_work_dir': '/builds/slave/test', 17:43:12 INFO - 'blob_upload_branch': 'Autoland', 17:43:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:43:12 INFO - 'branch': 'Autoland', 17:43:12 INFO - 'buildbot_json_path': 'buildprops.json', 17:43:12 INFO - 'config_files': ('talos/mac_config.py',), 17:43:12 INFO - 'default_actions': ('clobber', 17:43:12 INFO - 'read-buildbot-config', 17:43:12 INFO - 'download-and-extract', 17:43:12 INFO - 'populate-webroot', 17:43:12 INFO - 'create-virtualenv', 17:43:12 INFO - 'install', 17:43:12 INFO - 'run-tests'), 17:43:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:43:12 INFO - 'download_minidump_stackwalk': True, 17:43:12 INFO - 'download_symbols': 'ondemand', 17:43:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:43:12 INFO - 'tooltool.py': '/tools/tooltool.py', 17:43:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:43:12 INFO - '/tools/misc-python/virtualenv.py')}, 17:43:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:43:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:43:12 INFO - 'installer_path': 'installer.exe', 17:43:12 INFO - 'log_level': 'info', 17:43:12 INFO - 'log_name': 'talos', 17:43:12 INFO - 'log_to_console': True, 17:43:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:43:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:43:12 INFO - 'opt_config_files': (), 17:43:12 INFO - 'pip_index': False, 17:43:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:43:12 INFO - 'cmd': ('bash', 17:43:12 INFO - '-c', 17:43:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:43:12 INFO - 'enabled': True, 17:43:12 INFO - 'halt_on_failure': False, 17:43:12 INFO - 'name': 'check_screen_resolution'},), 17:43:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:43:12 INFO - 'cmd': ('bash', 17:43:12 INFO - '-c', 17:43:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:43:12 INFO - 'enabled': True, 17:43:12 INFO - 'halt_on_failure': False, 17:43:12 INFO - 'name': 'check_screen_resolution'},), 17:43:12 INFO - 'run_cmd_checks_enabled': True, 17:43:12 INFO - 'sps_profile': False, 17:43:12 INFO - 'sps_profile_interval': 0, 17:43:12 INFO - 'suite': 'dromaeojs', 17:43:12 INFO - 'system_bits': '32', 17:43:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:43:12 INFO - 'title': 't-yosemite-r7-0191', 17:43:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:43:12 INFO - 'use_talos_json': True, 17:43:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:43:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:43:12 INFO - 'work_dir': 'build'} 17:43:12 INFO - [mozharness: 2016-07-22 00:43:12.305904Z] Running clobber step. 17:43:12 INFO - Running pre-action listener: _resource_record_pre_action 17:43:12 INFO - Running main action method: clobber 17:43:12 INFO - rmtree: /builds/slave/test/build 17:43:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:43:14 INFO - Running post-action listener: _resource_record_post_action 17:43:14 INFO - [mozharness: 2016-07-22 00:43:14.440369Z] Finished clobber step (success) 17:43:14 INFO - [mozharness: 2016-07-22 00:43:14.440529Z] Running read-buildbot-config step. 17:43:14 INFO - Running pre-action listener: _resource_record_pre_action 17:43:14 INFO - Running main action method: read_buildbot_config 17:43:14 INFO - Using buildbot properties: 17:43:14 INFO - { 17:43:14 INFO - "project": "", 17:43:14 INFO - "product": "firefox", 17:43:14 INFO - "script_repo_revision": "production", 17:43:14 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 17:43:14 INFO - "repository": "", 17:43:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 17:43:14 INFO - "buildid": "20160721160215", 17:43:14 INFO - "pgo_build": "False", 17:43:14 INFO - "basedir": "/builds/slave/test", 17:43:14 INFO - "buildnumber": 69, 17:43:14 INFO - "slavename": "t-yosemite-r7-0191", 17:43:14 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 17:43:14 INFO - "platform": "yosemite_r7", 17:43:14 INFO - "scheduler": "tests-autoland-macosx64-talos", 17:43:14 INFO - "branch": "autoland", 17:43:14 INFO - "repo_path": "integration/autoland", 17:43:14 INFO - "revision": "126f8a174bda3faf9ecb206569656d2b820bf6b7", 17:43:14 INFO - "stage_platform": "macosx64", 17:43:14 INFO - "builduid": "310c3c5566594ecd92b2374eaf3701be", 17:43:14 INFO - "slavebuilddir": "test" 17:43:14 INFO - } 17:43:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 17:43:14 INFO - Running post-action listener: _resource_record_post_action 17:43:14 INFO - [mozharness: 2016-07-22 00:43:14.446073Z] Finished read-buildbot-config step (success) 17:43:14 INFO - [mozharness: 2016-07-22 00:43:14.446278Z] Running download-and-extract step. 17:43:14 INFO - Running pre-action listener: _resource_record_pre_action 17:43:14 INFO - Running main action method: download_and_extract 17:43:14 INFO - mkdir: /builds/slave/test/build/tests 17:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:43:14 INFO - https://queue.taskcluster.net/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:43:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 17:43:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 17:43:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/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 17:43:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/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 17:43:15 INFO - Downloaded 1199 bytes. 17:43:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 17:43:15 INFO - Using the following test package requirements: 17:43:15 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 17:43:15 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:43:15 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 17:43:15 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:43:15 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 17:43:15 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:43:15 INFO - u'jsshell-mac.zip'], 17:43:15 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:43:15 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 17:43:15 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 17:43:15 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:43:15 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 17:43:15 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:43:15 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 17:43:15 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:43:15 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 17:43:15 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 17:43:15 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 17:43:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:43:15 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')]} 17:43:15 INFO - https://queue.taskcluster.net/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:43:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:43:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:43:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/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 17:43:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/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 17:43:16 INFO - Downloaded 18806506 bytes. 17:43:16 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'] 17:43:16 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 17:43:20 INFO - Return code: 0 17:43:20 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 17:43: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')]} 17:43:20 INFO - https://queue.taskcluster.net/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:43:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:43:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 17:43:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/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 17:43:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/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 17:43:22 INFO - Downloaded 18806506 bytes. 17:43:22 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'] 17:43:22 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 17:43:25 INFO - Return code: 0 17:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:43:25 INFO - https://queue.taskcluster.net/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:43:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 17:43:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 17:43:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/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 17:43:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/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 17:43:27 INFO - Downloaded 14403317 bytes. 17:43:27 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'] 17:43:27 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 17:43:27 INFO - Return code: 0 17:43:27 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')]} 17:43:27 INFO - https://queue.taskcluster.net/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:43:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 17:43:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 17:43:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 17:43:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRTSBu4EQZCuku81o9RQyQ/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 17:43:30 INFO - Downloaded 112791914 bytes. 17:43:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 17:43:30 INFO - mkdir: /builds/slave/test/properties 17:43:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:43:30 INFO - Writing to file /builds/slave/test/properties/build_url 17:43:30 INFO - Contents: 17:43:30 INFO - build_url:https://queue.taskcluster.net/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 17:43:31 INFO - Running post-action listener: _resource_record_post_action 17:43:31 INFO - Running post-action listener: set_extra_try_arguments 17:43:31 INFO - [mozharness: 2016-07-22 00:43:31.539379Z] Finished download-and-extract step (success) 17:43:31 INFO - [mozharness: 2016-07-22 00:43:31.539554Z] Running populate-webroot step. 17:43:31 INFO - Running pre-action listener: _resource_record_pre_action 17:43:31 INFO - Running main action method: populate_webroot 17:43:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:43:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:43:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:43:31 INFO - '--tppagecycles', 17:43:31 INFO - '7'], 17:43:31 INFO - 'tests': ['tsvgm']}}, 17:43:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:43:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:43:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:43:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:43:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:43:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:43:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:31 INFO - 'talos_options': ['--disable-e10s'], 17:43:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:43:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:31 INFO - 'talos_options': ['--disable-e10s'], 17:43:31 INFO - 'tests': ['damp', 'tps']}, 17:43:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:31 INFO - 'tests': ['damp', 'tps']}, 17:43:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:43:31 INFO - 'tests': ['dromaeo_dom']}, 17:43:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:43:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:43:31 INFO - 'tests': ['basic_compositor_video']}, 17:43:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:43:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:43:31 INFO - 'tests': ['a11yr', 17:43:31 INFO - 'ts_paint', 17:43:31 INFO - 'tpaint', 17:43:31 INFO - 'sessionrestore', 17:43:31 INFO - 'sessionrestore_no_auto_restore', 17:43:31 INFO - 'tabpaint']}, 17:43:31 INFO - 'other-e10s': {'tests': ['a11yr', 17:43:31 INFO - 'ts_paint', 17:43:31 INFO - 'tpaint', 17:43:31 INFO - 'sessionrestore', 17:43:31 INFO - 'sessionrestore_no_auto_restore', 17:43:31 INFO - 'tabpaint']}, 17:43:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:43:31 INFO - 'ts_paint', 17:43:31 INFO - 'tpaint', 17:43:31 INFO - 'sessionrestore', 17:43:31 INFO - 'sessionrestore_no_auto_restore', 17:43:31 INFO - 'tabpaint']}, 17:43:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:43:31 INFO - 'ts_paint', 17:43:31 INFO - 'tpaint', 17:43:31 INFO - 'sessionrestore', 17:43:31 INFO - 'sessionrestore_no_auto_restore', 17:43:31 INFO - 'tabpaint']}, 17:43:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:43:31 INFO - 'tests': ['a11yr', 17:43:31 INFO - 'ts_paint', 17:43:31 INFO - 'tpaint', 17:43:31 INFO - 'sessionrestore', 17:43:31 INFO - 'sessionrestore_no_auto_restore', 17:43:31 INFO - 'tabpaint']}, 17:43:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:43:31 INFO - 'tests': ['a11yr', 17:43:31 INFO - 'ts_paint', 17:43:31 INFO - 'tpaint', 17:43:31 INFO - 'sessionrestore', 17:43:31 INFO - 'sessionrestore_no_auto_restore', 17:43:31 INFO - 'tabpaint']}, 17:43:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:43:31 INFO - 'tests': ['tsvgx', 17:43:31 INFO - 'tsvgr_opacity', 17:43:31 INFO - 'tart', 17:43:31 INFO - 'tscrollx', 17:43:31 INFO - 'cart']}, 17:43:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:43:31 INFO - 'tsvgr_opacity', 17:43:31 INFO - 'tart', 17:43:31 INFO - 'tscrollx', 17:43:31 INFO - 'cart']}, 17:43:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:31 INFO - 'talos_options': ['--disable-e10s'], 17:43:31 INFO - 'tests': ['tp5o']}, 17:43:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:31 INFO - 'tests': ['tp5o']}, 17:43:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:31 INFO - 'talos_options': ['--disable-e10s', 17:43:31 INFO - '--xperf_path', 17:43:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:31 INFO - 'tests': ['tp5n']}, 17:43:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:43:31 INFO - 'talos_options': ['--xperf_path', 17:43:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:43:31 INFO - 'tests': ['tp5n']}}, 17:43:31 INFO - 'talos.zip': {'path': '', 17:43:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:43:31 INFO - Running post-action listener: _resource_record_post_action 17:43:31 INFO - [mozharness: 2016-07-22 00:43:31.558388Z] Finished populate-webroot step (success) 17:43:31 INFO - [mozharness: 2016-07-22 00:43:31.558521Z] Running create-virtualenv step. 17:43:31 INFO - Running pre-action listener: _resource_record_pre_action 17:43:31 INFO - Running main action method: create_virtualenv 17:43:31 INFO - Creating virtualenv /builds/slave/test/build/venv 17:43:31 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 17:43:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:43:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:43:31 INFO - Using real prefix '/tools/python27' 17:43:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:43:32 INFO - Installing distribute.............................................................................................................................................................................................done. 17:43:35 INFO - Installing pip.................done. 17:43:35 INFO - Return code: 0 17:43:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:35 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 0x10b4d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b56b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9b572680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43ad30>, '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 0x10b19fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b432b20>, '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.sKxV5jXTwd/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.wn244lnyoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 17:43:35 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 17:43:35 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 17:43:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKxV5jXTwd/Render', 17:43:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:35 INFO - 'HOME': '/Users/cltbld', 17:43:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:35 INFO - 'LOGNAME': 'cltbld', 17:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:35 INFO - 'MOZ_NO_REMOTE': '1', 17:43:35 INFO - 'NO_EM_RESTART': '1', 17:43:35 INFO - 'PAGER': '/bin/cat', 17:43:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:35 INFO - 'PWD': '/builds/slave/test', 17:43:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:35 INFO - 'SHELL': '/bin/bash', 17:43:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wn244lnyoR/Listeners', 17:43:35 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 17:43:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:35 INFO - 'USER': 'cltbld', 17:43:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:35 INFO - 'XPC_FLAGS': '0x0', 17:43:35 INFO - 'XPC_SERVICE_NAME': '0', 17:43:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:35 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 17:43:35 INFO - Cleaning up... 17:43:35 INFO - Return code: 0 17:43:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:43:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:43:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:35 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 0x10b4d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b56b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9b572680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43ad30>, '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 0x10b19fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b432b20>, '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.sKxV5jXTwd/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.wn244lnyoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 17:43:35 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 17:43:35 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 17:43:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKxV5jXTwd/Render', 17:43:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:35 INFO - 'HOME': '/Users/cltbld', 17:43:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:35 INFO - 'LOGNAME': 'cltbld', 17:43:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:35 INFO - 'MOZ_NO_REMOTE': '1', 17:43:35 INFO - 'NO_EM_RESTART': '1', 17:43:35 INFO - 'PAGER': '/bin/cat', 17:43:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:35 INFO - 'PWD': '/builds/slave/test', 17:43:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:35 INFO - 'SHELL': '/bin/bash', 17:43:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wn244lnyoR/Listeners', 17:43:35 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 17:43:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:35 INFO - 'USER': 'cltbld', 17:43:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:35 INFO - 'XPC_FLAGS': '0x0', 17:43:35 INFO - 'XPC_SERVICE_NAME': '0', 17:43:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:35 INFO - Downloading/unpacking psutil>=3.1.1 17:43:35 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 17:43:35 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 17:43:35 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 17:43:35 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 17:43:35 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 17:43:35 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 17:43:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:43:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:38 INFO - Installing collected packages: psutil 17:43:38 INFO - Running setup.py install for psutil 17:43:38 INFO - building 'psutil._psutil_osx' extension 17:43:38 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 17:43:39 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 17:43:39 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 17:43:39 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 17:43:39 INFO - building 'psutil._psutil_posix' extension 17:43:39 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 17:43:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:43:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:43:39 INFO - ^ 17:43:39 INFO - 1 warning generated. 17:43:39 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 17:43:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:43:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:43:39 INFO - Successfully installed psutil 17:43:39 INFO - Cleaning up... 17:43:40 INFO - Return code: 0 17:43:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43: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')]} 17:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b56b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9b572680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43ad30>, '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 0x10b19fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b432b20>, '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.sKxV5jXTwd/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.wn244lnyoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 17:43: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:43: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 mozsystemmonitor==0.3 17:43:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKxV5jXTwd/Render', 17:43:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:40 INFO - 'HOME': '/Users/cltbld', 17:43:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:40 INFO - 'LOGNAME': 'cltbld', 17:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:40 INFO - 'MOZ_NO_REMOTE': '1', 17:43:40 INFO - 'NO_EM_RESTART': '1', 17:43:40 INFO - 'PAGER': '/bin/cat', 17:43:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:40 INFO - 'PWD': '/builds/slave/test', 17:43:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:40 INFO - 'SHELL': '/bin/bash', 17:43:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wn244lnyoR/Listeners', 17:43:40 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 17:43:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:40 INFO - 'USER': 'cltbld', 17:43:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:40 INFO - 'XPC_FLAGS': '0x0', 17:43:40 INFO - 'XPC_SERVICE_NAME': '0', 17:43:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43: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 17:43:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:43:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:43:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:43:42 INFO - Installing collected packages: mozsystemmonitor 17:43:42 INFO - Running setup.py install for mozsystemmonitor 17:43:42 INFO - Successfully installed mozsystemmonitor 17:43:42 INFO - Cleaning up... 17:43:43 INFO - Return code: 0 17:43:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:43:43 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')]} 17:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:43 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')]} 17:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:43 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 0x10b4d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b56b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9b572680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43ad30>, '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 0x10b19fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b432b20>, '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.sKxV5jXTwd/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.wn244lnyoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 17:43:43 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 17:43:43 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 17:43:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKxV5jXTwd/Render', 17:43:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:43 INFO - 'HOME': '/Users/cltbld', 17:43:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:43 INFO - 'LOGNAME': 'cltbld', 17:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:43 INFO - 'MOZ_NO_REMOTE': '1', 17:43:43 INFO - 'NO_EM_RESTART': '1', 17:43:43 INFO - 'PAGER': '/bin/cat', 17:43:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:43 INFO - 'PWD': '/builds/slave/test', 17:43:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:43 INFO - 'SHELL': '/bin/bash', 17:43:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wn244lnyoR/Listeners', 17:43:43 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 17:43:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:43 INFO - 'USER': 'cltbld', 17:43:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:43 INFO - 'XPC_FLAGS': '0x0', 17:43:43 INFO - 'XPC_SERVICE_NAME': '0', 17:43:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:43 INFO - Downloading/unpacking jsonschema==2.5.1 17:43:43 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 17:43:43 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 17:43:43 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 17:43:43 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 17:43:43 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 17:43:43 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 17:43:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:43:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:43:45 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 17:43:45 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 17:43:45 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 17:43:45 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 17:43:45 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 17:43:45 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 17:43:46 INFO - Downloading functools32-3.2.3-2.tar.gz 17:43:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:43:46 INFO - warning: no files found matching '*.txt' 17:43:46 INFO - no previously-included directories found matching 'build' 17:43:46 INFO - no previously-included directories found matching 'dist' 17:43:46 INFO - no previously-included directories found matching '.git*' 17:43:46 INFO - Installing collected packages: jsonschema, functools32 17:43:46 INFO - Running setup.py install for functools32 17:43:46 INFO - warning: no files found matching '*.txt' 17:43:46 INFO - no previously-included directories found matching 'build' 17:43:46 INFO - no previously-included directories found matching 'dist' 17:43:46 INFO - no previously-included directories found matching '.git*' 17:43:46 INFO - Successfully installed jsonschema functools32 17:43:46 INFO - Cleaning up... 17:43:46 INFO - Return code: 0 17:43:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:43:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b4d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b56b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9b572680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43ad30>, '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 0x10b19fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b432b20>, '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.sKxV5jXTwd/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.wn244lnyoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 17:43:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:43:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:43:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKxV5jXTwd/Render', 17:43:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:46 INFO - 'HOME': '/Users/cltbld', 17:43:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:46 INFO - 'LOGNAME': 'cltbld', 17:43:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:46 INFO - 'MOZ_NO_REMOTE': '1', 17:43:46 INFO - 'NO_EM_RESTART': '1', 17:43:46 INFO - 'PAGER': '/bin/cat', 17:43:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:46 INFO - 'PWD': '/builds/slave/test', 17:43:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:46 INFO - 'SHELL': '/bin/bash', 17:43:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wn244lnyoR/Listeners', 17:43:46 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 17:43:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:46 INFO - 'USER': 'cltbld', 17:43:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:46 INFO - 'XPC_FLAGS': '0x0', 17:43:46 INFO - 'XPC_SERVICE_NAME': '0', 17:43:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:46 INFO - Downloading/unpacking blobuploader==1.2.4 17:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:49 INFO - Downloading blobuploader-1.2.4.tar.gz 17:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:43:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:43:49 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 17:43:49 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 17:43:49 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 17:43:49 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 17:43:49 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 17:43:49 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 17:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:43:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:43:49 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 17:43:49 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 17:43:49 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 17:43:49 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 17:43:49 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 17:43:49 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 17:43:50 INFO - Downloading docopt-0.6.1.tar.gz 17:43:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:43:50 INFO - Installing collected packages: blobuploader, requests, docopt 17:43:50 INFO - Running setup.py install for blobuploader 17:43:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:43:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:43:50 INFO - Running setup.py install for requests 17:43:51 INFO - Running setup.py install for docopt 17:43:51 INFO - Successfully installed blobuploader requests docopt 17:43:51 INFO - Cleaning up... 17:43:51 INFO - Return code: 0 17:43:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:43:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:51 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 0x10b4d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b56b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9b572680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43ad30>, '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 0x10b19fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b432b20>, '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.sKxV5jXTwd/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.wn244lnyoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 17:43:51 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 17:43:51 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 17:43:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKxV5jXTwd/Render', 17:43:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:51 INFO - 'HOME': '/Users/cltbld', 17:43:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:51 INFO - 'LOGNAME': 'cltbld', 17:43:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:51 INFO - 'MOZ_NO_REMOTE': '1', 17:43:51 INFO - 'NO_EM_RESTART': '1', 17:43:51 INFO - 'PAGER': '/bin/cat', 17:43:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:51 INFO - 'PWD': '/builds/slave/test', 17:43:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:51 INFO - 'SHELL': '/bin/bash', 17:43:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wn244lnyoR/Listeners', 17:43:51 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 17:43:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:51 INFO - 'USER': 'cltbld', 17:43:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:51 INFO - 'XPC_FLAGS': '0x0', 17:43:51 INFO - 'XPC_SERVICE_NAME': '0', 17:43:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:51 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-E2Z9nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:51 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-_DiUbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:51 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-VEvzN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:51 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-8Jxsqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:52 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-UjXz3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:52 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-XWtZOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:52 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-mQQz6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:52 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-m58ZJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:52 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-1O0Cgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:52 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-WosF_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:52 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-0sEsjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:52 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-9ArWx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:52 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-iVN0dX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:52 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-EbF439-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:53 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-gTOqQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:53 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-x2k_PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:53 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ddDSjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:43:53 INFO - Running setup.py install for manifestparser 17:43:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:43:53 INFO - Running setup.py install for mozcrash 17:43:53 INFO - Running setup.py install for mozdebug 17:43:53 INFO - Running setup.py install for mozdevice 17:43:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:43:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:43:53 INFO - Running setup.py install for mozfile 17:43:54 INFO - Running setup.py install for mozhttpd 17:43:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:43:54 INFO - Running setup.py install for mozinfo 17:43:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:43:54 INFO - Running setup.py install for mozInstall 17:43:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:43:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:43:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:43:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:43:54 INFO - Running setup.py install for mozleak 17:43:54 INFO - Running setup.py install for mozlog 17:43:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:43:54 INFO - Running setup.py install for moznetwork 17:43:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:43:54 INFO - Running setup.py install for mozprocess 17:43:55 INFO - Running setup.py install for mozprofile 17:43:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Running setup.py install for mozrunner 17:43:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Running setup.py install for mozscreenshot 17:43:55 INFO - Running setup.py install for moztest 17:43:55 INFO - Running setup.py install for mozversion 17:43:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:43:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:43:55 INFO - Cleaning up... 17:43:55 INFO - Return code: 0 17:43:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:43: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')]} 17:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:43:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43: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')]} 17:43:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:43:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:43:55 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 0x10b4d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b56b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9b572680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43ad30>, '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 0x10b19fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b432b20>, '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.sKxV5jXTwd/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.wn244lnyoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 17:43:55 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 17:43:55 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 17:43:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKxV5jXTwd/Render', 17:43:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:43:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:43:55 INFO - 'HOME': '/Users/cltbld', 17:43:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:43:55 INFO - 'LOGNAME': 'cltbld', 17:43:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:43:55 INFO - 'MOZ_NO_REMOTE': '1', 17:43:55 INFO - 'NO_EM_RESTART': '1', 17:43:55 INFO - 'PAGER': '/bin/cat', 17:43:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:43:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:43:55 INFO - 'PWD': '/builds/slave/test', 17:43:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:43:55 INFO - 'SHELL': '/bin/bash', 17:43:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wn244lnyoR/Listeners', 17:43:55 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 17:43:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:43:55 INFO - 'USER': 'cltbld', 17:43:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:43:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:43:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:43:55 INFO - 'XPC_FLAGS': '0x0', 17:43:55 INFO - 'XPC_SERVICE_NAME': '0', 17:43:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:43:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-bcNxhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:43:56 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)) 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:43:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Rll1jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:43:56 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)) 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:43:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-FY7TIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:43:56 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)) 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:43:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-FPCwgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:43:56 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)) 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:43:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-AvxyIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:43:56 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)) 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:43:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-T3HsK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:43:56 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)) 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:43:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-HsBKSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:43:56 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)) 17:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:43:56 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-RnAAxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:43:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-nu90Lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:43:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Tk2lVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:43:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:43:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-1mtWAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:43:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-VqF_z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:43:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-ftCn5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:43:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-DGgYaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-V5juxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:43:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-fuKwdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:43:57 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)) 17:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:43:57 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-UQ1thO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:43:58 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)) 17:43:58 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)) 17:43:58 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)) 17:43:58 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)) 17:43:58 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)) 17:43:58 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)) 17:43:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:43:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:43:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:43:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:00 INFO - Downloading blessings-1.6.tar.gz 17:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:44:00 INFO - Installing collected packages: blessings 17:44:00 INFO - Running setup.py install for blessings 17:44:00 INFO - Successfully installed blessings 17:44:00 INFO - Cleaning up... 17:44:00 INFO - Return code: 0 17:44:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:44:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:01 INFO - Reading from file tmpfile_stdout 17:44:01 INFO - Current package versions: 17:44:01 INFO - blessings == 1.6 17:44:01 INFO - blobuploader == 1.2.4 17:44:01 INFO - docopt == 0.6.1 17:44:01 INFO - functools32 == 3.2.3-2 17:44:01 INFO - jsonschema == 2.5.1 17:44:01 INFO - manifestparser == 1.1 17:44:01 INFO - mozInstall == 1.12 17:44:01 INFO - mozcrash == 0.17 17:44:01 INFO - mozdebug == 0.1 17:44:01 INFO - mozdevice == 0.48 17:44:01 INFO - mozfile == 1.2 17:44:01 INFO - mozhttpd == 0.7 17:44:01 INFO - mozinfo == 0.9 17:44:01 INFO - mozleak == 0.1 17:44:01 INFO - mozlog == 3.3 17:44:01 INFO - moznetwork == 0.27 17:44:01 INFO - mozprocess == 0.23 17:44:01 INFO - mozprofile == 0.28 17:44:01 INFO - mozrunner == 6.12 17:44:01 INFO - mozscreenshot == 0.1 17:44:01 INFO - mozsystemmonitor == 0.3 17:44:01 INFO - moztest == 0.7 17:44:01 INFO - mozversion == 1.4 17:44:01 INFO - psutil == 3.1.1 17:44:01 INFO - requests == 1.2.3 17:44:01 INFO - wsgiref == 0.1.2 17:44:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:01 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 0x10b4d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b56b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9b572680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43ad30>, '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 0x10b19fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b432b20>, '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.sKxV5jXTwd/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.wn244lnyoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 17:44:01 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 17:44:01 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 17:44:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKxV5jXTwd/Render', 17:44:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:01 INFO - 'HOME': '/Users/cltbld', 17:44:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:01 INFO - 'LOGNAME': 'cltbld', 17:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:01 INFO - 'MOZ_NO_REMOTE': '1', 17:44:01 INFO - 'NO_EM_RESTART': '1', 17:44:01 INFO - 'PAGER': '/bin/cat', 17:44:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:01 INFO - 'PWD': '/builds/slave/test', 17:44:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:01 INFO - 'SHELL': '/bin/bash', 17:44:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wn244lnyoR/Listeners', 17:44:01 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 17:44:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:01 INFO - 'USER': 'cltbld', 17:44:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:01 INFO - 'XPC_FLAGS': '0x0', 17:44:01 INFO - 'XPC_SERVICE_NAME': '0', 17:44:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:01 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)) 17:44:01 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)) 17:44:01 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)) 17:44:01 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)) 17:44:01 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)) 17:44:01 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)) 17:44:01 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)) 17:44:01 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)) 17:44:01 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)) 17:44:01 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)) 17:44:01 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)) 17:44:01 INFO - Cleaning up... 17:44:01 INFO - Return code: 0 17:44:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:01 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 0x10b4d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b56b618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b9b572680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b43ad30>, '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 0x10b19fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b432b20>, '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.sKxV5jXTwd/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.wn244lnyoR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 17:44:01 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 17:44:01 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 17:44:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKxV5jXTwd/Render', 17:44:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:01 INFO - 'HOME': '/Users/cltbld', 17:44:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:01 INFO - 'LOGNAME': 'cltbld', 17:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:01 INFO - 'MOZ_NO_REMOTE': '1', 17:44:01 INFO - 'NO_EM_RESTART': '1', 17:44:01 INFO - 'PAGER': '/bin/cat', 17:44:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:01 INFO - 'PWD': '/builds/slave/test', 17:44:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:01 INFO - 'SHELL': '/bin/bash', 17:44:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wn244lnyoR/Listeners', 17:44:01 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 17:44:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:01 INFO - 'USER': 'cltbld', 17:44:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:01 INFO - 'XPC_FLAGS': '0x0', 17:44:01 INFO - 'XPC_SERVICE_NAME': '0', 17:44:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:44:01 INFO - Cleaning up... 17:44:01 INFO - Return code: 0 17:44:01 INFO - Running post-action listener: _resource_record_post_action 17:44:01 INFO - Running post-action listener: _start_resource_monitoring 17:44:01 INFO - Starting resource monitoring. 17:44:01 INFO - [mozharness: 2016-07-22 00:44:01.649767Z] Finished create-virtualenv step (success) 17:44:01 INFO - [mozharness: 2016-07-22 00:44:01.650681Z] Running install step. 17:44:01 INFO - Running pre-action listener: _resource_record_pre_action 17:44:01 INFO - Running main action method: install 17:44:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:01 INFO - Reading from file tmpfile_stdout 17:44:01 INFO - Detecting whether we're running mozinstall >=1.0... 17:44:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:44:02 INFO - Reading from file tmpfile_stdout 17:44:02 INFO - Output received: 17:44:02 INFO - Usage: mozinstall [options] installer 17:44:02 INFO - Options: 17:44:02 INFO - -h, --help show this help message and exit 17:44:02 INFO - -d DEST, --destination=DEST 17:44:02 INFO - Directory to install application into. [default: 17:44:02 INFO - "/builds/slave/test"] 17:44:02 INFO - --app=APP Application being installed. [default: firefox] 17:44:02 INFO - mkdir: /builds/slave/test/build/application 17:44:02 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'] 17:44:02 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 17:44:36 INFO - Reading from file tmpfile_stdout 17:44:36 INFO - Output received: 17:44:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:44:36 INFO - Running post-action listener: _resource_record_post_action 17:44:36 INFO - [mozharness: 2016-07-22 00:44:36.087642Z] Finished install step (success) 17:44:36 INFO - [mozharness: 2016-07-22 00:44:36.087771Z] Running run-tests step. 17:44:36 INFO - Running pre-action listener: _resource_record_pre_action 17:44:36 INFO - Running main action method: run_tests 17:44:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:44:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:44:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:44:36 INFO - 2016-07-21 17:44:36.102 screenresolution[1636:7424] starting screenresolution argv=screenresolution get 17:44:36 INFO - 2016-07-21 17:44:36.104 screenresolution[1636:7424] Display 0: 1600x1200x32@60 17:44:36 INFO - 2016-07-21 17:44:36.111 screenresolution[1637:7426] starting screenresolution argv=screenresolution list 17:44:36 INFO - Available Modes on Display 0 17:44:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:44:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:44:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:44:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:44:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:44:36 INFO - Intel Iris: 17:44:36 INFO - Chipset Model: Intel Iris 17:44:36 INFO - Type: GPU 17:44:36 INFO - Bus: Built-In 17:44:36 INFO - VRAM (Dynamic, Max): 1536 MB 17:44:36 INFO - Vendor: Intel (0x8086) 17:44:36 INFO - Device ID: 0x0a2e 17:44:36 INFO - Revision ID: 0x0009 17:44:36 INFO - Displays: 17:44:36 INFO - Display: 17:44:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:44:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:44:36 INFO - Display Serial Number: 1600x1200 60 17:44:36 INFO - Main Display: Yes 17:44:36 INFO - Mirror: Off 17:44:36 INFO - Online: Yes 17:44:36 INFO - Rotation: Supported 17:44:36 INFO - Return code: 0 17:44:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:44:36 INFO - Python 2.7.3 17:44:36 INFO - Return code: 0 17:44:36 INFO - grabbing minidump binary from tooltool 17:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:44:36 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 0x10b43ad30>, '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 0x10b19fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b432b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:44:36 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 17:44:36 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 17:44:36 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 17:44:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:44:36 INFO - Return code: 0 17:44:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:44:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:44:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:44:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:44:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:44:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 17:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0191 --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 17:44:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sKxV5jXTwd/Render', 17:44:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:44:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:44:36 INFO - 'HOME': '/Users/cltbld', 17:44:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:44:36 INFO - 'LOGNAME': 'cltbld', 17:44:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:44:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:36 INFO - 'MOZ_NO_REMOTE': '1', 17:44:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:44:36 INFO - 'NO_EM_RESTART': '1', 17:44:36 INFO - 'PAGER': '/bin/cat', 17:44:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:36 INFO - 'PWD': '/builds/slave/test', 17:44:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:44:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:44:36 INFO - 'SHELL': '/bin/bash', 17:44:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wn244lnyoR/Listeners', 17:44:36 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 17:44:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:44:36 INFO - 'USER': 'cltbld', 17:44:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:44:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:36 INFO - 'XPC_FLAGS': '0x0', 17:44:36 INFO - 'XPC_SERVICE_NAME': '0', 17:44:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:44:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 17:44:36 INFO - mozversion application_buildid: 20160721160215 17:44:36 INFO - mozversion application_changeset: 126f8a174bda3faf9ecb206569656d2b820bf6b7 17:44:36 INFO - mozversion application_display_name: Nightly 17:44:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:44:36 INFO - mozversion application_name: Firefox 17:44:36 INFO - mozversion application_remotingname: firefox 17:44:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 17:44:36 INFO - mozversion application_vendor: Mozilla 17:44:36 INFO - mozversion application_version: 50.0a1 17:44:36 INFO - mozversion platform_buildid: 20160721160215 17:44:36 INFO - mozversion platform_changeset: 126f8a174bda3faf9ecb206569656d2b820bf6b7 17:44:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 17:44:36 INFO - mozversion platform_version: 50.0a1 17:44:36 INFO - using testdate: 1469148276 17:44:36 INFO - actual date: 1469148276 17:44:36 INFO - starting webserver on 'localhost:49275' 17:44:36 INFO - SUITE-START | Running 2 tests 17:44:36 INFO - TEST-START | dromaeo_css 17:44:36 INFO - operating with platform_type : mac_ 17:44:36 INFO - Initialising browser for dromaeo_css test... 17:44:36 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpJWMuwa/profile http://localhost:49275/getInfo.html) 17:44:39 INFO - PROCESS | 1647 | JavaScript error: , line 0: uncaught exception: undefined 17:44:39 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 17:44:39 INFO - PROCESS | 1647 | colorDepth:24 17:44:39 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 17:44:39 INFO - PROCESS | 1647 | __metrics 17:44:39 INFO - PROCESS | 1647 | 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" 17:44:39 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:44:40 INFO - TEST-INFO | 1647: exit 0 17:44:40 INFO - Browser initialized. 17:44:40 INFO - Running cycle 1/1 for dromaeo_css test... 17:44:40 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpJWMuwa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:52 INFO - PROCESS | 1649 | RSS: Main: 245608448 17:44:52 INFO - PROCESS | 1649 | 17:45:43 INFO - PROCESS | 1649 | 1469148343880 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] 17:47:54 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 17:47:55 INFO - PROCESS | 1649 | RSS: Main: 343482368 17:47:55 INFO - PROCESS | 1649 | 17:50:58 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 17:50:59 INFO - PROCESS | 1649 | RSS: Main: 388964352 17:50:59 INFO - PROCESS | 1649 | 17:54:01 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 17:54:02 INFO - PROCESS | 1649 | RSS: Main: 379867136 17:54:02 INFO - PROCESS | 1649 | 17:57:04 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 17:57:04 INFO - PROCESS | 1649 | RSS: Main: 381411328 17:57:04 INFO - PROCESS | 1649 | 18:00:08 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 18:00:08 INFO - PROCESS | 1649 | RSS: Main: 351485952 18:00:08 INFO - PROCESS | 1649 | 18:03:12 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 18:03:12 INFO - PROCESS | 1649 | RSS: Main: 430493696 18:03:12 INFO - PROCESS | 1649 | 18:03:12 INFO - PROCESS | 1649 | __start_tp_report 18:03:12 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 18:03:12 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 18:03:12 INFO - PROCESS | 1649 | |i|pagename|runs| 18:03:12 INFO - PROCESS | 1649 | |0;dojo.html;3302.867885284588;3328.9500657490134;3349.983250083749;3371.6796904294083;3411.5564976553046;5498.422665620113;5572.777088916444;5617.01702202114;5655.4910058094765;5673.68794716291;5585.748641311141;5622.634528755638;5631.155326700997;5633.295838020247;5635.295588051494;5111.514406131421;5138.997895410396;5161.896762064756;5163.793448262065;5231.65994210377;5228.372595288552;5232.3197984262;5252.71110088945;5253.4746525347355;5261.868453288679;4218.704690671654;5184.688918664873;5185.740712964355;5217.191335343009;5219.8434046978655;5216.634835561512;5236.926430081824;5247.816326428557;5260.473952604747;5292.338457692788;5084.593232541425;5108.872278193037;5109.514596113363;5162;5177.689338639656;5574.526165275956;5635.8591035224035;5646.435356464362;5662.886742265173;5685.090385538336;6103.426345496464;6112.6638034908065;6122.724477398528;6128.509719222496;6129.17398945517;6049.969750151221;6116.235470566179;6150.108234306045;6214.378562143795;6215.502759779207;5673.517750991129;5692.0608099663095;5712.200291959129;5734.311882574118;5755.856103597402;6327.462165715966;6330.113784070234;6340.207474065742;6346.2067241594805;6354.936450635434;4870.439899411613;5940.6435613863305;5947.791827286024;6004.519638428916;6076.149339092531;6091.878162436727;6110.346130329577;6169.814905552751;6187.16473276111;6215.378462153839;6103.12554305995;6104.732011601605;6111.755529778848;6111.786087486917;6122.571420000646;6107;6154.815355539341;6161.383861613893;6168.19813424261;6178.196834411498;4804.327394164819;4848.733319667382;4856.63575231852;4873.122837889214;4877.95122048775;4366.951931536472;4391.297392417198;4398.362237475548;4404.66964977628;4430.933535996963;5640.633358831663;5642.548596112383;5665.291838520185;5691.3170419549915;5704.828855134353;6166.876662466726;6234.532410069263;6237;6257.5932564383165;6263.248410190807;5541.501264886179;5600.047991841397;5608.85977850557;5639.041362968305;5648.604597678123;5322.281491998608;5349.946500535023;5353.063213937623;5364.195370694349;5389.272448219519;6330.905036424458;6338.176037115146;6348.396902294275;6348.492120630431;6349.301576826545;6104.428839602146;6106.755729770759;6128.693565321805;6151.384861513813;6215.378462153749;6282.528810339334;6324.114623952558;6347.143135676624;6377.936220637735;6385.616862988049;6034.758609655741;6051.6369017857305;6072.119542666377;6078.787242446493;6086.421789929949;6008.5493587981955;6065.848353791191;6134.89601744574;6139.754409823736;6144.723487442986;5966.582339236212;5979.162917191684;6036.245469316335;6037.63774173551;6064.48451881595;5968.731407086779;5982.072778719132;5990.071538911476;6000.759969601167;6003.549733769897;4783.784729687103;5849.912251316148;5851;5859;5901.2033375495475;5995.190649262294;6001.849953751192;6036.185115009417;6037.0642550404755;6071.605345652519;5783.681897495678;5801.332846722681;5806.361300257053;5807.622504537191;5809.419058094157 18:03:12 INFO - PROCESS | 1649 | |1;ext.html;488.22616153396865;531.6437986549012;532.9280547126136;538.163156291966;554.0802268234731;30655;31256.531152032738;43438;44230.115397692025;44332.11335773291;45667.543324566745;46017;46056;46110.53889461105;46163;9738.318317717763;9922.40465572068;9925.652602158925;9926.354786938826;9936.602535898592;8854.955725221365;9000.144986226298;9033.774155646095;9166.083391660814;9809.754756131082;11877.70305742359;12032.578859739911;12049.03607711381;12382.62852114438;12395.690107747334;12310.19983701061;12338.321392323418;12342.75314493714;12346.197497162655;12375.443105060249;8828.42615230008;11731.354775487345;12041.458134383975;12126.939365303206;12152.696182595417;41653.791731041456;43796.56203437989;43961;43961.78019109884;44058.898527536745;3601.729870259741;3617.9095522611883;3670.944935825965;3745.400735882246;3906.511686039245;32707;33965.490517642254;33988.66011339879;33993.98018059462;34073.14817129567;3256.218507558193;3346.2638219591895;3408.0798184490295;3416.009357286384;3424.417848965682;544579;544595;544905;546333.999999996;547490;65963.34036659668;66297;66310;66412.33587664062;66581.66709166423;71162.64418677874;71172;71221.64389178022;71222.64388678024;71290.64354678194;17066.48800535986;17337.919449665867;17345.826541734674;17367.218475168647;17386;13180.275084870233;13240.801387979189;13251.933740331237;13288;13288.601341959757;11674.766504669858;15523.767143492856;16285.430009949594;16712.41506547265;18562.58686370763;7626.275503827128;7707.421943354271;7773.222677732295;7781.027371578552;7859.724909628136;828.7513745876333;1011.9190464762802;1021.2340744441668;1043.3531210649446;1079;30472.84763576168;31331;31424.685753142632;32163;32307.51538726921;1014.518103900656;1044.8402273476436;1073.3559864081644;1150.3500522204927;1241.5158088345552;13794.448222071205;16153.676926461405;16399;16431.917840410722;16477.258523366476;193961;195727;195938;197015;197166;54233.72883135638;62582.68708656428;63350.683246583474;63368.68315658484;63734;1416.355558221007;1418.1065928465207;1454.2437932275159;1454.4437451926337;1458.0668372241562;30537.54193687052;31400;32521;32545.837270813496;33261;41723.58276417318;49761;49874.00251994867;49898;49919.251211232586;622024;625775;626111;626393;626521;41573.168536628495;42244.577554225296;42996;43180;43213.56786432221;49606.50393496019;49905;50768.74615626898;50860.237096444325;50948.74525627348;38476.03809904663;40719.98200044904;41969.37045944252;42510.787446062575;42616.360754589325;41829.38289652326;42385.78807105945;42411.57588424076;42696.0601772538;42801.785991069846;40256.396154057125;40574.9856253596;41509.169816602895;41584.792076039426;41659.791701042515;34273.65726342705;36336.818315908255;36726.2757866458;37159;37459.62540374562;26831.463370732865;26859;26967;27055;27131.72868271371 18:03:12 INFO - PROCESS | 1649 | |2;jquery.html;308.93512362403897;359.687072247145;385.9015950932511;387.2371428286275;412.52111181414625;15689.52931412058;16955.915220423896;20585.38243852683;21178;21279.14883404664;21110.89444552779;21528.677069843925;21726.9136543173;21942.561148777055;22451.98966046528;5901.557383196256;5951.642901425917;6117.66352850593;6174.536909731765;6216;6099.634021958675;6104.786332478364;6151.108089327045;6155;6159.23009623797;4195.37069439585;6345.428911397973;6745.392914637681;6822.351876571718;6905.205901321362;6579.835504112388;6779.694913728894;6842.04211410403;6844.1444819397575;6869.553479023847;5875.529957603381;5914.349421563625;5914.61554998928;5925.555583331225;5929.377415371367;26497.602535961974;27389.767460464325;27477.587836182272;27487.587686184725;27689.44621107587;2311.861288322706;2409.361519197414;2462.2859370782453;2478.8884500197532;2483.6026235802365;10385.636502722444;10622;10821.404822734747;12576.559820406334;15245.009074410127;1824.616830465604;1859.2470049629922;1882.8776129551536;1907.6947688369933;1960.1669290551602;119781;124051.75948240583;124495;125736.37131814373;127557.36221318835;10145.28982971185;11317.320960742381;11566.826497602542;11811.409429528489;11841.88158118425;15054.849451505344;15059.322330495153;15077.09537427736;15089.868259880554;15095.849041509664;8493.872591911126;8756.649734010696;8801.735947921572;8924;8931.19619234259;8684.8697269541;8705.912940870638;8724.476531408136;8919.974202966741;8923.330750193632;4535.750533720677;4629.4722741495225;4648.2098043332035;4659.52291843128;4736.7631618418945;1726.663300656385;1898.8322181858057;1914.3536558559629;1962.3131903833544;1966.2036875065335;927.8190752803139;944.5985456181232;953.6852838563258;996.5814357969671;1063.7340664833791;21247.131637229086;21834.781652183276;22529.774702253097;22593.0962761491;22629.773702263097;974.6793095355691;979.363413781048;980.887197972228;1017.4099022566893;1032.4270030133198;10727.195460340507;11729.35488548121;11757.118216133824;11762.35307058103;11794.764104717857;596438;596438;603547.9822600859;615972;616090;140528.5947140536;141376.2931185358;145266;148827.0234595302;151753.24123379312;956.1824639932896;966.2849491376331;985.9950700246453;987.5605355616825;992.3847214726916;19155.808441915404;19756.703649445557;19775.80224197797;19817.910014949317;19838;56241.43758562362;58010;58499.66001359898;58771;59295.40704593071;62795.37204628078;78532;80747.38505229745;82327.17672823435;83249.58375208086;7122.679479423542;8198.918010820054;8374.07885132647;8511.659533618586;8597.054324024228;12099.637010889688;12117.818232726693;13023.739525209632;13929.024968252124;13984.650383740487;11629.76740465203;11702.70743231426;11900;12027.579034733742;12063.21589096706;10249.540110373606;11111;11572.6528204154;11632.88367116318;11713.531458741896;9816.950915245377;11841.940790295994;11999.220050696676;12153.149279550347;12166.513339466323;8313.875291870747;8474.788130296793;8507.404481686222;8708.825823483621;8723.214910658071;11075.113990880549;11618.593349232737;11791.528338866348;11953.820692689791;12122.030237581148 18:03:12 INFO - PROCESS | 1649 | |3;mootools.html;1395.1768456610598;1464.7656374980002;1581.3911644017053;1819.581496255861;1993.05329968265;7733.381329493641;8465.36509761768;8707.521086340248;8716.259117974972;8852.291816654668;8606.354523410753;8682.782930426742;8698.217160455557;8703.564821758902;8706.608202630881;2318.6174281243616;2336.0538981712434;2357.127862690807;2357.163207061494;2364.18435639704;2308.7806658367513;2347.7652234776556;2369.3365857559825;2373.074500944633;2373.679553260305;2310.8151347892126;2337.263761915;2344.8593084414906;2350.4006478348083;2351.7648235176516;2297.2074634251157;2328.8136949044037;2337.322176568793;2337.801286890616;2340.8595484271;2330.6620540021604;2330.953380932372;2332.5684748321614;2333.8132949364012;2337.2053501809296;8738.082501337332;8742;8816.735497935073;8826.646934122627;8830.381873268874;5173.689578625294;5395.136778115482;5398.109311963561;5449.782008719647;5457.399686034533;3601.837917293728;3622.3479773640734;3674.173311005029;3688.483612294281;3717.5353080864893;1053.120644262042;1061.8035663402218;1062.877769056553;1082.1342925659442;1084.528230219849;11633.302001879914;11657.883421165765;11763.294202347886;11782.410879455992;11805.88194118065;3919.7648141111627;4405.933910991338;4480.641548676098;4628.537146285412;4662.7202367858035;9179.990201077877;9189.356745027917;9194.17252447283;9195.356325057182;9195.954020229856;5259.39516955555;5260;5260.815871444558;5264.447233040552;5275.419703832576;4298.161858437637;4395.516493185747;4529.705569137996;4893.412790465096;4926.4088309403105;3796.52543432071;3812.14226798968;3909.2181563687377;3911.902202444962;3920.1571662092215;1133.6825688807148;1153.2446247707765;1155.179822326141;1168.2464810197375;1168.9006434453167;958.242988039441;962.2830990911815;963.8361478548663;965.5510187762724;991.1327588360185;5942.64344139353;6069.484093852072;6083.5741498095595;6131.908021379683;6140.140380346755;395.3634648216369;443.22435737459443;456.40211323166756;460.5624656576266;461.9491855895849;4014.6788256939376;4020.155767288902;4079.02103495159;4161.126163505698;4163.937540936889;10371.533281002223;10672.306300090624;10796.082333001626;10801.24391292602;10808.135349172047;10737.78524429507;10740.140788736882;10764.977327154065;10781.568737250578;10810.243282970117;7777.650005749755;8182.590870456454;8201.917980820115;8202.712905048294;8276.875846862302;5375.220593013913;6014.879702406015;6137.785177518944;6229.470495007794;6274.811755647338;9909.702708918743;10164.695059148238;10188.592456301665;10190.796184076426;10203;8096.162298571397;9918.652847150315;10236.641717539851;10298.433586152834;10394.532246049097;7410.333070023724;7732.652030658746;7734.690612375442;7735.922640773745;7747.070351557849;8176.46852954556;8292.626831792462;8322.37582181351;8326.417150799629;8400.705975290835;7579.621018949141;7615.847683046197;7632.274933881273;7643.961780191064;7671;7411.5553066816165;7468.663910124166;7481.027466429329;7525.661345239587;7539.246075392417;6291.93037183689;6650.83372915681;7012.6844292008;7077.964610176916;7144.499885007999;5055.216441451581;5094.133997220407;5112.182050871843;5137.588992880485;5170.238967747178;5009.148444764472;5111.718855462986;5134.743262836769;5159.948400516097;5279.947200527946 18:03:12 INFO - PROCESS | 1649 | |4;prototype.html;294.38473590196486;300.9292816188195;315.73478278246273;318.293388677137;322.7740581592884;5385.21914322423;5412.15861672622;5434.184872269162;5466.070767969445;5467.5899307551945;5087.898242035157;5109.770060347284;5325.573954083674;5385.2999110115725;5433.429489903562;4173.979130104345;4186.874393768184;4194.895127621803;4221.577842215769;4241.893952651193;4202.621764041236;4219.514755803091;4221.7889105544755;4232.640225580829;4276.593723596254;3580.8925732228076;4041.211963667086;4139.90292572467;4178.850816025587;4204.663626909855;3467.058447269512;4157.563455837124;4180.686448516373;4215.388768628532;4230.809613567397;3605.13476765577;3615.4576813477925;3628.9455658165148;3634.83643236055;3663.505426767379;4259.61663450291;4384.7369157850635;5222.817201397933;5259.842204733826;5273.367195936474;3842.4620553122304;4013.3578627419474;4696.553827386393;4770.614692653673;4840.201366774478;5029.843136078685;5206.010857937018;5233.005728911495;5332.093544097513;5698.974184646762;3792.829322680486;3800.9429858552144;3889.6499315061496;3990.6009399060154;4021;5054.848354549333;5936.5066671997865;5937.910931336033;6083.665398403086;6097.847553811146;4073.796310184479;4089.4255711550672;4093.9181216375505;4107.424960505532;4114.177164567099;3354.2117602363423;4149.751014939114;4163.292240319153;4164.271252530795;4182.519010313792;3985.4221137934837;4007.73949693269;4569.314602809605;4729.834455794099;4755.548222918817;4872.926906096412;5679.829605111853;5751.223584815996;5771.971140144273;5795.652260864362;1323.847757507899;1396.8603139686154;1417.3976060174384;1419.2903548225886;1428.9642758930902;696.923338432772;751.8872169174667;859.2438653984453;956.4548207521785;958.1233171648004;4499.5275496072445;4601.815927362935;5131.947950670104;5223.347081614798;5251.238570407346;5018.347614810052;5776.537876969833;5791.710414479344;5819.6508209507565;5861.3552509223955;4229.196452673982;4903.014279216923;5157.277981082651;5216.4522725114075;5240.528352448222;2648.8410695357957;2852.429514097189;2911.6069330640094;3076.5385192221347;3078.6459557150765;4652.697574657636;5757.971210143923;6010.338862725097;6063;6107.007566292574;5035.155137347387;5602.159676048625;5939.792107276225;6016.939830601726;6037.09443583466;5557.5831812614215;5751.971240143856;6019.729112189962;6032.371259759928;6059.697464881739;4988.55103040728;5578.785374615735;5806.648307435496;5841.773227622247;5901.498372638373;5740.827775166752;5747.885042299215;5759.481646651821;5761.913571296518;5773.769049237983;5289.973550132225;5528.308961379827;6007.639541627516;6092.543059270483;6098.329183789869;3263.2983908459796;3368.915777105592;3590.479380489867;3895.9546238225157;3963.445117683584;5582.413846546055;5795.942040579709;5804.245448091721;5925.525957923442;5981.7308221131025;4951.777170027285;5000.649824547425;5137.434882162885;5423.484768946943;5825.6795876225515;4427.535108813657;4752.833650822205;4945.505449455026;5464.480874316933;5689.6586204827845;4680.368150299802;4827.262185613106;5159.019786240602;5191.352410270713;5611.915821262603;5216.2436446714255;5420.699032232157;5778.653280803165;5788.710564471676;5864.589478736448;5448.237246785532;5531.612787104864;5557.3331200256225;5636.520895723909;5639.492445679744 18:03:12 INFO - PROCESS | 1649 | |5;yui.html;685.8114018644874;786.6460092958171;808.9433739638228;855.8972923249211;898.3217670658656;15712.764308535367;16607;16632;16653.66692666146;16667.499975000737;14922.850771492282;15113.319900604472;15174.08955462673;16395.344186232567;16506.752398713998;898.7842917699754;934.8317302885478;937.779621788879;938.5541867612864;939.9765005874874;725.9310365515267;741.0995640297039;918.0544039639183;923.1091996223643;924.2282693950559;945.3666043750703;974.3374505336404;977.6627063663025;984.1388784813288;984.9803003939917;955.6511873166244;956.6077908057698;956.8086382723483;957.5499515227832;957.7940742740309;567.0445299670027;708.0406049802494;715.2096932889135;717.0928775099503;719.4568101083648;15791.210439478094;15877.285522151531;15920.601984950354;15938.521844344688;15993.28030238642;13969.441222351094;14165.93755468344;14217.857821421756;14222.288885555681;14234.430622775077;13296.335183240895;13487.393067311994;13805.17168969865;13836.100653457494;14157.504487342996;4559.224931761609;4662.624525764907;4689.2966055091665;4698.647601429872;4847.830325938575;132178.33910830482;133012.3349383247;133245;134795.32602336924;137020;11050.179728244953;11058.281211721212;11255.212135150625;11312.886871131348;11575.189736718348;22231.555368892532;22257.55484890293;22276.443088922908;22279;22291.108355665918;7822;7844.254795794391;7864.4888082274465;7984.840303193903;8018.799530011796;4334.241507736134;4414.1171765647;4463.843765468193;4581.312803079498;4701.811927522861;3460.2041530447636;3579.284143171376;3602.3875941090078;3605.8197090145386;3607.0801945504254;652.116382301974;668.3817468841303;686.4576984182539;689.1076056506836;697.8778713725078;612.6385432594791;647.9805605831832;714.4106112457243;714.7069701422391;718.2924819053333;8333.874991875127;8722;9020.466520691498;10532.631357902437;10581.41802200871;524.9868753281122;567.5884983387094;611.2023808929301;632.4213344789558;675.1762849323915;4674.275487299406;4839.322494850724;4841.612670986313;4845.2732090186755;4852;131029;144122;151474;152745.23627381792;157429;124822;125052;127249.72750272379;131348;131575.3421232907;85438;113534.43232783949;113825;114390;115504.42247788707;9108.180263776292;9336.439813611205;9397.624095036395;9421.366828875502;9506.382085164441;61437.385626143165;61496;62872;63273.73452530832;64481;66179;91017.08982910351;95679;96399;99484.50257748665;11863;12205.816912746493;12244.142909996572;12312.076594255288;12674.429650665927;13502.257375844423;13745.656358590715;13789.474729224245;13820.308984550531;13832.308384580529;12597.11820172579;12790.808137877753;12821.551245706356;13355.332233388097;13401.597952061455;12469.75060498803;12627.810582841448;12671.619851404472;12711.42798574085;13090.280034597808;12426.254424734545;12445.148404385125;12538.686532836751;12798.488060477848;12977.41601627948;9481.478518681262;9962.900370996487;10056.886435612907;10117.544710488193;10658.840117398091;9290.674826381044;9384.436933783722;9983.15143212806;10089.545970431494;10132.240081993732 18:03:12 INFO - PROCESS | 1649 | __end_tp_report 18:03:12 INFO - PROCESS | 1649 | __start_cc_report 18:03:12 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1376 18:03:12 INFO - PROCESS | 1649 | __end_cc_report 18:03:12 INFO - PROCESS | 1649 | __startTimestamp1469149392477__endTimestamp 18:03:12 INFO - PROCESS | 1649 | 18:03:12 INFO - PROCESS | 1649 | ------- Summary: start ------- 18:03:12 INFO - PROCESS | 1649 | Number of tests: 6 18:03:12 INFO - PROCESS | 1649 | 18:03:12 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5670.04 Median:5849.91 stddev:639.16 (10.9%) stddev-sans-first:613.55 18:03:12 INFO - PROCESS | 1649 | Values: 3302.9 3329.0 3350.0 3371.7 3411.6 5498.4 5572.8 5617.0 5655.5 5673.7 5585.7 5622.6 5631.2 5633.3 5635.3 5111.5 5139.0 5161.9 5163.8 5231.7 5228.4 5232.3 5252.7 5253.5 5261.9 4218.7 5184.7 5185.7 5217.2 5219.8 5216.6 5236.9 5247.8 5260.5 5292.3 5084.6 5108.9 5109.5 5162.0 5177.7 5574.5 5635.9 5646.4 5662.9 5685.1 6103.4 6112.7 6122.7 6128.5 6129.2 6050.0 6116.2 6150.1 6214.4 6215.5 5673.5 5692.1 5712.2 5734.3 5755.9 6327.5 6330.1 6340.2 6346.2 6354.9 4870.4 5940.6 5947.8 6004.5 6076.1 6091.9 6110.3 6169.8 6187.2 6215.4 6103.1 6104.7 6111.8 6111.8 6122.6 6107.0 6154.8 6161.4 6168.2 6178.2 4804.3 4848.7 4856.6 4873.1 4878.0 4367.0 4391.3 4398.4 4404.7 4430.9 5640.6 5642.5 5665.3 5691.3 5704.8 6166.9 6234.5 6237.0 6257.6 6263.2 5541.5 5600.0 5608.9 5639.0 5648.6 5322.3 5349.9 5353.1 5364.2 5389.3 6330.9 6338.2 6348.4 6348.5 6349.3 6104.4 6106.8 6128.7 6151.4 6215.4 6282.5 6324.1 6347.1 6377.9 6385.6 6034.8 6051.6 6072.1 6078.8 6086.4 6008.5 6065.8 6134.9 6139.8 6144.7 5966.6 5979.2 6036.2 6037.6 6064.5 5968.7 5982.1 5990.1 6000.8 6003.5 4783.8 5849.9 5851.0 5859.0 5901.2 5995.2 6001.8 6036.2 6037.1 6071.6 5783.7 5801.3 5806.4 5807.6 5809.4 18:03:12 INFO - PROCESS | 1649 | 18:03:12 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:62692.63 Median:22081.45 stddev:131944.74 (597.5%) stddev-sans-first:132232.22 18:03:12 INFO - PROCESS | 1649 | Values: 488.2 531.6 532.9 538.2 554.1 30655.0 31256.5 43438.0 44230.1 44332.1 45667.5 46017.0 46056.0 46110.5 46163.0 9738.3 9922.4 9925.7 9926.4 9936.6 8855.0 9000.1 9033.8 9166.1 9809.8 11877.7 12032.6 12049.0 12382.6 12395.7 12310.2 12338.3 12342.8 12346.2 12375.4 8828.4 11731.4 12041.5 12126.9 12152.7 41653.8 43796.6 43961.0 43961.8 44058.9 3601.7 3617.9 3670.9 3745.4 3906.5 32707.0 33965.5 33988.7 33994.0 34073.1 3256.2 3346.3 3408.1 3416.0 3424.4 544579.0 544595.0 544905.0 546334.0 547490.0 65963.3 66297.0 66310.0 66412.3 66581.7 71162.6 71172.0 71221.6 71222.6 71290.6 17066.5 17337.9 17345.8 17367.2 17386.0 13180.3 13240.8 13251.9 13288.0 13288.6 11674.8 15523.8 16285.4 16712.4 18562.6 7626.3 7707.4 7773.2 7781.0 7859.7 828.8 1011.9 1021.2 1043.4 1079.0 30472.8 31331.0 31424.7 32163.0 32307.5 1014.5 1044.8 1073.4 1150.4 1241.5 13794.4 16153.7 16399.0 16431.9 16477.3 193961.0 195727.0 195938.0 197015.0 197166.0 54233.7 62582.7 63350.7 63368.7 63734.0 1416.4 1418.1 1454.2 1454.4 1458.1 30537.5 31400.0 32521.0 32545.8 33261.0 41723.6 49761.0 49874.0 49898.0 49919.3 622024.0 625775.0 626111.0 626393.0 626521.0 41573.2 42244.6 42996.0 43180.0 43213.6 49606.5 49905.0 50768.7 50860.2 50948.7 38476.0 40720.0 41969.4 42510.8 42616.4 41829.4 42385.8 42411.6 42696.1 42801.8 40256.4 40575.0 41509.2 41584.8 41659.8 34273.7 36336.8 36726.3 37159.0 37459.6 26831.5 26859.0 26967.0 27055.0 27131.7 18:03:12 INFO - PROCESS | 1649 | 18:03:12 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:36394.81 Median:2481.25 stddev:101624.16 (4095.7%) stddev-sans-first:101873.12 18:03:12 INFO - PROCESS | 1649 | Values: 308.9 359.7 385.9 387.2 412.5 15689.5 16955.9 20585.4 21178.0 21279.1 21110.9 21528.7 21726.9 21942.6 22452.0 5901.6 5951.6 6117.7 6174.5 6216.0 6099.6 6104.8 6151.1 6155.0 6159.2 4195.4 6345.4 6745.4 6822.4 6905.2 6579.8 6779.7 6842.0 6844.1 6869.6 5875.5 5914.3 5914.6 5925.6 5929.4 26497.6 27389.8 27477.6 27487.6 27689.4 2311.9 2409.4 2462.3 2478.9 2483.6 10385.6 10622.0 10821.4 12576.6 15245.0 1824.6 1859.2 1882.9 1907.7 1960.2 119781.0 124051.8 124495.0 125736.4 127557.4 10145.3 11317.3 11566.8 11811.4 11841.9 15054.8 15059.3 15077.1 15089.9 15095.8 8493.9 8756.6 8801.7 8924.0 8931.2 8684.9 8705.9 8724.5 8920.0 8923.3 4535.8 4629.5 4648.2 4659.5 4736.8 1726.7 1898.8 1914.4 1962.3 1966.2 927.8 944.6 953.7 996.6 1063.7 21247.1 21834.8 22529.8 22593.1 22629.8 974.7 979.4 980.9 1017.4 1032.4 10727.2 11729.4 11757.1 11762.4 11794.8 596438.0 596438.0 603548.0 615972.0 616090.0 140528.6 141376.3 145266.0 148827.0 151753.2 956.2 966.3 986.0 987.6 992.4 19155.8 19756.7 19775.8 19817.9 19838.0 56241.4 58010.0 58499.7 58771.0 59295.4 62795.4 78532.0 80747.4 82327.2 83249.6 7122.7 8198.9 8374.1 8511.7 8597.1 12099.6 12117.8 13023.7 13929.0 13984.7 11629.8 11702.7 11900.0 12027.6 12063.2 10249.5 11111.0 11572.7 11632.9 11713.5 9817.0 11841.9 11999.2 12153.1 12166.5 8313.9 8474.8 8507.4 8708.8 8723.2 11075.1 11618.6 11791.5 11953.8 12122.0 18:03:12 INFO - PROCESS | 1649 | 18:03:12 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5692.30 Median:4909.91 stddev:3201.69 (65.2%) stddev-sans-first:3194.38 18:03:12 INFO - PROCESS | 1649 | Values: 1395.2 1464.8 1581.4 1819.6 1993.1 7733.4 8465.4 8707.5 8716.3 8852.3 8606.4 8682.8 8698.2 8703.6 8706.6 2318.6 2336.1 2357.1 2357.2 2364.2 2308.8 2347.8 2369.3 2373.1 2373.7 2310.8 2337.3 2344.9 2350.4 2351.8 2297.2 2328.8 2337.3 2337.8 2340.9 2330.7 2331.0 2332.6 2333.8 2337.2 8738.1 8742.0 8816.7 8826.6 8830.4 5173.7 5395.1 5398.1 5449.8 5457.4 3601.8 3622.3 3674.2 3688.5 3717.5 1053.1 1061.8 1062.9 1082.1 1084.5 11633.3 11657.9 11763.3 11782.4 11805.9 3919.8 4405.9 4480.6 4628.5 4662.7 9180.0 9189.4 9194.2 9195.4 9196.0 5259.4 5260.0 5260.8 5264.4 5275.4 4298.2 4395.5 4529.7 4893.4 4926.4 3796.5 3812.1 3909.2 3911.9 3920.2 1133.7 1153.2 1155.2 1168.2 1168.9 958.2 962.3 963.8 965.6 991.1 5942.6 6069.5 6083.6 6131.9 6140.1 395.4 443.2 456.4 460.6 461.9 4014.7 4020.2 4079.0 4161.1 4163.9 10371.5 10672.3 10796.1 10801.2 10808.1 10737.8 10740.1 10765.0 10781.6 10810.2 7777.7 8182.6 8201.9 8202.7 8276.9 5375.2 6014.9 6137.8 6229.5 6274.8 9909.7 10164.7 10188.6 10190.8 10203.0 8096.2 9918.7 10236.6 10298.4 10394.5 7410.3 7732.7 7734.7 7735.9 7747.1 8176.5 8292.6 8322.4 8326.4 8400.7 7579.6 7615.8 7632.3 7644.0 7671.0 7411.6 7468.7 7481.0 7525.7 7539.2 6291.9 6650.8 7012.7 7078.0 7144.5 5055.2 5094.1 5112.2 5137.6 5170.2 5009.1 5111.7 5134.7 5159.9 5279.9 18:03:12 INFO - PROCESS | 1649 | 18:03:12 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4578.12 Median:5098.83 stddev:1400.40 (27.5%) stddev-sans-first:1366.92 18:03:12 INFO - PROCESS | 1649 | Values: 294.4 300.9 315.7 318.3 322.8 5385.2 5412.2 5434.2 5466.1 5467.6 5087.9 5109.8 5325.6 5385.3 5433.4 4174.0 4186.9 4194.9 4221.6 4241.9 4202.6 4219.5 4221.8 4232.6 4276.6 3580.9 4041.2 4139.9 4178.9 4204.7 3467.1 4157.6 4180.7 4215.4 4230.8 3605.1 3615.5 3628.9 3634.8 3663.5 4259.6 4384.7 5222.8 5259.8 5273.4 3842.5 4013.4 4696.6 4770.6 4840.2 5029.8 5206.0 5233.0 5332.1 5699.0 3792.8 3800.9 3889.6 3990.6 4021.0 5054.8 5936.5 5937.9 6083.7 6097.8 4073.8 4089.4 4093.9 4107.4 4114.2 3354.2 4149.8 4163.3 4164.3 4182.5 3985.4 4007.7 4569.3 4729.8 4755.5 4872.9 5679.8 5751.2 5772.0 5795.7 1323.8 1396.9 1417.4 1419.3 1429.0 696.9 751.9 859.2 956.5 958.1 4499.5 4601.8 5131.9 5223.3 5251.2 5018.3 5776.5 5791.7 5819.7 5861.4 4229.2 4903.0 5157.3 5216.5 5240.5 2648.8 2852.4 2911.6 3076.5 3078.6 4652.7 5758.0 6010.3 6063.0 6107.0 5035.2 5602.2 5939.8 6016.9 6037.1 5557.6 5752.0 6019.7 6032.4 6059.7 4988.6 5578.8 5806.6 5841.8 5901.5 5740.8 5747.9 5759.5 5761.9 5773.8 5290.0 5528.3 6007.6 6092.5 6098.3 3263.3 3368.9 3590.5 3896.0 3963.4 5582.4 5795.9 5804.2 5925.5 5981.7 4951.8 5000.6 5137.4 5423.5 5825.7 4427.5 4752.8 4945.5 5464.5 5689.7 4680.4 4827.3 5159.0 5191.4 5611.9 5216.2 5420.7 5778.7 5788.7 5864.6 5448.2 5531.6 5557.3 5636.5 5639.5 18:03:12 INFO - PROCESS | 1649 | 18:03:12 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:25427.94 Median:3970.66 stddev:40962.82 (1031.6%) stddev-sans-first:41035.60 18:03:12 INFO - PROCESS | 1649 | Values: 685.8 786.6 808.9 855.9 898.3 15712.8 16607.0 16632.0 16653.7 16667.5 14922.9 15113.3 15174.1 16395.3 16506.8 898.8 934.8 937.8 938.6 940.0 725.9 741.1 918.1 923.1 924.2 945.4 974.3 977.7 984.1 985.0 955.7 956.6 956.8 957.5 957.8 567.0 708.0 715.2 717.1 719.5 15791.2 15877.3 15920.6 15938.5 15993.3 13969.4 14165.9 14217.9 14222.3 14234.4 13296.3 13487.4 13805.2 13836.1 14157.5 4559.2 4662.6 4689.3 4698.6 4847.8 132178.3 133012.3 133245.0 134795.3 137020.0 11050.2 11058.3 11255.2 11312.9 11575.2 22231.6 22257.6 22276.4 22279.0 22291.1 7822.0 7844.3 7864.5 7984.8 8018.8 4334.2 4414.1 4463.8 4581.3 4701.8 3460.2 3579.3 3602.4 3605.8 3607.1 652.1 668.4 686.5 689.1 697.9 612.6 648.0 714.4 714.7 718.3 8333.9 8722.0 9020.5 10532.6 10581.4 525.0 567.6 611.2 632.4 675.2 4674.3 4839.3 4841.6 4845.3 4852.0 131029.0 144122.0 151474.0 152745.2 157429.0 124822.0 125052.0 127249.7 131348.0 131575.3 85438.0 113534.4 113825.0 114390.0 115504.4 9108.2 9336.4 9397.6 9421.4 9506.4 61437.4 61496.0 62872.0 63273.7 64481.0 66179.0 91017.1 95679.0 96399.0 99484.5 11863.0 12205.8 12244.1 12312.1 12674.4 13502.3 13745.7 13789.5 13820.3 13832.3 12597.1 12790.8 12821.6 13355.3 13401.6 12469.8 12627.8 12671.6 12711.4 13090.3 12426.3 12445.1 12538.7 12798.5 12977.4 9481.5 9962.9 10056.9 10117.5 10658.8 9290.7 9384.4 9983.2 10089.5 10132.2 18:03:12 INFO - PROCESS | 1649 | -------- Summary: end -------- 18:03:12 INFO - PROCESS | 1649 | 18:03:13 INFO - TEST-INFO | 1649: exit 0 18:03:13 INFO - TEST-OK | dromaeo_css | took 1116414ms 18:03:13 INFO - TEST-START | kraken 18:03:13 INFO - operating with platform_type : mac_ 18:03:13 INFO - Initialising browser for kraken test... 18:03:13 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpuBV3hl/profile http://localhost:49275/getInfo.html) 18:03:15 INFO - PROCESS | 1658 | JavaScript error: , line 0: uncaught exception: undefined 18:03:15 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 18:03:15 INFO - PROCESS | 1658 | colorDepth:24 18:03:15 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 18:03:15 INFO - PROCESS | 1658 | __metrics 18:03:15 INFO - PROCESS | 1658 | 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" 18:03:15 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:03:16 INFO - TEST-INFO | 1658: exit 0 18:03:16 INFO - Browser initialized. 18:03:16 INFO - Running cycle 1/1 for kraken test... 18:03:16 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpuBV3hl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:28 INFO - PROCESS | 1659 | RSS: Main: 245506048 18:03:28 INFO - PROCESS | 1659 | 18:03:31 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 18:03:31 INFO - PROCESS | 1659 | RSS: Main: 326352896 18:03:31 INFO - PROCESS | 1659 | 18:03:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 18:03:35 INFO - PROCESS | 1659 | RSS: Main: 337256448 18:03:35 INFO - PROCESS | 1659 | 18:03:38 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 18:03:39 INFO - PROCESS | 1659 | RSS: Main: 427716608 18:03:39 INFO - PROCESS | 1659 | 18:03:41 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 18:03:42 INFO - PROCESS | 1659 | RSS: Main: 330403840 18:03:42 INFO - PROCESS | 1659 | 18:03:44 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:03:44 INFO - PROCESS | 1659 | RSS: Main: 334438400 18:03:44 INFO - PROCESS | 1659 | 18:03:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 18:03:48 INFO - PROCESS | 1659 | RSS: Main: 373022720 18:03:48 INFO - PROCESS | 1659 | 18:03:51 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 18:03:51 INFO - PROCESS | 1659 | RSS: Main: 373116928 18:03:51 INFO - PROCESS | 1659 | 18:03:54 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 18:03:55 INFO - PROCESS | 1659 | RSS: Main: 372310016 18:03:55 INFO - PROCESS | 1659 | 18:03:56 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:03:57 INFO - PROCESS | 1659 | RSS: Main: 350990336 18:03:57 INFO - PROCESS | 1659 | 18:03:59 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:03:59 INFO - PROCESS | 1659 | RSS: Main: 357883904 18:03:59 INFO - PROCESS | 1659 | 18:04:01 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:04:02 INFO - PROCESS | 1659 | RSS: Main: 355127296 18:04:02 INFO - PROCESS | 1659 | 18:04:05 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:04:06 INFO - PROCESS | 1659 | RSS: Main: 364924928 18:04:06 INFO - PROCESS | 1659 | 18:04:08 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:04:09 INFO - PROCESS | 1659 | RSS: Main: 367775744 18:04:09 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 18:04:11 INFO - PROCESS | 1659 | RSS: Main: 410984448 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | __start_tp_report 18:04:11 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 18:04:11 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 18:04:11 INFO - PROCESS | 1659 | |i|pagename|runs| 18:04:11 INFO - PROCESS | 1659 | |0;ai-astar;101;113;112;112;116;161;167;112;112;111 18:04:11 INFO - PROCESS | 1659 | |1;audio-beat-detection;165;135;136;166;107;131;128;108;157;106 18:04:11 INFO - PROCESS | 1659 | |2;audio-dft;185;182;187;183;186;184;183;185;182;182 18:04:11 INFO - PROCESS | 1659 | |3;audio-fft;78;58;60;106;72;79;86;62;85;55 18:04:11 INFO - PROCESS | 1659 | |4;audio-oscillator;85;68;91;71;76;68;97;93;97;131 18:04:11 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;87;85;86;83;86;83;88;84;86;84 18:04:11 INFO - PROCESS | 1659 | |6;imaging-darkroom;93;93;94;93;93;94;93;95;93;93 18:04:11 INFO - PROCESS | 1659 | |7;imaging-desaturate;84;87;87;86;86;86;86;86;86;86 18:04:11 INFO - PROCESS | 1659 | |8;json-parse-financial;54;53;52;52;52;53;53;51;51;52 18:04:11 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;67;71;72;84;74;71;69;69;72;71 18:04:11 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;83;82;84;83;81;80;80;79;83;85 18:04:11 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;136;141;125;144;149;138;141;143;244;126 18:04:11 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;163;159;163;162;164;163;161;170;157;144 18:04:11 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;67;71;87;84;84;70;67;63;68;77 18:04:11 INFO - PROCESS | 1659 | __end_tp_report 18:04:11 INFO - PROCESS | 1659 | __start_cc_report 18:04:11 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2111 18:04:11 INFO - PROCESS | 1659 | __end_cc_report 18:04:11 INFO - PROCESS | 1659 | __startTimestamp1469149451761__endTimestamp 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | ------- Summary: start ------- 18:04:11 INFO - PROCESS | 1659 | Number of tests: 14 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:121.70 Median:112.50 stddev:22.67 (20.1%) stddev-sans-first:22.77 18:04:11 INFO - PROCESS | 1659 | Values: 101.0 113.0 112.0 112.0 116.0 161.0 167.0 112.0 112.0 111.0 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:135.50 stddev:22.98 (17.0%) stddev-sans-first:21.44 18:04:11 INFO - PROCESS | 1659 | Values: 165.0 135.0 136.0 166.0 107.0 131.0 128.0 108.0 157.0 106.0 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.50 stddev:1.79 (1.0%) stddev-sans-first:1.86 18:04:11 INFO - PROCESS | 1659 | Values: 185.0 182.0 187.0 183.0 186.0 184.0 183.0 185.0 182.0 182.0 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:74.10 Median:75.00 stddev:15.95 (21.3%) stddev-sans-first:16.86 18:04:11 INFO - PROCESS | 1659 | Values: 78.0 58.0 60.0 106.0 72.0 79.0 86.0 62.0 85.0 55.0 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:88.00 stddev:19.11 (21.7%) stddev-sans-first:20.24 18:04:11 INFO - PROCESS | 1659 | Values: 85.0 68.0 91.0 71.0 76.0 68.0 97.0 93.0 97.0 131.0 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.00 stddev:1.69 (2.0%) stddev-sans-first:1.66 18:04:11 INFO - PROCESS | 1659 | Values: 87.0 85.0 86.0 83.0 86.0 83.0 88.0 84.0 86.0 84.0 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 18:04:11 INFO - PROCESS | 1659 | Values: 93.0 93.0 94.0 93.0 93.0 94.0 93.0 95.0 93.0 93.0 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.00 stddev:0.82 (0.9%) stddev-sans-first:0.44 18:04:11 INFO - PROCESS | 1659 | Values: 84.0 87.0 87.0 86.0 86.0 86.0 86.0 86.0 86.0 86.0 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.50 stddev:0.95 (1.8%) stddev-sans-first:0.78 18:04:11 INFO - PROCESS | 1659 | Values: 54.0 53.0 52.0 52.0 52.0 53.0 53.0 51.0 51.0 52.0 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:71.50 stddev:4.64 (6.5%) stddev-sans-first:4.56 18:04:11 INFO - PROCESS | 1659 | Values: 67.0 71.0 72.0 84.0 74.0 71.0 69.0 69.0 72.0 71.0 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:83.00 stddev:1.94 (2.3%) stddev-sans-first:2.03 18:04:11 INFO - PROCESS | 1659 | Values: 83.0 82.0 84.0 83.0 81.0 80.0 80.0 79.0 83.0 85.0 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:148.70 Median:142.00 stddev:34.33 (24.2%) stddev-sans-first:36.11 18:04:11 INFO - PROCESS | 1659 | Values: 136.0 141.0 125.0 144.0 149.0 138.0 141.0 143.0 244.0 126.0 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:163.00 stddev:6.75 (4.1%) stddev-sans-first:7.11 18:04:11 INFO - PROCESS | 1659 | Values: 163.0 159.0 163.0 162.0 164.0 163.0 161.0 170.0 157.0 144.0 18:04:11 INFO - PROCESS | 1659 | 18:04:11 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:74.00 stddev:8.55 (11.6%) stddev-sans-first:8.71 18:04:11 INFO - PROCESS | 1659 | Values: 67.0 71.0 87.0 84.0 84.0 70.0 67.0 63.0 68.0 77.0 18:04:11 INFO - PROCESS | 1659 | -------- Summary: end -------- 18:04:11 INFO - PROCESS | 1659 | 18:04:12 INFO - TEST-INFO | 1659: exit 0 18:04:12 INFO - TEST-OK | kraken | took 59595ms 18:04:12 INFO - SUITE-END | took 1176s 18:04:12 INFO - Completed test suite (00:19:36) 18:04:12 INFO - javascript benchmark 18:04:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3302.867885284588, 3328.9500657490134, 3349.983250083749, 3371.6796904294083, 3411.5564976553046, 5498.422665620113, 5572.777088916444, 5617.01702202114, 5655.4910058094765, 5673.68794716291, 5585.748641311141, 5622.634528755638, 5631.155326700997, 5633.295838020247, 5635.295588051494, 5111.514406131421, 5138.997895410396, 5161.896762064756, 5163.793448262065, 5231.65994210377, 5228.372595288552, 5232.3197984262, 5252.71110088945, 5253.4746525347355, 5261.868453288679, 4218.704690671654, 5184.688918664873, 5185.740712964355, 5217.191335343009, 5219.8434046978655, 5216.634835561512, 5236.926430081824, 5247.816326428557, 5260.473952604747, 5292.338457692788, 5084.593232541425, 5108.872278193037, 5109.514596113363, 5162.0, 5177.689338639656, 5574.526165275956, 5635.8591035224035, 5646.435356464362, 5662.886742265173, 5685.090385538336, 6103.426345496464, 6112.6638034908065, 6122.724477398528, 6128.509719222496, 6129.17398945517, 6049.969750151221, 6116.235470566179, 6150.108234306045, 6214.378562143795, 6215.502759779207, 5673.517750991129, 5692.0608099663095, 5712.200291959129, 5734.311882574118, 5755.856103597402, 6327.462165715966, 6330.113784070234, 6340.207474065742, 6346.2067241594805, 6354.936450635434, 4870.439899411613, 5940.6435613863305, 5947.791827286024, 6004.519638428916, 6076.149339092531, 6091.878162436727, 6110.346130329577, 6169.814905552751, 6187.16473276111, 6215.378462153839, 6103.12554305995, 6104.732011601605, 6111.755529778848, 6111.786087486917, 6122.571420000646, 6107.0, 6154.815355539341, 6161.383861613893, 6168.19813424261, 6178.196834411498, 4804.327394164819, 4848.733319667382, 4856.63575231852, 4873.122837889214, 4877.95122048775, 4366.951931536472, 4391.297392417198, 4398.362237475548, 4404.66964977628, 4430.933535996963, 5640.633358831663, 5642.548596112383, 5665.291838520185, 5691.3170419549915, 5704.828855134353, 6166.876662466726, 6234.532410069263, 6237.0, 6257.5932564383165, 6263.248410190807, 5541.501264886179, 5600.047991841397, 5608.85977850557, 5639.041362968305, 5648.604597678123, 5322.281491998608, 5349.946500535023, 5353.063213937623, 5364.195370694349, 5389.272448219519, 6330.905036424458, 6338.176037115146, 6348.396902294275, 6348.492120630431, 6349.301576826545, 6104.428839602146, 6106.755729770759, 6128.693565321805, 6151.384861513813, 6215.378462153749, 6282.528810339334, 6324.114623952558, 6347.143135676624, 6377.936220637735, 6385.616862988049, 6034.758609655741, 6051.6369017857305, 6072.119542666377, 6078.787242446493, 6086.421789929949, 6008.5493587981955, 6065.848353791191, 6134.89601744574, 6139.754409823736, 6144.723487442986, 5966.582339236212, 5979.162917191684, 6036.245469316335, 6037.63774173551, 6064.48451881595, 5968.731407086779, 5982.072778719132, 5990.071538911476, 6000.759969601167, 6003.549733769897, 4783.784729687103, 5849.912251316148, 5851.0, 5859.0, 5901.2033375495475, 5995.190649262294, 6001.849953751192, 6036.185115009417, 6037.0642550404755, 6071.605345652519, 5783.681897495678, 5801.332846722681, 5806.361300257053, 5807.622504537191, 5809.419058094157], "value": 5629.577444700168, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.22616153396865, 531.6437986549012, 532.9280547126136, 538.163156291966, 554.0802268234731, 30655.0, 31256.531152032738, 43438.0, 44230.115397692025, 44332.11335773291, 45667.543324566745, 46017.0, 46056.0, 46110.53889461105, 46163.0, 9738.318317717763, 9922.40465572068, 9925.652602158925, 9926.354786938826, 9936.602535898592, 8854.955725221365, 9000.144986226298, 9033.774155646095, 9166.083391660814, 9809.754756131082, 11877.70305742359, 12032.578859739911, 12049.03607711381, 12382.62852114438, 12395.690107747334, 12310.19983701061, 12338.321392323418, 12342.75314493714, 12346.197497162655, 12375.443105060249, 8828.42615230008, 11731.354775487345, 12041.458134383975, 12126.939365303206, 12152.696182595417, 41653.791731041456, 43796.56203437989, 43961.0, 43961.78019109884, 44058.898527536745, 3601.729870259741, 3617.9095522611883, 3670.944935825965, 3745.400735882246, 3906.511686039245, 32707.0, 33965.490517642254, 33988.66011339879, 33993.98018059462, 34073.14817129567, 3256.218507558193, 3346.2638219591895, 3408.0798184490295, 3416.009357286384, 3424.417848965682, 544579.0, 544595.0, 544905.0, 546333.999999996, 547490.0, 65963.34036659668, 66297.0, 66310.0, 66412.33587664062, 66581.66709166423, 71162.64418677874, 71172.0, 71221.64389178022, 71222.64388678024, 71290.64354678194, 17066.48800535986, 17337.919449665867, 17345.826541734674, 17367.218475168647, 17386.0, 13180.275084870233, 13240.801387979189, 13251.933740331237, 13288.0, 13288.601341959757, 11674.766504669858, 15523.767143492856, 16285.430009949594, 16712.41506547265, 18562.58686370763, 7626.275503827128, 7707.421943354271, 7773.222677732295, 7781.027371578552, 7859.724909628136, 828.7513745876333, 1011.9190464762802, 1021.2340744441668, 1043.3531210649446, 1079.0, 30472.84763576168, 31331.0, 31424.685753142632, 32163.0, 32307.51538726921, 1014.518103900656, 1044.8402273476436, 1073.3559864081644, 1150.3500522204927, 1241.5158088345552, 13794.448222071205, 16153.676926461405, 16399.0, 16431.917840410722, 16477.258523366476, 193961.0, 195727.0, 195938.0, 197015.0, 197166.0, 54233.72883135638, 62582.68708656428, 63350.683246583474, 63368.68315658484, 63734.0, 1416.355558221007, 1418.1065928465207, 1454.2437932275159, 1454.4437451926337, 1458.0668372241562, 30537.54193687052, 31400.0, 32521.0, 32545.837270813496, 33261.0, 41723.58276417318, 49761.0, 49874.00251994867, 49898.0, 49919.251211232586, 622024.0, 625775.0, 626111.0, 626393.0, 626521.0, 41573.168536628495, 42244.577554225296, 42996.0, 43180.0, 43213.56786432221, 49606.50393496019, 49905.0, 50768.74615626898, 50860.237096444325, 50948.74525627348, 38476.03809904663, 40719.98200044904, 41969.37045944252, 42510.787446062575, 42616.360754589325, 41829.38289652326, 42385.78807105945, 42411.57588424076, 42696.0601772538, 42801.785991069846, 40256.396154057125, 40574.9856253596, 41509.169816602895, 41584.792076039426, 41659.791701042515, 34273.65726342705, 36336.818315908255, 36726.2757866458, 37159.0, 37459.62540374562, 26831.463370732865, 26859.0, 26967.0, 27055.0, 27131.72868271371], "value": 20779.18854447009, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.93512362403897, 359.687072247145, 385.9015950932511, 387.2371428286275, 412.52111181414625, 15689.52931412058, 16955.915220423896, 20585.38243852683, 21178.0, 21279.14883404664, 21110.89444552779, 21528.677069843925, 21726.9136543173, 21942.561148777055, 22451.98966046528, 5901.557383196256, 5951.642901425917, 6117.66352850593, 6174.536909731765, 6216.0, 6099.634021958675, 6104.786332478364, 6151.108089327045, 6155.0, 6159.23009623797, 4195.37069439585, 6345.428911397973, 6745.392914637681, 6822.351876571718, 6905.205901321362, 6579.835504112388, 6779.694913728894, 6842.04211410403, 6844.1444819397575, 6869.553479023847, 5875.529957603381, 5914.349421563625, 5914.61554998928, 5925.555583331225, 5929.377415371367, 26497.602535961974, 27389.767460464325, 27477.587836182272, 27487.587686184725, 27689.44621107587, 2311.861288322706, 2409.361519197414, 2462.2859370782453, 2478.8884500197532, 2483.6026235802365, 10385.636502722444, 10622.0, 10821.404822734747, 12576.559820406334, 15245.009074410127, 1824.616830465604, 1859.2470049629922, 1882.8776129551536, 1907.6947688369933, 1960.1669290551602, 119781.0, 124051.75948240583, 124495.0, 125736.37131814373, 127557.36221318835, 10145.28982971185, 11317.320960742381, 11566.826497602542, 11811.409429528489, 11841.88158118425, 15054.849451505344, 15059.322330495153, 15077.09537427736, 15089.868259880554, 15095.849041509664, 8493.872591911126, 8756.649734010696, 8801.735947921572, 8924.0, 8931.19619234259, 8684.8697269541, 8705.912940870638, 8724.476531408136, 8919.974202966741, 8923.330750193632, 4535.750533720677, 4629.4722741495225, 4648.2098043332035, 4659.52291843128, 4736.7631618418945, 1726.663300656385, 1898.8322181858057, 1914.3536558559629, 1962.3131903833544, 1966.2036875065335, 927.8190752803139, 944.5985456181232, 953.6852838563258, 996.5814357969671, 1063.7340664833791, 21247.131637229086, 21834.781652183276, 22529.774702253097, 22593.0962761491, 22629.773702263097, 974.6793095355691, 979.363413781048, 980.887197972228, 1017.4099022566893, 1032.4270030133198, 10727.195460340507, 11729.35488548121, 11757.118216133824, 11762.35307058103, 11794.764104717857, 596438.0, 596438.0, 603547.9822600859, 615972.0, 616090.0, 140528.5947140536, 141376.2931185358, 145266.0, 148827.0234595302, 151753.24123379312, 956.1824639932896, 966.2849491376331, 985.9950700246453, 987.5605355616825, 992.3847214726916, 19155.808441915404, 19756.703649445557, 19775.80224197797, 19817.910014949317, 19838.0, 56241.43758562362, 58010.0, 58499.66001359898, 58771.0, 59295.40704593071, 62795.37204628078, 78532.0, 80747.38505229745, 82327.17672823435, 83249.58375208086, 7122.679479423542, 8198.918010820054, 8374.07885132647, 8511.659533618586, 8597.054324024228, 12099.637010889688, 12117.818232726693, 13023.739525209632, 13929.024968252124, 13984.650383740487, 11629.76740465203, 11702.70743231426, 11900.0, 12027.579034733742, 12063.21589096706, 10249.540110373606, 11111.0, 11572.6528204154, 11632.88367116318, 11713.531458741896, 9816.950915245377, 11841.940790295994, 11999.220050696676, 12153.149279550347, 12166.513339466323, 8313.875291870747, 8474.788130296793, 8507.404481686222, 8708.825823483621, 8723.214910658071, 11075.113990880549, 11618.593349232737, 11791.528338866348, 11953.820692689791, 12122.030237581148], "value": 9992.789014093394, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.1768456610598, 1464.7656374980002, 1581.3911644017053, 1819.581496255861, 1993.05329968265, 7733.381329493641, 8465.36509761768, 8707.521086340248, 8716.259117974972, 8852.291816654668, 8606.354523410753, 8682.782930426742, 8698.217160455557, 8703.564821758902, 8706.608202630881, 2318.6174281243616, 2336.0538981712434, 2357.127862690807, 2357.163207061494, 2364.18435639704, 2308.7806658367513, 2347.7652234776556, 2369.3365857559825, 2373.074500944633, 2373.679553260305, 2310.8151347892126, 2337.263761915, 2344.8593084414906, 2350.4006478348083, 2351.7648235176516, 2297.2074634251157, 2328.8136949044037, 2337.322176568793, 2337.801286890616, 2340.8595484271, 2330.6620540021604, 2330.953380932372, 2332.5684748321614, 2333.8132949364012, 2337.2053501809296, 8738.082501337332, 8742.0, 8816.735497935073, 8826.646934122627, 8830.381873268874, 5173.689578625294, 5395.136778115482, 5398.109311963561, 5449.782008719647, 5457.399686034533, 3601.837917293728, 3622.3479773640734, 3674.173311005029, 3688.483612294281, 3717.5353080864893, 1053.120644262042, 1061.8035663402218, 1062.877769056553, 1082.1342925659442, 1084.528230219849, 11633.302001879914, 11657.883421165765, 11763.294202347886, 11782.410879455992, 11805.88194118065, 3919.7648141111627, 4405.933910991338, 4480.641548676098, 4628.537146285412, 4662.7202367858035, 9179.990201077877, 9189.356745027917, 9194.17252447283, 9195.356325057182, 9195.954020229856, 5259.39516955555, 5260.0, 5260.815871444558, 5264.447233040552, 5275.419703832576, 4298.161858437637, 4395.516493185747, 4529.705569137996, 4893.412790465096, 4926.4088309403105, 3796.52543432071, 3812.14226798968, 3909.2181563687377, 3911.902202444962, 3920.1571662092215, 1133.6825688807148, 1153.2446247707765, 1155.179822326141, 1168.2464810197375, 1168.9006434453167, 958.242988039441, 962.2830990911815, 963.8361478548663, 965.5510187762724, 991.1327588360185, 5942.64344139353, 6069.484093852072, 6083.5741498095595, 6131.908021379683, 6140.140380346755, 395.3634648216369, 443.22435737459443, 456.40211323166756, 460.5624656576266, 461.9491855895849, 4014.6788256939376, 4020.155767288902, 4079.02103495159, 4161.126163505698, 4163.937540936889, 10371.533281002223, 10672.306300090624, 10796.082333001626, 10801.24391292602, 10808.135349172047, 10737.78524429507, 10740.140788736882, 10764.977327154065, 10781.568737250578, 10810.243282970117, 7777.650005749755, 8182.590870456454, 8201.917980820115, 8202.712905048294, 8276.875846862302, 5375.220593013913, 6014.879702406015, 6137.785177518944, 6229.470495007794, 6274.811755647338, 9909.702708918743, 10164.695059148238, 10188.592456301665, 10190.796184076426, 10203.0, 8096.162298571397, 9918.652847150315, 10236.641717539851, 10298.433586152834, 10394.532246049097, 7410.333070023724, 7732.652030658746, 7734.690612375442, 7735.922640773745, 7747.070351557849, 8176.46852954556, 8292.626831792462, 8322.37582181351, 8326.417150799629, 8400.705975290835, 7579.621018949141, 7615.847683046197, 7632.274933881273, 7643.961780191064, 7671.0, 7411.5553066816165, 7468.663910124166, 7481.027466429329, 7525.661345239587, 7539.246075392417, 6291.93037183689, 6650.83372915681, 7012.6844292008, 7077.964610176916, 7144.499885007999, 5055.216441451581, 5094.133997220407, 5112.182050871843, 5137.588992880485, 5170.238967747178, 5009.148444764472, 5111.718855462986, 5134.743262836769, 5159.948400516097, 5279.947200527946], "value": 4496.332217517044, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.38473590196486, 300.9292816188195, 315.73478278246273, 318.293388677137, 322.7740581592884, 5385.21914322423, 5412.15861672622, 5434.184872269162, 5466.070767969445, 5467.5899307551945, 5087.898242035157, 5109.770060347284, 5325.573954083674, 5385.2999110115725, 5433.429489903562, 4173.979130104345, 4186.874393768184, 4194.895127621803, 4221.577842215769, 4241.893952651193, 4202.621764041236, 4219.514755803091, 4221.7889105544755, 4232.640225580829, 4276.593723596254, 3580.8925732228076, 4041.211963667086, 4139.90292572467, 4178.850816025587, 4204.663626909855, 3467.058447269512, 4157.563455837124, 4180.686448516373, 4215.388768628532, 4230.809613567397, 3605.13476765577, 3615.4576813477925, 3628.9455658165148, 3634.83643236055, 3663.505426767379, 4259.61663450291, 4384.7369157850635, 5222.817201397933, 5259.842204733826, 5273.367195936474, 3842.4620553122304, 4013.3578627419474, 4696.553827386393, 4770.614692653673, 4840.201366774478, 5029.843136078685, 5206.010857937018, 5233.005728911495, 5332.093544097513, 5698.974184646762, 3792.829322680486, 3800.9429858552144, 3889.6499315061496, 3990.6009399060154, 4021.0, 5054.848354549333, 5936.5066671997865, 5937.910931336033, 6083.665398403086, 6097.847553811146, 4073.796310184479, 4089.4255711550672, 4093.9181216375505, 4107.424960505532, 4114.177164567099, 3354.2117602363423, 4149.751014939114, 4163.292240319153, 4164.271252530795, 4182.519010313792, 3985.4221137934837, 4007.73949693269, 4569.314602809605, 4729.834455794099, 4755.548222918817, 4872.926906096412, 5679.829605111853, 5751.223584815996, 5771.971140144273, 5795.652260864362, 1323.847757507899, 1396.8603139686154, 1417.3976060174384, 1419.2903548225886, 1428.9642758930902, 696.923338432772, 751.8872169174667, 859.2438653984453, 956.4548207521785, 958.1233171648004, 4499.5275496072445, 4601.815927362935, 5131.947950670104, 5223.347081614798, 5251.238570407346, 5018.347614810052, 5776.537876969833, 5791.710414479344, 5819.6508209507565, 5861.3552509223955, 4229.196452673982, 4903.014279216923, 5157.277981082651, 5216.4522725114075, 5240.528352448222, 2648.8410695357957, 2852.429514097189, 2911.6069330640094, 3076.5385192221347, 3078.6459557150765, 4652.697574657636, 5757.971210143923, 6010.338862725097, 6063.0, 6107.007566292574, 5035.155137347387, 5602.159676048625, 5939.792107276225, 6016.939830601726, 6037.09443583466, 5557.5831812614215, 5751.971240143856, 6019.729112189962, 6032.371259759928, 6059.697464881739, 4988.55103040728, 5578.785374615735, 5806.648307435496, 5841.773227622247, 5901.498372638373, 5740.827775166752, 5747.885042299215, 5759.481646651821, 5761.913571296518, 5773.769049237983, 5289.973550132225, 5528.308961379827, 6007.639541627516, 6092.543059270483, 6098.329183789869, 3263.2983908459796, 3368.915777105592, 3590.479380489867, 3895.9546238225157, 3963.445117683584, 5582.413846546055, 5795.942040579709, 5804.245448091721, 5925.525957923442, 5981.7308221131025, 4951.777170027285, 5000.649824547425, 5137.434882162885, 5423.484768946943, 5825.6795876225515, 4427.535108813657, 4752.833650822205, 4945.505449455026, 5464.480874316933, 5689.6586204827845, 4680.368150299802, 4827.262185613106, 5159.019786240602, 5191.352410270713, 5611.915821262603, 5216.2436446714255, 5420.699032232157, 5778.653280803165, 5788.710564471676, 5864.589478736448, 5448.237246785532, 5531.612787104864, 5557.3331200256225, 5636.520895723909, 5639.492445679744], "value": 4131.328072678568, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.8114018644874, 786.6460092958171, 808.9433739638228, 855.8972923249211, 898.3217670658656, 15712.764308535367, 16607.0, 16632.0, 16653.66692666146, 16667.499975000737, 14922.850771492282, 15113.319900604472, 15174.08955462673, 16395.344186232567, 16506.752398713998, 898.7842917699754, 934.8317302885478, 937.779621788879, 938.5541867612864, 939.9765005874874, 725.9310365515267, 741.0995640297039, 918.0544039639183, 923.1091996223643, 924.2282693950559, 945.3666043750703, 974.3374505336404, 977.6627063663025, 984.1388784813288, 984.9803003939917, 955.6511873166244, 956.6077908057698, 956.8086382723483, 957.5499515227832, 957.7940742740309, 567.0445299670027, 708.0406049802494, 715.2096932889135, 717.0928775099503, 719.4568101083648, 15791.210439478094, 15877.285522151531, 15920.601984950354, 15938.521844344688, 15993.28030238642, 13969.441222351094, 14165.93755468344, 14217.857821421756, 14222.288885555681, 14234.430622775077, 13296.335183240895, 13487.393067311994, 13805.17168969865, 13836.100653457494, 14157.504487342996, 4559.224931761609, 4662.624525764907, 4689.2966055091665, 4698.647601429872, 4847.830325938575, 132178.33910830482, 133012.3349383247, 133245.0, 134795.32602336924, 137020.0, 11050.179728244953, 11058.281211721212, 11255.212135150625, 11312.886871131348, 11575.189736718348, 22231.555368892532, 22257.55484890293, 22276.443088922908, 22279.0, 22291.108355665918, 7822.0, 7844.254795794391, 7864.4888082274465, 7984.840303193903, 8018.799530011796, 4334.241507736134, 4414.1171765647, 4463.843765468193, 4581.312803079498, 4701.811927522861, 3460.2041530447636, 3579.284143171376, 3602.3875941090078, 3605.8197090145386, 3607.0801945504254, 652.116382301974, 668.3817468841303, 686.4576984182539, 689.1076056506836, 697.8778713725078, 612.6385432594791, 647.9805605831832, 714.4106112457243, 714.7069701422391, 718.2924819053333, 8333.874991875127, 8722.0, 9020.466520691498, 10532.631357902437, 10581.41802200871, 524.9868753281122, 567.5884983387094, 611.2023808929301, 632.4213344789558, 675.1762849323915, 4674.275487299406, 4839.322494850724, 4841.612670986313, 4845.2732090186755, 4852.0, 131029.0, 144122.0, 151474.0, 152745.23627381792, 157429.0, 124822.0, 125052.0, 127249.72750272379, 131348.0, 131575.3421232907, 85438.0, 113534.43232783949, 113825.0, 114390.0, 115504.42247788707, 9108.180263776292, 9336.439813611205, 9397.624095036395, 9421.366828875502, 9506.382085164441, 61437.385626143165, 61496.0, 62872.0, 63273.73452530832, 64481.0, 66179.0, 91017.08982910351, 95679.0, 96399.0, 99484.50257748665, 11863.0, 12205.816912746493, 12244.142909996572, 12312.076594255288, 12674.429650665927, 13502.257375844423, 13745.656358590715, 13789.474729224245, 13820.308984550531, 13832.308384580529, 12597.11820172579, 12790.808137877753, 12821.551245706356, 13355.332233388097, 13401.597952061455, 12469.75060498803, 12627.810582841448, 12671.619851404472, 12711.42798574085, 13090.280034597808, 12426.254424734545, 12445.148404385125, 12538.686532836751, 12798.488060477848, 12977.41601627948, 9481.478518681262, 9962.900370996487, 10056.886435612907, 10117.544710488193, 10658.840117398091, 9290.674826381044, 9384.436933783722, 9983.15143212806, 10089.545970431494, 10132.240081993732], "value": 7987.499498938882, "unit": "score"}], "name": "dromaeo_css", "value": 7467.922081396472, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 112.0, 112.0, 116.0, 161.0, 167.0, 112.0, 112.0, 111.0], "value": 121.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 135.0, 136.0, 166.0, 107.0, 131.0, 128.0, 108.0, 157.0, 106.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 187.0, 183.0, 186.0, 184.0, 183.0, 185.0, 182.0, 182.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 60.0, 106.0, 72.0, 79.0, 86.0, 62.0, 85.0, 55.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 68.0, 91.0, 71.0, 76.0, 68.0, 97.0, 93.0, 97.0, 131.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 83.0, 86.0, 83.0, 88.0, 84.0, 86.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 93.0, 93.0, 94.0, 93.0, 95.0, 93.0, 93.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 87.0, 86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 52.0, 52.0, 53.0, 53.0, 51.0, 51.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 72.0, 84.0, 74.0, 71.0, 69.0, 69.0, 72.0, 71.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 84.0, 83.0, 81.0, 80.0, 80.0, 79.0, 83.0, 85.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 141.0, 125.0, 144.0, 149.0, 138.0, 141.0, 143.0, 244.0, 126.0], "value": 148.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 163.0, 162.0, 164.0, 163.0, 161.0, 170.0, 157.0, 144.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 87.0, 84.0, 84.0, 70.0, 67.0, 63.0, 68.0, 77.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1455.3, "alertThreshold": 2.0}]} 18:04:12 INFO - Return code: 0 18:04:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:04:13 INFO - # TBPL SUCCESS # 18:04:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:04:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:04:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:04:13 INFO - 2016-07-21 18:04:13.023 screenresolution[1663:9610] starting screenresolution argv=screenresolution get 18:04:13 INFO - 2016-07-21 18:04:13.027 screenresolution[1663:9610] Display 0: 1600x1200x32@60 18:04:13 INFO - 2016-07-21 18:04:13.033 screenresolution[1664:9613] starting screenresolution argv=screenresolution list 18:04:13 INFO - Available Modes on Display 0 18:04:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:04:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:04:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:04:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:04:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:04:13 INFO - Intel Iris: 18:04:13 INFO - Chipset Model: Intel Iris 18:04:13 INFO - Type: GPU 18:04:13 INFO - Bus: Built-In 18:04:13 INFO - VRAM (Dynamic, Max): 1536 MB 18:04:13 INFO - Vendor: Intel (0x8086) 18:04:13 INFO - Device ID: 0x0a2e 18:04:13 INFO - Revision ID: 0x0009 18:04:13 INFO - Displays: 18:04:13 INFO - Display: 18:04:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:04:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:04:13 INFO - Display Serial Number: 1600x1200 60 18:04:13 INFO - Main Display: Yes 18:04:13 INFO - Mirror: Off 18:04:13 INFO - Online: Yes 18:04:13 INFO - Rotation: Supported 18:04:13 INFO - Return code: 0 18:04:13 INFO - Running post-action listener: _resource_record_post_action 18:04:13 INFO - [mozharness: 2016-07-22 01:04:13.274283Z] Finished run-tests step (success) 18:04:13 INFO - Running post-run listener: _resource_record_post_run 18:04:13 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 37417984; Write bytes: 705321984; Read time: 385; Write time: 2388 18:04:13 INFO - TinderboxPrint: CPU usage
53.6% 18:04:13 INFO - TinderboxPrint: I/O read bytes / time
37,417,984 / 385 18:04:13 INFO - TinderboxPrint: I/O write bytes / time
705,321,984 / 2,388 18:04:13 INFO - TinderboxPrint: CPU idle
2,250.2 (46.4%) 18:04:13 INFO - TinderboxPrint: CPU system
969.1 (20.0%) 18:04:13 INFO - TinderboxPrint: CPU user
1,626.3 (33.6%) 18:04:13 INFO - TinderboxPrint: Swap in / out
445,157,376 / 0 18:04:13 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399421952; Write bytes: 394241536; Read time: 29518; Write time: 1006 18:04:13 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 35357696; Write bytes: 293373440; Read time: 363; Write time: 1341 18:04:13 INFO - Running post-run listener: _upload_blobber_files 18:04:13 INFO - Blob upload gear active. 18:04:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:04:13 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 18:04:13 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:04:13 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:04:14 INFO - (blobuploader) - INFO - Open directory for files ... 18:04:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:04:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:04:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:15 INFO - (blobuploader) - INFO - Done attempting. 18:04:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:04:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:04:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:16 INFO - (blobuploader) - INFO - Done attempting. 18:04:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:04:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:04:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:19 INFO - (blobuploader) - INFO - Done attempting. 18:04:19 INFO - (blobuploader) - INFO - Iteration through files over. 18:04:19 INFO - Return code: 0 18:04:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:04:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:04:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/023aa35eddf9c0d147e3ee74e4c379db84f8d38c0924f83ab3217849bedc753bd3e6d15fe32c7b317d166cfcf75bd1cc7dcbd07133b49dc20aec7d5afe72868a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/03f77edd4b3724fbe7a804e0e3aba0b2188bd469cf4e089a3d44d2f3450d06745abe43e44be609ca0c8d3348cc748d37f46f724f56c97d1ab4afe957f0fe4f5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1a504b355e1cf4ba3c047ae06ff5eda4b3ec2791934f4353acd72d9c66c090eeb19ae1ae831e98bad58f820762a78f087c438310e587b3f20b680b977617c961"} 18:04:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:04:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:04:19 INFO - Contents: 18:04:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/023aa35eddf9c0d147e3ee74e4c379db84f8d38c0924f83ab3217849bedc753bd3e6d15fe32c7b317d166cfcf75bd1cc7dcbd07133b49dc20aec7d5afe72868a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/03f77edd4b3724fbe7a804e0e3aba0b2188bd469cf4e089a3d44d2f3450d06745abe43e44be609ca0c8d3348cc748d37f46f724f56c97d1ab4afe957f0fe4f5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1a504b355e1cf4ba3c047ae06ff5eda4b3ec2791934f4353acd72d9c66c090eeb19ae1ae831e98bad58f820762a78f087c438310e587b3f20b680b977617c961"} 18:04:19 INFO - Running post-run listener: copy_logs_to_upload_dir 18:04:19 INFO - Copying logs to upload dir... 18:04:19 INFO - mkdir: /builds/slave/test/build/upload/logs 18:04:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.244930 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-21 18:04:19.395432) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 18:04:19.399196) ========= 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.sKxV5jXTwd/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.wn244lnyoR/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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/Autoland/sha512/023aa35eddf9c0d147e3ee74e4c379db84f8d38c0924f83ab3217849bedc753bd3e6d15fe32c7b317d166cfcf75bd1cc7dcbd07133b49dc20aec7d5afe72868a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/03f77edd4b3724fbe7a804e0e3aba0b2188bd469cf4e089a3d44d2f3450d06745abe43e44be609ca0c8d3348cc748d37f46f724f56c97d1ab4afe957f0fe4f5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1a504b355e1cf4ba3c047ae06ff5eda4b3ec2791934f4353acd72d9c66c090eeb19ae1ae831e98bad58f820762a78f087c438310e587b3f20b680b977617c961"} build_url:https://queue.taskcluster.net/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011150 build_url: 'https://queue.taskcluster.net/v1/task/KRTSBu4EQZCuku81o9RQyQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/023aa35eddf9c0d147e3ee74e4c379db84f8d38c0924f83ab3217849bedc753bd3e6d15fe32c7b317d166cfcf75bd1cc7dcbd07133b49dc20aec7d5afe72868a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/03f77edd4b3724fbe7a804e0e3aba0b2188bd469cf4e089a3d44d2f3450d06745abe43e44be609ca0c8d3348cc748d37f46f724f56c97d1ab4afe957f0fe4f5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1a504b355e1cf4ba3c047ae06ff5eda4b3ec2791934f4353acd72d9c66c090eeb19ae1ae831e98bad58f820762a78f087c438310e587b3f20b680b977617c961"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 18:04:19.432058) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:04:19.432406) ========= 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.sKxV5jXTwd/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.wn244lnyoR/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005154 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:04:19.481589) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 18:04:19.481941) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 18:04:19.482319) ========= ========= Total master_lag: 0.17 =========