builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0013 starttime: 1468405636.18 results: success (0) buildid: 20160713023112 builduid: d8e920648a9540d99fb267847ef64c7a revision: b682d06315f82ac0c2ac38a8dd0ec05174835582 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 03:27:16.184389) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 03:27:16.184912) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 03:27:16.185192) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 03:27:16.221018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:27:16.221423) ========= 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.WkiBz9H0Ix/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.P49BKLv8hP/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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-13 03:27:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 114M=0s 2016-07-13 03:27:16 (114 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086228 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:27:16.330895) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:27:16.331221) ========= 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.WkiBz9H0Ix/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.P49BKLv8hP/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.028585 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:27:16.383716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:27:16.384325) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b682d06315f82ac0c2ac38a8dd0ec05174835582 --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 b682d06315f82ac0c2ac38a8dd0ec05174835582 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WkiBz9H0Ix/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.P49BKLv8hP/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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-13 03:27:16,461 truncating revision to first 12 chars 2016-07-13 03:27:16,461 Setting DEBUG logging. 2016-07-13 03:27:16,461 attempt 1/10 2016-07-13 03:27:16,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b682d06315f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 03:27:16,818 unpacking tar archive at: autoland-b682d06315f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.616923 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:27:17.023618) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 03:27:17.023978) ========= script_repo_revision: b682d06315f82ac0c2ac38a8dd0ec05174835582 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 03:27:17.024391) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 03:27:17.024692) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 03:27:17.044360) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-13 03:27:17.044822) ========= /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.WkiBz9H0Ix/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.P49BKLv8hP/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 03:27:17 INFO - MultiFileLogger online at 20160713 03:27:17 in /builds/slave/test 03:27:17 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 03:27:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:27:17 INFO - {'append_to_log': False, 03:27:17 INFO - 'base_work_dir': '/builds/slave/test', 03:27:17 INFO - 'blob_upload_branch': 'Autoland', 03:27:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:27:17 INFO - 'branch': 'Autoland', 03:27:17 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:17 INFO - 'config_files': ('talos/mac_config.py',), 03:27:17 INFO - 'default_actions': ('clobber', 03:27:17 INFO - 'read-buildbot-config', 03:27:17 INFO - 'download-and-extract', 03:27:17 INFO - 'populate-webroot', 03:27:17 INFO - 'create-virtualenv', 03:27:17 INFO - 'install', 03:27:17 INFO - 'run-tests'), 03:27:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:17 INFO - 'download_minidump_stackwalk': True, 03:27:17 INFO - 'download_symbols': 'ondemand', 03:27:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:27:17 INFO - 'tooltool.py': '/tools/tooltool.py', 03:27:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:27:17 INFO - '/tools/misc-python/virtualenv.py')}, 03:27:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:17 INFO - 'installer_path': 'installer.exe', 03:27:17 INFO - 'log_level': 'info', 03:27:17 INFO - 'log_name': 'talos', 03:27:17 INFO - 'log_to_console': True, 03:27:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:27:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:27:17 INFO - 'opt_config_files': (), 03:27:17 INFO - 'pip_index': False, 03:27:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:27:17 INFO - 'cmd': ('bash', 03:27:17 INFO - '-c', 03:27:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:27:17 INFO - 'enabled': True, 03:27:17 INFO - 'halt_on_failure': False, 03:27:17 INFO - 'name': 'check_screen_resolution'},), 03:27:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:27:17 INFO - 'cmd': ('bash', 03:27:17 INFO - '-c', 03:27:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:27:17 INFO - 'enabled': True, 03:27:17 INFO - 'halt_on_failure': False, 03:27:17 INFO - 'name': 'check_screen_resolution'},), 03:27:17 INFO - 'run_cmd_checks_enabled': True, 03:27:17 INFO - 'sps_profile': False, 03:27:17 INFO - 'sps_profile_interval': 0, 03:27:17 INFO - 'suite': 'dromaeojs', 03:27:17 INFO - 'system_bits': '32', 03:27:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:17 INFO - 'title': 't-yosemite-r7-0013', 03:27:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:17 INFO - 'use_talos_json': True, 03:27:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:27:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:17 INFO - 'work_dir': 'build'} 03:27:17 INFO - ##### 03:27:17 INFO - ##### Running clobber step. 03:27:17 INFO - ##### 03:27:17 INFO - Running pre-action listener: _resource_record_pre_action 03:27:17 INFO - Running main action method: clobber 03:27:17 INFO - rmtree: /builds/slave/test/build 03:27:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:27:19 INFO - Running post-action listener: _resource_record_post_action 03:27:19 INFO - ##### 03:27:19 INFO - ##### Finished clobber step (success) 03:27:19 INFO - ##### 03:27:19 INFO - ##### 03:27:19 INFO - ##### Running read-buildbot-config step. 03:27:19 INFO - ##### 03:27:19 INFO - Running pre-action listener: _resource_record_pre_action 03:27:19 INFO - Running main action method: read_buildbot_config 03:27:19 INFO - Using buildbot properties: 03:27:19 INFO - { 03:27:19 INFO - "project": "", 03:27:19 INFO - "product": "firefox", 03:27:19 INFO - "script_repo_revision": "production", 03:27:19 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 03:27:19 INFO - "repository": "", 03:27:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 03:27:19 INFO - "buildid": "20160713023112", 03:27:19 INFO - "pgo_build": "False", 03:27:19 INFO - "basedir": "/builds/slave/test", 03:27:19 INFO - "buildnumber": 60, 03:27:19 INFO - "slavename": "t-yosemite-r7-0013", 03:27:19 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:27:19 INFO - "platform": "yosemite_r7", 03:27:19 INFO - "scheduler": "tests-autoland-macosx64-talos", 03:27:19 INFO - "branch": "autoland", 03:27:19 INFO - "repo_path": "integration/autoland", 03:27:19 INFO - "revision": "b682d06315f82ac0c2ac38a8dd0ec05174835582", 03:27:19 INFO - "stage_platform": "macosx64", 03:27:19 INFO - "builduid": "d8e920648a9540d99fb267847ef64c7a", 03:27:19 INFO - "slavebuilddir": "test" 03:27:19 INFO - } 03:27:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 03:27:19 INFO - Running post-action listener: _resource_record_post_action 03:27:19 INFO - ##### 03:27:19 INFO - ##### Finished read-buildbot-config step (success) 03:27:19 INFO - ##### 03:27:19 INFO - ##### 03:27:19 INFO - ##### Running download-and-extract step. 03:27:19 INFO - ##### 03:27:19 INFO - Running pre-action listener: _resource_record_pre_action 03:27:19 INFO - Running main action method: download_and_extract 03:27:19 INFO - mkdir: /builds/slave/test/build/tests 03:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:27:19 INFO - https://queue.taskcluster.net/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:27:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 03:27:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 03:27:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/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 03:27:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/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 03:27:21 INFO - Downloaded 1199 bytes. 03:27:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 03:27:21 INFO - Using the following test package requirements: 03:27:21 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 03:27:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:27:21 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 03:27:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:27:21 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 03:27:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:27:21 INFO - u'jsshell-mac.zip'], 03:27:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:27:21 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 03:27:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 03:27:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:27:21 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 03:27:21 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:27:21 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 03:27:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:27:21 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 03:27:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:27:21 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 03:27:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:21 INFO - https://queue.taskcluster.net/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:27:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:27:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:27:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/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 03:27:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/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 03:27:23 INFO - Downloaded 18822820 bytes. 03:27:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:27:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:27:26 INFO - Return code: 0 03:27:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:27:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:26 INFO - https://queue.taskcluster.net/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:27:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:27:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:27:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/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 03:27:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/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 03:27:27 INFO - Downloaded 18822820 bytes. 03:27:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:27:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:27:31 INFO - Return code: 0 03:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:31 INFO - https://queue.taskcluster.net/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:27:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 03:27:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 03:27:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/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 03:27:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/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 03:27:32 INFO - Downloaded 14403317 bytes. 03:27:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:27:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:27:33 INFO - Return code: 0 03:27:33 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')]} 03:27:33 INFO - https://queue.taskcluster.net/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:27:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:27:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:27:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 03:27:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BVRTObPaQTusWF6QYYrW4g/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 03:27:36 INFO - Downloaded 112791107 bytes. 03:27:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:27:36 INFO - mkdir: /builds/slave/test/properties 03:27:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:27:36 INFO - Writing to file /builds/slave/test/properties/build_url 03:27:36 INFO - Contents: 03:27:36 INFO - build_url:https://queue.taskcluster.net/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:27:37 INFO - Running post-action listener: _resource_record_post_action 03:27:37 INFO - Running post-action listener: set_extra_try_arguments 03:27:37 INFO - ##### 03:27:37 INFO - ##### Finished download-and-extract step (success) 03:27:37 INFO - ##### 03:27:37 INFO - ##### 03:27:37 INFO - ##### Running populate-webroot step. 03:27:37 INFO - ##### 03:27:37 INFO - Running pre-action listener: _resource_record_pre_action 03:27:37 INFO - Running main action method: populate_webroot 03:27:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:27:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:27:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:27:37 INFO - '--tppagecycles', 03:27:37 INFO - '7'], 03:27:37 INFO - 'tests': ['tsvgm']}}, 03:27:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:27:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:27:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:27:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:27:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:27:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:27:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:37 INFO - 'talos_options': ['--disable-e10s'], 03:27:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:37 INFO - 'talos_options': ['--disable-e10s'], 03:27:37 INFO - 'tests': ['damp', 'tps']}, 03:27:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:37 INFO - 'tests': ['damp', 'tps']}, 03:27:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:27:37 INFO - 'tests': ['dromaeo_dom']}, 03:27:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:27:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:27:37 INFO - 'tests': ['basic_compositor_video']}, 03:27:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:27:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:27:37 INFO - 'tests': ['a11yr', 03:27:37 INFO - 'ts_paint', 03:27:37 INFO - 'tpaint', 03:27:37 INFO - 'sessionrestore', 03:27:37 INFO - 'sessionrestore_no_auto_restore', 03:27:37 INFO - 'tabpaint']}, 03:27:37 INFO - 'other-e10s': {'tests': ['a11yr', 03:27:37 INFO - 'ts_paint', 03:27:37 INFO - 'tpaint', 03:27:37 INFO - 'sessionrestore', 03:27:37 INFO - 'sessionrestore_no_auto_restore', 03:27:37 INFO - 'tabpaint']}, 03:27:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:27:37 INFO - 'ts_paint', 03:27:37 INFO - 'tpaint', 03:27:37 INFO - 'sessionrestore', 03:27:37 INFO - 'sessionrestore_no_auto_restore', 03:27:37 INFO - 'tabpaint']}, 03:27:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:27:37 INFO - 'ts_paint', 03:27:37 INFO - 'tpaint', 03:27:37 INFO - 'sessionrestore', 03:27:37 INFO - 'sessionrestore_no_auto_restore', 03:27:37 INFO - 'tabpaint']}, 03:27:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:27:37 INFO - 'tests': ['a11yr', 03:27:37 INFO - 'ts_paint', 03:27:37 INFO - 'tpaint', 03:27:37 INFO - 'sessionrestore', 03:27:37 INFO - 'sessionrestore_no_auto_restore', 03:27:37 INFO - 'tabpaint']}, 03:27:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:27:37 INFO - 'tests': ['a11yr', 03:27:37 INFO - 'ts_paint', 03:27:37 INFO - 'tpaint', 03:27:37 INFO - 'sessionrestore', 03:27:37 INFO - 'sessionrestore_no_auto_restore', 03:27:37 INFO - 'tabpaint']}, 03:27:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:27:37 INFO - 'tests': ['tsvgx', 03:27:37 INFO - 'tsvgr_opacity', 03:27:37 INFO - 'tart', 03:27:37 INFO - 'tscrollx', 03:27:37 INFO - 'cart']}, 03:27:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:27:37 INFO - 'tsvgr_opacity', 03:27:37 INFO - 'tart', 03:27:37 INFO - 'tscrollx', 03:27:37 INFO - 'cart']}, 03:27:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:37 INFO - 'talos_options': ['--disable-e10s'], 03:27:37 INFO - 'tests': ['tp5o']}, 03:27:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:37 INFO - 'tests': ['tp5o']}, 03:27:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:37 INFO - 'talos_options': ['--disable-e10s', 03:27:37 INFO - '--xperf_path', 03:27:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:37 INFO - 'tests': ['tp5n']}, 03:27:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:27:37 INFO - 'talos_options': ['--xperf_path', 03:27:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:37 INFO - 'tests': ['tp5n']}}, 03:27:37 INFO - 'talos.zip': {'path': '', 03:27:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:27:37 INFO - Running post-action listener: _resource_record_post_action 03:27:37 INFO - ##### 03:27:37 INFO - ##### Finished populate-webroot step (success) 03:27:37 INFO - ##### 03:27:37 INFO - ##### 03:27:37 INFO - ##### Running create-virtualenv step. 03:27:37 INFO - ##### 03:27:37 INFO - Running pre-action listener: _resource_record_pre_action 03:27:37 INFO - Running main action method: create_virtualenv 03:27:37 INFO - Creating virtualenv /builds/slave/test/build/venv 03:27:37 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 03:27:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:27:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:27:37 INFO - Using real prefix '/tools/python27' 03:27:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:27:37 INFO - Installing distribute.............................................................................................................................................................................................done. 03:27:40 INFO - Installing pip.................done. 03:27:40 INFO - Return code: 0 03:27:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104953a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8849d4ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b7d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048afb20>, '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.WkiBz9H0Ix/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.P49BKLv8hP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 03:27:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:27:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:27:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkiBz9H0Ix/Render', 03:27:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:40 INFO - 'HOME': '/Users/cltbld', 03:27:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:40 INFO - 'LOGNAME': 'cltbld', 03:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:40 INFO - 'MOZ_NO_REMOTE': '1', 03:27:40 INFO - 'NO_EM_RESTART': '1', 03:27:40 INFO - 'PAGER': '/bin/cat', 03:27:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:40 INFO - 'PWD': '/builds/slave/test', 03:27:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:40 INFO - 'SHELL': '/bin/bash', 03:27:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P49BKLv8hP/Listeners', 03:27:40 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 03:27:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:40 INFO - 'USER': 'cltbld', 03:27:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:40 INFO - 'XPC_FLAGS': '0x0', 03:27:40 INFO - 'XPC_SERVICE_NAME': '0', 03:27:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:41 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 03:27:41 INFO - Cleaning up... 03:27:41 INFO - Return code: 0 03:27:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104953a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8849d4ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b7d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048afb20>, '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.WkiBz9H0Ix/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.P49BKLv8hP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 03:27:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:27:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkiBz9H0Ix/Render', 03:27:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:41 INFO - 'HOME': '/Users/cltbld', 03:27:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:41 INFO - 'LOGNAME': 'cltbld', 03:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:41 INFO - 'MOZ_NO_REMOTE': '1', 03:27:41 INFO - 'NO_EM_RESTART': '1', 03:27:41 INFO - 'PAGER': '/bin/cat', 03:27:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:41 INFO - 'PWD': '/builds/slave/test', 03:27:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:41 INFO - 'SHELL': '/bin/bash', 03:27:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P49BKLv8hP/Listeners', 03:27:41 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 03:27:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:41 INFO - 'USER': 'cltbld', 03:27:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:41 INFO - 'XPC_FLAGS': '0x0', 03:27:41 INFO - 'XPC_SERVICE_NAME': '0', 03:27:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:41 INFO - Downloading/unpacking psutil>=3.1.1 03:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:27:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:44 INFO - Installing collected packages: psutil 03:27:44 INFO - Running setup.py install for psutil 03:27:44 INFO - building 'psutil._psutil_osx' extension 03:27:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:27:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:27:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:27:44 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:27:45 INFO - building 'psutil._psutil_posix' extension 03:27:45 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 03:27:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:27:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:27:45 INFO - ^ 03:27:45 INFO - 1 warning generated. 03:27:45 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 03:27:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:45 INFO - Successfully installed psutil 03:27:45 INFO - Cleaning up... 03:27:45 INFO - Return code: 0 03:27:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104953a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8849d4ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b7d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048afb20>, '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.WkiBz9H0Ix/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.P49BKLv8hP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 03:27:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:27:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkiBz9H0Ix/Render', 03:27:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:45 INFO - 'HOME': '/Users/cltbld', 03:27:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:45 INFO - 'LOGNAME': 'cltbld', 03:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:45 INFO - 'MOZ_NO_REMOTE': '1', 03:27:45 INFO - 'NO_EM_RESTART': '1', 03:27:45 INFO - 'PAGER': '/bin/cat', 03:27:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:45 INFO - 'PWD': '/builds/slave/test', 03:27:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:45 INFO - 'SHELL': '/bin/bash', 03:27:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P49BKLv8hP/Listeners', 03:27:45 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 03:27:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:45 INFO - 'USER': 'cltbld', 03:27:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:45 INFO - 'XPC_FLAGS': '0x0', 03:27:45 INFO - 'XPC_SERVICE_NAME': '0', 03:27:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:27: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 03:27: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 03:27: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 03:27: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 03:27: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 03:27: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 03:27:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:27:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:27:48 INFO - Installing collected packages: mozsystemmonitor 03:27:48 INFO - Running setup.py install for mozsystemmonitor 03:27:48 INFO - Successfully installed mozsystemmonitor 03:27:48 INFO - Cleaning up... 03:27:48 INFO - Return code: 0 03:27:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 03:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104953a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8849d4ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b7d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048afb20>, '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.WkiBz9H0Ix/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.P49BKLv8hP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 03:27:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:27:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkiBz9H0Ix/Render', 03:27:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:48 INFO - 'HOME': '/Users/cltbld', 03:27:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:48 INFO - 'LOGNAME': 'cltbld', 03:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:48 INFO - 'MOZ_NO_REMOTE': '1', 03:27:48 INFO - 'NO_EM_RESTART': '1', 03:27:48 INFO - 'PAGER': '/bin/cat', 03:27:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:48 INFO - 'PWD': '/builds/slave/test', 03:27:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:48 INFO - 'SHELL': '/bin/bash', 03:27:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P49BKLv8hP/Listeners', 03:27:48 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 03:27:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:48 INFO - 'USER': 'cltbld', 03:27:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:48 INFO - 'XPC_FLAGS': '0x0', 03:27:48 INFO - 'XPC_SERVICE_NAME': '0', 03:27:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:48 INFO - Downloading/unpacking jsonschema==2.5.1 03:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:27:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:51 INFO - Downloading functools32-3.2.3-2.tar.gz 03:27:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:27:51 INFO - warning: no files found matching '*.txt' 03:27:51 INFO - no previously-included directories found matching 'build' 03:27:51 INFO - no previously-included directories found matching 'dist' 03:27:51 INFO - no previously-included directories found matching '.git*' 03:27:51 INFO - Installing collected packages: jsonschema, functools32 03:27:51 INFO - Running setup.py install for functools32 03:27:51 INFO - warning: no files found matching '*.txt' 03:27:51 INFO - no previously-included directories found matching 'build' 03:27:51 INFO - no previously-included directories found matching 'dist' 03:27:51 INFO - no previously-included directories found matching '.git*' 03:27:51 INFO - Successfully installed jsonschema functools32 03:27:51 INFO - Cleaning up... 03:27:51 INFO - Return code: 0 03:27:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27: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')]} 03:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104953a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8849d4ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b7d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048afb20>, '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.WkiBz9H0Ix/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.P49BKLv8hP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 03:27:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:27:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkiBz9H0Ix/Render', 03:27:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:51 INFO - 'HOME': '/Users/cltbld', 03:27:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:51 INFO - 'LOGNAME': 'cltbld', 03:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:51 INFO - 'MOZ_NO_REMOTE': '1', 03:27:51 INFO - 'NO_EM_RESTART': '1', 03:27:51 INFO - 'PAGER': '/bin/cat', 03:27:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:51 INFO - 'PWD': '/builds/slave/test', 03:27:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:51 INFO - 'SHELL': '/bin/bash', 03:27:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P49BKLv8hP/Listeners', 03:27:51 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 03:27:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:51 INFO - 'USER': 'cltbld', 03:27:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:51 INFO - 'XPC_FLAGS': '0x0', 03:27:51 INFO - 'XPC_SERVICE_NAME': '0', 03:27:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:52 INFO - Downloading/unpacking blobuploader==1.2.4 03:27:52 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 03:27:52 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 03:27:52 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 03:27:52 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 03:27:52 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 03:27:52 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 03:27:54 INFO - Downloading blobuploader-1.2.4.tar.gz 03:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:27:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:27:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:27:55 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 03:27:55 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 03:27:55 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 03:27:55 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 03:27:55 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 03:27:55 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 03:27:55 INFO - Downloading docopt-0.6.1.tar.gz 03:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:27:55 INFO - Installing collected packages: blobuploader, requests, docopt 03:27:55 INFO - Running setup.py install for blobuploader 03:27:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:27:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:27:56 INFO - Running setup.py install for requests 03:27:56 INFO - Running setup.py install for docopt 03:27:56 INFO - Successfully installed blobuploader requests docopt 03:27:56 INFO - Cleaning up... 03:27:56 INFO - Return code: 0 03:27:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:56 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')]} 03:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:56 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')]} 03:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:27:56 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 0x104953a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8849d4ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b7d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048afb20>, '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.WkiBz9H0Ix/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.P49BKLv8hP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 03:27:56 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 03:27:56 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 03:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkiBz9H0Ix/Render', 03:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:27:56 INFO - 'HOME': '/Users/cltbld', 03:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:27:56 INFO - 'LOGNAME': 'cltbld', 03:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:56 INFO - 'MOZ_NO_REMOTE': '1', 03:27:56 INFO - 'NO_EM_RESTART': '1', 03:27:56 INFO - 'PAGER': '/bin/cat', 03:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:56 INFO - 'PWD': '/builds/slave/test', 03:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:27:56 INFO - 'SHELL': '/bin/bash', 03:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P49BKLv8hP/Listeners', 03:27:56 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 03:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:27:56 INFO - 'USER': 'cltbld', 03:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:56 INFO - 'XPC_FLAGS': '0x0', 03:27:56 INFO - 'XPC_SERVICE_NAME': '0', 03:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-obt9Bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-AyjYjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ohmyFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-HKoD8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-dOJuqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-1bzIpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-LE2f_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-GhYw6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:57 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ZpjNoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:58 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Pz0Atz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:58 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-nBQFOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:58 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-y1P6YP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:58 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-T96mQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:58 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-kpYRRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:58 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-2Nh2tE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:58 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-QW4eQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:58 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-y4yEBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:27:58 INFO - Running setup.py install for manifestparser 03:27:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:27:58 INFO - Running setup.py install for mozcrash 03:27:59 INFO - Running setup.py install for mozdebug 03:27:59 INFO - Running setup.py install for mozdevice 03:27:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:27:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:27:59 INFO - Running setup.py install for mozfile 03:27:59 INFO - Running setup.py install for mozhttpd 03:27:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:27:59 INFO - Running setup.py install for mozinfo 03:27:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:27:59 INFO - Running setup.py install for mozInstall 03:27:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:27:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:27:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:27:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:27:59 INFO - Running setup.py install for mozleak 03:28:00 INFO - Running setup.py install for mozlog 03:28:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:00 INFO - Running setup.py install for moznetwork 03:28:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:00 INFO - Running setup.py install for mozprocess 03:28:00 INFO - Running setup.py install for mozprofile 03:28:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:00 INFO - Running setup.py install for mozrunner 03:28:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:00 INFO - Running setup.py install for mozscreenshot 03:28:01 INFO - Running setup.py install for moztest 03:28:01 INFO - Running setup.py install for mozversion 03:28:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:01 INFO - Cleaning up... 03:28:01 INFO - Return code: 0 03:28:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:01 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 0x104953a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8849d4ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b7d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048afb20>, '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.WkiBz9H0Ix/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.P49BKLv8hP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 03:28:01 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 03:28:01 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 03:28:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkiBz9H0Ix/Render', 03:28:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:01 INFO - 'HOME': '/Users/cltbld', 03:28:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:01 INFO - 'LOGNAME': 'cltbld', 03:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:01 INFO - 'MOZ_NO_REMOTE': '1', 03:28:01 INFO - 'NO_EM_RESTART': '1', 03:28:01 INFO - 'PAGER': '/bin/cat', 03:28:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:01 INFO - 'PWD': '/builds/slave/test', 03:28:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:01 INFO - 'SHELL': '/bin/bash', 03:28:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P49BKLv8hP/Listeners', 03:28:01 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 03:28:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:01 INFO - 'USER': 'cltbld', 03:28:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:01 INFO - 'XPC_FLAGS': '0x0', 03:28:01 INFO - 'XPC_SERVICE_NAME': '0', 03:28:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:01 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-lbLNGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:01 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)) 03:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:01 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-hD2Twi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:01 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)) 03:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:01 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-NW1YSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:01 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-YuR3Ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:02 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)) 03:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-hXo3Ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:02 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)) 03:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-ljICME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:02 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)) 03:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-7jLF9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:02 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)) 03:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-xeIy1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:02 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)) 03:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-w0iUat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:02 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)) 03:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-wIrdBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-892Wuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:02 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)) 03:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-Vxop9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:02 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-IYiyWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:03 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)) 03:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:03 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-nBgfUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:03 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)) 03:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:03 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-4xpXD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:03 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)) 03:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:03 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-k9q2bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:03 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)) 03:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:03 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-2DEmeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:03 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)) 03:28:03 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)) 03:28:03 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)) 03:28:03 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)) 03:28:03 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)) 03:28:03 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)) 03:28:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:03 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 03:28:03 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 03:28:03 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 03:28:03 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 03:28:03 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 03:28:03 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 03:28:05 INFO - Downloading blessings-1.6.tar.gz 03:28:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:06 INFO - Installing collected packages: blessings 03:28:06 INFO - Running setup.py install for blessings 03:28:06 INFO - Successfully installed blessings 03:28:06 INFO - Cleaning up... 03:28:06 INFO - Return code: 0 03:28:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:06 INFO - Reading from file tmpfile_stdout 03:28:06 INFO - Current package versions: 03:28:06 INFO - blessings == 1.6 03:28:06 INFO - blobuploader == 1.2.4 03:28:06 INFO - docopt == 0.6.1 03:28:06 INFO - functools32 == 3.2.3-2 03:28:06 INFO - jsonschema == 2.5.1 03:28:06 INFO - manifestparser == 1.1 03:28:06 INFO - mozInstall == 1.12 03:28:06 INFO - mozcrash == 0.17 03:28:06 INFO - mozdebug == 0.1 03:28:06 INFO - mozdevice == 0.48 03:28:06 INFO - mozfile == 1.2 03:28:06 INFO - mozhttpd == 0.7 03:28:06 INFO - mozinfo == 0.9 03:28:06 INFO - mozleak == 0.1 03:28:06 INFO - mozlog == 3.2 03:28:06 INFO - moznetwork == 0.27 03:28:06 INFO - mozprocess == 0.23 03:28:06 INFO - mozprofile == 0.28 03:28:06 INFO - mozrunner == 6.12 03:28:06 INFO - mozscreenshot == 0.1 03:28:06 INFO - mozsystemmonitor == 0.3 03:28:06 INFO - moztest == 0.7 03:28:06 INFO - mozversion == 1.4 03:28:06 INFO - psutil == 3.1.1 03:28:06 INFO - requests == 1.2.3 03:28:06 INFO - wsgiref == 0.1.2 03:28:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:06 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')]} 03:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:06 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')]} 03:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:06 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 0x104953a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8849d4ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b7d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048afb20>, '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.WkiBz9H0Ix/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.P49BKLv8hP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 03:28:06 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 03:28:06 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 03:28:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkiBz9H0Ix/Render', 03:28:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:06 INFO - 'HOME': '/Users/cltbld', 03:28:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:06 INFO - 'LOGNAME': 'cltbld', 03:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:06 INFO - 'MOZ_NO_REMOTE': '1', 03:28:06 INFO - 'NO_EM_RESTART': '1', 03:28:06 INFO - 'PAGER': '/bin/cat', 03:28:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:06 INFO - 'PWD': '/builds/slave/test', 03:28:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:06 INFO - 'SHELL': '/bin/bash', 03:28:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P49BKLv8hP/Listeners', 03:28:06 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 03:28:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:06 INFO - 'USER': 'cltbld', 03:28:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:06 INFO - 'XPC_FLAGS': '0x0', 03:28:06 INFO - 'XPC_SERVICE_NAME': '0', 03:28:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:06 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)) 03:28:06 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)) 03:28:06 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)) 03:28:06 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)) 03:28:06 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)) 03:28:06 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)) 03:28:06 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)) 03:28:06 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)) 03:28:06 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)) 03:28:06 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)) 03:28:06 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)) 03:28:06 INFO - Cleaning up... 03:28:06 INFO - Return code: 0 03:28:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28:06 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')]} 03:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:06 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')]} 03:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:06 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 0x104953a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1049e8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8849d4ff40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048b7d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048afb20>, '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.WkiBz9H0Ix/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.P49BKLv8hP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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 03:28:06 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 03:28:06 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 03:28:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkiBz9H0Ix/Render', 03:28:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:06 INFO - 'HOME': '/Users/cltbld', 03:28:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:06 INFO - 'LOGNAME': 'cltbld', 03:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:06 INFO - 'MOZ_NO_REMOTE': '1', 03:28:06 INFO - 'NO_EM_RESTART': '1', 03:28:06 INFO - 'PAGER': '/bin/cat', 03:28:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:06 INFO - 'PWD': '/builds/slave/test', 03:28:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:06 INFO - 'SHELL': '/bin/bash', 03:28:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P49BKLv8hP/Listeners', 03:28:06 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 03:28:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:06 INFO - 'USER': 'cltbld', 03:28:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:06 INFO - 'XPC_FLAGS': '0x0', 03:28:06 INFO - 'XPC_SERVICE_NAME': '0', 03:28:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:28:07 INFO - Cleaning up... 03:28:07 INFO - Return code: 0 03:28:07 INFO - Running post-action listener: _resource_record_post_action 03:28:07 INFO - Running post-action listener: _start_resource_monitoring 03:28:07 INFO - Starting resource monitoring. 03:28:07 INFO - ##### 03:28:07 INFO - ##### Finished create-virtualenv step (success) 03:28:07 INFO - ##### 03:28:07 INFO - ##### 03:28:07 INFO - ##### Running install step. 03:28:07 INFO - ##### 03:28:07 INFO - Running pre-action listener: _resource_record_pre_action 03:28:07 INFO - Running main action method: install 03:28:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:07 INFO - Reading from file tmpfile_stdout 03:28:07 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:07 INFO - Reading from file tmpfile_stdout 03:28:07 INFO - Output received: 03:28:07 INFO - Usage: mozinstall [options] installer 03:28:07 INFO - Options: 03:28:07 INFO - -h, --help show this help message and exit 03:28:07 INFO - -d DEST, --destination=DEST 03:28:07 INFO - Directory to install application into. [default: 03:28:07 INFO - "/builds/slave/test"] 03:28:07 INFO - --app=APP Application being installed. [default: firefox] 03:28:07 INFO - mkdir: /builds/slave/test/build/application 03:28:07 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'] 03:28:07 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 03:28:42 INFO - Reading from file tmpfile_stdout 03:28:42 INFO - Output received: 03:28:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:28:42 INFO - Running post-action listener: _resource_record_post_action 03:28:42 INFO - ##### 03:28:42 INFO - ##### Finished install step (success) 03:28:42 INFO - ##### 03:28:42 INFO - ##### 03:28:42 INFO - ##### Running run-tests step. 03:28:42 INFO - ##### 03:28:42 INFO - Running pre-action listener: _resource_record_pre_action 03:28:42 INFO - Running main action method: run_tests 03:28:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:28:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:28:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:28:42 INFO - 2016-07-13 03:28:42.259 screenresolution[1640:7538] starting screenresolution argv=screenresolution get 03:28:42 INFO - 2016-07-13 03:28:42.261 screenresolution[1640:7538] Display 0: 1600x1200x32@60 03:28:42 INFO - 2016-07-13 03:28:42.268 screenresolution[1641:7540] starting screenresolution argv=screenresolution list 03:28:42 INFO - Available Modes on Display 0 03:28:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:28:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:28:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:28:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:28:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:28:42 INFO - Intel Iris: 03:28:42 INFO - Chipset Model: Intel Iris 03:28:42 INFO - Type: GPU 03:28:42 INFO - Bus: Built-In 03:28:42 INFO - VRAM (Dynamic, Max): 1536 MB 03:28:42 INFO - Vendor: Intel (0x8086) 03:28:42 INFO - Device ID: 0x0a2e 03:28:42 INFO - Revision ID: 0x0009 03:28:42 INFO - Displays: 03:28:42 INFO - Display: 03:28:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:28:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:28:42 INFO - Display Serial Number: 1600x1200 60 03:28:42 INFO - Main Display: Yes 03:28:42 INFO - Mirror: Off 03:28:42 INFO - Online: Yes 03:28:42 INFO - Rotation: Supported 03:28:42 INFO - Return code: 0 03:28:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:28:42 INFO - Python 2.7.3 03:28:42 INFO - Return code: 0 03:28:42 INFO - grabbing minidump binary from tooltool 03:28:42 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')]} 03:28:42 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 0x1048b7d30>, '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 0x10461cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1048afb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:28:42 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 03:28:42 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 03:28:42 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 03:28:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:42 INFO - Return code: 0 03:28:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:28:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:28:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:28:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:28:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:28:42 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/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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 03:28:42 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/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0013 --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 03:28:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WkiBz9H0Ix/Render', 03:28:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:28:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:28:42 INFO - 'HOME': '/Users/cltbld', 03:28:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:28:42 INFO - 'LOGNAME': 'cltbld', 03:28:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:42 INFO - 'MOZ_NO_REMOTE': '1', 03:28:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:42 INFO - 'NO_EM_RESTART': '1', 03:28:42 INFO - 'PAGER': '/bin/cat', 03:28:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:42 INFO - 'PWD': '/builds/slave/test', 03:28:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:28:42 INFO - 'SHELL': '/bin/bash', 03:28:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P49BKLv8hP/Listeners', 03:28:42 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 03:28:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:28:42 INFO - 'USER': 'cltbld', 03:28:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:28:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:42 INFO - 'XPC_FLAGS': '0x0', 03:28:42 INFO - 'XPC_SERVICE_NAME': '0', 03:28:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:28:42 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/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--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 03:28:42 INFO - mozversion application_buildid: 20160713023112 03:28:42 INFO - mozversion application_changeset: b682d06315f82ac0c2ac38a8dd0ec05174835582 03:28:42 INFO - mozversion application_display_name: Nightly 03:28:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:42 INFO - mozversion application_name: Firefox 03:28:42 INFO - mozversion application_remotingname: firefox 03:28:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:28:42 INFO - mozversion application_vendor: Mozilla 03:28:42 INFO - mozversion application_version: 50.0a1 03:28:42 INFO - mozversion platform_buildid: 20160713023112 03:28:42 INFO - mozversion platform_changeset: b682d06315f82ac0c2ac38a8dd0ec05174835582 03:28:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:28:42 INFO - mozversion platform_version: 50.0a1 03:28:42 INFO - using testdate: 1468405722 03:28:42 INFO - actual date: 1468405722 03:28:42 INFO - starting webserver on 'localhost:49271' 03:28:42 INFO - SUITE-START | Running 2 tests 03:28:42 INFO - TEST-START | dromaeo_css 03:28:42 INFO - operating with platform_type : mac_ 03:28:42 INFO - Initialising browser for dromaeo_css test... 03:28:42 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpS4Dk5N/profile http://localhost:49271/getInfo.html) 03:28:45 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 03:28:45 INFO - PROCESS | 1651 | colorDepth:24 03:28:45 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 03:28:45 INFO - PROCESS | 1651 | __metrics 03:28:45 INFO - PROCESS | 1651 | 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" 03:28:45 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:28:46 INFO - TEST-INFO | 1651: exit 0 03:28:46 INFO - Browser initialized. 03:28:46 INFO - Running cycle 1/1 for dromaeo_css test... 03:28:46 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpS4Dk5N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:28:58 INFO - PROCESS | 1653 | RSS: Main: 243585024 03:28:58 INFO - PROCESS | 1653 | 03:29:49 INFO - PROCESS | 1653 | 1468405789752 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] 03:32:00 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 03:32:01 INFO - PROCESS | 1653 | RSS: Main: 342343680 03:32:01 INFO - PROCESS | 1653 | 03:35:04 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 03:35:05 INFO - PROCESS | 1653 | RSS: Main: 374460416 03:35:05 INFO - PROCESS | 1653 | 03:38:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 03:38:07 INFO - PROCESS | 1653 | RSS: Main: 372682752 03:38:07 INFO - PROCESS | 1653 | 03:41:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 03:41:10 INFO - PROCESS | 1653 | RSS: Main: 372359168 03:41:10 INFO - PROCESS | 1653 | 03:44:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 03:44:14 INFO - PROCESS | 1653 | RSS: Main: 338817024 03:44:14 INFO - PROCESS | 1653 | 03:47:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 03:47:18 INFO - PROCESS | 1653 | RSS: Main: 383991808 03:47:18 INFO - PROCESS | 1653 | 03:47:18 INFO - PROCESS | 1653 | __start_tp_report 03:47:18 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 03:47:18 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 03:47:18 INFO - PROCESS | 1653 | |i|pagename|runs| 03:47:18 INFO - PROCESS | 1653 | |0;dojo.html;3261.217307846117;3285.457899446593;3298.6536413676563;3307.503874418838;3352.296017836254;5415.729213539317;5496.477834605711;5516.7517461714215;5558.082916318807;5568.582356323272;5521;5539.892021595687;5551.333839939203;5558.110702287635;5558.610897237195;4968.677035992658;5016.097102521545;5035.84892453227;5083.898322033557;5113.821016264432;5031.018951304497;5092.643514953955;5098.413682426512;5103.23451482277;5140.0490909181735;5029.899402011957;5050.898982020358;5054.014467178901;5064.3922729272535;5076.796928122871;5100.617453690969;5134;5138.74306284688;5143.794248230066;5171.250168725552;4943.1596628573225;4993.775280112403;4996.900061998776;5043.394792624872;5064.924026139611;5527.917081243784;5532.5573954083575;5557.916631250535;5569.777208911639;5572.136318870582;6036.3360030396625;6036.426539478786;6051.939480605181;6053.485453736438;6064.8180554583;5882.941170588282;6082.270127584674;6095.598012457115;6146.323904370515;6171.537134714914;5603.2435621191435;5637;5646.0683987141665;5656.575756818214;5669.716514174357;6275.278342990615;6289.276733175652;6293.2762732285455;6295.905561416583;6298.370162983665;5706.80026199081;5801.622894511843;5874.0014197586515;5876.588638795329;5923.141144534018;6051.909221361683;6061.931942483185;6069.247852462062;6070.63359567529;6108.236470441195;5231.633785635046;5938.049912014057;5945.346011938684;5957.225560677084;5967.075103358986;5835.533157347402;5925.674087925119;5999.730012149464;6038.094285857069;6075.027995520783;4790.305405716222;4792.760361981887;4793.400824896888;4796.136695394863;4827.806887724522;4280.336547835091;4307.870763877088;4336.436263285753;4345.352748031395;4377.255866502702;5333.7866485340155;5415.160650099241;5500.834974950758;5552;5554.305711786027;6129.478994285536;6131.693415329216;6142.324344322121;6143.447089761854;6150.600210986271;5486.753096110685;5552.111662134039;5560.138178582326;5574.052411090124;5582.888342233133;5135.281060651511;5190.37715474138;5204.089284375219;5227.18978558324;5261.210818377274;6280.183576135073;6284.151639528788;6290.779822706183;6294.590851594632;6309.652969086653;6041.667708276087;6060.757569697163;6085.786997455068;6095.451409373;6096.268447786117;6109.266887973294;6231.2522497300615;6285.842853928689;6335.1447554579545;6350.936490635219;5959.016762234182;5983.820485385445;5998.880022399615;6006.369331220334;6056.364081771527;5859.794907178229;6087.878242435215;6100.389961004042;6147.754089836357;6152.077188421773;5777.884442311214;5793.449622285876;5807.157962095557;5813.79651712188;5841.707914604168;5770.913436298375;5786.3056433228285;5787.2187254720075;5790.334111577223;5808.244928159481;5592.161175823659;5683.943160568341;5689.687067211343;5698.544116470755;5704.828855134353;4933.383327084114;5831.387704290988;5844.912326315024;5878.823635290948;5880.911786323123;5665.858353541194;5719.885602287848;5728.140778883201;5735.426457354231;5746.023176059996 03:47:18 INFO - PROCESS | 1653 | |1;ext.html;494.666100382242;496.92049272116424;514.7992283009625;530.3317819547372;536.1180857489429;26683.466330673375;31600;40663.796681016625;41214;41245.17509649805;42666.57333426665;42947.92630184247;43041.35437968433;43055.13889722204;43170.56829431705;9741.756456088602;9923.751906202366;9943;9945.602175912954;9948.353357031807;8793.516356600385;8951.32865035125;8965.820683586324;9088.272938164931;9106;11855.22941008836;12024.33866137362;12056.63830085099;12304.261744295327;12324.445399957023;12085.395730213499;12246;12263.877361226363;12268.079894007897;12269.263844169378;8671.956640216822;11626.825597616042;11958.88041119595;12044.698882528008;12048.578299759467;38563.84308470751;41003.794981024905;41125;41148;41155.58844411548;3531.3820081485637;3603.5855876574005;3981;4240.385144154111;4253.21315556623;27014.45971080587;31824.84087579547;32653.51019734706;32892.34215315704;32955.50566741501;3243.140567749548;3328.1679580104974;3365.4855315108052;3372.780769249991;3410.3179364127272;421486;540757;542485;543330;544889;58965.70517147387;59028.7048564763;59524.40475595189;59525.10712339319;59536.106958395656;63236.683816580626;63371.683141584916;63429;63452.68273658602;63521;15920.76118858218;16454.177291135635;16459.25933332979;16463.423780167635;16470;12811;12895.871041289467;12898.226106433644;12904.870951290555;12907.548235811702;13879.722405552035;14214.076085054437;14261.78607320891;15601.297941592655;15968.281427335798;5347.973260133675;6413.198350206224;6500.317466666026;6556.114924485229;6560.573562718408;909.9454032758056;965.6137544981923;982.2387649571639;1017.4963393120305;1056.7041228455892;28739.425211495654;28914.710852891203;29984.700152998626;30267.848660756554;30688;877.5612193903048;1069.9893001070045;1071.7106381277013;1148.311013391975;1158.4034222375483;12771.233725976472;15076.321565529577;15386.9230653846;15435.691286174213;15743.842561574467;708930.3660445097;710635;715412;716934;717845;50498.74750626223;58942.70528647329;59384;59563.40436595665;61072.69463652742;1405.1358414574963;1417.9007469477037;1427.0438806000004;1430.27056201336;1430.8068410764622;26521.60217596776;30664.540031899985;31541.842290788398;31697.683023170397;32463.513047303837;49599;50096;50656;50692.746536267085;50695.98608027745;451281;528861;667447;668660;669472.5684601016;38454.846354609406;38965.41551876668;39353.40969885511;39468.40797388099;39514.40728389134;46563.53436465592;46660.53339466562;46999;47262;47536.8115797094;32276.677233228307;38707.03232419212;38720.41919371268;38744.61255387523;39346.01634959149;37045.6295437053;37966.62033379631;38402.42396364113;38746;39098.2180356397;37200.62799371972;37513.43729844109;37574.24851503009;37982.25221847269;38294;28588.712902968127;33129.834350829056;33842.8307858469;34368.48447273343;34465.48301775526;20988.68516972216;24829.62755558704;25331.62002569926;25584.744152558236;25586.458037551813 03:47:18 INFO - PROCESS | 1653 | |2;jquery.html;322.3247296912966;357.53877498027543;376.72499075674756;392.5093632958802;409.83196889275405;15055.548333549983;17042.233099510522;20351.796482035174;21189.788102118993;21197.682034769452;20162.395128146178;21049.894750526226;21094.57810843782;21340.786592134074;21359;4882.389701287339;5356.7321633918245;5516.448355164492;5543.196236545698;5544.500994910457;5453.481919217668;5460.153676180198;5490.533304669108;5501.834944951658;5503;5366.812161574346;5415.512603865652;5502.394736578973;5506.531944784698;5554.055810512223;5439.564834813205;5457.808976685837;5464.316960379952;5480.862978425532;5486.204500347447;5141.177411614124;5275.0632917713465;5308.177232528964;5309.548688361494;5331.466853314676;24567.877160614084;25336.746632533625;25368.492630147477;25621;26495.867520662272;2184.71598692169;2193.3419974007893;2212.358416059341;2234.4637287051155;2269.205777977711;10082.848757268646;10328.896711032869;10860.294080884718;10889.618863339825;15698.843011569967;1917.405604262683;1938.9224431022742;1950.2101648832245;1981.990090049555;2026.037632124729;131331.34334328363;138348;138401.3079934604;139405;142001;9436.716898493056;11542.653720388402;11749.412529373498;11814.704632384259;11934.880651193376;14721.55835324942;14846.109233446028;14851.405943762345;14860.256987150815;14862.70274594502;8527.74416767498;8721.433106848035;8761.912380876238;8811.867821982676;8858.512781797062;8686.044535101133;8696.78258043554;8708.042115367305;8813.515256660945;8836.513991730388;4311.771145223596;4560.198721505053;4598.057398233354;4640.303954406866;4660.627149828006;1754.6402987387555;1768.1866341482805;1805.4309951923701;1959.3730006397816;1965.3121407507545;898.9123160975294;914.6615752171606;967.6419724701765;984.7045886234101;1002.4937406609761;17398.739018914726;20481.48796280105;20989.68515472269;21119.366419007456;21308.467288317916;948.1087777489277;948.5399581203111;977.8191034658611;1041.9684512332735;1064.760428903506;10926.945365273281;11233.10135189183;11248.662540123809;11288.379139147262;11340.6030788922;605026;615406;618262;619169;619269;83393.16606833975;91826.08173918175;113025;138767;144265;952.7379970508305;954.9904500954901;959.4627008875052;985.3595163144014;985.8324084905584;14867.256637168315;19073.046347682837;19224.519387015436;19586.118624661638;19707.60584788325;52195.90963400527;55485.89028219494;56173.876522468505;56371;56394.7180264096;53900;73347;74072.62963685363;74890.62554687192;75292.24707752852;8186.590670466572;8197.590120493833;8255.463394879314;8395.580220988804;8397.328213743009;9274.582643781181;12429.813552796535;12757.744845103232;12989.870101298866;13074.738505230032;11068.225224234226;11080.058195053189;11281;11288.548458061585;11303.095752339628;10866.728331791452;11015.559377624806;11034.117270618171;11171.553137874718;11296.943515282372;11328.263662861887;11332.37671928019;11460;11466.82799758021;11631;8094.919050809416;8147.307478864363;8280.958595206985;8343.41596088268;8373.413861029912;10163.84754228702;11053.115750740082;11252.774944501229;11304.547818087512;11398.886011139783 03:47:18 INFO - PROCESS | 1653 | |3;mootools.html;1537.3158944269796;1581.7627355896614;1782.8841125326853;1928.0456174193775;1932.3236867096518;8369.539675317856;8632.352573556993;8789.42868713534;8789.95605021974;8808.955955220232;7027.929720702791;7685.462017658752;7916.050073991115;8555.144485551442;8641.567921603926;1957.579120489091;2367.5146594948083;2367.763223677627;2370.2533701883935;2379.845310054841;2329.149860300995;2354.682117914085;2358.2335740884196;2359.0445869422824;2360.905563777447;2078.085642317383;2156;2270.0919632147106;2346.049849810821;2353.505763789606;2303.9193628222934;2312.167619656922;2339.9181028664;2381.9047238110543;2386.9880650596638;2360.8819559022154;2361.303415492434;2384.1655420602824;2388.641703744435;2391.1272385579314;8684.435511691783;8734.825303493895;8735.388522803407;8740.606672699743;8745.956270218672;5234.241035049897;5349.545288650469;5401.432849550819;5404.216388623667;5406.216098665672;3578.6600272974024;3597.1007248187952;3641.3081514512423;3652.5251717276583;3665.560132784083;1090.5201711247025;1093.7265683579105;1102.2229328323513;1117.4301106435696;1117.458032854065;11214.215004949658;11426.200165988384;11434.199606027581;11443.084553235722;11454.885451145548;3986.3023970804993;4423.712458690239;4543.840965566189;4575.611073058827;4621.214393553104;9905.108540231413;9909.801803964025;9910.454924979196;9919;9931.255155863195;5301.575873930076;5366;5366.356037275552;5381.408045115034;5388.5419739321815;4764.094821983812;4936.259561065869;4937.8271760488215;4942.629302802305;4957.925631115536;3205.951910721341;3785.6403641653997;3816.637419445148;3861;3866.188100498927;1160.228448082016;1197.9101567382481;1201.5193922431097;1225.08730995409;1243.5274595653593;762.6606160258632;781.1719577248135;804.1797366685947;943.4103237182586;969.6412327438893;5172.612054095958;5599.356074051455;5894.941050589439;6014.879702405928;6149.108379284979;902.5216635183364;914.7850255190025;934.5747684803398;1012.2003617142375;1024.7028361775;3821.3885778275344;3907.667848232932;4024.436578878959;4074.7758873261664;4077.7757223353;10405.42770147634;10544.947275263574;10714.946425267979;10721;10722.356658600509;9706.272029597809;10598.841017384746;10669.89330106689;10669.89330106689;10691.358518488916;7829.960850195713;8081.757547273592;8133.959330203311;8239.970003749651;8263.421560490828;5789.2184555086205;5976.3669535043655;6026.90959635597;6104.4505994460715;6254.906176407449;9404.200642945427;9992.300538962203;9993.850092248767;10001.499925003865;10028.598856045677;9841.60633574649;9971.900280997388;10002.649907253211;10007.949960250153;10023.649172278936;6705.329467053256;7221.097362829646;7264.34620884123;7376.4467664926415;7583.62081895892;8107.1082180958865;8387.95806020966;8392.622331994953;8394.454360466794;8395.328373729964;7118.181409138016;7238.6018768968215;7252.202257751748;7380.557166569808;7436;7139.535930164523;7172.820679483055;7206.819829504304;7288.161861385796;7308.488405811542;6734.966325168343;6960.47796415281;6963.4777391694815;6990.790276291719;7046.189688185924;4840.564349208588;4875.7074575525585;4887.560119589254;4926.655134140576;4996.475370086234;4940.9505904941925;4953.628477864103;4954.50454954516;4982.551570358685;5071.594272458121 03:47:18 INFO - PROCESS | 1653 | |4;prototype.html;303.4416673321089;309.5588785979978;311.14435302916974;314.474827038845;318.5731120298799;5355.732213389329;5443.727813609318;5477.917831232535;5490.780368785244;5503.596582871367;4460.996275837935;5096.916365598815;5302.761375738091;5416.295881535395;5438.646487978289;3269.411505928932;3511.9297614047705;3848.960780589239;3857.8649747258783;4108.26051310764;3508.5965114011833;3817.7136714746366;3964.742291751041;4114.259433302004;4148.357004664282;4036.8587099451524;4053.9391909121387;4080.8775736727944;4080.8979775505554;4092.3043082676018;3370.898873033813;3372.477266023746;3814.2835723924068;3831.7509361891525;3951.6641085507767;2909.846713432045;3100.968990310113;3569.3396721606327;3571.946275848631;3580.5882323532865;4294.668652717636;4755.335632528622;4847.975760121212;5267.236250743659;5309.991101690666;4355.5862193091925;4669.509701481329;4709.835155769531;4726.125666751662;4755.50067242938;4455.153520831064;4831.589314908237;5635.126555383881;5640.717964101819;5647.989927151686;3731.7201209909367;3860.4713912387433;3869.9226015479812;3874.8837534874;3882.6699730522655;5470.316210473691;5882.294124705063;5995.430434108753;5999.190109335227;6033.366496517846;3261;3497.8282275438014;3865.342891708416;3874.554426240962;3895.337792575269;3329.9843547717696;3475.9050898966743;3814.7030009796804;3985.5217373915316;3987.940180897289;4209.779164042455;4328.826846926151;4642.3500709900645;4647.883802904955;4649.977005058881;4548.3158641500495;5416.293867431747;5695.177543186223;5706.058500347396;5743.310802703619;1132.5752842683994;1134.7673726885969;1191.7914364986093;1261.4575732434957;1340.2978217663708;672.277301900459;738.7635956493978;816.4937738602105;822.658596682382;833.7998880268813;4684.992726563805;4957.0085982803585;5074.949250507448;5230.3985041719925;5237.764300606482;5090.073207905469;5614.6631202128;5751.194832723422;5776.393478684761;5875.618084824473;4409.933850992237;5053.700566242351;5282.524572788468;5290.65610735301;5300.701328174622;2527.633493143484;2695.4878573071055;2899.6520417550028;3096.783225174216;3107.456195165837;4977.113274300897;5716.79947211082;5944;5999.220101386792;6057.303410107806;5553.334799032619;5635.21107045014;5726.513246374105;6037.607555508878;6052.727627256696;5312.1673022807845;5512.0905050667;6016.939830601638;6043.879122417615;6045.72794224261;5513.9448605513435;5599.496045355938;5870.9412905870395;5876.764929402947;5883.911476376884;4573.382593349856;5225.242339860775;5279.128943724396;5372.301600791872;5727.799527016535;5467.863303417446;5999.370066142992;6007.017684164302;6028.914795336881;6052.182955300978;2632.4603456291798;3373.9878036589416;3399.7450191236253;3400.982995085009;3403.6936675699308;4115.609017143366;4546.1129286017;4949.0101979603505;4952.8761780955765;4992.475790042138;4358.716683415568;4393.516713161485;4881.9023619528125;4907.754612269301;4930.433000205022;4081.9999100220634;4318.186361728019;4389.76122177698;4645.606318104623;4916.803327866845;4201.243776120327;4301.5698430156735;4370.6887933619155;4388.332433675183;4629.328747331685;5044.5875154956675;5114.3378402020235;5183.688978661293;5314.024146477985;5371.973140134274;4816.614670826255;5209.583233341248;5525.475079867406;5543.334799824047;5545.944540554543 03:47:18 INFO - PROCESS | 1653 | |5;yui.html;758.651020530556;762.6377470701417;789.9091604465489;858.7724253072935;859.587398048936;14937.925310373446;16040.679186416279;16067.517974460756;16067.758983615226;16164.83835161651;14170.787438188436;15105.546833594983;15149.242537873117;15150.318235679393;15166.545003649908;707.2538471912156;731.4477569435069;867.4491697771913;876.6449587916871;888.1562515610163;813.2721214513007;877.4647465046316;897.3987428422939;900.9279257659405;910.2490445382585;953.2421724728822;957.301170145794;957.7126861941424;958.884933807944;959.5921733263335;732.5311800447718;925.4632313258361;949.9430034197935;953.0993211415181;960.0639376607821;706.9960655868679;707.3421717802441;708.922018577956;709.2411120101493;709.4608097845675;13005.154664946747;14964.326605302678;15096.849031509653;15105.697886042328;15181.772273415907;13042.608721738363;13823.226877226783;13836.792448113287;13917;14145.222012789292;12418.627441176779;12555.811662825065;12575.245485270822;12592.559260425933;12711.872881271162;4460.710053846489;4523.570260825217;4560.110778398213;4701.7414042227665;4723.055388922195;112363.31455028181;114332;115083;115980;116186.83813161845;10820.080293175011;10928.071113955402;10943.945280273547;10948.412480190327;11243.550257989753;21662.35012949614;21665.67501487479;21680;21691.67462488064;21704.457388565414;7901.446898717035;7908.683652653945;7928.365730741527;7991.320737737241;8162.591870406456;4047.6761859051207;4538.02432477019;4583.129205450954;4591.219492686251;4592.03567250881;3559.964400356015;3700.962990370062;3703.9444408333898;3704.4443333499653;3704.49989251453;628.7830698409042;655.885220086483;657.5857209957792;670.7350596514447;673.1081317254657;573.5211098732522;581.5638271296527;617.6232498176109;629.1946308724839;632.569852500295;8701.303895688456;8721.17148870869;8861.468311901177;8933.553322333857;8993.955030224937;478.6984199954007;529.7139544645848;567.3674448130964;599.3706608061518;601.3505414152704;4083.469149010669;4353.760543170156;4385.451818522684;4392.475145357487;4473.261911784519;148522;151572;156569;160720;166374;127371;130555.34722326517;139302;140775;151420;74872.25127748762;83925.16074839295;91930.54034729784;109681;122311;8349.499030058216;8748.737537873874;8757.6934807284;8787.165219304155;8974.641014359613;55964.44035559755;56394.43605563892;59898.70050649719;60369;60721;79494.20505794868;84522.57738711267;95500.52249738706;98517.50741246535;98830;13418.664533386744;13515.729685406433;13520.526781562598;13597.116187447784;13823;14639.121652700873;14825.777613336024;15063;15263.923680381527;15316.770248446059;14313.856861431252;14394.712105758035;14498.34757435939;14670.853291466949;14870.544595180603;14174;14217.289135543388;14231.217283049531;14570.635734106732;14683.92658036703;13371.732565348833;13445.588213237861;13551;14109.223992680501;14110.647233819236;9903.702888913343;11324.924132207756;11478.713032174262;11986.460609272777;12043.939780301393;11552.537898483966;11579.42102894835;11751.882481175078;11785.057195424173;11841.940790295994 03:47:18 INFO - PROCESS | 1653 | __end_tp_report 03:47:18 INFO - PROCESS | 1653 | __start_cc_report 03:47:18 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1059 03:47:18 INFO - PROCESS | 1653 | __end_cc_report 03:47:18 INFO - PROCESS | 1653 | __startTimestamp1468406838420__endTimestamp 03:47:18 INFO - PROCESS | 1653 | 03:47:18 INFO - PROCESS | 1653 | ------- Summary: start ------- 03:47:18 INFO - PROCESS | 1653 | Number of tests: 6 03:47:18 INFO - PROCESS | 1653 | 03:47:18 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5571.36 Median:5704.83 stddev:622.46 (10.9%) stddev-sans-first:597.40 03:47:18 INFO - PROCESS | 1653 | Values: 3261.2 3285.5 3298.7 3307.5 3352.3 5415.7 5496.5 5516.8 5558.1 5568.6 5521.0 5539.9 5551.3 5558.1 5558.6 4968.7 5016.1 5035.8 5083.9 5113.8 5031.0 5092.6 5098.4 5103.2 5140.0 5029.9 5050.9 5054.0 5064.4 5076.8 5100.6 5134.0 5138.7 5143.8 5171.3 4943.2 4993.8 4996.9 5043.4 5064.9 5527.9 5532.6 5557.9 5569.8 5572.1 6036.3 6036.4 6051.9 6053.5 6064.8 5882.9 6082.3 6095.6 6146.3 6171.5 5603.2 5637.0 5646.1 5656.6 5669.7 6275.3 6289.3 6293.3 6295.9 6298.4 5706.8 5801.6 5874.0 5876.6 5923.1 6051.9 6061.9 6069.2 6070.6 6108.2 5231.6 5938.0 5945.3 5957.2 5967.1 5835.5 5925.7 5999.7 6038.1 6075.0 4790.3 4792.8 4793.4 4796.1 4827.8 4280.3 4307.9 4336.4 4345.4 4377.3 5333.8 5415.2 5500.8 5552.0 5554.3 6129.5 6131.7 6142.3 6143.4 6150.6 5486.8 5552.1 5560.1 5574.1 5582.9 5135.3 5190.4 5204.1 5227.2 5261.2 6280.2 6284.2 6290.8 6294.6 6309.7 6041.7 6060.8 6085.8 6095.5 6096.3 6109.3 6231.3 6285.8 6335.1 6350.9 5959.0 5983.8 5998.9 6006.4 6056.4 5859.8 6087.9 6100.4 6147.8 6152.1 5777.9 5793.4 5807.2 5813.8 5841.7 5770.9 5786.3 5787.2 5790.3 5808.2 5592.2 5683.9 5689.7 5698.5 5704.8 4933.4 5831.4 5844.9 5878.8 5880.9 5665.9 5719.9 5728.1 5735.4 5746.0 03:47:18 INFO - PROCESS | 1653 | 03:47:18 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:73894.83 Median:38713.73 stddev:165593.06 (427.7%) stddev-sans-first:165965.89 03:47:18 INFO - PROCESS | 1653 | Values: 494.7 496.9 514.8 530.3 536.1 26683.5 31600.0 40663.8 41214.0 41245.2 42666.6 42947.9 43041.4 43055.1 43170.6 9741.8 9923.8 9943.0 9945.6 9948.4 8793.5 8951.3 8965.8 9088.3 9106.0 11855.2 12024.3 12056.6 12304.3 12324.4 12085.4 12246.0 12263.9 12268.1 12269.3 8672.0 11626.8 11958.9 12044.7 12048.6 38563.8 41003.8 41125.0 41148.0 41155.6 3531.4 3603.6 3981.0 4240.4 4253.2 27014.5 31824.8 32653.5 32892.3 32955.5 3243.1 3328.2 3365.5 3372.8 3410.3 421486.0 540757.0 542485.0 543330.0 544889.0 58965.7 59028.7 59524.4 59525.1 59536.1 63236.7 63371.7 63429.0 63452.7 63521.0 15920.8 16454.2 16459.3 16463.4 16470.0 12811.0 12895.9 12898.2 12904.9 12907.5 13879.7 14214.1 14261.8 15601.3 15968.3 5348.0 6413.2 6500.3 6556.1 6560.6 909.9 965.6 982.2 1017.5 1056.7 28739.4 28914.7 29984.7 30267.8 30688.0 877.6 1070.0 1071.7 1148.3 1158.4 12771.2 15076.3 15386.9 15435.7 15743.8 708930.4 710635.0 715412.0 716934.0 717845.0 50498.7 58942.7 59384.0 59563.4 61072.7 1405.1 1417.9 1427.0 1430.3 1430.8 26521.6 30664.5 31541.8 31697.7 32463.5 49599.0 50096.0 50656.0 50692.7 50696.0 451281.0 528861.0 667447.0 668660.0 669472.6 38454.8 38965.4 39353.4 39468.4 39514.4 46563.5 46660.5 46999.0 47262.0 47536.8 32276.7 38707.0 38720.4 38744.6 39346.0 37045.6 37966.6 38402.4 38746.0 39098.2 37200.6 37513.4 37574.2 37982.3 38294.0 28588.7 33129.8 33842.8 34368.5 34465.5 20988.7 24829.6 25331.6 25584.7 25586.5 03:47:18 INFO - PROCESS | 1653 | 03:47:18 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:35503.43 Median:25352.62 stddev:102768.51 (405.4%) stddev-sans-first:103022.85 03:47:18 INFO - PROCESS | 1653 | Values: 322.3 357.5 376.7 392.5 409.8 15055.5 17042.2 20351.8 21189.8 21197.7 20162.4 21049.9 21094.6 21340.8 21359.0 4882.4 5356.7 5516.4 5543.2 5544.5 5453.5 5460.2 5490.5 5501.8 5503.0 5366.8 5415.5 5502.4 5506.5 5554.1 5439.6 5457.8 5464.3 5480.9 5486.2 5141.2 5275.1 5308.2 5309.5 5331.5 24567.9 25336.7 25368.5 25621.0 26495.9 2184.7 2193.3 2212.4 2234.5 2269.2 10082.8 10328.9 10860.3 10889.6 15698.8 1917.4 1938.9 1950.2 1982.0 2026.0 131331.3 138348.0 138401.3 139405.0 142001.0 9436.7 11542.7 11749.4 11814.7 11934.9 14721.6 14846.1 14851.4 14860.3 14862.7 8527.7 8721.4 8761.9 8811.9 8858.5 8686.0 8696.8 8708.0 8813.5 8836.5 4311.8 4560.2 4598.1 4640.3 4660.6 1754.6 1768.2 1805.4 1959.4 1965.3 898.9 914.7 967.6 984.7 1002.5 17398.7 20481.5 20989.7 21119.4 21308.5 948.1 948.5 977.8 1042.0 1064.8 10926.9 11233.1 11248.7 11288.4 11340.6 605026.0 615406.0 618262.0 619169.0 619269.0 83393.2 91826.1 113025.0 138767.0 144265.0 952.7 955.0 959.5 985.4 985.8 14867.3 19073.0 19224.5 19586.1 19707.6 52195.9 55485.9 56173.9 56371.0 56394.7 53900.0 73347.0 74072.6 74890.6 75292.2 8186.6 8197.6 8255.5 8395.6 8397.3 9274.6 12429.8 12757.7 12989.9 13074.7 11068.2 11080.1 11281.0 11288.5 11303.1 10866.7 11015.6 11034.1 11171.6 11296.9 11328.3 11332.4 11460.0 11466.8 11631.0 8094.9 8147.3 8281.0 8343.4 8373.4 10163.8 11053.1 11252.8 11304.5 11398.9 03:47:18 INFO - PROCESS | 1653 | 03:47:18 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5646.63 Median:4954.07 stddev:3142.34 (63.4%) stddev-sans-first:3135.98 03:47:18 INFO - PROCESS | 1653 | Values: 1537.3 1581.8 1782.9 1928.0 1932.3 8369.5 8632.4 8789.4 8790.0 8809.0 7027.9 7685.5 7916.1 8555.1 8641.6 1957.6 2367.5 2367.8 2370.3 2379.8 2329.1 2354.7 2358.2 2359.0 2360.9 2078.1 2156.0 2270.1 2346.0 2353.5 2303.9 2312.2 2339.9 2381.9 2387.0 2360.9 2361.3 2384.2 2388.6 2391.1 8684.4 8734.8 8735.4 8740.6 8746.0 5234.2 5349.5 5401.4 5404.2 5406.2 3578.7 3597.1 3641.3 3652.5 3665.6 1090.5 1093.7 1102.2 1117.4 1117.5 11214.2 11426.2 11434.2 11443.1 11454.9 3986.3 4423.7 4543.8 4575.6 4621.2 9905.1 9909.8 9910.5 9919.0 9931.3 5301.6 5366.0 5366.4 5381.4 5388.5 4764.1 4936.3 4937.8 4942.6 4957.9 3206.0 3785.6 3816.6 3861.0 3866.2 1160.2 1197.9 1201.5 1225.1 1243.5 762.7 781.2 804.2 943.4 969.6 5172.6 5599.4 5894.9 6014.9 6149.1 902.5 914.8 934.6 1012.2 1024.7 3821.4 3907.7 4024.4 4074.8 4077.8 10405.4 10544.9 10714.9 10721.0 10722.4 9706.3 10598.8 10669.9 10669.9 10691.4 7830.0 8081.8 8134.0 8240.0 8263.4 5789.2 5976.4 6026.9 6104.5 6254.9 9404.2 9992.3 9993.9 10001.5 10028.6 9841.6 9971.9 10002.6 10007.9 10023.6 6705.3 7221.1 7264.3 7376.4 7583.6 8107.1 8388.0 8392.6 8394.5 8395.3 7118.2 7238.6 7252.2 7380.6 7436.0 7139.5 7172.8 7206.8 7288.2 7308.5 6735.0 6960.5 6963.5 6990.8 7046.2 4840.6 4875.7 4887.6 4926.7 4996.5 4941.0 4953.6 4954.5 4982.6 5071.6 03:47:18 INFO - PROCESS | 1653 | 03:47:18 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4396.42 Median:4786.06 stddev:1402.56 (29.3%) stddev-sans-first:1372.44 03:47:18 INFO - PROCESS | 1653 | Values: 303.4 309.6 311.1 314.5 318.6 5355.7 5443.7 5477.9 5490.8 5503.6 4461.0 5096.9 5302.8 5416.3 5438.6 3269.4 3511.9 3849.0 3857.9 4108.3 3508.6 3817.7 3964.7 4114.3 4148.4 4036.9 4053.9 4080.9 4080.9 4092.3 3370.9 3372.5 3814.3 3831.8 3951.7 2909.8 3101.0 3569.3 3571.9 3580.6 4294.7 4755.3 4848.0 5267.2 5310.0 4355.6 4669.5 4709.8 4726.1 4755.5 4455.2 4831.6 5635.1 5640.7 5648.0 3731.7 3860.5 3869.9 3874.9 3882.7 5470.3 5882.3 5995.4 5999.2 6033.4 3261.0 3497.8 3865.3 3874.6 3895.3 3330.0 3475.9 3814.7 3985.5 3987.9 4209.8 4328.8 4642.4 4647.9 4650.0 4548.3 5416.3 5695.2 5706.1 5743.3 1132.6 1134.8 1191.8 1261.5 1340.3 672.3 738.8 816.5 822.7 833.8 4685.0 4957.0 5074.9 5230.4 5237.8 5090.1 5614.7 5751.2 5776.4 5875.6 4409.9 5053.7 5282.5 5290.7 5300.7 2527.6 2695.5 2899.7 3096.8 3107.5 4977.1 5716.8 5944.0 5999.2 6057.3 5553.3 5635.2 5726.5 6037.6 6052.7 5312.2 5512.1 6016.9 6043.9 6045.7 5513.9 5599.5 5870.9 5876.8 5883.9 4573.4 5225.2 5279.1 5372.3 5727.8 5467.9 5999.4 6007.0 6028.9 6052.2 2632.5 3374.0 3399.7 3401.0 3403.7 4115.6 4546.1 4949.0 4952.9 4992.5 4358.7 4393.5 4881.9 4907.8 4930.4 4082.0 4318.2 4389.8 4645.6 4916.8 4201.2 4301.6 4370.7 4388.3 4629.3 5044.6 5114.3 5183.7 5314.0 5372.0 4816.6 5209.6 5525.5 5543.3 5545.9 03:47:18 INFO - PROCESS | 1653 | 03:47:18 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:25118.54 Median:3876.09 stddev:40542.65 (1046.0%) stddev-sans-first:40615.13 03:47:18 INFO - PROCESS | 1653 | Values: 758.7 762.6 789.9 858.8 859.6 14937.9 16040.7 16067.5 16067.8 16164.8 14170.8 15105.5 15149.2 15150.3 15166.5 707.3 731.4 867.4 876.6 888.2 813.3 877.5 897.4 900.9 910.2 953.2 957.3 957.7 958.9 959.6 732.5 925.5 949.9 953.1 960.1 707.0 707.3 708.9 709.2 709.5 13005.2 14964.3 15096.8 15105.7 15181.8 13042.6 13823.2 13836.8 13917.0 14145.2 12418.6 12555.8 12575.2 12592.6 12711.9 4460.7 4523.6 4560.1 4701.7 4723.1 112363.3 114332.0 115083.0 115980.0 116186.8 10820.1 10928.1 10943.9 10948.4 11243.6 21662.4 21665.7 21680.0 21691.7 21704.5 7901.4 7908.7 7928.4 7991.3 8162.6 4047.7 4538.0 4583.1 4591.2 4592.0 3560.0 3701.0 3703.9 3704.4 3704.5 628.8 655.9 657.6 670.7 673.1 573.5 581.6 617.6 629.2 632.6 8701.3 8721.2 8861.5 8933.6 8994.0 478.7 529.7 567.4 599.4 601.4 4083.5 4353.8 4385.5 4392.5 4473.3 148522.0 151572.0 156569.0 160720.0 166374.0 127371.0 130555.3 139302.0 140775.0 151420.0 74872.3 83925.2 91930.5 109681.0 122311.0 8349.5 8748.7 8757.7 8787.2 8974.6 55964.4 56394.4 59898.7 60369.0 60721.0 79494.2 84522.6 95500.5 98517.5 98830.0 13418.7 13515.7 13520.5 13597.1 13823.0 14639.1 14825.8 15063.0 15263.9 15316.8 14313.9 14394.7 14498.3 14670.9 14870.5 14174.0 14217.3 14231.2 14570.6 14683.9 13371.7 13445.6 13551.0 14109.2 14110.6 9903.7 11324.9 11478.7 11986.5 12043.9 11552.5 11579.4 11751.9 11785.1 11841.9 03:47:18 INFO - PROCESS | 1653 | -------- Summary: end -------- 03:47:18 INFO - PROCESS | 1653 | 03:47:19 INFO - TEST-INFO | 1653: exit 0 03:47:19 INFO - TEST-OK | dromaeo_css | took 1116245ms 03:47:19 INFO - TEST-START | kraken 03:47:19 INFO - operating with platform_type : mac_ 03:47:19 INFO - Initialising browser for kraken test... 03:47:19 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpVaGUzZ/profile http://localhost:49271/getInfo.html) 03:47:21 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 03:47:21 INFO - PROCESS | 1682 | colorDepth:24 03:47:21 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 03:47:21 INFO - PROCESS | 1682 | __metrics 03:47:21 INFO - PROCESS | 1682 | 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" 03:47:21 INFO - PROCESS | 1682 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:47:21 INFO - TEST-INFO | 1682: exit 0 03:47:21 INFO - Browser initialized. 03:47:21 INFO - Running cycle 1/1 for kraken test... 03:47:21 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpVaGUzZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:33 INFO - PROCESS | 1683 | RSS: Main: 243961856 03:47:33 INFO - PROCESS | 1683 | 03:47:36 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 03:47:37 INFO - PROCESS | 1683 | RSS: Main: 294223872 03:47:37 INFO - PROCESS | 1683 | 03:47:40 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 03:47:40 INFO - PROCESS | 1683 | RSS: Main: 304418816 03:47:40 INFO - PROCESS | 1683 | 03:47:44 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 03:47:44 INFO - PROCESS | 1683 | RSS: Main: 393793536 03:47:44 INFO - PROCESS | 1683 | 03:47:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 03:47:47 INFO - PROCESS | 1683 | RSS: Main: 292462592 03:47:47 INFO - PROCESS | 1683 | 03:47:49 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:47:50 INFO - PROCESS | 1683 | RSS: Main: 296202240 03:47:50 INFO - PROCESS | 1683 | 03:47:52 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:53 INFO - PROCESS | 1683 | RSS: Main: 334737408 03:47:53 INFO - PROCESS | 1683 | 03:47:56 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 03:47:57 INFO - PROCESS | 1683 | RSS: Main: 336781312 03:47:57 INFO - PROCESS | 1683 | 03:48:00 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 03:48:00 INFO - PROCESS | 1683 | RSS: Main: 335327232 03:48:00 INFO - PROCESS | 1683 | 03:48:02 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:03 INFO - PROCESS | 1683 | RSS: Main: 311975936 03:48:03 INFO - PROCESS | 1683 | 03:48:04 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:05 INFO - PROCESS | 1683 | RSS: Main: 318394368 03:48:05 INFO - PROCESS | 1683 | 03:48:07 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:08 INFO - PROCESS | 1683 | RSS: Main: 317259776 03:48:08 INFO - PROCESS | 1683 | 03:48:11 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:11 INFO - PROCESS | 1683 | RSS: Main: 326516736 03:48:11 INFO - PROCESS | 1683 | 03:48:14 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:48:15 INFO - PROCESS | 1683 | RSS: Main: 330301440 03:48:15 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 03:48:17 INFO - PROCESS | 1683 | RSS: Main: 374263808 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | __start_tp_report 03:48:17 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 03:48:17 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 03:48:17 INFO - PROCESS | 1683 | |i|pagename|runs| 03:48:17 INFO - PROCESS | 1683 | |0;ai-astar;101;114;119;163;161;112;112;110;112;111 03:48:17 INFO - PROCESS | 1683 | |1;audio-beat-detection;166;117;108;155;107;107;127;106;143;106 03:48:17 INFO - PROCESS | 1683 | |2;audio-dft;187;185;184;183;186;181;182;183;186;183 03:48:17 INFO - PROCESS | 1683 | |3;audio-fft;77;73;57;109;58;57;60;60;98;57 03:48:17 INFO - PROCESS | 1683 | |4;audio-oscillator;82;84;92;70;71;67;93;69;66;97 03:48:17 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;94;90;90;88;95;87;94;92;89;91 03:48:17 INFO - PROCESS | 1683 | |6;imaging-darkroom;94;94;108;149;148;94;95;96;95;95 03:48:17 INFO - PROCESS | 1683 | |7;imaging-desaturate;86;84;115;140;140;87;84;86;87;84 03:48:17 INFO - PROCESS | 1683 | |8;json-parse-financial;54;54;57;54;55;54;55;54;54;55 03:48:17 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;66;70;82;81;72;70;70;72;71;72 03:48:17 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;84;83;84;82;81;85;82;84;83;81 03:48:17 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;136;136;134;133;133;134;134;136;227;153 03:48:17 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;221;176;164;163;163;163;164;162;163;158 03:48:17 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;67;68;66;67;67;65;66;65;66;65 03:48:17 INFO - PROCESS | 1683 | __end_tp_report 03:48:17 INFO - PROCESS | 1683 | __start_cc_report 03:48:17 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,2070 03:48:17 INFO - PROCESS | 1683 | __end_cc_report 03:48:17 INFO - PROCESS | 1683 | __startTimestamp1468406897359__endTimestamp 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | ------- Summary: start ------- 03:48:17 INFO - PROCESS | 1683 | Number of tests: 14 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:121.50 Median:113.00 stddev:21.80 (19.3%) stddev-sans-first:21.83 03:48:17 INFO - PROCESS | 1683 | Values: 101.0 114.0 119.0 163.0 161.0 112.0 112.0 110.0 112.0 111.0 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:124.20 Median:122.00 stddev:22.67 (18.6%) stddev-sans-first:18.32 03:48:17 INFO - PROCESS | 1683 | Values: 166.0 117.0 108.0 155.0 107.0 107.0 127.0 106.0 143.0 106.0 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.50 stddev:1.94 (1.1%) stddev-sans-first:1.73 03:48:17 INFO - PROCESS | 1683 | Values: 187.0 185.0 184.0 183.0 186.0 181.0 182.0 183.0 186.0 183.0 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:70.60 Median:60.00 stddev:18.89 (31.5%) stddev-sans-first:19.89 03:48:17 INFO - PROCESS | 1683 | Values: 77.0 73.0 57.0 109.0 58.0 57.0 60.0 60.0 98.0 57.0 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:83.00 stddev:11.93 (14.4%) stddev-sans-first:12.61 03:48:17 INFO - PROCESS | 1683 | Values: 82.0 84.0 92.0 70.0 71.0 67.0 93.0 69.0 66.0 97.0 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:91.50 stddev:2.71 (3.0%) stddev-sans-first:2.65 03:48:17 INFO - PROCESS | 1683 | Values: 94.0 90.0 90.0 88.0 95.0 87.0 94.0 92.0 89.0 91.0 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:106.80 Median:94.50 stddev:22.37 (23.7%) stddev-sans-first:23.25 03:48:17 INFO - PROCESS | 1683 | Values: 94.0 94.0 108.0 149.0 148.0 94.0 95.0 96.0 95.0 95.0 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:99.30 Median:85.00 stddev:23.38 (27.5%) stddev-sans-first:24.29 03:48:17 INFO - PROCESS | 1683 | Values: 86.0 84.0 115.0 140.0 140.0 87.0 84.0 86.0 87.0 84.0 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:0.97 (1.8%) stddev-sans-first:1.00 03:48:17 INFO - PROCESS | 1683 | Values: 54.0 54.0 57.0 54.0 55.0 54.0 55.0 54.0 54.0 55.0 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:72.00 stddev:5.02 (7.0%) stddev-sans-first:4.72 03:48:17 INFO - PROCESS | 1683 | Values: 66.0 70.0 82.0 81.0 72.0 70.0 70.0 72.0 71.0 72.0 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.50 stddev:1.37 (1.6%) stddev-sans-first:1.39 03:48:17 INFO - PROCESS | 1683 | Values: 84.0 83.0 84.0 82.0 81.0 85.0 82.0 84.0 83.0 81.0 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:136.00 stddev:29.21 (21.5%) stddev-sans-first:30.77 03:48:17 INFO - PROCESS | 1683 | Values: 136.0 136.0 134.0 133.0 133.0 134.0 134.0 136.0 227.0 153.0 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:163.50 stddev:18.60 (11.4%) stddev-sans-first:4.85 03:48:17 INFO - PROCESS | 1683 | Values: 221.0 176.0 164.0 163.0 163.0 163.0 164.0 162.0 163.0 158.0 03:48:17 INFO - PROCESS | 1683 | 03:48:17 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.03 (1.6%) stddev-sans-first:1.05 03:48:17 INFO - PROCESS | 1683 | Values: 67.0 68.0 66.0 67.0 67.0 65.0 66.0 65.0 66.0 65.0 03:48:17 INFO - PROCESS | 1683 | -------- Summary: end -------- 03:48:17 INFO - PROCESS | 1683 | 03:48:18 INFO - TEST-INFO | 1683: exit 0 03:48:18 INFO - TEST-OK | kraken | took 59071ms 03:48:18 INFO - SUITE-END | took 1175s 03:48:18 INFO - Completed test suite (00:19:35) 03:48:18 INFO - javascript benchmark 03:48:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3261.217307846117, 3285.457899446593, 3298.6536413676563, 3307.503874418838, 3352.296017836254, 5415.729213539317, 5496.477834605711, 5516.7517461714215, 5558.082916318807, 5568.582356323272, 5521.0, 5539.892021595687, 5551.333839939203, 5558.110702287635, 5558.610897237195, 4968.677035992658, 5016.097102521545, 5035.84892453227, 5083.898322033557, 5113.821016264432, 5031.018951304497, 5092.643514953955, 5098.413682426512, 5103.23451482277, 5140.0490909181735, 5029.899402011957, 5050.898982020358, 5054.014467178901, 5064.3922729272535, 5076.796928122871, 5100.617453690969, 5134.0, 5138.74306284688, 5143.794248230066, 5171.250168725552, 4943.1596628573225, 4993.775280112403, 4996.900061998776, 5043.394792624872, 5064.924026139611, 5527.917081243784, 5532.5573954083575, 5557.916631250535, 5569.777208911639, 5572.136318870582, 6036.3360030396625, 6036.426539478786, 6051.939480605181, 6053.485453736438, 6064.8180554583, 5882.941170588282, 6082.270127584674, 6095.598012457115, 6146.323904370515, 6171.537134714914, 5603.2435621191435, 5637.0, 5646.0683987141665, 5656.575756818214, 5669.716514174357, 6275.278342990615, 6289.276733175652, 6293.2762732285455, 6295.905561416583, 6298.370162983665, 5706.80026199081, 5801.622894511843, 5874.0014197586515, 5876.588638795329, 5923.141144534018, 6051.909221361683, 6061.931942483185, 6069.247852462062, 6070.63359567529, 6108.236470441195, 5231.633785635046, 5938.049912014057, 5945.346011938684, 5957.225560677084, 5967.075103358986, 5835.533157347402, 5925.674087925119, 5999.730012149464, 6038.094285857069, 6075.027995520783, 4790.305405716222, 4792.760361981887, 4793.400824896888, 4796.136695394863, 4827.806887724522, 4280.336547835091, 4307.870763877088, 4336.436263285753, 4345.352748031395, 4377.255866502702, 5333.7866485340155, 5415.160650099241, 5500.834974950758, 5552.0, 5554.305711786027, 6129.478994285536, 6131.693415329216, 6142.324344322121, 6143.447089761854, 6150.600210986271, 5486.753096110685, 5552.111662134039, 5560.138178582326, 5574.052411090124, 5582.888342233133, 5135.281060651511, 5190.37715474138, 5204.089284375219, 5227.18978558324, 5261.210818377274, 6280.183576135073, 6284.151639528788, 6290.779822706183, 6294.590851594632, 6309.652969086653, 6041.667708276087, 6060.757569697163, 6085.786997455068, 6095.451409373, 6096.268447786117, 6109.266887973294, 6231.2522497300615, 6285.842853928689, 6335.1447554579545, 6350.936490635219, 5959.016762234182, 5983.820485385445, 5998.880022399615, 6006.369331220334, 6056.364081771527, 5859.794907178229, 6087.878242435215, 6100.389961004042, 6147.754089836357, 6152.077188421773, 5777.884442311214, 5793.449622285876, 5807.157962095557, 5813.79651712188, 5841.707914604168, 5770.913436298375, 5786.3056433228285, 5787.2187254720075, 5790.334111577223, 5808.244928159481, 5592.161175823659, 5683.943160568341, 5689.687067211343, 5698.544116470755, 5704.828855134353, 4933.383327084114, 5831.387704290988, 5844.912326315024, 5878.823635290948, 5880.911786323123, 5665.858353541194, 5719.885602287848, 5728.140778883201, 5735.426457354231, 5746.023176059996], "value": 5531.655585376246, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.666100382242, 496.92049272116424, 514.7992283009625, 530.3317819547372, 536.1180857489429, 26683.466330673375, 31600.0, 40663.796681016625, 41214.0, 41245.17509649805, 42666.57333426665, 42947.92630184247, 43041.35437968433, 43055.13889722204, 43170.56829431705, 9741.756456088602, 9923.751906202366, 9943.0, 9945.602175912954, 9948.353357031807, 8793.516356600385, 8951.32865035125, 8965.820683586324, 9088.272938164931, 9106.0, 11855.22941008836, 12024.33866137362, 12056.63830085099, 12304.261744295327, 12324.445399957023, 12085.395730213499, 12246.0, 12263.877361226363, 12268.079894007897, 12269.263844169378, 8671.956640216822, 11626.825597616042, 11958.88041119595, 12044.698882528008, 12048.578299759467, 38563.84308470751, 41003.794981024905, 41125.0, 41148.0, 41155.58844411548, 3531.3820081485637, 3603.5855876574005, 3981.0, 4240.385144154111, 4253.21315556623, 27014.45971080587, 31824.84087579547, 32653.51019734706, 32892.34215315704, 32955.50566741501, 3243.140567749548, 3328.1679580104974, 3365.4855315108052, 3372.780769249991, 3410.3179364127272, 421486.0, 540757.0, 542485.0, 543330.0, 544889.0, 58965.70517147387, 59028.7048564763, 59524.40475595189, 59525.10712339319, 59536.106958395656, 63236.683816580626, 63371.683141584916, 63429.0, 63452.68273658602, 63521.0, 15920.76118858218, 16454.177291135635, 16459.25933332979, 16463.423780167635, 16470.0, 12811.0, 12895.871041289467, 12898.226106433644, 12904.870951290555, 12907.548235811702, 13879.722405552035, 14214.076085054437, 14261.78607320891, 15601.297941592655, 15968.281427335798, 5347.973260133675, 6413.198350206224, 6500.317466666026, 6556.114924485229, 6560.573562718408, 909.9454032758056, 965.6137544981923, 982.2387649571639, 1017.4963393120305, 1056.7041228455892, 28739.425211495654, 28914.710852891203, 29984.700152998626, 30267.848660756554, 30688.0, 877.5612193903048, 1069.9893001070045, 1071.7106381277013, 1148.311013391975, 1158.4034222375483, 12771.233725976472, 15076.321565529577, 15386.9230653846, 15435.691286174213, 15743.842561574467, 708930.3660445097, 710635.0, 715412.0, 716934.0, 717845.0, 50498.74750626223, 58942.70528647329, 59384.0, 59563.40436595665, 61072.69463652742, 1405.1358414574963, 1417.9007469477037, 1427.0438806000004, 1430.27056201336, 1430.8068410764622, 26521.60217596776, 30664.540031899985, 31541.842290788398, 31697.683023170397, 32463.513047303837, 49599.0, 50096.0, 50656.0, 50692.746536267085, 50695.98608027745, 451281.0, 528861.0, 667447.0, 668660.0, 669472.5684601016, 38454.846354609406, 38965.41551876668, 39353.40969885511, 39468.40797388099, 39514.40728389134, 46563.53436465592, 46660.53339466562, 46999.0, 47262.0, 47536.8115797094, 32276.677233228307, 38707.03232419212, 38720.41919371268, 38744.61255387523, 39346.01634959149, 37045.6295437053, 37966.62033379631, 38402.42396364113, 38746.0, 39098.2180356397, 37200.62799371972, 37513.43729844109, 37574.24851503009, 37982.25221847269, 38294.0, 28588.712902968127, 33129.834350829056, 33842.8307858469, 34368.48447273343, 34465.48301775526, 20988.68516972216, 24829.62755558704, 25331.62002569926, 25584.744152558236, 25586.458037551813], "value": 20453.15336757251, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.3247296912966, 357.53877498027543, 376.72499075674756, 392.5093632958802, 409.83196889275405, 15055.548333549983, 17042.233099510522, 20351.796482035174, 21189.788102118993, 21197.682034769452, 20162.395128146178, 21049.894750526226, 21094.57810843782, 21340.786592134074, 21359.0, 4882.389701287339, 5356.7321633918245, 5516.448355164492, 5543.196236545698, 5544.500994910457, 5453.481919217668, 5460.153676180198, 5490.533304669108, 5501.834944951658, 5503.0, 5366.812161574346, 5415.512603865652, 5502.394736578973, 5506.531944784698, 5554.055810512223, 5439.564834813205, 5457.808976685837, 5464.316960379952, 5480.862978425532, 5486.204500347447, 5141.177411614124, 5275.0632917713465, 5308.177232528964, 5309.548688361494, 5331.466853314676, 24567.877160614084, 25336.746632533625, 25368.492630147477, 25621.0, 26495.867520662272, 2184.71598692169, 2193.3419974007893, 2212.358416059341, 2234.4637287051155, 2269.205777977711, 10082.848757268646, 10328.896711032869, 10860.294080884718, 10889.618863339825, 15698.843011569967, 1917.405604262683, 1938.9224431022742, 1950.2101648832245, 1981.990090049555, 2026.037632124729, 131331.34334328363, 138348.0, 138401.3079934604, 139405.0, 142001.0, 9436.716898493056, 11542.653720388402, 11749.412529373498, 11814.704632384259, 11934.880651193376, 14721.55835324942, 14846.109233446028, 14851.405943762345, 14860.256987150815, 14862.70274594502, 8527.74416767498, 8721.433106848035, 8761.912380876238, 8811.867821982676, 8858.512781797062, 8686.044535101133, 8696.78258043554, 8708.042115367305, 8813.515256660945, 8836.513991730388, 4311.771145223596, 4560.198721505053, 4598.057398233354, 4640.303954406866, 4660.627149828006, 1754.6402987387555, 1768.1866341482805, 1805.4309951923701, 1959.3730006397816, 1965.3121407507545, 898.9123160975294, 914.6615752171606, 967.6419724701765, 984.7045886234101, 1002.4937406609761, 17398.739018914726, 20481.48796280105, 20989.68515472269, 21119.366419007456, 21308.467288317916, 948.1087777489277, 948.5399581203111, 977.8191034658611, 1041.9684512332735, 1064.760428903506, 10926.945365273281, 11233.10135189183, 11248.662540123809, 11288.379139147262, 11340.6030788922, 605026.0, 615406.0, 618262.0, 619169.0, 619269.0, 83393.16606833975, 91826.08173918175, 113025.0, 138767.0, 144265.0, 952.7379970508305, 954.9904500954901, 959.4627008875052, 985.3595163144014, 985.8324084905584, 14867.256637168315, 19073.046347682837, 19224.519387015436, 19586.118624661638, 19707.60584788325, 52195.90963400527, 55485.89028219494, 56173.876522468505, 56371.0, 56394.7180264096, 53900.0, 73347.0, 74072.62963685363, 74890.62554687192, 75292.24707752852, 8186.590670466572, 8197.590120493833, 8255.463394879314, 8395.580220988804, 8397.328213743009, 9274.582643781181, 12429.813552796535, 12757.744845103232, 12989.870101298866, 13074.738505230032, 11068.225224234226, 11080.058195053189, 11281.0, 11288.548458061585, 11303.095752339628, 10866.728331791452, 11015.559377624806, 11034.117270618171, 11171.553137874718, 11296.943515282372, 11328.263662861887, 11332.37671928019, 11460.0, 11466.82799758021, 11631.0, 8094.919050809416, 8147.307478864363, 8280.958595206985, 8343.41596088268, 8373.413861029912, 10163.84754228702, 11053.115750740082, 11252.774944501229, 11304.547818087512, 11398.886011139783], "value": 9535.97233693443, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.3158944269796, 1581.7627355896614, 1782.8841125326853, 1928.0456174193775, 1932.3236867096518, 8369.539675317856, 8632.352573556993, 8789.42868713534, 8789.95605021974, 8808.955955220232, 7027.929720702791, 7685.462017658752, 7916.050073991115, 8555.144485551442, 8641.567921603926, 1957.579120489091, 2367.5146594948083, 2367.763223677627, 2370.2533701883935, 2379.845310054841, 2329.149860300995, 2354.682117914085, 2358.2335740884196, 2359.0445869422824, 2360.905563777447, 2078.085642317383, 2156.0, 2270.0919632147106, 2346.049849810821, 2353.505763789606, 2303.9193628222934, 2312.167619656922, 2339.9181028664, 2381.9047238110543, 2386.9880650596638, 2360.8819559022154, 2361.303415492434, 2384.1655420602824, 2388.641703744435, 2391.1272385579314, 8684.435511691783, 8734.825303493895, 8735.388522803407, 8740.606672699743, 8745.956270218672, 5234.241035049897, 5349.545288650469, 5401.432849550819, 5404.216388623667, 5406.216098665672, 3578.6600272974024, 3597.1007248187952, 3641.3081514512423, 3652.5251717276583, 3665.560132784083, 1090.5201711247025, 1093.7265683579105, 1102.2229328323513, 1117.4301106435696, 1117.458032854065, 11214.215004949658, 11426.200165988384, 11434.199606027581, 11443.084553235722, 11454.885451145548, 3986.3023970804993, 4423.712458690239, 4543.840965566189, 4575.611073058827, 4621.214393553104, 9905.108540231413, 9909.801803964025, 9910.454924979196, 9919.0, 9931.255155863195, 5301.575873930076, 5366.0, 5366.356037275552, 5381.408045115034, 5388.5419739321815, 4764.094821983812, 4936.259561065869, 4937.8271760488215, 4942.629302802305, 4957.925631115536, 3205.951910721341, 3785.6403641653997, 3816.637419445148, 3861.0, 3866.188100498927, 1160.228448082016, 1197.9101567382481, 1201.5193922431097, 1225.08730995409, 1243.5274595653593, 762.6606160258632, 781.1719577248135, 804.1797366685947, 943.4103237182586, 969.6412327438893, 5172.612054095958, 5599.356074051455, 5894.941050589439, 6014.879702405928, 6149.108379284979, 902.5216635183364, 914.7850255190025, 934.5747684803398, 1012.2003617142375, 1024.7028361775, 3821.3885778275344, 3907.667848232932, 4024.436578878959, 4074.7758873261664, 4077.7757223353, 10405.42770147634, 10544.947275263574, 10714.946425267979, 10721.0, 10722.356658600509, 9706.272029597809, 10598.841017384746, 10669.89330106689, 10669.89330106689, 10691.358518488916, 7829.960850195713, 8081.757547273592, 8133.959330203311, 8239.970003749651, 8263.421560490828, 5789.2184555086205, 5976.3669535043655, 6026.90959635597, 6104.4505994460715, 6254.906176407449, 9404.200642945427, 9992.300538962203, 9993.850092248767, 10001.499925003865, 10028.598856045677, 9841.60633574649, 9971.900280997388, 10002.649907253211, 10007.949960250153, 10023.649172278936, 6705.329467053256, 7221.097362829646, 7264.34620884123, 7376.4467664926415, 7583.62081895892, 8107.1082180958865, 8387.95806020966, 8392.622331994953, 8394.454360466794, 8395.328373729964, 7118.181409138016, 7238.6018768968215, 7252.202257751748, 7380.557166569808, 7436.0, 7139.535930164523, 7172.820679483055, 7206.819829504304, 7288.161861385796, 7308.488405811542, 6734.966325168343, 6960.47796415281, 6963.4777391694815, 6990.790276291719, 7046.189688185924, 4840.564349208588, 4875.7074575525585, 4887.560119589254, 4926.655134140576, 4996.475370086234, 4940.9505904941925, 4953.628477864103, 4954.50454954516, 4982.551570358685, 5071.594272458121], "value": 4549.538392704234, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.4416673321089, 309.5588785979978, 311.14435302916974, 314.474827038845, 318.5731120298799, 5355.732213389329, 5443.727813609318, 5477.917831232535, 5490.780368785244, 5503.596582871367, 4460.996275837935, 5096.916365598815, 5302.761375738091, 5416.295881535395, 5438.646487978289, 3269.411505928932, 3511.9297614047705, 3848.960780589239, 3857.8649747258783, 4108.26051310764, 3508.5965114011833, 3817.7136714746366, 3964.742291751041, 4114.259433302004, 4148.357004664282, 4036.8587099451524, 4053.9391909121387, 4080.8775736727944, 4080.8979775505554, 4092.3043082676018, 3370.898873033813, 3372.477266023746, 3814.2835723924068, 3831.7509361891525, 3951.6641085507767, 2909.846713432045, 3100.968990310113, 3569.3396721606327, 3571.946275848631, 3580.5882323532865, 4294.668652717636, 4755.335632528622, 4847.975760121212, 5267.236250743659, 5309.991101690666, 4355.5862193091925, 4669.509701481329, 4709.835155769531, 4726.125666751662, 4755.50067242938, 4455.153520831064, 4831.589314908237, 5635.126555383881, 5640.717964101819, 5647.989927151686, 3731.7201209909367, 3860.4713912387433, 3869.9226015479812, 3874.8837534874, 3882.6699730522655, 5470.316210473691, 5882.294124705063, 5995.430434108753, 5999.190109335227, 6033.366496517846, 3261.0, 3497.8282275438014, 3865.342891708416, 3874.554426240962, 3895.337792575269, 3329.9843547717696, 3475.9050898966743, 3814.7030009796804, 3985.5217373915316, 3987.940180897289, 4209.779164042455, 4328.826846926151, 4642.3500709900645, 4647.883802904955, 4649.977005058881, 4548.3158641500495, 5416.293867431747, 5695.177543186223, 5706.058500347396, 5743.310802703619, 1132.5752842683994, 1134.7673726885969, 1191.7914364986093, 1261.4575732434957, 1340.2978217663708, 672.277301900459, 738.7635956493978, 816.4937738602105, 822.658596682382, 833.7998880268813, 4684.992726563805, 4957.0085982803585, 5074.949250507448, 5230.3985041719925, 5237.764300606482, 5090.073207905469, 5614.6631202128, 5751.194832723422, 5776.393478684761, 5875.618084824473, 4409.933850992237, 5053.700566242351, 5282.524572788468, 5290.65610735301, 5300.701328174622, 2527.633493143484, 2695.4878573071055, 2899.6520417550028, 3096.783225174216, 3107.456195165837, 4977.113274300897, 5716.79947211082, 5944.0, 5999.220101386792, 6057.303410107806, 5553.334799032619, 5635.21107045014, 5726.513246374105, 6037.607555508878, 6052.727627256696, 5312.1673022807845, 5512.0905050667, 6016.939830601638, 6043.879122417615, 6045.72794224261, 5513.9448605513435, 5599.496045355938, 5870.9412905870395, 5876.764929402947, 5883.911476376884, 4573.382593349856, 5225.242339860775, 5279.128943724396, 5372.301600791872, 5727.799527016535, 5467.863303417446, 5999.370066142992, 6007.017684164302, 6028.914795336881, 6052.182955300978, 2632.4603456291798, 3373.9878036589416, 3399.7450191236253, 3400.982995085009, 3403.6936675699308, 4115.609017143366, 4546.1129286017, 4949.0101979603505, 4952.8761780955765, 4992.475790042138, 4358.716683415568, 4393.516713161485, 4881.9023619528125, 4907.754612269301, 4930.433000205022, 4081.9999100220634, 4318.186361728019, 4389.76122177698, 4645.606318104623, 4916.803327866845, 4201.243776120327, 4301.5698430156735, 4370.6887933619155, 4388.332433675183, 4629.328747331685, 5044.5875154956675, 5114.3378402020235, 5183.688978661293, 5314.024146477985, 5371.973140134274, 4816.614670826255, 5209.583233341248, 5525.475079867406, 5543.334799824047, 5545.944540554543], "value": 3948.161878253144, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.651020530556, 762.6377470701417, 789.9091604465489, 858.7724253072935, 859.587398048936, 14937.925310373446, 16040.679186416279, 16067.517974460756, 16067.758983615226, 16164.83835161651, 14170.787438188436, 15105.546833594983, 15149.242537873117, 15150.318235679393, 15166.545003649908, 707.2538471912156, 731.4477569435069, 867.4491697771913, 876.6449587916871, 888.1562515610163, 813.2721214513007, 877.4647465046316, 897.3987428422939, 900.9279257659405, 910.2490445382585, 953.2421724728822, 957.301170145794, 957.7126861941424, 958.884933807944, 959.5921733263335, 732.5311800447718, 925.4632313258361, 949.9430034197935, 953.0993211415181, 960.0639376607821, 706.9960655868679, 707.3421717802441, 708.922018577956, 709.2411120101493, 709.4608097845675, 13005.154664946747, 14964.326605302678, 15096.849031509653, 15105.697886042328, 15181.772273415907, 13042.608721738363, 13823.226877226783, 13836.792448113287, 13917.0, 14145.222012789292, 12418.627441176779, 12555.811662825065, 12575.245485270822, 12592.559260425933, 12711.872881271162, 4460.710053846489, 4523.570260825217, 4560.110778398213, 4701.7414042227665, 4723.055388922195, 112363.31455028181, 114332.0, 115083.0, 115980.0, 116186.83813161845, 10820.080293175011, 10928.071113955402, 10943.945280273547, 10948.412480190327, 11243.550257989753, 21662.35012949614, 21665.67501487479, 21680.0, 21691.67462488064, 21704.457388565414, 7901.446898717035, 7908.683652653945, 7928.365730741527, 7991.320737737241, 8162.591870406456, 4047.6761859051207, 4538.02432477019, 4583.129205450954, 4591.219492686251, 4592.03567250881, 3559.964400356015, 3700.962990370062, 3703.9444408333898, 3704.4443333499653, 3704.49989251453, 628.7830698409042, 655.885220086483, 657.5857209957792, 670.7350596514447, 673.1081317254657, 573.5211098732522, 581.5638271296527, 617.6232498176109, 629.1946308724839, 632.569852500295, 8701.303895688456, 8721.17148870869, 8861.468311901177, 8933.553322333857, 8993.955030224937, 478.6984199954007, 529.7139544645848, 567.3674448130964, 599.3706608061518, 601.3505414152704, 4083.469149010669, 4353.760543170156, 4385.451818522684, 4392.475145357487, 4473.261911784519, 148522.0, 151572.0, 156569.0, 160720.0, 166374.0, 127371.0, 130555.34722326517, 139302.0, 140775.0, 151420.0, 74872.25127748762, 83925.16074839295, 91930.54034729784, 109681.0, 122311.0, 8349.499030058216, 8748.737537873874, 8757.6934807284, 8787.165219304155, 8974.641014359613, 55964.44035559755, 56394.43605563892, 59898.70050649719, 60369.0, 60721.0, 79494.20505794868, 84522.57738711267, 95500.52249738706, 98517.50741246535, 98830.0, 13418.664533386744, 13515.729685406433, 13520.526781562598, 13597.116187447784, 13823.0, 14639.121652700873, 14825.777613336024, 15063.0, 15263.923680381527, 15316.770248446059, 14313.856861431252, 14394.712105758035, 14498.34757435939, 14670.853291466949, 14870.544595180603, 14174.0, 14217.289135543388, 14231.217283049531, 14570.635734106732, 14683.92658036703, 13371.732565348833, 13445.588213237861, 13551.0, 14109.223992680501, 14110.647233819236, 9903.702888913343, 11324.924132207756, 11478.713032174262, 11986.460609272777, 12043.939780301393, 11552.537898483966, 11579.42102894835, 11751.882481175078, 11785.057195424173, 11841.940790295994], "value": 7921.679890501686, "unit": "score"}], "name": "dromaeo_css", "value": 7317.592772086527, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 114.0, 119.0, 163.0, 161.0, 112.0, 112.0, 110.0, 112.0, 111.0], "value": 121.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 117.0, 108.0, 155.0, 107.0, 107.0, 127.0, 106.0, 143.0, 106.0], "value": 124.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 184.0, 183.0, 186.0, 181.0, 182.0, 183.0, 186.0, 183.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 57.0, 109.0, 58.0, 57.0, 60.0, 60.0, 98.0, 57.0], "value": 70.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 92.0, 70.0, 71.0, 67.0, 93.0, 69.0, 66.0, 97.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 90.0, 90.0, 88.0, 95.0, 87.0, 94.0, 92.0, 89.0, 91.0], "value": 91.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 108.0, 149.0, 148.0, 94.0, 95.0, 96.0, 95.0, 95.0], "value": 106.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 115.0, 140.0, 140.0, 87.0, 84.0, 86.0, 87.0, 84.0], "value": 99.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 57.0, 54.0, 55.0, 54.0, 55.0, 54.0, 54.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 82.0, 81.0, 72.0, 70.0, 70.0, 72.0, 71.0, 72.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 82.0, 81.0, 85.0, 82.0, 84.0, 83.0, 81.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 134.0, 133.0, 133.0, 134.0, 134.0, 136.0, 227.0, 153.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 176.0, 164.0, 163.0, 163.0, 163.0, 164.0, 162.0, 163.0, 158.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 67.0, 67.0, 65.0, 66.0, 65.0, 66.0, 65.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1468.1, "alertThreshold": 2.0}]} 03:48:18 INFO - Return code: 0 03:48:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:48:18 INFO - # TBPL SUCCESS # 03:48:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:48:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:48:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:48:18 INFO - 2016-07-13 03:48:18.685 screenresolution[1687:9735] starting screenresolution argv=screenresolution get 03:48:18 INFO - 2016-07-13 03:48:18.688 screenresolution[1687:9735] Display 0: 1600x1200x32@60 03:48:18 INFO - 2016-07-13 03:48:18.694 screenresolution[1688:9738] starting screenresolution argv=screenresolution list 03:48:18 INFO - Available Modes on Display 0 03:48:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:48:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:48:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:48:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:48:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:48:18 INFO - Intel Iris: 03:48:18 INFO - Chipset Model: Intel Iris 03:48:18 INFO - Type: GPU 03:48:18 INFO - Bus: Built-In 03:48:18 INFO - VRAM (Dynamic, Max): 1536 MB 03:48:18 INFO - Vendor: Intel (0x8086) 03:48:18 INFO - Device ID: 0x0a2e 03:48:18 INFO - Revision ID: 0x0009 03:48:18 INFO - Displays: 03:48:18 INFO - Display: 03:48:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:48:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:48:18 INFO - Display Serial Number: 1600x1200 60 03:48:18 INFO - Main Display: Yes 03:48:18 INFO - Mirror: Off 03:48:18 INFO - Online: Yes 03:48:18 INFO - Rotation: Supported 03:48:18 INFO - Return code: 0 03:48:18 INFO - Running post-action listener: _resource_record_post_action 03:48:18 INFO - ##### 03:48:18 INFO - ##### Finished run-tests step (success) 03:48:18 INFO - ##### 03:48:18 INFO - Running post-run listener: _resource_record_post_run 03:48:18 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 38065664; Write bytes: 707757568; Read time: 386; Write time: 2187 03:48:18 INFO - TinderboxPrint: CPU usage
53.3% 03:48:18 INFO - TinderboxPrint: I/O read bytes / time
38,065,664 / 386 03:48:18 INFO - TinderboxPrint: I/O write bytes / time
707,757,568 / 2,187 03:48:18 INFO - TinderboxPrint: CPU idle
2,261.8 (46.7%) 03:48:18 INFO - TinderboxPrint: CPU system
961.8 (19.8%) 03:48:18 INFO - TinderboxPrint: CPU user
1,622.1 (33.5%) 03:48:18 INFO - TinderboxPrint: Swap in / out
444,706,816 / 0 03:48:18 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 413166080; Write bytes: 411725312; Read time: 31092; Write time: 854 03:48:19 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 29138432; Write bytes: 294545408; Read time: 277; Write time: 1326 03:48:19 INFO - Running post-run listener: _upload_blobber_files 03:48:19 INFO - Blob upload gear active. 03:48:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:48:19 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 03:48:19 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'] 03:48:19 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 03:48:19 INFO - (blobuploader) - INFO - Open directory for files ... 03:48:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:48:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:48:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:21 INFO - (blobuploader) - INFO - Done attempting. 03:48:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:48:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:48:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:22 INFO - (blobuploader) - INFO - Done attempting. 03:48:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:48:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:48:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:25 INFO - (blobuploader) - INFO - Done attempting. 03:48:25 INFO - (blobuploader) - INFO - Iteration through files over. 03:48:25 INFO - Return code: 0 03:48:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:48:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:48:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9c9cedf13efea5f8b5931508c3d3f4e1a7ccbf7b3a1c5e24bcc5c69baf9cf6edbce2f8342b735f368657582dc6f9e603f65c21930d63868f80d55833b701d7a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5e9d747bf31bccd4c4c5c42208bf2f95f90df8fabe92a505bf18f3c506f3d75f8854d3b6874e9ca74cf7d25e8949ad330e500e2e0e787df31d0e6826a38d3796", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f51bccf81977594b60568ede714c8f2c42a0383894faccf4b174091c34f52d04f2228f0563486a070879030b82cfb0b144ed243ea8ac72686713f3f74b68d24"} 03:48:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:48:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:48:25 INFO - Contents: 03:48:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9c9cedf13efea5f8b5931508c3d3f4e1a7ccbf7b3a1c5e24bcc5c69baf9cf6edbce2f8342b735f368657582dc6f9e603f65c21930d63868f80d55833b701d7a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5e9d747bf31bccd4c4c5c42208bf2f95f90df8fabe92a505bf18f3c506f3d75f8854d3b6874e9ca74cf7d25e8949ad330e500e2e0e787df31d0e6826a38d3796", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f51bccf81977594b60568ede714c8f2c42a0383894faccf4b174091c34f52d04f2228f0563486a070879030b82cfb0b144ed243ea8ac72686713f3f74b68d24"} 03:48:25 INFO - Running post-run listener: copy_logs_to_upload_dir 03:48:25 INFO - Copying logs to upload dir... 03:48:25 INFO - mkdir: /builds/slave/test/build/upload/logs 03:48:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.242773 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-13 03:48:25.324795) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 03:48:25.328038) ========= 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.WkiBz9H0Ix/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.P49BKLv8hP/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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/9c9cedf13efea5f8b5931508c3d3f4e1a7ccbf7b3a1c5e24bcc5c69baf9cf6edbce2f8342b735f368657582dc6f9e603f65c21930d63868f80d55833b701d7a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5e9d747bf31bccd4c4c5c42208bf2f95f90df8fabe92a505bf18f3c506f3d75f8854d3b6874e9ca74cf7d25e8949ad330e500e2e0e787df31d0e6826a38d3796", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f51bccf81977594b60568ede714c8f2c42a0383894faccf4b174091c34f52d04f2228f0563486a070879030b82cfb0b144ed243ea8ac72686713f3f74b68d24"} build_url:https://queue.taskcluster.net/v1/task/BVRTObPaQTusWF6QYYrW4g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011444 build_url: 'https://queue.taskcluster.net/v1/task/BVRTObPaQTusWF6QYYrW4g/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/9c9cedf13efea5f8b5931508c3d3f4e1a7ccbf7b3a1c5e24bcc5c69baf9cf6edbce2f8342b735f368657582dc6f9e603f65c21930d63868f80d55833b701d7a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5e9d747bf31bccd4c4c5c42208bf2f95f90df8fabe92a505bf18f3c506f3d75f8854d3b6874e9ca74cf7d25e8949ad330e500e2e0e787df31d0e6826a38d3796", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0f51bccf81977594b60568ede714c8f2c42a0383894faccf4b174091c34f52d04f2228f0563486a070879030b82cfb0b144ed243ea8ac72686713f3f74b68d24"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 03:48:25.360982) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:48:25.361285) ========= 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.WkiBz9H0Ix/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.P49BKLv8hP/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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.005135 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 03:48:25.409906) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 03:48:25.410242) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 03:48:25.410575) ========= ========= Total master_lag: 0.17 =========