builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0179 starttime: 1467970456.29 results: success (0) buildid: 20160707234229 builduid: 162d40f1279e4aa9ae74f60176c17edc revision: 9329897c803de9e5a7b77d7ff4020b9158d41d5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 02:34:16.289371) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 02:34:16.289792) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 02:34:16.290141) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 02:34:16.315752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 02:34:16.316069) ========= 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.CcS4dlhnXP/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.k3Y6c4UQ6j/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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-08 02:34:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.60M=0.001s 2016-07-08 02:34:16 (8.60 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122210 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 02:34:16.460335) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 02:34:16.460705) ========= 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.CcS4dlhnXP/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.k3Y6c4UQ6j/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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.020877 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 02:34:16.509142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 02:34:16.509524) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9329897c803de9e5a7b77d7ff4020b9158d41d5f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 9329897c803de9e5a7b77d7ff4020b9158d41d5f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CcS4dlhnXP/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.k3Y6c4UQ6j/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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-08 02:34:16,581 truncating revision to first 12 chars 2016-07-08 02:34:16,581 Setting DEBUG logging. 2016-07-08 02:34:16,581 attempt 1/10 2016-07-08 02:34:16,581 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9329897c803d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 02:34:17,213 unpacking tar archive at: fx-team-9329897c803d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.895297 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 02:34:17.427684) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 02:34:17.428004) ========= script_repo_revision: 9329897c803de9e5a7b77d7ff4020b9158d41d5f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 02:34:17.428405) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 02:34:17.428669) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 02:34:17.446490) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-08 02:34:17.446773) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CcS4dlhnXP/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.k3Y6c4UQ6j/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 02:34:17 INFO - MultiFileLogger online at 20160708 02:34:17 in /builds/slave/test 02:34:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:34:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:34:17 INFO - {'append_to_log': False, 02:34:17 INFO - 'base_work_dir': '/builds/slave/test', 02:34:17 INFO - 'blob_upload_branch': 'Fx-Team', 02:34:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:34:17 INFO - 'branch': 'Fx-Team', 02:34:17 INFO - 'buildbot_json_path': 'buildprops.json', 02:34:17 INFO - 'config_files': ('talos/mac_config.py',), 02:34:17 INFO - 'default_actions': ('clobber', 02:34:17 INFO - 'read-buildbot-config', 02:34:17 INFO - 'download-and-extract', 02:34:17 INFO - 'populate-webroot', 02:34:17 INFO - 'create-virtualenv', 02:34:17 INFO - 'install', 02:34:17 INFO - 'run-tests'), 02:34:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:34:17 INFO - 'download_minidump_stackwalk': True, 02:34:17 INFO - 'download_symbols': 'ondemand', 02:34:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:34:17 INFO - 'tooltool.py': '/tools/tooltool.py', 02:34:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:34:17 INFO - '/tools/misc-python/virtualenv.py')}, 02:34:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:34:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:34:17 INFO - 'installer_path': 'installer.exe', 02:34:17 INFO - 'log_level': 'info', 02:34:17 INFO - 'log_name': 'talos', 02:34:17 INFO - 'log_to_console': True, 02:34:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:34:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:34:17 INFO - 'opt_config_files': (), 02:34:17 INFO - 'pip_index': False, 02:34:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:34:17 INFO - 'cmd': ('bash', 02:34:17 INFO - '-c', 02:34:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:34:17 INFO - 'enabled': True, 02:34:17 INFO - 'halt_on_failure': False, 02:34:17 INFO - 'name': 'check_screen_resolution'},), 02:34:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:34:17 INFO - 'cmd': ('bash', 02:34:17 INFO - '-c', 02:34:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:34:17 INFO - 'enabled': True, 02:34:17 INFO - 'halt_on_failure': False, 02:34:17 INFO - 'name': 'check_screen_resolution'},), 02:34:17 INFO - 'run_cmd_checks_enabled': True, 02:34:17 INFO - 'sps_profile': False, 02:34:17 INFO - 'sps_profile_interval': 0, 02:34:17 INFO - 'suite': 'dromaeojs-e10s', 02:34:17 INFO - 'system_bits': '32', 02:34:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:34:17 INFO - 'title': 't-yosemite-r7-0179', 02:34:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:34:17 INFO - 'use_talos_json': True, 02:34:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:34:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:34:17 INFO - 'work_dir': 'build'} 02:34:17 INFO - ##### 02:34:17 INFO - ##### Running clobber step. 02:34:17 INFO - ##### 02:34:17 INFO - Running pre-action listener: _resource_record_pre_action 02:34:17 INFO - Running main action method: clobber 02:34:17 INFO - rmtree: /builds/slave/test/build 02:34:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:34:19 INFO - Running post-action listener: _resource_record_post_action 02:34:19 INFO - ##### 02:34:19 INFO - ##### Finished clobber step (success) 02:34:19 INFO - ##### 02:34:19 INFO - ##### 02:34:19 INFO - ##### Running read-buildbot-config step. 02:34:19 INFO - ##### 02:34:19 INFO - Running pre-action listener: _resource_record_pre_action 02:34:19 INFO - Running main action method: read_buildbot_config 02:34:19 INFO - Using buildbot properties: 02:34:19 INFO - { 02:34:19 INFO - "project": "", 02:34:19 INFO - "product": "firefox", 02:34:19 INFO - "script_repo_revision": "production", 02:34:19 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 02:34:19 INFO - "repository": "", 02:34:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 02:34:19 INFO - "buildid": "20160707234229", 02:34:19 INFO - "pgo_build": "False", 02:34:19 INFO - "basedir": "/builds/slave/test", 02:34:19 INFO - "buildnumber": 715, 02:34:19 INFO - "slavename": "t-yosemite-r7-0179", 02:34:19 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:34:19 INFO - "platform": "yosemite_r7", 02:34:19 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 02:34:19 INFO - "branch": "fx-team", 02:34:19 INFO - "repo_path": "integration/fx-team", 02:34:19 INFO - "revision": "9329897c803de9e5a7b77d7ff4020b9158d41d5f", 02:34:19 INFO - "stage_platform": "macosx64", 02:34:19 INFO - "builduid": "162d40f1279e4aa9ae74f60176c17edc", 02:34:19 INFO - "slavebuilddir": "test" 02:34:19 INFO - } 02:34:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 02:34:19 INFO - Running post-action listener: _resource_record_post_action 02:34:19 INFO - ##### 02:34:19 INFO - ##### Finished read-buildbot-config step (success) 02:34:19 INFO - ##### 02:34:19 INFO - ##### 02:34:19 INFO - ##### Running download-and-extract step. 02:34:19 INFO - ##### 02:34:19 INFO - Running pre-action listener: _resource_record_pre_action 02:34:19 INFO - Running main action method: download_and_extract 02:34:19 INFO - mkdir: /builds/slave/test/build/tests 02:34: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')]} 02:34:19 INFO - https://queue.taskcluster.net/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:34:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 02:34:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 02:34:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/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 02:34:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/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 02:34:20 INFO - Downloaded 1199 bytes. 02:34:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 02:34:20 INFO - Using the following test package requirements: 02:34:20 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 02:34:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:34:20 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 02:34:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:34:20 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 02:34:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:34:20 INFO - u'jsshell-mac.zip'], 02:34:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:34:20 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 02:34:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 02:34:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:34:20 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 02:34:20 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:34:20 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 02:34:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:34:20 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 02:34:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:34:20 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 02:34:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:20 INFO - https://queue.taskcluster.net/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:34:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:34:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:34:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/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 02:34:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/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 02:34:21 INFO - Downloaded 18806300 bytes. 02:34:21 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'] 02:34:21 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 02:34:25 INFO - Return code: 0 02:34:25 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 02:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:25 INFO - https://queue.taskcluster.net/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:34:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:34:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:34:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/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 02:34:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/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 02:34:26 INFO - Downloaded 18806300 bytes. 02:34:26 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'] 02:34:26 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 02:34:29 INFO - Return code: 0 02:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:34:29 INFO - https://queue.taskcluster.net/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:34:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 02:34:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 02:34:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/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 02:34:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/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 02:34:31 INFO - Downloaded 14403333 bytes. 02:34:31 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'] 02:34:31 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 02:34:31 INFO - Return code: 0 02:34: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')]} 02:34:31 INFO - https://queue.taskcluster.net/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:34:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:34:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:34:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 02:34:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RiYx9kWCQSSrhuSy9VKOkA/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 02:34:34 INFO - Downloaded 112428877 bytes. 02:34:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:34:34 INFO - mkdir: /builds/slave/test/properties 02:34:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:34:34 INFO - Writing to file /builds/slave/test/properties/build_url 02:34:34 INFO - Contents: 02:34:34 INFO - build_url:https://queue.taskcluster.net/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:34:35 INFO - Running post-action listener: _resource_record_post_action 02:34:35 INFO - Running post-action listener: set_extra_try_arguments 02:34:35 INFO - ##### 02:34:35 INFO - ##### Finished download-and-extract step (success) 02:34:35 INFO - ##### 02:34:35 INFO - ##### 02:34:35 INFO - ##### Running populate-webroot step. 02:34:35 INFO - ##### 02:34:35 INFO - Running pre-action listener: _resource_record_pre_action 02:34:35 INFO - Running main action method: populate_webroot 02:34:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:34:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:34:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:34:35 INFO - '--tppagecycles', 02:34:35 INFO - '7'], 02:34:35 INFO - 'tests': ['tsvgm']}}, 02:34:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:34:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:34:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:34:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:34:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:34:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:34:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:35 INFO - 'talos_options': ['--disable-e10s'], 02:34:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:34:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:34:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:35 INFO - 'talos_options': ['--disable-e10s'], 02:34:35 INFO - 'tests': ['damp', 'tps']}, 02:34:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:35 INFO - 'tests': ['damp', 'tps']}, 02:34:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:34:35 INFO - 'tests': ['dromaeo_dom']}, 02:34:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:34:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:34:35 INFO - 'tests': ['basic_compositor_video']}, 02:34:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:34:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:34:35 INFO - 'tests': ['a11yr', 02:34:35 INFO - 'ts_paint', 02:34:35 INFO - 'tpaint', 02:34:35 INFO - 'sessionrestore', 02:34:35 INFO - 'sessionrestore_no_auto_restore', 02:34:35 INFO - 'tabpaint']}, 02:34:35 INFO - 'other-e10s': {'tests': ['a11yr', 02:34:35 INFO - 'ts_paint', 02:34:35 INFO - 'tpaint', 02:34:35 INFO - 'sessionrestore', 02:34:35 INFO - 'sessionrestore_no_auto_restore', 02:34:35 INFO - 'tabpaint']}, 02:34:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:34:35 INFO - 'ts_paint', 02:34:35 INFO - 'tpaint', 02:34:35 INFO - 'sessionrestore', 02:34:35 INFO - 'sessionrestore_no_auto_restore', 02:34:35 INFO - 'tabpaint']}, 02:34:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:34:35 INFO - 'ts_paint', 02:34:35 INFO - 'tpaint', 02:34:35 INFO - 'sessionrestore', 02:34:35 INFO - 'sessionrestore_no_auto_restore', 02:34:35 INFO - 'tabpaint']}, 02:34:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:34:35 INFO - 'tests': ['a11yr', 02:34:35 INFO - 'ts_paint', 02:34:35 INFO - 'tpaint', 02:34:35 INFO - 'sessionrestore', 02:34:35 INFO - 'sessionrestore_no_auto_restore', 02:34:35 INFO - 'tabpaint']}, 02:34:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:34:35 INFO - 'tests': ['a11yr', 02:34:35 INFO - 'ts_paint', 02:34:35 INFO - 'tpaint', 02:34:35 INFO - 'sessionrestore', 02:34:35 INFO - 'sessionrestore_no_auto_restore', 02:34:35 INFO - 'tabpaint']}, 02:34:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:34:35 INFO - 'tests': ['tsvgx', 02:34:35 INFO - 'tsvgr_opacity', 02:34:35 INFO - 'tart', 02:34:35 INFO - 'tscrollx', 02:34:35 INFO - 'cart']}, 02:34:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:34:35 INFO - 'tsvgr_opacity', 02:34:35 INFO - 'tart', 02:34:35 INFO - 'tscrollx', 02:34:35 INFO - 'cart']}, 02:34:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:35 INFO - 'talos_options': ['--disable-e10s'], 02:34:35 INFO - 'tests': ['tp5o']}, 02:34:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:35 INFO - 'tests': ['tp5o']}, 02:34:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:35 INFO - 'talos_options': ['--disable-e10s', 02:34:35 INFO - '--xperf_path', 02:34:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:34:35 INFO - 'tests': ['tp5n']}, 02:34:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:35 INFO - 'talos_options': ['--xperf_path', 02:34:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:34:35 INFO - 'tests': ['tp5n']}}, 02:34:35 INFO - 'talos.zip': {'path': '', 02:34:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:34:35 INFO - Running post-action listener: _resource_record_post_action 02:34:35 INFO - ##### 02:34:35 INFO - ##### Finished populate-webroot step (success) 02:34:35 INFO - ##### 02:34:35 INFO - ##### 02:34:35 INFO - ##### Running create-virtualenv step. 02:34:35 INFO - ##### 02:34:35 INFO - Running pre-action listener: _resource_record_pre_action 02:34:35 INFO - Running main action method: create_virtualenv 02:34:35 INFO - Creating virtualenv /builds/slave/test/build/venv 02:34:35 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 02:34:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:34:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:34:35 INFO - Using real prefix '/tools/python27' 02:34:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:34:36 INFO - Installing distribute.............................................................................................................................................................................................done. 02:34:39 INFO - Installing pip.................done. 02:34:39 INFO - Return code: 0 02:34:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:34:39 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')]} 02:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:39 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')]} 02:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:39 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 0x10fc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81aac4d760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc6d30>, '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 0x10f92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbbeb20>, '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.CcS4dlhnXP/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.k3Y6c4UQ6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 02:34:39 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 02:34:39 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 02:34:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CcS4dlhnXP/Render', 02:34:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:39 INFO - 'HOME': '/Users/cltbld', 02:34:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:39 INFO - 'LOGNAME': 'cltbld', 02:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:39 INFO - 'MOZ_NO_REMOTE': '1', 02:34:39 INFO - 'NO_EM_RESTART': '1', 02:34:39 INFO - 'PAGER': '/bin/cat', 02:34:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:39 INFO - 'PWD': '/builds/slave/test', 02:34:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:39 INFO - 'SHELL': '/bin/bash', 02:34:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3Y6c4UQ6j/Listeners', 02:34:39 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 02:34:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:39 INFO - 'USER': 'cltbld', 02:34:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:39 INFO - 'XPC_FLAGS': '0x0', 02:34:39 INFO - 'XPC_SERVICE_NAME': '0', 02:34:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:39 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 02:34:39 INFO - Cleaning up... 02:34:39 INFO - Return code: 0 02:34:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:34:39 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')]} 02:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:39 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')]} 02:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:39 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 0x10fc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81aac4d760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc6d30>, '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 0x10f92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbbeb20>, '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.CcS4dlhnXP/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.k3Y6c4UQ6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 02:34:39 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 02:34:39 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 02:34:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CcS4dlhnXP/Render', 02:34:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:39 INFO - 'HOME': '/Users/cltbld', 02:34:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:39 INFO - 'LOGNAME': 'cltbld', 02:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:39 INFO - 'MOZ_NO_REMOTE': '1', 02:34:39 INFO - 'NO_EM_RESTART': '1', 02:34:39 INFO - 'PAGER': '/bin/cat', 02:34:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:39 INFO - 'PWD': '/builds/slave/test', 02:34:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:39 INFO - 'SHELL': '/bin/bash', 02:34:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3Y6c4UQ6j/Listeners', 02:34:39 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 02:34:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:39 INFO - 'USER': 'cltbld', 02:34:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:39 INFO - 'XPC_FLAGS': '0x0', 02:34:39 INFO - 'XPC_SERVICE_NAME': '0', 02:34:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:39 INFO - Downloading/unpacking psutil>=3.1.1 02:34:39 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 02:34:39 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 02:34:39 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 02:34:39 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 02:34:39 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 02:34:39 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 02:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:34:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:34:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:34:42 INFO - Installing collected packages: psutil 02:34:42 INFO - Running setup.py install for psutil 02:34:42 INFO - building 'psutil._psutil_osx' extension 02:34:42 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 02:34:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:34:43 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:34:43 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 02:34:43 INFO - building 'psutil._psutil_posix' extension 02:34:43 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 02:34:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:34:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:34:43 INFO - ^ 02:34:43 INFO - 1 warning generated. 02:34:43 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 02:34:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:34:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:34:43 INFO - Successfully installed psutil 02:34:43 INFO - Cleaning up... 02:34:43 INFO - Return code: 0 02:34:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81aac4d760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc6d30>, '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 0x10f92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbbeb20>, '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.CcS4dlhnXP/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.k3Y6c4UQ6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 02:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:34:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CcS4dlhnXP/Render', 02:34:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:43 INFO - 'HOME': '/Users/cltbld', 02:34:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:43 INFO - 'LOGNAME': 'cltbld', 02:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:43 INFO - 'MOZ_NO_REMOTE': '1', 02:34:43 INFO - 'NO_EM_RESTART': '1', 02:34:43 INFO - 'PAGER': '/bin/cat', 02:34:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:43 INFO - 'PWD': '/builds/slave/test', 02:34:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:43 INFO - 'SHELL': '/bin/bash', 02:34:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3Y6c4UQ6j/Listeners', 02:34:43 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 02:34:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:43 INFO - 'USER': 'cltbld', 02:34:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:43 INFO - 'XPC_FLAGS': '0x0', 02:34:43 INFO - 'XPC_SERVICE_NAME': '0', 02:34:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:34:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:34:46 INFO - Installing collected packages: mozsystemmonitor 02:34:46 INFO - Running setup.py install for mozsystemmonitor 02:34:46 INFO - Successfully installed mozsystemmonitor 02:34:46 INFO - Cleaning up... 02:34:46 INFO - Return code: 0 02:34:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81aac4d760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc6d30>, '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 0x10f92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbbeb20>, '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.CcS4dlhnXP/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.k3Y6c4UQ6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 02:34:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:34:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CcS4dlhnXP/Render', 02:34:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:46 INFO - 'HOME': '/Users/cltbld', 02:34:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:46 INFO - 'LOGNAME': 'cltbld', 02:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:46 INFO - 'MOZ_NO_REMOTE': '1', 02:34:46 INFO - 'NO_EM_RESTART': '1', 02:34:46 INFO - 'PAGER': '/bin/cat', 02:34:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:46 INFO - 'PWD': '/builds/slave/test', 02:34:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:46 INFO - 'SHELL': '/bin/bash', 02:34:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3Y6c4UQ6j/Listeners', 02:34:46 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 02:34:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:46 INFO - 'USER': 'cltbld', 02:34:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:46 INFO - 'XPC_FLAGS': '0x0', 02:34:46 INFO - 'XPC_SERVICE_NAME': '0', 02:34:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:47 INFO - Downloading/unpacking jsonschema==2.5.1 02:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:34:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:49 INFO - Downloading functools32-3.2.3-2.tar.gz 02:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:34:49 INFO - warning: no files found matching '*.txt' 02:34:49 INFO - no previously-included directories found matching 'build' 02:34:49 INFO - no previously-included directories found matching 'dist' 02:34:49 INFO - no previously-included directories found matching '.git*' 02:34:49 INFO - Installing collected packages: jsonschema, functools32 02:34:49 INFO - Running setup.py install for functools32 02:34:50 INFO - warning: no files found matching '*.txt' 02:34:50 INFO - no previously-included directories found matching 'build' 02:34:50 INFO - no previously-included directories found matching 'dist' 02:34:50 INFO - no previously-included directories found matching '.git*' 02:34:50 INFO - Successfully installed jsonschema functools32 02:34:50 INFO - Cleaning up... 02:34:50 INFO - Return code: 0 02:34:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81aac4d760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc6d30>, '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 0x10f92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbbeb20>, '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.CcS4dlhnXP/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.k3Y6c4UQ6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 02:34:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CcS4dlhnXP/Render', 02:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:50 INFO - 'HOME': '/Users/cltbld', 02:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:50 INFO - 'LOGNAME': 'cltbld', 02:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:50 INFO - 'MOZ_NO_REMOTE': '1', 02:34:50 INFO - 'NO_EM_RESTART': '1', 02:34:50 INFO - 'PAGER': '/bin/cat', 02:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:50 INFO - 'PWD': '/builds/slave/test', 02:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:50 INFO - 'SHELL': '/bin/bash', 02:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3Y6c4UQ6j/Listeners', 02:34:50 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 02:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:50 INFO - 'USER': 'cltbld', 02:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:50 INFO - 'XPC_FLAGS': '0x0', 02:34:50 INFO - 'XPC_SERVICE_NAME': '0', 02:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:50 INFO - Downloading/unpacking blobuploader==1.2.4 02:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:52 INFO - Downloading blobuploader-1.2.4.tar.gz 02:34:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:34:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:34: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 02:34: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 02:34: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 02:34: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 02:34: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 02:34: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 02:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:34:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:53 INFO - Downloading docopt-0.6.1.tar.gz 02:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:34:54 INFO - Installing collected packages: blobuploader, requests, docopt 02:34:54 INFO - Running setup.py install for blobuploader 02:34:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:34:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:34:54 INFO - Running setup.py install for requests 02:34:54 INFO - Running setup.py install for docopt 02:34:54 INFO - Successfully installed blobuploader requests docopt 02:34:54 INFO - Cleaning up... 02:34:54 INFO - Return code: 0 02:34:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:54 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 0x10fc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81aac4d760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc6d30>, '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 0x10f92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbbeb20>, '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.CcS4dlhnXP/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.k3Y6c4UQ6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 02:34:54 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 02:34:54 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 02:34:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CcS4dlhnXP/Render', 02:34:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:54 INFO - 'HOME': '/Users/cltbld', 02:34:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:54 INFO - 'LOGNAME': 'cltbld', 02:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:54 INFO - 'MOZ_NO_REMOTE': '1', 02:34:54 INFO - 'NO_EM_RESTART': '1', 02:34:54 INFO - 'PAGER': '/bin/cat', 02:34:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:54 INFO - 'PWD': '/builds/slave/test', 02:34:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:54 INFO - 'SHELL': '/bin/bash', 02:34:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3Y6c4UQ6j/Listeners', 02:34:54 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 02:34:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:54 INFO - 'USER': 'cltbld', 02:34:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:54 INFO - 'XPC_FLAGS': '0x0', 02:34:54 INFO - 'XPC_SERVICE_NAME': '0', 02:34:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:34:55 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-0THKM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:34:55 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-kTYYQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:34:55 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-ONvJwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:34:55 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-JATEYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:34:55 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-T7RQge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:34:55 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-2Z8Yns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:34:55 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-LQ_xWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:34:55 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-JjLMHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:34:56 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-rOfZDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:34:56 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-IgSEan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:34:56 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-JeEUrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:34:56 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-PkjchL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:34:56 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-I9CfZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:34:56 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-FL_ull-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:56 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-75QcgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:34:56 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-PfaVDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:34:56 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-BoLxJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:34:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:34:57 INFO - Running setup.py install for manifestparser 02:34:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:34:57 INFO - Running setup.py install for mozcrash 02:34:57 INFO - Running setup.py install for mozdebug 02:34:57 INFO - Running setup.py install for mozdevice 02:34:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:34:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:34:57 INFO - Running setup.py install for mozfile 02:34:57 INFO - Running setup.py install for mozhttpd 02:34:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:34:57 INFO - Running setup.py install for mozinfo 02:34:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:34:58 INFO - Running setup.py install for mozInstall 02:34:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:34:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:34:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:34:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:34:58 INFO - Running setup.py install for mozleak 02:34:58 INFO - Running setup.py install for mozlog 02:34:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:34:58 INFO - Running setup.py install for moznetwork 02:34:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:34:58 INFO - Running setup.py install for mozprocess 02:34:58 INFO - Running setup.py install for mozprofile 02:34:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:34:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:34:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:34:58 INFO - Running setup.py install for mozrunner 02:34:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:34:59 INFO - Running setup.py install for mozscreenshot 02:34:59 INFO - Running setup.py install for moztest 02:34:59 INFO - Running setup.py install for mozversion 02:34:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:34:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:34:59 INFO - Cleaning up... 02:34:59 INFO - Return code: 0 02:34:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:34:59 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')]} 02:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:59 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')]} 02:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:59 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 0x10fc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81aac4d760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc6d30>, '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 0x10f92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbbeb20>, '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.CcS4dlhnXP/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.k3Y6c4UQ6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 02:34:59 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 02:34:59 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 02:34:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CcS4dlhnXP/Render', 02:34:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:34:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:34:59 INFO - 'HOME': '/Users/cltbld', 02:34:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:34:59 INFO - 'LOGNAME': 'cltbld', 02:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:59 INFO - 'MOZ_NO_REMOTE': '1', 02:34:59 INFO - 'NO_EM_RESTART': '1', 02:34:59 INFO - 'PAGER': '/bin/cat', 02:34:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:59 INFO - 'PWD': '/builds/slave/test', 02:34:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:34:59 INFO - 'SHELL': '/bin/bash', 02:34:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3Y6c4UQ6j/Listeners', 02:34:59 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 02:34:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:34:59 INFO - 'USER': 'cltbld', 02:34:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:34:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:59 INFO - 'XPC_FLAGS': '0x0', 02:34:59 INFO - 'XPC_SERVICE_NAME': '0', 02:34:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:34:59 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-YJBRpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:34:59 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)) 02:34:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:34:59 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-2g5lTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:35:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:35:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-HdKXg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:35:00 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)) 02:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:35:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-ixTRUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:35:00 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)) 02:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:35:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-_iSF2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:35:00 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)) 02:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:35:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-MNseyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:35:00 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)) 02:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:35:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-TlkeAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:35:00 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)) 02:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:35:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-WNXM8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:35:00 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)) 02:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:35:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-c2trSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:35:00 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)) 02:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:35:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-90BhFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:35:00 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)) 02:35:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:35:00 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-bBhxew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:35:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-_iwH2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:35:01 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)) 02:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:35:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-RXvdM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:35:01 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)) 02:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:35:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-jyUpPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:35:01 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)) 02:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-4BmuSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:01 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)) 02:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:35:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-E9KYij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:35:01 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)) 02:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:35:01 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-dZuaNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:35:01 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)) 02:35:01 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)) 02:35:01 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)) 02:35:01 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)) 02:35:01 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)) 02:35:01 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)) 02:35:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:04 INFO - Downloading blessings-1.6.tar.gz 02:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:35:04 INFO - Installing collected packages: blessings 02:35:04 INFO - Running setup.py install for blessings 02:35:04 INFO - Successfully installed blessings 02:35:04 INFO - Cleaning up... 02:35:04 INFO - Return code: 0 02:35:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:35:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:35:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:35:04 INFO - Reading from file tmpfile_stdout 02:35:04 INFO - Current package versions: 02:35:04 INFO - blessings == 1.6 02:35:04 INFO - blobuploader == 1.2.4 02:35:04 INFO - docopt == 0.6.1 02:35:04 INFO - functools32 == 3.2.3-2 02:35:04 INFO - jsonschema == 2.5.1 02:35:04 INFO - manifestparser == 1.1 02:35:04 INFO - mozInstall == 1.12 02:35:04 INFO - mozcrash == 0.17 02:35:04 INFO - mozdebug == 0.1 02:35:04 INFO - mozdevice == 0.48 02:35:04 INFO - mozfile == 1.2 02:35:04 INFO - mozhttpd == 0.7 02:35:04 INFO - mozinfo == 0.9 02:35:04 INFO - mozleak == 0.1 02:35:04 INFO - mozlog == 3.2 02:35:04 INFO - moznetwork == 0.27 02:35:04 INFO - mozprocess == 0.23 02:35:04 INFO - mozprofile == 0.28 02:35:04 INFO - mozrunner == 6.12 02:35:04 INFO - mozscreenshot == 0.1 02:35:04 INFO - mozsystemmonitor == 0.3 02:35:04 INFO - moztest == 0.7 02:35:04 INFO - mozversion == 1.4 02:35:04 INFO - psutil == 3.1.1 02:35:04 INFO - requests == 1.2.3 02:35:04 INFO - wsgiref == 0.1.2 02:35:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:35:04 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')]} 02:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:04 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')]} 02:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:04 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 0x10fc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81aac4d760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc6d30>, '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 0x10f92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbbeb20>, '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.CcS4dlhnXP/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.k3Y6c4UQ6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 02:35:04 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 02:35:04 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 02:35:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CcS4dlhnXP/Render', 02:35:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:04 INFO - 'HOME': '/Users/cltbld', 02:35:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:04 INFO - 'LOGNAME': 'cltbld', 02:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:04 INFO - 'MOZ_NO_REMOTE': '1', 02:35:04 INFO - 'NO_EM_RESTART': '1', 02:35:04 INFO - 'PAGER': '/bin/cat', 02:35:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:04 INFO - 'PWD': '/builds/slave/test', 02:35:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:04 INFO - 'SHELL': '/bin/bash', 02:35:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3Y6c4UQ6j/Listeners', 02:35:04 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 02:35:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:04 INFO - 'USER': 'cltbld', 02:35:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:04 INFO - 'XPC_FLAGS': '0x0', 02:35:04 INFO - 'XPC_SERVICE_NAME': '0', 02:35:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:35:05 INFO - Cleaning up... 02:35:05 INFO - Return code: 0 02:35:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fc62a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fcf7618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81aac4d760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc6d30>, '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 0x10f92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbbeb20>, '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.CcS4dlhnXP/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.k3Y6c4UQ6j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 02:35:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:35:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CcS4dlhnXP/Render', 02:35:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:05 INFO - 'HOME': '/Users/cltbld', 02:35:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:05 INFO - 'LOGNAME': 'cltbld', 02:35:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:05 INFO - 'MOZ_NO_REMOTE': '1', 02:35:05 INFO - 'NO_EM_RESTART': '1', 02:35:05 INFO - 'PAGER': '/bin/cat', 02:35:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:05 INFO - 'PWD': '/builds/slave/test', 02:35:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:05 INFO - 'SHELL': '/bin/bash', 02:35:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3Y6c4UQ6j/Listeners', 02:35:05 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 02:35:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:05 INFO - 'USER': 'cltbld', 02:35:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:05 INFO - 'XPC_FLAGS': '0x0', 02:35:05 INFO - 'XPC_SERVICE_NAME': '0', 02:35:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:35:05 INFO - Cleaning up... 02:35:05 INFO - Return code: 0 02:35:05 INFO - Running post-action listener: _resource_record_post_action 02:35:05 INFO - Running post-action listener: _start_resource_monitoring 02:35:05 INFO - Starting resource monitoring. 02:35:05 INFO - ##### 02:35:05 INFO - ##### Finished create-virtualenv step (success) 02:35:05 INFO - ##### 02:35:05 INFO - ##### 02:35:05 INFO - ##### Running install step. 02:35:05 INFO - ##### 02:35:05 INFO - Running pre-action listener: _resource_record_pre_action 02:35:05 INFO - Running main action method: install 02:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:35:05 INFO - Reading from file tmpfile_stdout 02:35:05 INFO - Detecting whether we're running mozinstall >=1.0... 02:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:35:05 INFO - Reading from file tmpfile_stdout 02:35:05 INFO - Output received: 02:35:05 INFO - Usage: mozinstall [options] installer 02:35:05 INFO - Options: 02:35:05 INFO - -h, --help show this help message and exit 02:35:05 INFO - -d DEST, --destination=DEST 02:35:05 INFO - Directory to install application into. [default: 02:35:05 INFO - "/builds/slave/test"] 02:35:05 INFO - --app=APP Application being installed. [default: firefox] 02:35:05 INFO - mkdir: /builds/slave/test/build/application 02:35:05 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'] 02:35:05 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 02:35:40 INFO - Reading from file tmpfile_stdout 02:35:40 INFO - Output received: 02:35:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:35:40 INFO - Running post-action listener: _resource_record_post_action 02:35:40 INFO - ##### 02:35:40 INFO - ##### Finished install step (success) 02:35:40 INFO - ##### 02:35:40 INFO - ##### 02:35:40 INFO - ##### Running run-tests step. 02:35:40 INFO - ##### 02:35:40 INFO - Running pre-action listener: _resource_record_pre_action 02:35:40 INFO - Running main action method: run_tests 02:35:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:35:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:35:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:35:40 INFO - 2016-07-08 02:35:40.460 screenresolution[1980:10550] starting screenresolution argv=screenresolution get 02:35:40 INFO - 2016-07-08 02:35:40.463 screenresolution[1980:10550] Display 0: 1600x1200x32@60 02:35:40 INFO - 2016-07-08 02:35:40.468 screenresolution[1981:10552] starting screenresolution argv=screenresolution list 02:35:40 INFO - Available Modes on Display 0 02:35:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:35:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:35:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:35:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:35:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:35:40 INFO - Intel Iris: 02:35:40 INFO - Chipset Model: Intel Iris 02:35:40 INFO - Type: GPU 02:35:40 INFO - Bus: Built-In 02:35:40 INFO - VRAM (Dynamic, Max): 1536 MB 02:35:40 INFO - Vendor: Intel (0x8086) 02:35:40 INFO - Device ID: 0x0a2e 02:35:40 INFO - Revision ID: 0x0009 02:35:40 INFO - Displays: 02:35:40 INFO - Display: 02:35:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:35:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:35:40 INFO - Display Serial Number: 1600x1200 60 02:35:40 INFO - Main Display: Yes 02:35:40 INFO - Mirror: Off 02:35:40 INFO - Online: Yes 02:35:40 INFO - Rotation: Supported 02:35:40 INFO - Return code: 0 02:35:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:35:40 INFO - Python 2.7.3 02:35:40 INFO - Return code: 0 02:35:40 INFO - grabbing minidump binary from tooltool 02:35: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')]} 02:35:40 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fbc6d30>, '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 0x10f92bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fbbeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:35:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:35:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:35:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:35:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:35:40 INFO - Return code: 0 02:35:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:35:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:35:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:35:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:35:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:35:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0179', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0179 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:35:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CcS4dlhnXP/Render', 02:35:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:35:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:35:40 INFO - 'HOME': '/Users/cltbld', 02:35:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:35:40 INFO - 'LOGNAME': 'cltbld', 02:35:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:35:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:35:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:40 INFO - 'MOZ_NO_REMOTE': '1', 02:35:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:35:40 INFO - 'NO_EM_RESTART': '1', 02:35:40 INFO - 'PAGER': '/bin/cat', 02:35:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:35:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:40 INFO - 'PWD': '/builds/slave/test', 02:35:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:35:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:35:40 INFO - 'SHELL': '/bin/bash', 02:35:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.k3Y6c4UQ6j/Listeners', 02:35:40 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 02:35:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:35:40 INFO - 'USER': 'cltbld', 02:35:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:35:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:35:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:40 INFO - 'XPC_FLAGS': '0x0', 02:35:40 INFO - 'XPC_SERVICE_NAME': '0', 02:35:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:35:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0179', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:35:41 INFO - mozversion application_buildid: 20160707234229 02:35:41 INFO - mozversion application_changeset: 9329897c803de9e5a7b77d7ff4020b9158d41d5f 02:35:41 INFO - mozversion application_display_name: Nightly 02:35:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:35:41 INFO - mozversion application_name: Firefox 02:35:41 INFO - mozversion application_remotingname: firefox 02:35:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:35:41 INFO - mozversion application_vendor: Mozilla 02:35:41 INFO - mozversion application_version: 50.0a1 02:35:41 INFO - mozversion platform_buildid: 20160707234229 02:35:41 INFO - mozversion platform_changeset: 9329897c803de9e5a7b77d7ff4020b9158d41d5f 02:35:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:35:41 INFO - mozversion platform_version: 50.0a1 02:35:41 INFO - using testdate: 1467970541 02:35:41 INFO - actual date: 1467970541 02:35:41 INFO - starting webserver on 'localhost:49391' 02:35:41 INFO - SUITE-START | Running 2 tests 02:35:41 INFO - TEST-START | dromaeo_css 02:35:41 INFO - operating with platform_type : mac_ 02:35:41 INFO - Initialising browser for dromaeo_css test... 02:35:41 INFO - TEST-INFO | started process 1991 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmpH0NWok/profile http://localhost:49391/getInfo.html) 02:35:43 INFO - PROCESS | 1991 | __metrics Screen width/height:1600/1200 02:35:43 INFO - PROCESS | 1991 | colorDepth:24 02:35:43 INFO - PROCESS | 1991 | Browser inner width/height: 1024/689 02:35:43 INFO - PROCESS | 1991 | __metrics 02:35:44 ERROR - PROCESS | 1991 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 02:35:44 INFO - TEST-INFO | 1991: exit 0 02:35:44 INFO - Browser initialized. 02:35:44 INFO - Running cycle 1/1 for dromaeo_css test... 02:35:44 INFO - TEST-INFO | started process 1995 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmpH0NWok/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:35:56 INFO - PROCESS | 1995 | RSS: Main: 254423040 02:35:56 INFO - PROCESS | 1995 | 02:36:46 INFO - PROCESS | 1995 | 1467970606338 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] 02:38:56 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49391/tests/dromaeo/cssquery-ext.html) 02:38:57 INFO - PROCESS | 1995 | RSS: Main: 266964992 02:38:57 INFO - PROCESS | 1995 | 02:41:59 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-ext.html (next: http://localhost:49391/tests/dromaeo/cssquery-jquery.html) 02:42:00 INFO - PROCESS | 1995 | RSS: Main: 275718144 02:42:00 INFO - PROCESS | 1995 | 02:45:02 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49391/tests/dromaeo/cssquery-mootools.html) 02:45:02 INFO - PROCESS | 1995 | RSS: Main: 280150016 02:45:02 INFO - PROCESS | 1995 | 02:48:04 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49391/tests/dromaeo/cssquery-prototype.html) 02:48:05 INFO - PROCESS | 1995 | RSS: Main: 279126016 02:48:05 INFO - PROCESS | 1995 | 02:51:07 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49391/tests/dromaeo/cssquery-yui.html) 02:51:08 INFO - PROCESS | 1995 | RSS: Main: 282939392 02:51:08 INFO - PROCESS | 1995 | 02:54:11 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:49391/tests/dromaeo/cssquery-yui.html (next: http://localhost:49391/tests/dromaeo/cssquery-dojo.html) 02:54:11 INFO - PROCESS | 1995 | RSS: Main: 283004928 02:54:11 INFO - PROCESS | 1995 | 02:54:11 INFO - PROCESS | 1995 | __start_tp_report 02:54:11 INFO - PROCESS | 1995 | _x_x_mozilla_page_load 02:54:11 INFO - PROCESS | 1995 | _x_x_mozilla_page_load_details 02:54:11 INFO - PROCESS | 1995 | |i|pagename|runs| 02:54:11 INFO - PROCESS | 1995 | |0;dojo.html;3406.3868503669337;3413.4026545354573;3414.095264754839;3433.7939723616587;3454.4990976308436;4272.316429371302;4764.690295130823;4900.852974410765;4969.353983982086;5668.943310566899;4794.304825800257;4945.5301746334135;4957.702537847732;5537.418571050032;5735.598508104435;5034.565148932555;5123.487651234866;5166.509181627739;5245.344331958505;5321.893562128756;155.09826454271334;4712.764361781914;4970.353853998975;5174.767135478913;5281.2342210379475;4231.259529582326;5224.3730752309775;5230.21546767984;5230.686158830464;5232.372115346183;5152.819651312224;5221.686698798084;5237.292965449654;5261.710605916673;5267.815626453055;5125.2312153176945;5143.948560514422;5164.92252616211;5181.870453238699;5200.973995130038;4768.997021251048;5571.303587051619;5736.913946290809;5807.738651760681;5880.617759845596;6074.0281554951;6182.474489668339;6334.366563343675;6336.4930805535905;6353.237611486605;6277.932751432268;6333.113364129025;6346.682665866734;6365.395287447685;6367.554271201017;5881.558883083786;5908.97045514774;5909.674967876722;5912.142739302777;5954.672493012882;6242.5942313749465;6247.9062814057825;6273.8115369693805;6281.152044474029;6297.937020629826;6244.406781355764;6249.437550620466;6269.185005949289;6269.96865015672;6282.434580887742;6325.715342809584;6327;6333;6351.936480635227;6365.840853978595;6137.96931015342;6197.659128747962;6216.129741836146;6232.158658581124;6310.337414571404;6091.543134264948;6235.844103897439;6293.433590976834;6297.307296197415;6313.40022697843;4888.951110488921;4972.428170760337;4988.226824842155;4996.225585034325;5003.324551185616;3566.661167189113;4412.22786012453;4448.5551444855255;4514.706544074625;4553.886152846206;5713.771449142071;5840.503557197686;5844.532437404998;5847.415258474203;5858.384869588717;6287.96856015717;6311.400416960381;6336.303006669263;6339.334369891095;6341.587796793194;5691.117876729114;5775.682337471395;5796.82609521715;5826.242588463472;5842.298924129132;5478.780848766084;5485.6434331768305;5489.286392768914;5499.1476321170285;5505.642133261325;6304.936950630618;6336.081268216083;6351.110844481776;6351.904721429182;6356.078368636522;6203.410675985774;6258.061290806416;6286.622802631857;6304.936950630618;6312.89524333249;5062.544371006627;6298.401651843067;6316.968415157895;6332.0818481320875;6338.619682819046;6096.908546371719;6246.250449946036;6290.087937248982;6297.653629050446;6318;6257.9674353731125;6260.718267678057;6311.936880631135;6317.96841015792;6357.777477788255;4831.931723355765;5703.771849126155;6058.4244496772735;6193.876122477435;6208.286047104641;4970.65205435616;6011;6143.692815359124;6202.317745047951;6219.160413344141;5906.881862362815;5915.260592425947;6014.398560144125;6094;6094.116353128683;5049.26785616091;6121.938780612137;6158.507319414526;6160.784372546939;6190.566660333733;5883.676397798162;5999.040153575407;6014.548908831943;6032.245969253843;6041 02:54:11 INFO - PROCESS | 1995 | |1;ext.html;471.71461265934107;480.36351833820197;525.2436491452308;544.7984245829043;568.7867049856304;38525.80737096314;40891;40990.79504602473;41044.97387565316;41110.7944460278;42057.369139462935;42190.367144492855;42553.7233882984;42602.573974260245;42719.57280427195;9744.07431294026;9821.214302855755;9826.410415375065;9859.260555458333;9891.010898910123;9773.951130244375;9863.90136098637;9886.456244906527;9901.8612859521;9906.306558540906;9810.46042467664;9862.358946668479;9922.156616687591;9940.40357578544;9940.6520771773;9861.260405469618;9884.851727224097;9891.554880030415;9910.20718342531;9912.157466615346;9722.90277097227;9778.41329520231;9798.069183427635;9800.656977005841;9803.656872009517;39670.60329396698;40022.39966400506;40365.19269614621;40466.79766601178;40600.59399405998;3191.4414977378865;3432.7940323580665;3471.687548120656;3478.9478157827652;3593.964060359389;28940.565891511644;30508.694913050807;31338.843305783554;31564;32440.675593244003;3133.138466594619;3188.8883889063773;3193.5209718542174;3228.6448490666007;3292;512912;514636;517739;519975.9999999962;520873.3956330232;63518;63708.72582548416;64454.677726611066;64698.059058228326;64750.352496475374;35302;35440.291194175974;36057.8197109018;36791.81604091962;67834;17194.484165475056;17230.65538689219;17356.13219339028;17362.95822250669;17405.129743512774;12696.619101426972;13053.738925221633;13088.803667944989;13142.802857957138;13160;19833.702494462595;20010.29963951255;20062.598748024957;20103.39689809308;20119.396418107186;7257.346838784535;7306.890396644055;8032.558209298428;8384.83230335402;8401.579921003926;931.5621657820814;946.711253067821;998.8612981201436;1021.4331046269392;1028.6296933104227;28744.850205991945;30870.69129308723;30878.22804429907;31251.906183283478;31552;939.201678573221;1044.8171569975225;1095.4960718069776;1151.9308841469538;1164.8602167739925;13313.534026309033;15492;15530.611734706723;15541.145237011846;15862;673135;680818.5959070172;681784;686206;689001;58378;58945.705271473365;59038.70480647569;59050.704746475996;59141.704291478265;1105.8507101541188;1439.9208043557496;1440.337444775394;1444.2489905249422;1446.1612264886342;24422.290439669054;27406.5889011669;29319.413611728072;29376.971805986686;30021.54967675443;47462.3388181412;48374;52658;52685.47314526806;53391;520171;523696;527107;596041;599646;27118.457630847668;27146.185614430808;27166.049188278317;27320.726792731817;27467;48309.792255193905;48626.756866215444;49125.508744913524;49414.50585494099;49463.516094517225;40114.39828402518;40243.798781005906;40487.9942659173;41171.58828411797;41423;40194.59805401909;40856.38715419212;40895.591044089175;40969.180616388105;41104;32743.836280818443;34334.31331373309;36544.63455365519;36712.449313259785;38989.6353627633;33620;35236.58234424387;35346.46980295349;36493.45259821052;37285.81357093197;25248.495030099664;25594.232173034838;25670.22989310324;26207.73792262053;26267.60598591061 02:54:11 INFO - PROCESS | 1995 | |2;jquery.html;368.4730834906084;381.1500354210113;383.8445429601012;399.07215723443005;408.75883228894963;18013.459596212102;19467.902660486696;21707.565848683018;21936.45158871027;22014.44963875902;20685.586288274226;20704.48238794031;21224.151033958624;21591.46021349467;21621.783782162172;5281.86795330116;5894.968380533411;6012.098185272201;6030.6080104793045;6038.6074905131245;5814.302283725959;5947.613405128653;5956;5999.880002399949;6010.939890601104;5792.884142317151;5850.648961062328;5895.469407753301;5979.730912108966;5979.880402391949;5832.445917637839;5861.970690146564;5932.970335148319;5955.047192449188;5989.640621562677;5106.106431374495;5197.116490196676;5221.765020574083;5222.399424066243;5236.895262094775;25977.480450390885;27036;27047.729522704718;27364;27448.725512744815;2317.3974766560814;2345.777151170636;2384.8688322142275;2839.843808590527;3095.1952492351925;13152.473901043946;16071;16215.27031283595;16296.103714295708;16359.672806543802;1832.569346203641;1875.4467432107424;1887.7262796894374;1902.3341830359402;1902.980970190308;79123.41753164963;97561;104170;104632.47683761608;122314.77685223123;11591.478383472595;11767.470463829148;11789.292642441482;11820.23168494045;11923.224990375598;12046.15676902626;14122.576322710334;14427.3507692152;14558.708825823423;14561.563153105424;7960.686486729624;8748.956255218684;8800.075992020873;8803.515806630698;8933.19601235892;8174.468659537111;8850.911490885137;8865.867011994826;8872.024077351487;8986.19124278818;4607.170709272363;4640.280756482751;4640.932585505353;4646.721196728207;4646.86059418218;1956.3739603326799;1994.0827219478913;2009.3670493794407;2038.082862711756;2045.3761602711018;747.4207489195917;819.7868554175957;866.9306455483546;1019.6686077024997;1046.8796088449926;18264;18654.44036678902;21736;21873.562528749335;21892.45268868291;802.2699343597415;932.4265576670299;970.5777986575862;981.4346117941872;1049.5644307612408;11014;11514.36670983104;11567.595134170264;11574.189806713617;11578.247413918069;555322;575630;579040;581209;582152;115176;116151;125663.37168314283;132622;139664;927.1377618814432;991.1525645573075;994.6220436234184;1015.3248090020054;1017.2167431078028;16061.919690401473;18453.81546184521;19106;19356.4193074208;19359.51601209981;42135.578644213165;48280.7585962068;50924;52589.474105259986;52895.735521322145;58881.41118588759;64174.037389438265;70678.29321706717;72907;74198;6729.2934241903895;7909.485883417559;8182.304504117216;8193.71322003727;8414;12544.24734515932;12614.747705045664;12641.2415255085;12732.363381831057;12784.105112642026;11100.444977750918;11100.889911008835;11118.388488633203;11225.943870280596;11237.887621124011;9984.750381240237;10166.135878450119;10916.563337466412;11022.338659680445;11234.269772464764;11162.162837787037;11241.38172400493;11332.830007549728;11356.716082098013;11401.600943966921;7952.801179970547;8100.351971842357;8137.918620813716;8144.75565733029;8360.163983601591;10726.785464290826;10943.124550036136;10977.615783447542;11055.391953442639;11198.38408887519 02:54:11 INFO - PROCESS | 1995 | |3;mootools.html;1576.0779943732912;1611.113887361951;1862.962740745185;1932.661784187767;1960.176725775176;8205.589720513964;8774.385792994493;8827.602757875895;9267.907320926788;9291.349605527615;8894.466332020083;8997.865032024509;9083.636654533811;9114.498702571356;9134.36059475837;2372.8101751859854;2395.9520809583796;2397.7482364351754;2399.9520009599887;2412.674288970984;2362.3739708977137;2365.656979737937;2388.426777573379;2405.494846082325;2408.397900524869;2389.450426401929;2392.6650268962358;2397.676313697646;2401.991163711237;2402.159244264511;2042.816146546803;2242.360927135767;2314.1090680088287;2367.822413318999;2387.4270175157926;2359.2686267257204;2380.750021247761;2381.4403615150427;2381.7141942966955;2382.6664267002634;9119.589618467186;9155.862662060075;9209;9223.354365194438;9253;5364.356277246717;5515.696636684981;5524.392316845144;5526.447355264481;5529.253550770634;3491.5460990071383;3619.384704600198;3648.5804132524568;3683.355412802749;3684.9447258291148;1065.575815020826;1074.623881641427;1083.544911137324;1097.5225776787042;1100.5872797700863;10858.782824343469;11908.702282442922;11956.521739130425;11987.82018269718;12034.217775844541;4474.373587697725;4491;4659.370984916993;4676.0647870426055;4679.532046795362;7977.282044616012;9318.440893546409;9441.622335106656;9453.621855125855;9459.19596834263;5240.213967904769;5241.816536421207;5242.239875218072;5263;5308.681479111266;4524.072565124207;4878.634102442331;4935.531124543235;5032.094223039815;5037.420696619935;3791.0711875590655;3839.865604703822;3898.3957486589625;3910.882673519799;3947.5460322062754;1183.7691650128143;1196.8922796948316;1205.1925210109248;1205.9035277177804;1211.9212251203644;837.0708513549955;904.7376260884402;916.170865366844;941.1341565759518;961.9759506012266;6103.6032657877095;6179.104029915637;6205.100260462208;6229.875402491924;6358.33237510064;435.8169568781056;448.7957979119493;460.32562296235506;469.0852836967926;471.69575623722505;3995.260876737813;4178.91642167155;4214.4099826024385;4240.618344349024;4241.257779888507;10610.363378197333;11024.889751102546;11159.442027898573;11160.883911608937;11183.32900026001;10820.242583019113;10849.403282819363;11073.280236784583;11115.499802508744;11141.108711303077;7982.760517184493;8392;8436.493810371398;8450.070492245848;8452.1547845215;5137.691738495702;6095.299040610209;6234.314225435108;6314.400131987454;6471.867423200827;7351.8162045949275;10426.971232151353;10433.843492347773;10563.996420340056;10575.682729518127;8862.20240178387;10381.169506439315;10412.427316497362;10485.161187105166;10523.789524209626;6658.400743933069;7166.677499512639;7567.167611562833;7692.19231980634;7867.213278672316;7520.360769334668;8601.956990215009;8650.524221167896;8701.34739894523;8791;7622.771316860503;7800.102988156435;7837.960810195913;7887.487313324616;7906.723264685708;7607.277308655669;7610.505317154367;7666.428382181528;7751;7782.455228133977;7204.495685302189;7281.5631062136445;7335.706571737071;7340.449466289942;7345;4950.282209079735;5181.844544663666;5195.19474481456;5225.555827754683;5281.075811733008;5225.477452254744;5269.78920843162;5275.80333371621;5345.786168553214;5445.863853403696 02:54:11 INFO - PROCESS | 1995 | |4;prototype.html;306.2298319725889;311.0450915688835;312.54524666610075;325.9071164718056;326.14875175791195;5532.474414930585;5699.173619825133;5748.683822389767;5856.648601083938;5872.060470324749;5012.7493625318675;5285.682859028461;5798.985177593925;5817.331006934204;5823.883522329551;3641.4901913732097;3669.486271921933;4398.054418300073;4398.516163222059;4407.427034485512;3930.3121953657997;4081.4694089768436;4245.23585754564;4386.758728269944;4395.670324725643;3925.862594809182;4272.572742725733;4324.805383757738;4326.43756311679;4359.847405340814;4342.804573794187;4348.369486424466;4379.934300985487;4380.67144964129;4391.758453285068;3197.4172784471834;3449.6542351201174;3660.652238037382;3776.4901738265257;3785.848566057354;5427.945720542783;5531.502164805187;5598.500936914428;5653.378128405872;5677.943220567783;3952.6442620164325;4403.735775853459;4451.132029254297;4833.975830120862;5075.51782580658;5806.4193580641595;6103.267607887037;6118.938810611881;6121.296050954153;6129.149945275468;3864.9613503864884;4140.730852494578;4174.7893110997775;4175.164967006581;4211.378619231587;4864.835148358981;5463.989162005002;6451.806445806634;6496.928006878859;6508.8698226035685;3469;4149.771762553029;4231.682623803227;4236.978815105905;4238.071677386782;3230.6769323067506;4170.895727606834;4176.540580536139;4187.958120418818;4229.809658565372;4352.69531132824;4987.775550100254;4994.725290109079;5008.574271186917;5015.022070696179;5901.76392944286;6113.296970848321;6227.19046523949;6241;6243.938530449835;1205.5473154848387;1426.8216472940883;1436.8491308412674;1438.6547228665254;1446.848080951506;818.5579786914999;831.4304701279643;848.6096395657943;874.6938571499924;874.9107361335178;4148.92128046704;4881.633877459205;4907.889607468751;4944.90110197794;4955.801767929314;4924.901501969941;5215.608829337815;5416.431274716177;5431.750697339634;5435.673859568438;4516.6128857179065;4765.928511072337;4923.75381230937;4927.408710954708;4947.282644016597;2484;2545.707243667002;2673.83956962579;2731.412746259564;2874.375977572665;4998.650094493423;5073.061483625541;5494.587905907073;5578.693171875505;5594.608232537438;4972.9254061188385;5212.429485802238;5293.030227329503;5441.700706461183;5492.395836457987;4636.165490211727;4963.354763880672;5309.123994540934;5608.158776183605;5618.39875635442;4708.529147085401;5219.562123973398;5398.757055932414;5401.758944633189;5416.674999500043;4495.752733599684;4571.519990401093;4801.4718380977365;5157.8452646420665;5364.356277246599;5276.39321478035;5557.499825015606;5566.552696298911;5613.550915926798;5666.603337766317;3991.7405368650943;4100.34394496879;4108.4864391951005;4126.958730412777;4135.255653982312;5483.643563168382;5712.914546236202;5756.453136951983;6254.499640028877;6279.1209230708655;5241.842744717665;5698.6580805151825;5727.964178985145;5835.008048631658;6184.5980011299125;5675.460831221028;5892.346745018116;6152.169457123231;6214.4407003369915;6251.78118765841;4943.876403089952;6063.787767428119;6097.695115244309;6112.694365281629;6115.510759139169;5391.865203369947;5573.331200255995;6165.969170154121;6174.969125154345;6181.403810399553;4958.355413796184;5884.529237660891;5891.852703682443;6085.847853803513;6097.2988106366565 02:54:11 INFO - PROCESS | 1995 | |5;yui.html;711.189244261542;758.5486635451904;761.090496856257;811.8498077855596;844.4046946902434;14395.640108997268;15351.923240383783;15672.138032408213;15820.76268855968;15820.841791582081;14429.422823087063;14512.637184070403;14546.927265363685;14555.272236388191;14566.053206541568;502.7109412088064;889.6797153024905;902.7743064233941;925.6898938855492;937.746808361742;912.1881525442328;915.0574907844897;916.1571354354011;917.655879045358;918.5958178401482;971.2375785008769;977.7115750853516;978.1050338939897;978.2809634918365;979.1628157924979;957.3633533700081;968.6900191938582;969.7381706939087;969.8157350103493;970.2819913264134;679.7858674517511;691.8927566227243;717.4690728860605;723.609251004457;724.6594100772628;14861.628459288497;14956;14956.925215373854;14962.62593435162;15250.466233681878;14272.429102835875;14593.854061459355;14752.323603218922;14791.334389952477;14847.851521484756;11976.221545599596;12075.93962030193;12175.33035683037;12258.26450412978;12467.625971220878;3604;3697.556293244828;3851.786687193553;3868.9226215475533;3894.5131858517684;82174;93830.530847346;98224.03551928993;99671.50492742614;108494.45752771264;9399.389039712534;10844.403557804397;10888.510017049251;11069.169812264112;11412.201145919871;19881.900590496956;23055;23447.648285275736;23450.765492344857;23538.58768473897;8342.749717508485;8370.790730231793;8430.156984301644;8467.407281490237;8508.10664880191;4594.770261486912;4661.021185551072;4683.882902927386;4699.718016918996;4704.129735998851;3562.839672214757;3609.5488063992;3666.7433279670167;3672.4307732301536;3933.704972127102;689.441552342604;696.7949417848662;731.5829976913109;736.3330613544578;743.9702411903571;610.7923306075955;663.349917081263;696.4009364707794;697.2748341724549;712.6080655639481;8597.398182127192;9404.576794044284;9739.805203895883;9913.752156196153;9970.351927124713;628.5443053785968;630.0234636313787;651.4299987510927;684.1072400517273;687.295522089862;4579.025110782884;4727.834525791581;4847.854564363075;4855.684380515255;4906.877328066756;85982;118050;156473.2176339134;162967;171788;147627.26186369214;150768;153073;155377;155389;126387.73612263944;128257;128586.71413285748;131646.99999999808;132463.3376833129;7862.567558784322;9962.950185249027;10089.798204036026;10257.897421025993;10271.486425678835;49281.75359123181;57817;60005.39994599998;60718.392816071275;61439.692801535704;48332.27501587409;67744.32255677578;77132.22867771475;90151.54924225337;97102.5144874271;13676.794848077088;13766.31168441594;13767.931160344135;13826.170429774245;14264.144151350538;15304.693906122038;15456.072635641898;15534.456294030108;15727.05637661744;15811.342833626117;14317.928410357881;14568.781468278195;14689.485867994568;15049.77425338599;15065.849341506444;14153.929230353782;14191;14245.64385890361;14772.48296309624;14947;13058.281794501394;14321.498747543787;14321.57035288943;14490.927545362205;14759.262036898326;11407.885921140682;11444.771104577696;11691.181617286707;11705.88294117082;11886.940565297118;9631.71104866855;9977.60089596408;10975.560977560808;11689.649310520697;11908.345041022827 02:54:11 INFO - PROCESS | 1995 | __end_tp_report 02:54:11 INFO - PROCESS | 1995 | __start_cc_report 02:54:11 INFO - PROCESS | 1995 | _x_x_mozilla_cycle_collect,433 02:54:11 INFO - PROCESS | 1995 | __end_cc_report 02:54:11 INFO - PROCESS | 1995 | __startTimestamp1467971651710__endTimestamp 02:54:11 INFO - PROCESS | 1995 | 02:54:11 INFO - PROCESS | 1995 | ------- Summary: start ------- 02:54:11 INFO - PROCESS | 1995 | Number of tests: 6 02:54:11 INFO - PROCESS | 1995 | 02:54:11 INFO - PROCESS | 1995 | [#0] dojo.html Cycles:165 Average:5671.52 Median:5954.67 stddev:833.42 (14.0%) stddev-sans-first:816.81 02:54:11 INFO - PROCESS | 1995 | Values: 3406.4 3413.4 3414.1 3433.8 3454.5 4272.3 4764.7 4900.9 4969.4 5668.9 4794.3 4945.5 4957.7 5537.4 5735.6 5034.6 5123.5 5166.5 5245.3 5321.9 155.1 4712.8 4970.4 5174.8 5281.2 4231.3 5224.4 5230.2 5230.7 5232.4 5152.8 5221.7 5237.3 5261.7 5267.8 5125.2 5143.9 5164.9 5181.9 5201.0 4769.0 5571.3 5736.9 5807.7 5880.6 6074.0 6182.5 6334.4 6336.5 6353.2 6277.9 6333.1 6346.7 6365.4 6367.6 5881.6 5909.0 5909.7 5912.1 5954.7 6242.6 6247.9 6273.8 6281.2 6297.9 6244.4 6249.4 6269.2 6270.0 6282.4 6325.7 6327.0 6333.0 6351.9 6365.8 6138.0 6197.7 6216.1 6232.2 6310.3 6091.5 6235.8 6293.4 6297.3 6313.4 4889.0 4972.4 4988.2 4996.2 5003.3 3566.7 4412.2 4448.6 4514.7 4553.9 5713.8 5840.5 5844.5 5847.4 5858.4 6288.0 6311.4 6336.3 6339.3 6341.6 5691.1 5775.7 5796.8 5826.2 5842.3 5478.8 5485.6 5489.3 5499.1 5505.6 6304.9 6336.1 6351.1 6351.9 6356.1 6203.4 6258.1 6286.6 6304.9 6312.9 5062.5 6298.4 6317.0 6332.1 6338.6 6096.9 6246.3 6290.1 6297.7 6318.0 6258.0 6260.7 6311.9 6318.0 6357.8 4831.9 5703.8 6058.4 6193.9 6208.3 4970.7 6011.0 6143.7 6202.3 6219.2 5906.9 5915.3 6014.4 6094.0 6094.1 5049.3 6121.9 6158.5 6160.8 6190.6 5883.7 5999.0 6014.5 6032.2 6041.0 02:54:11 INFO - PROCESS | 1995 | 02:54:11 INFO - PROCESS | 1995 | [#1] ext.html Cycles:180 Average:71394.67 Median:40873.69 stddev:157513.24 (385.4%) stddev-sans-first:157865.10 02:54:11 INFO - PROCESS | 1995 | Values: 471.7 480.4 525.2 544.8 568.8 38525.8 40891.0 40990.8 41045.0 41110.8 42057.4 42190.4 42553.7 42602.6 42719.6 9744.1 9821.2 9826.4 9859.3 9891.0 9774.0 9863.9 9886.5 9901.9 9906.3 9810.5 9862.4 9922.2 9940.4 9940.7 9861.3 9884.9 9891.6 9910.2 9912.2 9722.9 9778.4 9798.1 9800.7 9803.7 39670.6 40022.4 40365.2 40466.8 40600.6 3191.4 3432.8 3471.7 3478.9 3594.0 28940.6 30508.7 31338.8 31564.0 32440.7 3133.1 3188.9 3193.5 3228.6 3292.0 512912.0 514636.0 517739.0 519976.0 520873.4 63518.0 63708.7 64454.7 64698.1 64750.4 35302.0 35440.3 36057.8 36791.8 67834.0 17194.5 17230.7 17356.1 17363.0 17405.1 12696.6 13053.7 13088.8 13142.8 13160.0 19833.7 20010.3 20062.6 20103.4 20119.4 7257.3 7306.9 8032.6 8384.8 8401.6 931.6 946.7 998.9 1021.4 1028.6 28744.9 30870.7 30878.2 31251.9 31552.0 939.2 1044.8 1095.5 1151.9 1164.9 13313.5 15492.0 15530.6 15541.1 15862.0 673135.0 680818.6 681784.0 686206.0 689001.0 58378.0 58945.7 59038.7 59050.7 59141.7 1105.9 1439.9 1440.3 1444.2 1446.2 24422.3 27406.6 29319.4 29377.0 30021.5 47462.3 48374.0 52658.0 52685.5 53391.0 520171.0 523696.0 527107.0 596041.0 599646.0 27118.5 27146.2 27166.0 27320.7 27467.0 48309.8 48626.8 49125.5 49414.5 49463.5 40114.4 40243.8 40488.0 41171.6 41423.0 40194.6 40856.4 40895.6 40969.2 41104.0 32743.8 34334.3 36544.6 36712.4 38989.6 33620.0 35236.6 35346.5 36493.5 37285.8 25248.5 25594.2 25670.2 26207.7 26267.6 02:54:11 INFO - PROCESS | 1995 | 02:54:11 INFO - PROCESS | 1995 | [#2] jquery.html Cycles:180 Average:33707.56 Median:26506.74 stddev:95605.03 (360.7%) stddev-sans-first:95840.46 02:54:11 INFO - PROCESS | 1995 | Values: 368.5 381.2 383.8 399.1 408.8 18013.5 19467.9 21707.6 21936.5 22014.4 20685.6 20704.5 21224.2 21591.5 21621.8 5281.9 5895.0 6012.1 6030.6 6038.6 5814.3 5947.6 5956.0 5999.9 6010.9 5792.9 5850.6 5895.5 5979.7 5979.9 5832.4 5862.0 5933.0 5955.0 5989.6 5106.1 5197.1 5221.8 5222.4 5236.9 25977.5 27036.0 27047.7 27364.0 27448.7 2317.4 2345.8 2384.9 2839.8 3095.2 13152.5 16071.0 16215.3 16296.1 16359.7 1832.6 1875.4 1887.7 1902.3 1903.0 79123.4 97561.0 104170.0 104632.5 122314.8 11591.5 11767.5 11789.3 11820.2 11923.2 12046.2 14122.6 14427.4 14558.7 14561.6 7960.7 8749.0 8800.1 8803.5 8933.2 8174.5 8850.9 8865.9 8872.0 8986.2 4607.2 4640.3 4640.9 4646.7 4646.9 1956.4 1994.1 2009.4 2038.1 2045.4 747.4 819.8 866.9 1019.7 1046.9 18264.0 18654.4 21736.0 21873.6 21892.5 802.3 932.4 970.6 981.4 1049.6 11014.0 11514.4 11567.6 11574.2 11578.2 555322.0 575630.0 579040.0 581209.0 582152.0 115176.0 116151.0 125663.4 132622.0 139664.0 927.1 991.2 994.6 1015.3 1017.2 16061.9 18453.8 19106.0 19356.4 19359.5 42135.6 48280.8 50924.0 52589.5 52895.7 58881.4 64174.0 70678.3 72907.0 74198.0 6729.3 7909.5 8182.3 8193.7 8414.0 12544.2 12614.7 12641.2 12732.4 12784.1 11100.4 11100.9 11118.4 11225.9 11237.9 9984.8 10166.1 10916.6 11022.3 11234.3 11162.2 11241.4 11332.8 11356.7 11401.6 7952.8 8100.4 8137.9 8144.8 8360.2 10726.8 10943.1 10977.6 11055.4 11198.4 02:54:11 INFO - PROCESS | 1995 | 02:54:11 INFO - PROCESS | 1995 | [#3] mootools.html Cycles:180 Average:5803.44 Median:4942.91 stddev:3269.44 (66.1%) stddev-sans-first:3263.17 02:54:11 INFO - PROCESS | 1995 | Values: 1576.1 1611.1 1863.0 1932.7 1960.2 8205.6 8774.4 8827.6 9267.9 9291.3 8894.5 8997.9 9083.6 9114.5 9134.4 2372.8 2396.0 2397.7 2400.0 2412.7 2362.4 2365.7 2388.4 2405.5 2408.4 2389.5 2392.7 2397.7 2402.0 2402.2 2042.8 2242.4 2314.1 2367.8 2387.4 2359.3 2380.8 2381.4 2381.7 2382.7 9119.6 9155.9 9209.0 9223.4 9253.0 5364.4 5515.7 5524.4 5526.4 5529.3 3491.5 3619.4 3648.6 3683.4 3684.9 1065.6 1074.6 1083.5 1097.5 1100.6 10858.8 11908.7 11956.5 11987.8 12034.2 4474.4 4491.0 4659.4 4676.1 4679.5 7977.3 9318.4 9441.6 9453.6 9459.2 5240.2 5241.8 5242.2 5263.0 5308.7 4524.1 4878.6 4935.5 5032.1 5037.4 3791.1 3839.9 3898.4 3910.9 3947.5 1183.8 1196.9 1205.2 1205.9 1211.9 837.1 904.7 916.2 941.1 962.0 6103.6 6179.1 6205.1 6229.9 6358.3 435.8 448.8 460.3 469.1 471.7 3995.3 4178.9 4214.4 4240.6 4241.3 10610.4 11024.9 11159.4 11160.9 11183.3 10820.2 10849.4 11073.3 11115.5 11141.1 7982.8 8392.0 8436.5 8450.1 8452.2 5137.7 6095.3 6234.3 6314.4 6471.9 7351.8 10427.0 10433.8 10564.0 10575.7 8862.2 10381.2 10412.4 10485.2 10523.8 6658.4 7166.7 7567.2 7692.2 7867.2 7520.4 8602.0 8650.5 8701.3 8791.0 7622.8 7800.1 7838.0 7887.5 7906.7 7607.3 7610.5 7666.4 7751.0 7782.5 7204.5 7281.6 7335.7 7340.4 7345.0 4950.3 5181.8 5195.2 5225.6 5281.1 5225.5 5269.8 5275.8 5345.8 5445.9 02:54:11 INFO - PROCESS | 1995 | 02:54:11 INFO - PROCESS | 1995 | [#4] prototype.html Cycles:180 Average:4667.09 Median:5013.89 stddev:1442.00 (28.8%) stddev-sans-first:1408.41 02:54:11 INFO - PROCESS | 1995 | Values: 306.2 311.0 312.5 325.9 326.1 5532.5 5699.2 5748.7 5856.6 5872.1 5012.7 5285.7 5799.0 5817.3 5823.9 3641.5 3669.5 4398.1 4398.5 4407.4 3930.3 4081.5 4245.2 4386.8 4395.7 3925.9 4272.6 4324.8 4326.4 4359.8 4342.8 4348.4 4379.9 4380.7 4391.8 3197.4 3449.7 3660.7 3776.5 3785.8 5427.9 5531.5 5598.5 5653.4 5677.9 3952.6 4403.7 4451.1 4834.0 5075.5 5806.4 6103.3 6118.9 6121.3 6129.1 3865.0 4140.7 4174.8 4175.2 4211.4 4864.8 5464.0 6451.8 6496.9 6508.9 3469.0 4149.8 4231.7 4237.0 4238.1 3230.7 4170.9 4176.5 4188.0 4229.8 4352.7 4987.8 4994.7 5008.6 5015.0 5901.8 6113.3 6227.2 6241.0 6243.9 1205.5 1426.8 1436.8 1438.7 1446.8 818.6 831.4 848.6 874.7 874.9 4148.9 4881.6 4907.9 4944.9 4955.8 4924.9 5215.6 5416.4 5431.8 5435.7 4516.6 4765.9 4923.8 4927.4 4947.3 2484.0 2545.7 2673.8 2731.4 2874.4 4998.7 5073.1 5494.6 5578.7 5594.6 4972.9 5212.4 5293.0 5441.7 5492.4 4636.2 4963.4 5309.1 5608.2 5618.4 4708.5 5219.6 5398.8 5401.8 5416.7 4495.8 4571.5 4801.5 5157.8 5364.4 5276.4 5557.5 5566.6 5613.6 5666.6 3991.7 4100.3 4108.5 4127.0 4135.3 5483.6 5712.9 5756.5 6254.5 6279.1 5241.8 5698.7 5728.0 5835.0 6184.6 5675.5 5892.3 6152.2 6214.4 6251.8 4943.9 6063.8 6097.7 6112.7 6115.5 5391.9 5573.3 6166.0 6175.0 6181.4 4958.4 5884.5 5891.9 6085.8 6097.3 02:54:11 INFO - PROCESS | 1995 | 02:54:11 INFO - PROCESS | 1995 | [#5] yui.html Cycles:180 Average:25100.99 Median:3774.67 stddev:40892.71 (1083.3%) stddev-sans-first:40966.42 02:54:11 INFO - PROCESS | 1995 | Values: 711.2 758.5 761.1 811.8 844.4 14395.6 15351.9 15672.1 15820.8 15820.8 14429.4 14512.6 14546.9 14555.3 14566.1 502.7 889.7 902.8 925.7 937.7 912.2 915.1 916.2 917.7 918.6 971.2 977.7 978.1 978.3 979.2 957.4 968.7 969.7 969.8 970.3 679.8 691.9 717.5 723.6 724.7 14861.6 14956.0 14956.9 14962.6 15250.5 14272.4 14593.9 14752.3 14791.3 14847.9 11976.2 12075.9 12175.3 12258.3 12467.6 3604.0 3697.6 3851.8 3868.9 3894.5 82174.0 93830.5 98224.0 99671.5 108494.5 9399.4 10844.4 10888.5 11069.2 11412.2 19881.9 23055.0 23447.6 23450.8 23538.6 8342.7 8370.8 8430.2 8467.4 8508.1 4594.8 4661.0 4683.9 4699.7 4704.1 3562.8 3609.5 3666.7 3672.4 3933.7 689.4 696.8 731.6 736.3 744.0 610.8 663.3 696.4 697.3 712.6 8597.4 9404.6 9739.8 9913.8 9970.4 628.5 630.0 651.4 684.1 687.3 4579.0 4727.8 4847.9 4855.7 4906.9 85982.0 118050.0 156473.2 162967.0 171788.0 147627.3 150768.0 153073.0 155377.0 155389.0 126387.7 128257.0 128586.7 131647.0 132463.3 7862.6 9963.0 10089.8 10257.9 10271.5 49281.8 57817.0 60005.4 60718.4 61439.7 48332.3 67744.3 77132.2 90151.5 97102.5 13676.8 13766.3 13767.9 13826.2 14264.1 15304.7 15456.1 15534.5 15727.1 15811.3 14317.9 14568.8 14689.5 15049.8 15065.8 14153.9 14191.0 14245.6 14772.5 14947.0 13058.3 14321.5 14321.6 14490.9 14759.3 11407.9 11444.8 11691.2 11705.9 11886.9 9631.7 9977.6 10975.6 11689.6 11908.3 02:54:11 INFO - PROCESS | 1995 | -------- Summary: end -------- 02:54:11 INFO - PROCESS | 1995 | 02:54:12 INFO - TEST-INFO | 1995: exit 0 02:54:12 INFO - TEST-OK | dromaeo_css | took 1111220ms 02:54:12 INFO - TEST-START | kraken 02:54:12 INFO - operating with platform_type : mac_ 02:54:12 INFO - Initialising browser for kraken test... 02:54:12 INFO - TEST-INFO | started process 2001 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmpOCS52I/profile http://localhost:49391/getInfo.html) 02:54:15 INFO - PROCESS | 2001 | __metrics Screen width/height:1600/1200 02:54:15 INFO - PROCESS | 2001 | colorDepth:24 02:54:15 INFO - PROCESS | 2001 | Browser inner width/height: 1024/689 02:54:15 INFO - PROCESS | 2001 | __metrics 02:54:15 ERROR - PROCESS | 2001 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 02:54:15 INFO - TEST-INFO | 2001: exit 0 02:54:15 INFO - Browser initialized. 02:54:15 INFO - Running cycle 1/1 for kraken test... 02:54:15 INFO - TEST-INFO | started process 2003 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmpOCS52I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:54:28 INFO - PROCESS | 2003 | RSS: Main: 254402560 02:54:28 INFO - PROCESS | 2003 | 02:54:30 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-beat-detection) 02:54:31 INFO - PROCESS | 2003 | RSS: Main: 267149312 02:54:31 INFO - PROCESS | 2003 | 02:54:34 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-dft) 02:54:34 INFO - PROCESS | 2003 | RSS: Main: 271269888 02:54:34 INFO - PROCESS | 2003 | 02:54:38 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-fft) 02:54:39 INFO - PROCESS | 2003 | RSS: Main: 271646720 02:54:39 INFO - PROCESS | 2003 | 02:54:41 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49391/tests/kraken/driver.html?testName=audio-oscillator) 02:54:41 INFO - PROCESS | 2003 | RSS: Main: 272617472 02:54:41 INFO - PROCESS | 2003 | 02:54:43 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49391/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:54:44 INFO - PROCESS | 2003 | RSS: Main: 273235968 02:54:44 INFO - PROCESS | 2003 | 02:54:47 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49391/tests/kraken/driver.html?testName=imaging-darkroom) 02:54:47 INFO - PROCESS | 2003 | RSS: Main: 273539072 02:54:47 INFO - PROCESS | 2003 | 02:54:50 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49391/tests/kraken/driver.html?testName=imaging-desaturate) 02:54:51 INFO - PROCESS | 2003 | RSS: Main: 273743872 02:54:51 INFO - PROCESS | 2003 | 02:54:54 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49391/tests/kraken/driver.html?testName=json-parse-financial) 02:54:55 INFO - PROCESS | 2003 | RSS: Main: 273952768 02:54:55 INFO - PROCESS | 2003 | 02:54:56 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49391/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:54:57 INFO - PROCESS | 2003 | RSS: Main: 273821696 02:54:57 INFO - PROCESS | 2003 | 02:54:59 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:54:59 INFO - PROCESS | 2003 | RSS: Main: 273981440 02:54:59 INFO - PROCESS | 2003 | 02:55:01 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:55:02 INFO - PROCESS | 2003 | RSS: Main: 274038784 02:55:02 INFO - PROCESS | 2003 | 02:55:05 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:55:06 INFO - PROCESS | 2003 | RSS: Main: 274079744 02:55:06 INFO - PROCESS | 2003 | 02:55:08 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:55:09 INFO - PROCESS | 2003 | RSS: Main: 274034688 02:55:09 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:49391/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49391/tests/kraken/driver.html?testName=ai-astar) 02:55:11 INFO - PROCESS | 2003 | RSS: Main: 275329024 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | __start_tp_report 02:55:11 INFO - PROCESS | 2003 | _x_x_mozilla_page_load 02:55:11 INFO - PROCESS | 2003 | _x_x_mozilla_page_load_details 02:55:11 INFO - PROCESS | 2003 | |i|pagename|runs| 02:55:11 INFO - PROCESS | 2003 | |0;ai-astar;118;117;108;112;116;97;137;172;172;122 02:55:11 INFO - PROCESS | 2003 | |1;audio-beat-detection;148;111;138;185;140;134;126;109;159;108 02:55:11 INFO - PROCESS | 2003 | |2;audio-dft;199;195;212;257;256;283;218;195;197;195 02:55:11 INFO - PROCESS | 2003 | |3;audio-fft;71;89;99;178;49;62;83;88;140;50 02:55:11 INFO - PROCESS | 2003 | |4;audio-oscillator;71;71;131;70;72;76;114;79;101;147 02:55:11 INFO - PROCESS | 2003 | |5;imaging-gaussian-blur;90;89;90;88;90;86;91;90;90;86 02:55:11 INFO - PROCESS | 2003 | |6;imaging-darkroom;95;118;149;109;104;128;95;98;95;94 02:55:11 INFO - PROCESS | 2003 | |7;imaging-desaturate;100;95;92;91;91;91;91;92;91;103 02:55:11 INFO - PROCESS | 2003 | |8;json-parse-financial;55;56;59;56;55;56;59;58;58;57 02:55:11 INFO - PROCESS | 2003 | |9;json-stringify-tinderbox;67;72;70;75;74;77;73;74;71;69 02:55:11 INFO - PROCESS | 2003 | |10;stanford-crypto-aes;85;85;86;86;82;86;82;86;86;85 02:55:11 INFO - PROCESS | 2003 | |11;stanford-crypto-ccm;157;157;149;136;139;130;161;153;178;158 02:55:11 INFO - PROCESS | 2003 | |12;stanford-crypto-pbkdf2;162;165;163;164;163;162;163;170;163;165 02:55:11 INFO - PROCESS | 2003 | |13;stanford-crypto-sha256-iterative;69;66;68;65;67;69;86;87;67;67 02:55:11 INFO - PROCESS | 2003 | __end_tp_report 02:55:11 INFO - PROCESS | 2003 | __start_cc_report 02:55:11 INFO - PROCESS | 2003 | _x_x_mozilla_cycle_collect,1113 02:55:11 INFO - PROCESS | 2003 | __end_cc_report 02:55:11 INFO - PROCESS | 2003 | __startTimestamp1467971711535__endTimestamp 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | ------- Summary: start ------- 02:55:11 INFO - PROCESS | 2003 | Number of tests: 14 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | [#0] ai-astar Cycles:10 Average:127.10 Median:129.50 stddev:25.74 (19.9%) stddev-sans-first:27.09 02:55:11 INFO - PROCESS | 2003 | Values: 118.0 117.0 108.0 112.0 116.0 97.0 137.0 172.0 172.0 122.0 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:139.00 stddev:24.35 (17.5%) stddev-sans-first:25.42 02:55:11 INFO - PROCESS | 2003 | Values: 148.0 111.0 138.0 185.0 140.0 134.0 126.0 109.0 159.0 108.0 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | [#2] audio-dft Cycles:10 Average:220.70 Median:215.00 stddev:32.56 (15.1%) stddev-sans-first:33.58 02:55:11 INFO - PROCESS | 2003 | Values: 199.0 195.0 212.0 257.0 256.0 283.0 218.0 195.0 197.0 195.0 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | [#3] audio-fft Cycles:10 Average:90.90 Median:77.00 stddev:40.55 (52.7%) stddev-sans-first:42.36 02:55:11 INFO - PROCESS | 2003 | Values: 71.0 89.0 99.0 178.0 49.0 62.0 83.0 88.0 140.0 50.0 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:71.00 stddev:28.46 (40.1%) stddev-sans-first:29.03 02:55:11 INFO - PROCESS | 2003 | Values: 71.0 71.0 131.0 70.0 72.0 76.0 114.0 79.0 101.0 147.0 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:90.00 stddev:1.76 (2.0%) stddev-sans-first:1.83 02:55:11 INFO - PROCESS | 2003 | Values: 90.0 89.0 90.0 88.0 90.0 86.0 91.0 90.0 90.0 86.0 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | [#6] imaging-darkroom Cycles:10 Average:108.50 Median:94.50 stddev:18.25 (19.3%) stddev-sans-first:18.69 02:55:11 INFO - PROCESS | 2003 | Values: 95.0 118.0 149.0 109.0 104.0 128.0 95.0 98.0 95.0 94.0 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:91.00 stddev:4.35 (4.8%) stddev-sans-first:3.97 02:55:11 INFO - PROCESS | 2003 | Values: 100.0 95.0 92.0 91.0 91.0 91.0 91.0 92.0 91.0 103.0 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.50 stddev:1.52 (2.7%) stddev-sans-first:1.45 02:55:11 INFO - PROCESS | 2003 | Values: 55.0 56.0 59.0 56.0 55.0 56.0 59.0 58.0 58.0 57.0 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:73.50 stddev:3.01 (4.1%) stddev-sans-first:2.54 02:55:11 INFO - PROCESS | 2003 | Values: 67.0 72.0 70.0 75.0 74.0 77.0 73.0 74.0 71.0 69.0 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:86.00 stddev:1.60 (1.9%) stddev-sans-first:1.69 02:55:11 INFO - PROCESS | 2003 | Values: 85.0 85.0 86.0 86.0 82.0 86.0 82.0 86.0 86.0 85.0 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:157.00 stddev:13.99 (8.9%) stddev-sans-first:14.71 02:55:11 INFO - PROCESS | 2003 | Values: 157.0 157.0 149.0 136.0 139.0 130.0 161.0 153.0 178.0 158.0 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:163.50 stddev:2.36 (1.4%) stddev-sans-first:2.39 02:55:11 INFO - PROCESS | 2003 | Values: 162.0 165.0 163.0 164.0 163.0 162.0 163.0 170.0 163.0 165.0 02:55:11 INFO - PROCESS | 2003 | 02:55:11 INFO - PROCESS | 2003 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:68.50 stddev:8.21 (12.0%) stddev-sans-first:8.67 02:55:11 INFO - PROCESS | 2003 | Values: 69.0 66.0 68.0 65.0 67.0 69.0 86.0 87.0 67.0 67.0 02:55:11 INFO - PROCESS | 2003 | -------- Summary: end -------- 02:55:11 INFO - PROCESS | 2003 | 02:55:12 INFO - TEST-INFO | 2003: exit 0 02:55:12 INFO - TEST-OK | kraken | took 60065ms 02:55:12 INFO - SUITE-END | took 1171s 02:55:12 INFO - Completed test suite (00:19:31) 02:55:12 INFO - javascript benchmark 02:55:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7440.272569325438, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3406.3868503669337, 3413.4026545354573, 3414.095264754839, 3433.7939723616587, 3454.4990976308436, 4272.316429371302, 4764.690295130823, 4900.852974410765, 4969.353983982086, 5668.943310566899, 4794.304825800257, 4945.5301746334135, 4957.702537847732, 5537.418571050032, 5735.598508104435, 5034.565148932555, 5123.487651234866, 5166.509181627739, 5245.344331958505, 5321.893562128756, 155.09826454271334, 4712.764361781914, 4970.353853998975, 5174.767135478913, 5281.2342210379475, 4231.259529582326, 5224.3730752309775, 5230.21546767984, 5230.686158830464, 5232.372115346183, 5152.819651312224, 5221.686698798084, 5237.292965449654, 5261.710605916673, 5267.815626453055, 5125.2312153176945, 5143.948560514422, 5164.92252616211, 5181.870453238699, 5200.973995130038, 4768.997021251048, 5571.303587051619, 5736.913946290809, 5807.738651760681, 5880.617759845596, 6074.0281554951, 6182.474489668339, 6334.366563343675, 6336.4930805535905, 6353.237611486605, 6277.932751432268, 6333.113364129025, 6346.682665866734, 6365.395287447685, 6367.554271201017, 5881.558883083786, 5908.97045514774, 5909.674967876722, 5912.142739302777, 5954.672493012882, 6242.5942313749465, 6247.9062814057825, 6273.8115369693805, 6281.152044474029, 6297.937020629826, 6244.406781355764, 6249.437550620466, 6269.185005949289, 6269.96865015672, 6282.434580887742, 6325.715342809584, 6327.0, 6333.0, 6351.936480635227, 6365.840853978595, 6137.96931015342, 6197.659128747962, 6216.129741836146, 6232.158658581124, 6310.337414571404, 6091.543134264948, 6235.844103897439, 6293.433590976834, 6297.307296197415, 6313.40022697843, 4888.951110488921, 4972.428170760337, 4988.226824842155, 4996.225585034325, 5003.324551185616, 3566.661167189113, 4412.22786012453, 4448.5551444855255, 4514.706544074625, 4553.886152846206, 5713.771449142071, 5840.503557197686, 5844.532437404998, 5847.415258474203, 5858.384869588717, 6287.96856015717, 6311.400416960381, 6336.303006669263, 6339.334369891095, 6341.587796793194, 5691.117876729114, 5775.682337471395, 5796.82609521715, 5826.242588463472, 5842.298924129132, 5478.780848766084, 5485.6434331768305, 5489.286392768914, 5499.1476321170285, 5505.642133261325, 6304.936950630618, 6336.081268216083, 6351.110844481776, 6351.904721429182, 6356.078368636522, 6203.410675985774, 6258.061290806416, 6286.622802631857, 6304.936950630618, 6312.89524333249, 5062.544371006627, 6298.401651843067, 6316.968415157895, 6332.0818481320875, 6338.619682819046, 6096.908546371719, 6246.250449946036, 6290.087937248982, 6297.653629050446, 6318.0, 6257.9674353731125, 6260.718267678057, 6311.936880631135, 6317.96841015792, 6357.777477788255, 4831.931723355765, 5703.771849126155, 6058.4244496772735, 6193.876122477435, 6208.286047104641, 4970.65205435616, 6011.0, 6143.692815359124, 6202.317745047951, 6219.160413344141, 5906.881862362815, 5915.260592425947, 6014.398560144125, 6094.0, 6094.116353128683, 5049.26785616091, 6121.938780612137, 6158.507319414526, 6160.784372546939, 6190.566660333733, 5883.676397798162, 5999.040153575407, 6014.548908831943, 6032.245969253843, 6041.0], "value": 5618.575305082388, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.71461265934107, 480.36351833820197, 525.2436491452308, 544.7984245829043, 568.7867049856304, 38525.80737096314, 40891.0, 40990.79504602473, 41044.97387565316, 41110.7944460278, 42057.369139462935, 42190.367144492855, 42553.7233882984, 42602.573974260245, 42719.57280427195, 9744.07431294026, 9821.214302855755, 9826.410415375065, 9859.260555458333, 9891.010898910123, 9773.951130244375, 9863.90136098637, 9886.456244906527, 9901.8612859521, 9906.306558540906, 9810.46042467664, 9862.358946668479, 9922.156616687591, 9940.40357578544, 9940.6520771773, 9861.260405469618, 9884.851727224097, 9891.554880030415, 9910.20718342531, 9912.157466615346, 9722.90277097227, 9778.41329520231, 9798.069183427635, 9800.656977005841, 9803.656872009517, 39670.60329396698, 40022.39966400506, 40365.19269614621, 40466.79766601178, 40600.59399405998, 3191.4414977378865, 3432.7940323580665, 3471.687548120656, 3478.9478157827652, 3593.964060359389, 28940.565891511644, 30508.694913050807, 31338.843305783554, 31564.0, 32440.675593244003, 3133.138466594619, 3188.8883889063773, 3193.5209718542174, 3228.6448490666007, 3292.0, 512912.0, 514636.0, 517739.0, 519975.9999999962, 520873.3956330232, 63518.0, 63708.72582548416, 64454.677726611066, 64698.059058228326, 64750.352496475374, 35302.0, 35440.291194175974, 36057.8197109018, 36791.81604091962, 67834.0, 17194.484165475056, 17230.65538689219, 17356.13219339028, 17362.95822250669, 17405.129743512774, 12696.619101426972, 13053.738925221633, 13088.803667944989, 13142.802857957138, 13160.0, 19833.702494462595, 20010.29963951255, 20062.598748024957, 20103.39689809308, 20119.396418107186, 7257.346838784535, 7306.890396644055, 8032.558209298428, 8384.83230335402, 8401.579921003926, 931.5621657820814, 946.711253067821, 998.8612981201436, 1021.4331046269392, 1028.6296933104227, 28744.850205991945, 30870.69129308723, 30878.22804429907, 31251.906183283478, 31552.0, 939.201678573221, 1044.8171569975225, 1095.4960718069776, 1151.9308841469538, 1164.8602167739925, 13313.534026309033, 15492.0, 15530.611734706723, 15541.145237011846, 15862.0, 673135.0, 680818.5959070172, 681784.0, 686206.0, 689001.0, 58378.0, 58945.705271473365, 59038.70480647569, 59050.704746475996, 59141.704291478265, 1105.8507101541188, 1439.9208043557496, 1440.337444775394, 1444.2489905249422, 1446.1612264886342, 24422.290439669054, 27406.5889011669, 29319.413611728072, 29376.971805986686, 30021.54967675443, 47462.3388181412, 48374.0, 52658.0, 52685.47314526806, 53391.0, 520171.0, 523696.0, 527107.0, 596041.0, 599646.0, 27118.457630847668, 27146.185614430808, 27166.049188278317, 27320.726792731817, 27467.0, 48309.792255193905, 48626.756866215444, 49125.508744913524, 49414.50585494099, 49463.516094517225, 40114.39828402518, 40243.798781005906, 40487.9942659173, 41171.58828411797, 41423.0, 40194.59805401909, 40856.38715419212, 40895.591044089175, 40969.180616388105, 41104.0, 32743.836280818443, 34334.31331373309, 36544.63455365519, 36712.449313259785, 38989.6353627633, 33620.0, 35236.58234424387, 35346.46980295349, 36493.45259821052, 37285.81357093197, 25248.495030099664, 25594.232173034838, 25670.22989310324, 26207.73792262053, 26267.60598591061], "value": 20149.342406947828, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.4730834906084, 381.1500354210113, 383.8445429601012, 399.07215723443005, 408.75883228894963, 18013.459596212102, 19467.902660486696, 21707.565848683018, 21936.45158871027, 22014.44963875902, 20685.586288274226, 20704.48238794031, 21224.151033958624, 21591.46021349467, 21621.783782162172, 5281.86795330116, 5894.968380533411, 6012.098185272201, 6030.6080104793045, 6038.6074905131245, 5814.302283725959, 5947.613405128653, 5956.0, 5999.880002399949, 6010.939890601104, 5792.884142317151, 5850.648961062328, 5895.469407753301, 5979.730912108966, 5979.880402391949, 5832.445917637839, 5861.970690146564, 5932.970335148319, 5955.047192449188, 5989.640621562677, 5106.106431374495, 5197.116490196676, 5221.765020574083, 5222.399424066243, 5236.895262094775, 25977.480450390885, 27036.0, 27047.729522704718, 27364.0, 27448.725512744815, 2317.3974766560814, 2345.777151170636, 2384.8688322142275, 2839.843808590527, 3095.1952492351925, 13152.473901043946, 16071.0, 16215.27031283595, 16296.103714295708, 16359.672806543802, 1832.569346203641, 1875.4467432107424, 1887.7262796894374, 1902.3341830359402, 1902.980970190308, 79123.41753164963, 97561.0, 104170.0, 104632.47683761608, 122314.77685223123, 11591.478383472595, 11767.470463829148, 11789.292642441482, 11820.23168494045, 11923.224990375598, 12046.15676902626, 14122.576322710334, 14427.3507692152, 14558.708825823423, 14561.563153105424, 7960.686486729624, 8748.956255218684, 8800.075992020873, 8803.515806630698, 8933.19601235892, 8174.468659537111, 8850.911490885137, 8865.867011994826, 8872.024077351487, 8986.19124278818, 4607.170709272363, 4640.280756482751, 4640.932585505353, 4646.721196728207, 4646.86059418218, 1956.3739603326799, 1994.0827219478913, 2009.3670493794407, 2038.082862711756, 2045.3761602711018, 747.4207489195917, 819.7868554175957, 866.9306455483546, 1019.6686077024997, 1046.8796088449926, 18264.0, 18654.44036678902, 21736.0, 21873.562528749335, 21892.45268868291, 802.2699343597415, 932.4265576670299, 970.5777986575862, 981.4346117941872, 1049.5644307612408, 11014.0, 11514.36670983104, 11567.595134170264, 11574.189806713617, 11578.247413918069, 555322.0, 575630.0, 579040.0, 581209.0, 582152.0, 115176.0, 116151.0, 125663.37168314283, 132622.0, 139664.0, 927.1377618814432, 991.1525645573075, 994.6220436234184, 1015.3248090020054, 1017.2167431078028, 16061.919690401473, 18453.81546184521, 19106.0, 19356.4193074208, 19359.51601209981, 42135.578644213165, 48280.7585962068, 50924.0, 52589.474105259986, 52895.735521322145, 58881.41118588759, 64174.037389438265, 70678.29321706717, 72907.0, 74198.0, 6729.2934241903895, 7909.485883417559, 8182.304504117216, 8193.71322003727, 8414.0, 12544.24734515932, 12614.747705045664, 12641.2415255085, 12732.363381831057, 12784.105112642026, 11100.444977750918, 11100.889911008835, 11118.388488633203, 11225.943870280596, 11237.887621124011, 9984.750381240237, 10166.135878450119, 10916.563337466412, 11022.338659680445, 11234.269772464764, 11162.162837787037, 11241.38172400493, 11332.830007549728, 11356.716082098013, 11401.600943966921, 7952.801179970547, 8100.351971842357, 8137.918620813716, 8144.75565733029, 8360.163983601591, 10726.785464290826, 10943.124550036136, 10977.615783447542, 11055.391953442639, 11198.38408887519], "value": 9650.19226453881, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1576.0779943732912, 1611.113887361951, 1862.962740745185, 1932.661784187767, 1960.176725775176, 8205.589720513964, 8774.385792994493, 8827.602757875895, 9267.907320926788, 9291.349605527615, 8894.466332020083, 8997.865032024509, 9083.636654533811, 9114.498702571356, 9134.36059475837, 2372.8101751859854, 2395.9520809583796, 2397.7482364351754, 2399.9520009599887, 2412.674288970984, 2362.3739708977137, 2365.656979737937, 2388.426777573379, 2405.494846082325, 2408.397900524869, 2389.450426401929, 2392.6650268962358, 2397.676313697646, 2401.991163711237, 2402.159244264511, 2042.816146546803, 2242.360927135767, 2314.1090680088287, 2367.822413318999, 2387.4270175157926, 2359.2686267257204, 2380.750021247761, 2381.4403615150427, 2381.7141942966955, 2382.6664267002634, 9119.589618467186, 9155.862662060075, 9209.0, 9223.354365194438, 9253.0, 5364.356277246717, 5515.696636684981, 5524.392316845144, 5526.447355264481, 5529.253550770634, 3491.5460990071383, 3619.384704600198, 3648.5804132524568, 3683.355412802749, 3684.9447258291148, 1065.575815020826, 1074.623881641427, 1083.544911137324, 1097.5225776787042, 1100.5872797700863, 10858.782824343469, 11908.702282442922, 11956.521739130425, 11987.82018269718, 12034.217775844541, 4474.373587697725, 4491.0, 4659.370984916993, 4676.0647870426055, 4679.532046795362, 7977.282044616012, 9318.440893546409, 9441.622335106656, 9453.621855125855, 9459.19596834263, 5240.213967904769, 5241.816536421207, 5242.239875218072, 5263.0, 5308.681479111266, 4524.072565124207, 4878.634102442331, 4935.531124543235, 5032.094223039815, 5037.420696619935, 3791.0711875590655, 3839.865604703822, 3898.3957486589625, 3910.882673519799, 3947.5460322062754, 1183.7691650128143, 1196.8922796948316, 1205.1925210109248, 1205.9035277177804, 1211.9212251203644, 837.0708513549955, 904.7376260884402, 916.170865366844, 941.1341565759518, 961.9759506012266, 6103.6032657877095, 6179.104029915637, 6205.100260462208, 6229.875402491924, 6358.33237510064, 435.8169568781056, 448.7957979119493, 460.32562296235506, 469.0852836967926, 471.69575623722505, 3995.260876737813, 4178.91642167155, 4214.4099826024385, 4240.618344349024, 4241.257779888507, 10610.363378197333, 11024.889751102546, 11159.442027898573, 11160.883911608937, 11183.32900026001, 10820.242583019113, 10849.403282819363, 11073.280236784583, 11115.499802508744, 11141.108711303077, 7982.760517184493, 8392.0, 8436.493810371398, 8450.070492245848, 8452.1547845215, 5137.691738495702, 6095.299040610209, 6234.314225435108, 6314.400131987454, 6471.867423200827, 7351.8162045949275, 10426.971232151353, 10433.843492347773, 10563.996420340056, 10575.682729518127, 8862.20240178387, 10381.169506439315, 10412.427316497362, 10485.161187105166, 10523.789524209626, 6658.400743933069, 7166.677499512639, 7567.167611562833, 7692.19231980634, 7867.213278672316, 7520.360769334668, 8601.956990215009, 8650.524221167896, 8701.34739894523, 8791.0, 7622.771316860503, 7800.102988156435, 7837.960810195913, 7887.487313324616, 7906.723264685708, 7607.277308655669, 7610.505317154367, 7666.428382181528, 7751.0, 7782.455228133977, 7204.495685302189, 7281.5631062136445, 7335.706571737071, 7340.449466289942, 7345.0, 4950.282209079735, 5181.844544663666, 5195.19474481456, 5225.555827754683, 5281.075811733008, 5225.477452254744, 5269.78920843162, 5275.80333371621, 5345.786168553214, 5445.863853403696], "value": 4580.495753507633, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.2298319725889, 311.0450915688835, 312.54524666610075, 325.9071164718056, 326.14875175791195, 5532.474414930585, 5699.173619825133, 5748.683822389767, 5856.648601083938, 5872.060470324749, 5012.7493625318675, 5285.682859028461, 5798.985177593925, 5817.331006934204, 5823.883522329551, 3641.4901913732097, 3669.486271921933, 4398.054418300073, 4398.516163222059, 4407.427034485512, 3930.3121953657997, 4081.4694089768436, 4245.23585754564, 4386.758728269944, 4395.670324725643, 3925.862594809182, 4272.572742725733, 4324.805383757738, 4326.43756311679, 4359.847405340814, 4342.804573794187, 4348.369486424466, 4379.934300985487, 4380.67144964129, 4391.758453285068, 3197.4172784471834, 3449.6542351201174, 3660.652238037382, 3776.4901738265257, 3785.848566057354, 5427.945720542783, 5531.502164805187, 5598.500936914428, 5653.378128405872, 5677.943220567783, 3952.6442620164325, 4403.735775853459, 4451.132029254297, 4833.975830120862, 5075.51782580658, 5806.4193580641595, 6103.267607887037, 6118.938810611881, 6121.296050954153, 6129.149945275468, 3864.9613503864884, 4140.730852494578, 4174.7893110997775, 4175.164967006581, 4211.378619231587, 4864.835148358981, 5463.989162005002, 6451.806445806634, 6496.928006878859, 6508.8698226035685, 3469.0, 4149.771762553029, 4231.682623803227, 4236.978815105905, 4238.071677386782, 3230.6769323067506, 4170.895727606834, 4176.540580536139, 4187.958120418818, 4229.809658565372, 4352.69531132824, 4987.775550100254, 4994.725290109079, 5008.574271186917, 5015.022070696179, 5901.76392944286, 6113.296970848321, 6227.19046523949, 6241.0, 6243.938530449835, 1205.5473154848387, 1426.8216472940883, 1436.8491308412674, 1438.6547228665254, 1446.848080951506, 818.5579786914999, 831.4304701279643, 848.6096395657943, 874.6938571499924, 874.9107361335178, 4148.92128046704, 4881.633877459205, 4907.889607468751, 4944.90110197794, 4955.801767929314, 4924.901501969941, 5215.608829337815, 5416.431274716177, 5431.750697339634, 5435.673859568438, 4516.6128857179065, 4765.928511072337, 4923.75381230937, 4927.408710954708, 4947.282644016597, 2484.0, 2545.707243667002, 2673.83956962579, 2731.412746259564, 2874.375977572665, 4998.650094493423, 5073.061483625541, 5494.587905907073, 5578.693171875505, 5594.608232537438, 4972.9254061188385, 5212.429485802238, 5293.030227329503, 5441.700706461183, 5492.395836457987, 4636.165490211727, 4963.354763880672, 5309.123994540934, 5608.158776183605, 5618.39875635442, 4708.529147085401, 5219.562123973398, 5398.757055932414, 5401.758944633189, 5416.674999500043, 4495.752733599684, 4571.519990401093, 4801.4718380977365, 5157.8452646420665, 5364.356277246599, 5276.39321478035, 5557.499825015606, 5566.552696298911, 5613.550915926798, 5666.603337766317, 3991.7405368650943, 4100.34394496879, 4108.4864391951005, 4126.958730412777, 4135.255653982312, 5483.643563168382, 5712.914546236202, 5756.453136951983, 6254.499640028877, 6279.1209230708655, 5241.842744717665, 5698.6580805151825, 5727.964178985145, 5835.008048631658, 6184.5980011299125, 5675.460831221028, 5892.346745018116, 6152.169457123231, 6214.4407003369915, 6251.78118765841, 4943.876403089952, 6063.787767428119, 6097.695115244309, 6112.694365281629, 6115.510759139169, 5391.865203369947, 5573.331200255995, 6165.969170154121, 6174.969125154345, 6181.403810399553, 4958.355413796184, 5884.529237660891, 5891.852703682443, 6085.847853803513, 6097.2988106366565], "value": 4203.506920740256, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.189244261542, 758.5486635451904, 761.090496856257, 811.8498077855596, 844.4046946902434, 14395.640108997268, 15351.923240383783, 15672.138032408213, 15820.76268855968, 15820.841791582081, 14429.422823087063, 14512.637184070403, 14546.927265363685, 14555.272236388191, 14566.053206541568, 502.7109412088064, 889.6797153024905, 902.7743064233941, 925.6898938855492, 937.746808361742, 912.1881525442328, 915.0574907844897, 916.1571354354011, 917.655879045358, 918.5958178401482, 971.2375785008769, 977.7115750853516, 978.1050338939897, 978.2809634918365, 979.1628157924979, 957.3633533700081, 968.6900191938582, 969.7381706939087, 969.8157350103493, 970.2819913264134, 679.7858674517511, 691.8927566227243, 717.4690728860605, 723.609251004457, 724.6594100772628, 14861.628459288497, 14956.0, 14956.925215373854, 14962.62593435162, 15250.466233681878, 14272.429102835875, 14593.854061459355, 14752.323603218922, 14791.334389952477, 14847.851521484756, 11976.221545599596, 12075.93962030193, 12175.33035683037, 12258.26450412978, 12467.625971220878, 3604.0, 3697.556293244828, 3851.786687193553, 3868.9226215475533, 3894.5131858517684, 82174.0, 93830.530847346, 98224.03551928993, 99671.50492742614, 108494.45752771264, 9399.389039712534, 10844.403557804397, 10888.510017049251, 11069.169812264112, 11412.201145919871, 19881.900590496956, 23055.0, 23447.648285275736, 23450.765492344857, 23538.58768473897, 8342.749717508485, 8370.790730231793, 8430.156984301644, 8467.407281490237, 8508.10664880191, 4594.770261486912, 4661.021185551072, 4683.882902927386, 4699.718016918996, 4704.129735998851, 3562.839672214757, 3609.5488063992, 3666.7433279670167, 3672.4307732301536, 3933.704972127102, 689.441552342604, 696.7949417848662, 731.5829976913109, 736.3330613544578, 743.9702411903571, 610.7923306075955, 663.349917081263, 696.4009364707794, 697.2748341724549, 712.6080655639481, 8597.398182127192, 9404.576794044284, 9739.805203895883, 9913.752156196153, 9970.351927124713, 628.5443053785968, 630.0234636313787, 651.4299987510927, 684.1072400517273, 687.295522089862, 4579.025110782884, 4727.834525791581, 4847.854564363075, 4855.684380515255, 4906.877328066756, 85982.0, 118050.0, 156473.2176339134, 162967.0, 171788.0, 147627.26186369214, 150768.0, 153073.0, 155377.0, 155389.0, 126387.73612263944, 128257.0, 128586.71413285748, 131646.99999999808, 132463.3376833129, 7862.567558784322, 9962.950185249027, 10089.798204036026, 10257.897421025993, 10271.486425678835, 49281.75359123181, 57817.0, 60005.39994599998, 60718.392816071275, 61439.692801535704, 48332.27501587409, 67744.32255677578, 77132.22867771475, 90151.54924225337, 97102.5144874271, 13676.794848077088, 13766.31168441594, 13767.931160344135, 13826.170429774245, 14264.144151350538, 15304.693906122038, 15456.072635641898, 15534.456294030108, 15727.05637661744, 15811.342833626117, 14317.928410357881, 14568.781468278195, 14689.485867994568, 15049.77425338599, 15065.849341506444, 14153.929230353782, 14191.0, 14245.64385890361, 14772.48296309624, 14947.0, 13058.281794501394, 14321.498747543787, 14321.57035288943, 14490.927545362205, 14759.262036898326, 11407.885921140682, 11444.771104577696, 11691.181617286707, 11705.88294117082, 11886.940565297118, 9631.71104866855, 9977.60089596408, 10975.560977560808, 11689.649310520697, 11908.345041022827], "value": 8063.807831863132, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 108.0, 112.0, 116.0, 97.0, 137.0, 172.0, 172.0, 122.0], "value": 127.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 111.0, 138.0, 185.0, 140.0, 134.0, 126.0, 109.0, 159.0, 108.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 195.0, 212.0, 257.0, 256.0, 283.0, 218.0, 195.0, 197.0, 195.0], "value": 220.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 89.0, 99.0, 178.0, 49.0, 62.0, 83.0, 88.0, 140.0, 50.0], "value": 90.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 131.0, 70.0, 72.0, 76.0, 114.0, 79.0, 101.0, 147.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 90.0, 88.0, 90.0, 86.0, 91.0, 90.0, 90.0, 86.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 118.0, 149.0, 109.0, 104.0, 128.0, 95.0, 98.0, 95.0, 94.0], "value": 108.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 92.0, 91.0, 91.0, 91.0, 91.0, 92.0, 91.0, 103.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 59.0, 56.0, 55.0, 56.0, 59.0, 58.0, 58.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 70.0, 75.0, 74.0, 77.0, 73.0, 74.0, 71.0, 69.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 86.0, 82.0, 86.0, 82.0, 86.0, 86.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 157.0, 149.0, 136.0, 139.0, 130.0, 161.0, 153.0, 178.0, 158.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 163.0, 164.0, 163.0, 162.0, 163.0, 170.0, 163.0, 165.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 68.0, 65.0, 67.0, 69.0, 86.0, 87.0, 67.0, 67.0], "value": 71.1, "unit": "score"}]}]} 02:55:12 INFO - Return code: 0 02:55:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:55:12 ERROR - # TBPL SUCCESS # 02:55:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:55:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:55:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:55:12 INFO - 2016-07-08 02:55:12.854 screenresolution[2008:13138] starting screenresolution argv=screenresolution get 02:55:12 INFO - 2016-07-08 02:55:12.857 screenresolution[2008:13138] Display 0: 1600x1200x32@60 02:55:12 INFO - 2016-07-08 02:55:12.862 screenresolution[2009:13140] starting screenresolution argv=screenresolution list 02:55:12 INFO - Available Modes on Display 0 02:55:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:55:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:55:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:55:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:55:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:55:13 INFO - Intel Iris: 02:55:13 INFO - Chipset Model: Intel Iris 02:55:13 INFO - Type: GPU 02:55:13 INFO - Bus: Built-In 02:55:13 INFO - VRAM (Dynamic, Max): 1536 MB 02:55:13 INFO - Vendor: Intel (0x8086) 02:55:13 INFO - Device ID: 0x0a2e 02:55:13 INFO - Revision ID: 0x0009 02:55:13 INFO - Displays: 02:55:13 INFO - Display: 02:55:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:55:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:55:13 INFO - Display Serial Number: 1600x1200 60 02:55:13 INFO - Main Display: Yes 02:55:13 INFO - Mirror: Off 02:55:13 INFO - Online: Yes 02:55:13 INFO - Rotation: Supported 02:55:13 INFO - Return code: 0 02:55:13 INFO - Running post-action listener: _resource_record_post_action 02:55:13 INFO - ##### 02:55:13 INFO - ##### Finished run-tests step (success) 02:55:13 INFO - ##### 02:55:13 INFO - Running post-run listener: _resource_record_post_run 02:55:13 INFO - Total resource usage - Wall time: 1207s; CPU: 55.0%; Read bytes: 249856; Write bytes: 706740224; Read time: 6; Write time: 2040 02:55:13 INFO - TinderboxPrint: CPU usage
54.5% 02:55:13 INFO - TinderboxPrint: I/O read bytes / time
249,856 / 6 02:55:13 INFO - TinderboxPrint: I/O write bytes / time
706,740,224 / 2,040 02:55:13 INFO - TinderboxPrint: CPU idle
2,196.6 (45.5%) 02:55:13 INFO - TinderboxPrint: CPU system
978.4 (20.3%) 02:55:13 INFO - TinderboxPrint: CPU user
1,654.8 (34.3%) 02:55:13 INFO - TinderboxPrint: Swap in / out
407,281,664 / 0 02:55:13 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 407845376; Write bytes: 409523712; Read time: 30728; Write time: 748 02:55:13 INFO - run-tests - Wall time: 1173s; CPU: 55.0%; Read bytes: 204800; Write bytes: 295741952; Read time: 5; Write time: 1285 02:55:13 INFO - Running post-run listener: _upload_blobber_files 02:55:13 INFO - Blob upload gear active. 02:55:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:55:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:55:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:55:13 INFO - (blobuploader) - INFO - Open directory for files ... 02:55:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:55:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:55:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:15 INFO - (blobuploader) - INFO - Done attempting. 02:55:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:55:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:55:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:16 INFO - (blobuploader) - INFO - Done attempting. 02:55:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:55:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:55:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:19 INFO - (blobuploader) - INFO - Done attempting. 02:55:19 INFO - (blobuploader) - INFO - Iteration through files over. 02:55:19 INFO - Return code: 0 02:55:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:55:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:55:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b7be2fa251f71196a8182b5270865f90751e6458ef18bd543541c9309abc334754a8295a3b0cd733d9e0dd57b11df3e83013a90c349b289d0d61b193c400555", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fb16699a7961531ec56e5ac1addc766b983c35bffe8ffb17d2848e3e3ed3bd42657f32d644606eaef758d9d86a0680ad001ceee03b52b8b6c096602fa971329", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abd7987fb63045fd9fc4e6d3f59d3dd6b0cfbfe57025e9481f2e625ba6450ebd22dfbf8986c52c3de38fd97b4576b994f24e774bc6b7564b69bc8e968cdcd4ac"} 02:55:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:55:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:55:19 INFO - Contents: 02:55:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b7be2fa251f71196a8182b5270865f90751e6458ef18bd543541c9309abc334754a8295a3b0cd733d9e0dd57b11df3e83013a90c349b289d0d61b193c400555", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fb16699a7961531ec56e5ac1addc766b983c35bffe8ffb17d2848e3e3ed3bd42657f32d644606eaef758d9d86a0680ad001ceee03b52b8b6c096602fa971329", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abd7987fb63045fd9fc4e6d3f59d3dd6b0cfbfe57025e9481f2e625ba6450ebd22dfbf8986c52c3de38fd97b4576b994f24e774bc6b7564b69bc8e968cdcd4ac"} 02:55:19 INFO - Running post-run listener: copy_logs_to_upload_dir 02:55:19 INFO - Copying logs to upload dir... 02:55:19 INFO - mkdir: /builds/slave/test/build/upload/logs 02:55:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.087037 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-08 02:55:19.575535) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 02:55:19.579470) ========= 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.CcS4dlhnXP/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.k3Y6c4UQ6j/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b7be2fa251f71196a8182b5270865f90751e6458ef18bd543541c9309abc334754a8295a3b0cd733d9e0dd57b11df3e83013a90c349b289d0d61b193c400555", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fb16699a7961531ec56e5ac1addc766b983c35bffe8ffb17d2848e3e3ed3bd42657f32d644606eaef758d9d86a0680ad001ceee03b52b8b6c096602fa971329", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abd7987fb63045fd9fc4e6d3f59d3dd6b0cfbfe57025e9481f2e625ba6450ebd22dfbf8986c52c3de38fd97b4576b994f24e774bc6b7564b69bc8e968cdcd4ac"} build_url:https://queue.taskcluster.net/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/RiYx9kWCQSSrhuSy9VKOkA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b7be2fa251f71196a8182b5270865f90751e6458ef18bd543541c9309abc334754a8295a3b0cd733d9e0dd57b11df3e83013a90c349b289d0d61b193c400555", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fb16699a7961531ec56e5ac1addc766b983c35bffe8ffb17d2848e3e3ed3bd42657f32d644606eaef758d9d86a0680ad001ceee03b52b8b6c096602fa971329", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/abd7987fb63045fd9fc4e6d3f59d3dd6b0cfbfe57025e9481f2e625ba6450ebd22dfbf8986c52c3de38fd97b4576b994f24e774bc6b7564b69bc8e968cdcd4ac"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 02:55:19.612035) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 02:55:19.612328) ========= 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.CcS4dlhnXP/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.k3Y6c4UQ6j/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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.005213 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 02:55:19.664793) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 02:55:19.665528) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 02:55:19.666196) ========= ========= Total master_lag: 0.18 =========