builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0127 starttime: 1461145934.43 results: success (0) buildid: 20160420015738 builduid: 04b97639d3d34b7492e51a968cfd8920 revision: 834fed3f42db37b6427d1140a6e32a3cb6af1ed9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 02:52:14.428211) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 02:52:14.428712) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 02:52:14.429013) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 02:52:14.450664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:52:14.451073) ========= 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.2JvIfhNkyC/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.Lce6BYeSun/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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-04-20 02:52:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.4M=0.001s 2016-04-20 02:52:14 (19.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158929 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:52:14.628011) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:52:14.628329) ========= 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.2JvIfhNkyC/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.Lce6BYeSun/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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.025925 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:52:14.677713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 02:52:14.678098) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 834fed3f42db37b6427d1140a6e32a3cb6af1ed9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 834fed3f42db37b6427d1140a6e32a3cb6af1ed9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2JvIfhNkyC/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.Lce6BYeSun/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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-04-20 02:52:14,751 truncating revision to first 12 chars 2016-04-20 02:52:14,751 Setting DEBUG logging. 2016-04-20 02:52:14,751 attempt 1/10 2016-04-20 02:52:14,751 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/834fed3f42db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 02:52:15,936 unpacking tar archive at: mozilla-aurora-834fed3f42db/testing/mozharness/ program finished with exit code 0 elapsedTime=1.433363 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 02:52:16.128536) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 02:52:16.128901) ========= script_repo_revision: 834fed3f42db37b6427d1140a6e32a3cb6af1ed9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 02:52:16.129300) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 02:52:16.129571) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 02:52:16.143351) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-20 02:52:16.143775) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2JvIfhNkyC/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.Lce6BYeSun/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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:52:16 INFO - MultiFileLogger online at 20160420 02:52:16 in /builds/slave/test 02:52:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:52:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:52:16 INFO - {'append_to_log': False, 02:52:16 INFO - 'base_work_dir': '/builds/slave/test', 02:52:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:52:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:52:16 INFO - 'branch': 'Mozilla-Aurora', 02:52:16 INFO - 'buildbot_json_path': 'buildprops.json', 02:52:16 INFO - 'config_files': ('talos/mac_config.py',), 02:52:16 INFO - 'default_actions': ('clobber', 02:52:16 INFO - 'read-buildbot-config', 02:52:16 INFO - 'download-and-extract', 02:52:16 INFO - 'populate-webroot', 02:52:16 INFO - 'create-virtualenv', 02:52:16 INFO - 'install', 02:52:16 INFO - 'run-tests'), 02:52:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:52:16 INFO - 'download_minidump_stackwalk': True, 02:52:16 INFO - 'download_symbols': 'ondemand', 02:52:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:52:16 INFO - 'tooltool.py': '/tools/tooltool.py', 02:52:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:52:16 INFO - '/tools/misc-python/virtualenv.py')}, 02:52:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:52:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:52:16 INFO - 'installer_path': 'installer.exe', 02:52:16 INFO - 'log_level': 'info', 02:52:16 INFO - 'log_name': 'talos', 02:52:16 INFO - 'log_to_console': True, 02:52:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:52:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:52:16 INFO - 'opt_config_files': (), 02:52:16 INFO - 'pip_index': False, 02:52:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:52:16 INFO - 'cmd': ('bash', 02:52:16 INFO - '-c', 02:52:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:52:16 INFO - 'enabled': True, 02:52:16 INFO - 'halt_on_failure': False, 02:52:16 INFO - 'name': 'check_screen_resolution'},), 02:52:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:52:16 INFO - 'cmd': ('bash', 02:52:16 INFO - '-c', 02:52:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:52:16 INFO - 'enabled': True, 02:52:16 INFO - 'halt_on_failure': False, 02:52:16 INFO - 'name': 'check_screen_resolution'},), 02:52:16 INFO - 'run_cmd_checks_enabled': True, 02:52:16 INFO - 'sps_profile': False, 02:52:16 INFO - 'sps_profile_interval': 0, 02:52:16 INFO - 'suite': 'dromaeojs-e10s', 02:52:16 INFO - 'system_bits': '32', 02:52:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:52:16 INFO - 'title': 't-yosemite-r7-0127', 02:52:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:52:16 INFO - 'use_talos_json': True, 02:52:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:52:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:52:16 INFO - 'work_dir': 'build'} 02:52:16 INFO - ##### 02:52:16 INFO - ##### Running clobber step. 02:52:16 INFO - ##### 02:52:16 INFO - Running pre-action listener: _resource_record_pre_action 02:52:16 INFO - Running main action method: clobber 02:52:16 INFO - rmtree: /builds/slave/test/build 02:52:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:52:17 INFO - Running post-action listener: _resource_record_post_action 02:52:17 INFO - ##### 02:52:17 INFO - ##### Running read-buildbot-config step. 02:52:17 INFO - ##### 02:52:17 INFO - Running pre-action listener: _resource_record_pre_action 02:52:17 INFO - Running main action method: read_buildbot_config 02:52:17 INFO - Using buildbot properties: 02:52:17 INFO - { 02:52:17 INFO - "project": "", 02:52:17 INFO - "product": "firefox", 02:52:17 INFO - "script_repo_revision": "production", 02:52:17 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:52:17 INFO - "repository": "", 02:52:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:52:17 INFO - "buildid": "20160420015738", 02:52:17 INFO - "pgo_build": "False", 02:52:17 INFO - "basedir": "/builds/slave/test", 02:52:17 INFO - "buildnumber": 286, 02:52:17 INFO - "slavename": "t-yosemite-r7-0127", 02:52:17 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:52:17 INFO - "platform": "yosemite_r7", 02:52:17 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:52:17 INFO - "branch": "mozilla-aurora", 02:52:17 INFO - "repo_path": "releases/mozilla-aurora", 02:52:17 INFO - "revision": "834fed3f42db37b6427d1140a6e32a3cb6af1ed9", 02:52:17 INFO - "stage_platform": "macosx64", 02:52:17 INFO - "builduid": "04b97639d3d34b7492e51a968cfd8920", 02:52:17 INFO - "slavebuilddir": "test" 02:52:17 INFO - } 02:52:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 02:52:17 INFO - Running post-action listener: _resource_record_post_action 02:52:17 INFO - ##### 02:52:17 INFO - ##### Running download-and-extract step. 02:52:17 INFO - ##### 02:52:17 INFO - Running pre-action listener: _resource_record_pre_action 02:52:17 INFO - Running main action method: download_and_extract 02:52:17 INFO - mkdir: /builds/slave/test/build/tests 02:52:17 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:52:17 INFO - https://queue.taskcluster.net/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:52:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:52:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 02:52:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:52:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 02:52:19 INFO - Downloaded 1277 bytes. 02:52:19 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 02:52:19 INFO - Using the following test package requirements: 02:52:19 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:52:19 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:19 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 02:52:19 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:19 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 02:52:19 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:19 INFO - u'jsshell-mac.zip'], 02:52:19 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:19 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 02:52:19 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:52:19 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:19 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 02:52:19 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:19 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 02:52:19 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:19 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 02:52:19 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 02:52:19 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 02:52:19 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 02:52:19 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:52: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:52:19 INFO - https://queue.taskcluster.net/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:52:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:52:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:52:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:52:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:52:20 INFO - Downloaded 17911881 bytes. 02:52:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:52:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:52:23 INFO - Return code: 0 02:52:23 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:52:23 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:52:23 INFO - https://queue.taskcluster.net/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:52:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:52:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:52:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 02:52:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:52:24 INFO - Downloaded 17911881 bytes. 02:52:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:52:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:52:28 INFO - Return code: 0 02:52:28 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:52:28 INFO - https://queue.taskcluster.net/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:52:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:52:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:52:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 02:52:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:52:29 INFO - Downloaded 10845168 bytes. 02:52:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:52:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:52:29 INFO - Return code: 0 02:52: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:52:29 INFO - https://queue.taskcluster.net/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 02:52:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:52:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:52:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 02:52:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 02:52:32 INFO - Downloaded 115252068 bytes. 02:52:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:52:32 INFO - mkdir: /builds/slave/test/properties 02:52:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:52:32 INFO - Writing to file /builds/slave/test/properties/build_url 02:52:32 INFO - Contents: 02:52:32 INFO - build_url:https://queue.taskcluster.net/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 02:52:33 INFO - Running post-action listener: _resource_record_post_action 02:52:33 INFO - Running post-action listener: set_extra_try_arguments 02:52:33 INFO - ##### 02:52:33 INFO - ##### Running populate-webroot step. 02:52:33 INFO - ##### 02:52:33 INFO - Running pre-action listener: _resource_record_pre_action 02:52:33 INFO - Running main action method: populate_webroot 02:52:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:52:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:52:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:52:33 INFO - '--tppagecycles', 02:52:33 INFO - '7'], 02:52:33 INFO - 'tests': ['tsvgm']}}, 02:52:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:52:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:52:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:52:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:52:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:52:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:52:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'talos_options': ['--e10s'], 02:52:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'tests': ['damp', 'tps']}, 02:52:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'talos_options': ['--e10s'], 02:52:33 INFO - 'tests': ['damp', 'tps']}, 02:52:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:52:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:52:33 INFO - 'other': {'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:52:33 INFO - 'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:52:33 INFO - 'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:52:33 INFO - 'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'other_l64': {'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'other_nol64': {'tests': ['a11yr', 02:52:33 INFO - 'ts_paint', 02:52:33 INFO - 'tpaint', 02:52:33 INFO - 'sessionrestore', 02:52:33 INFO - 'sessionrestore_no_auto_restore', 02:52:33 INFO - 'tabpaint']}, 02:52:33 INFO - 'svgr': {'tests': ['tsvgx', 02:52:33 INFO - 'tsvgr_opacity', 02:52:33 INFO - 'tart', 02:52:33 INFO - 'tscrollx', 02:52:33 INFO - 'cart']}, 02:52:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:52:33 INFO - 'tests': ['tsvgx', 02:52:33 INFO - 'tsvgr_opacity', 02:52:33 INFO - 'tart', 02:52:33 INFO - 'tscrollx', 02:52:33 INFO - 'cart']}, 02:52:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'tests': ['tp5o']}, 02:52:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'talos_options': ['--e10s'], 02:52:33 INFO - 'tests': ['tp5o']}, 02:52:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'talos_options': ['--xperf_path', 02:52:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:33 INFO - 'tests': ['tp5n']}, 02:52:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:33 INFO - 'talos_options': ['--e10s', 02:52:33 INFO - '--xperf_path', 02:52:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:33 INFO - 'tests': ['tp5n']}}, 02:52:33 INFO - 'talos.zip': {'path': '', 02:52:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:52:33 INFO - Running post-action listener: _resource_record_post_action 02:52:33 INFO - ##### 02:52:33 INFO - ##### Running create-virtualenv step. 02:52:33 INFO - ##### 02:52:33 INFO - Running pre-action listener: _resource_record_pre_action 02:52:33 INFO - Running main action method: create_virtualenv 02:52:33 INFO - Creating virtualenv /builds/slave/test/build/venv 02:52:33 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:52:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:52:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:52:33 INFO - Using real prefix '/tools/python27' 02:52:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:52:34 INFO - Installing distribute.............................................................................................................................................................................................done. 02:52:37 INFO - Installing pip.................done. 02:52:37 INFO - Return code: 0 02:52:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:52:37 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:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:37 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:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:37 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 0x10e267a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5bd59f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bd30>, '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 0x10df6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e102b20>, '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.2JvIfhNkyC/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.Lce6BYeSun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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:52:37 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:52:37 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:52:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JvIfhNkyC/Render', 02:52:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:37 INFO - 'HOME': '/Users/cltbld', 02:52:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:37 INFO - 'LOGNAME': 'cltbld', 02:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:37 INFO - 'MOZ_NO_REMOTE': '1', 02:52:37 INFO - 'NO_EM_RESTART': '1', 02:52:37 INFO - 'PAGER': '/bin/cat', 02:52:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:37 INFO - 'PWD': '/builds/slave/test', 02:52:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:37 INFO - 'SHELL': '/bin/bash', 02:52:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lce6BYeSun/Listeners', 02:52:37 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:52:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:37 INFO - 'USER': 'cltbld', 02:52:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:37 INFO - 'XPC_FLAGS': '0x0', 02:52:37 INFO - 'XPC_SERVICE_NAME': '0', 02:52:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:37 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:52:37 INFO - Cleaning up... 02:52:37 INFO - Return code: 0 02:52:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:52:37 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:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:37 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:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:37 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e267a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5bd59f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bd30>, '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 0x10df6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e102b20>, '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.2JvIfhNkyC/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.Lce6BYeSun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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:52:37 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>=0.7.1'] in /builds/slave/test/build 02:52:37 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>=0.7.1 02:52:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JvIfhNkyC/Render', 02:52:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:37 INFO - 'HOME': '/Users/cltbld', 02:52:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:37 INFO - 'LOGNAME': 'cltbld', 02:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:37 INFO - 'MOZ_NO_REMOTE': '1', 02:52:37 INFO - 'NO_EM_RESTART': '1', 02:52:37 INFO - 'PAGER': '/bin/cat', 02:52:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:37 INFO - 'PWD': '/builds/slave/test', 02:52:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:37 INFO - 'SHELL': '/bin/bash', 02:52:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lce6BYeSun/Listeners', 02:52:37 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:52:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:37 INFO - 'USER': 'cltbld', 02:52:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:37 INFO - 'XPC_FLAGS': '0x0', 02:52:37 INFO - 'XPC_SERVICE_NAME': '0', 02:52:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:38 INFO - Downloading/unpacking psutil>=0.7.1 02:52:38 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:52:38 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:52:38 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:52:38 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:52:38 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:52:38 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:52:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:52:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:40 INFO - Installing collected packages: psutil 02:52:40 INFO - Running setup.py install for psutil 02:52:40 INFO - building 'psutil._psutil_osx' extension 02:52:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:52:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:52:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:52:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:52:41 INFO - building 'psutil._psutil_posix' extension 02:52:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:52:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:52:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:52:41 INFO - ^ 02:52:41 INFO - 1 warning generated. 02:52:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:52:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:41 INFO - Successfully installed psutil 02:52:41 INFO - Cleaning up... 02:52:42 INFO - Return code: 0 02:52:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:42 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e267a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5bd59f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bd30>, '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 0x10df6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e102b20>, '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.2JvIfhNkyC/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.Lce6BYeSun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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:52:42 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.0.0'] in /builds/slave/test/build 02:52:42 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.0.0 02:52:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JvIfhNkyC/Render', 02:52:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:42 INFO - 'HOME': '/Users/cltbld', 02:52:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:42 INFO - 'LOGNAME': 'cltbld', 02:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:42 INFO - 'MOZ_NO_REMOTE': '1', 02:52:42 INFO - 'NO_EM_RESTART': '1', 02:52:42 INFO - 'PAGER': '/bin/cat', 02:52:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:42 INFO - 'PWD': '/builds/slave/test', 02:52:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:42 INFO - 'SHELL': '/bin/bash', 02:52:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lce6BYeSun/Listeners', 02:52:42 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:52:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:42 INFO - 'USER': 'cltbld', 02:52:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:42 INFO - 'XPC_FLAGS': '0x0', 02:52:42 INFO - 'XPC_SERVICE_NAME': '0', 02:52:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:52:42 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:52:42 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:52:42 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:52:42 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:52:42 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:52:42 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:52:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:52:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:52:44 INFO - Installing collected packages: mozsystemmonitor 02:52:44 INFO - Running setup.py install for mozsystemmonitor 02:52:44 INFO - Successfully installed mozsystemmonitor 02:52:44 INFO - Cleaning up... 02:52:44 INFO - Return code: 0 02:52:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e267a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5bd59f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bd30>, '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 0x10df6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e102b20>, '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.2JvIfhNkyC/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.Lce6BYeSun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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:52:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:52:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JvIfhNkyC/Render', 02:52:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:44 INFO - 'HOME': '/Users/cltbld', 02:52:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:44 INFO - 'LOGNAME': 'cltbld', 02:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:44 INFO - 'MOZ_NO_REMOTE': '1', 02:52:44 INFO - 'NO_EM_RESTART': '1', 02:52:44 INFO - 'PAGER': '/bin/cat', 02:52:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:44 INFO - 'PWD': '/builds/slave/test', 02:52:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:44 INFO - 'SHELL': '/bin/bash', 02:52:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lce6BYeSun/Listeners', 02:52:44 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:52:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:44 INFO - 'USER': 'cltbld', 02:52:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:44 INFO - 'XPC_FLAGS': '0x0', 02:52:44 INFO - 'XPC_SERVICE_NAME': '0', 02:52:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:45 INFO - Downloading/unpacking blobuploader==1.2.4 02:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:47 INFO - Downloading blobuploader-1.2.4.tar.gz 02:52:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:52:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:52: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:52: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:52: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:52: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:52: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:52: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:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:52:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:48 INFO - Downloading docopt-0.6.1.tar.gz 02:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:52:48 INFO - Installing collected packages: blobuploader, requests, docopt 02:52:48 INFO - Running setup.py install for blobuploader 02:52:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:52:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:52:49 INFO - Running setup.py install for requests 02:52:49 INFO - Running setup.py install for docopt 02:52:49 INFO - Successfully installed blobuploader requests docopt 02:52:49 INFO - Cleaning up... 02:52:49 INFO - Return code: 0 02:52:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:49 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:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:49 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:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:49 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 0x10e267a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5bd59f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bd30>, '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 0x10df6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e102b20>, '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.2JvIfhNkyC/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.Lce6BYeSun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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:52:49 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:52:49 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:52:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JvIfhNkyC/Render', 02:52:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:49 INFO - 'HOME': '/Users/cltbld', 02:52:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:49 INFO - 'LOGNAME': 'cltbld', 02:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:49 INFO - 'MOZ_NO_REMOTE': '1', 02:52:49 INFO - 'NO_EM_RESTART': '1', 02:52:49 INFO - 'PAGER': '/bin/cat', 02:52:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:49 INFO - 'PWD': '/builds/slave/test', 02:52:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:49 INFO - 'SHELL': '/bin/bash', 02:52:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lce6BYeSun/Listeners', 02:52:49 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:52:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:49 INFO - 'USER': 'cltbld', 02:52:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:49 INFO - 'XPC_FLAGS': '0x0', 02:52:49 INFO - 'XPC_SERVICE_NAME': '0', 02:52:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-f4kapn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-XkFkCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-jPmv1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-hXFszm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-5ftapd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-mDexTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-j1AFBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-PbUJab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-xEj7Qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:50 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-3zE99d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:51 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-ThhL01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:51 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-JQPjQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:51 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-2lKTUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:51 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-mf9n4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:51 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-JluCbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:51 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-T4Ps7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:51 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-ewtnZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:52:51 INFO - Running setup.py install for manifestparser 02:52:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:52:51 INFO - Running setup.py install for mozcrash 02:52:52 INFO - Running setup.py install for mozdebug 02:52:52 INFO - Running setup.py install for mozdevice 02:52:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Running setup.py install for mozfile 02:52:52 INFO - Running setup.py install for mozhttpd 02:52:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Running setup.py install for mozinfo 02:52:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Running setup.py install for mozInstall 02:52:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:52:52 INFO - Running setup.py install for mozleak 02:52:53 INFO - Running setup.py install for mozlog 02:52:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:52:53 INFO - Running setup.py install for moznetwork 02:52:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:52:53 INFO - Running setup.py install for mozprocess 02:52:53 INFO - Running setup.py install for mozprofile 02:52:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:52:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:52:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:52:53 INFO - Running setup.py install for mozrunner 02:52:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:52:53 INFO - Running setup.py install for mozscreenshot 02:52:54 INFO - Running setup.py install for moztest 02:52:54 INFO - Running setup.py install for mozversion 02:52:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:52:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:52:54 INFO - Cleaning up... 02:52:54 INFO - Return code: 0 02:52:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52: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:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:54 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 0x10e267a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5bd59f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bd30>, '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 0x10df6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e102b20>, '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.2JvIfhNkyC/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.Lce6BYeSun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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:52:54 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:52:54 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:52:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JvIfhNkyC/Render', 02:52:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:54 INFO - 'HOME': '/Users/cltbld', 02:52:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:54 INFO - 'LOGNAME': 'cltbld', 02:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:54 INFO - 'MOZ_NO_REMOTE': '1', 02:52:54 INFO - 'NO_EM_RESTART': '1', 02:52:54 INFO - 'PAGER': '/bin/cat', 02:52:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:54 INFO - 'PWD': '/builds/slave/test', 02:52:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:54 INFO - 'SHELL': '/bin/bash', 02:52:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lce6BYeSun/Listeners', 02:52:54 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:52:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:54 INFO - 'USER': 'cltbld', 02:52:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:54 INFO - 'XPC_FLAGS': '0x0', 02:52:54 INFO - 'XPC_SERVICE_NAME': '0', 02:52:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:54 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-R7UCV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:54 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:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:54 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-id33EM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:54 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:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:54 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-FEcGT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:54 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:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:54 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-Phs6G2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:55 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:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:55 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-QOWLRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:55 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:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:55 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-qbPzJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:55 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:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:55 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-CpGsQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:55 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:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:55 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-JEOUDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:55 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:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:55 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-ISsoe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:55 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:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:55 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-1iUVIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:55 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-WTWRVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:55 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:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:55 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-heYTEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:55 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-2c8SSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:56 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:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:56 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-uQVC5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:56 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-fQgC61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:56 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:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:56 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-ozeLDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:56 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:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:56 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-t7wTRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:56 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:52:56 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:52:56 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:52:56 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:52:56 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:52:56 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:52:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:52:56 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:52:56 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:52:56 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:52:56 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:52:56 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:52:56 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:52:58 INFO - Downloading blessings-1.6.tar.gz 02:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:52:59 INFO - Installing collected packages: blessings 02:52:59 INFO - Running setup.py install for blessings 02:52:59 INFO - Successfully installed blessings 02:52:59 INFO - Cleaning up... 02:52:59 INFO - Return code: 0 02:52:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:52:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:59 INFO - Reading from file tmpfile_stdout 02:52:59 INFO - Current package versions: 02:52:59 INFO - blessings == 1.6 02:52:59 INFO - blobuploader == 1.2.4 02:52:59 INFO - docopt == 0.6.1 02:52:59 INFO - manifestparser == 1.1 02:52:59 INFO - mozInstall == 1.12 02:52:59 INFO - mozcrash == 0.17 02:52:59 INFO - mozdebug == 0.1 02:52:59 INFO - mozdevice == 0.48 02:52:59 INFO - mozfile == 1.2 02:52:59 INFO - mozhttpd == 0.7 02:52:59 INFO - mozinfo == 0.9 02:52:59 INFO - mozleak == 0.1 02:52:59 INFO - mozlog == 3.1 02:52:59 INFO - moznetwork == 0.27 02:52:59 INFO - mozprocess == 0.22 02:52:59 INFO - mozprofile == 0.28 02:52:59 INFO - mozrunner == 6.11 02:52:59 INFO - mozscreenshot == 0.1 02:52:59 INFO - mozsystemmonitor == 0.0 02:52:59 INFO - moztest == 0.7 02:52:59 INFO - mozversion == 1.4 02:52:59 INFO - psutil == 3.1.1 02:52:59 INFO - requests == 1.2.3 02:52:59 INFO - wsgiref == 0.1.2 02:52:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52: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:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:59 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 0x10e267a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5bd59f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bd30>, '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 0x10df6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e102b20>, '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.2JvIfhNkyC/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.Lce6BYeSun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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:52:59 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:52:59 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:52:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JvIfhNkyC/Render', 02:52:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:59 INFO - 'HOME': '/Users/cltbld', 02:52:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:59 INFO - 'LOGNAME': 'cltbld', 02:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:59 INFO - 'MOZ_NO_REMOTE': '1', 02:52:59 INFO - 'NO_EM_RESTART': '1', 02:52:59 INFO - 'PAGER': '/bin/cat', 02:52:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:59 INFO - 'PWD': '/builds/slave/test', 02:52:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:59 INFO - 'SHELL': '/bin/bash', 02:52:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lce6BYeSun/Listeners', 02:52:59 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:52:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:59 INFO - 'USER': 'cltbld', 02:52:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:59 INFO - 'XPC_FLAGS': '0x0', 02:52:59 INFO - 'XPC_SERVICE_NAME': '0', 02:52:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:59 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:52:59 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:52:59 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:52:59 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:52:59 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:52:59 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:52:59 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:52:59 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:52:59 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:52:59 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:52:59 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:52:59 INFO - Cleaning up... 02:52:59 INFO - Return code: 0 02:52:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:52: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:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52: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:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:52:59 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 0x10e267a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5bd59f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bd30>, '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 0x10df6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e102b20>, '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.2JvIfhNkyC/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.Lce6BYeSun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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:52:59 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:52:59 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:52:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JvIfhNkyC/Render', 02:52:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:52:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:52:59 INFO - 'HOME': '/Users/cltbld', 02:52:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:52:59 INFO - 'LOGNAME': 'cltbld', 02:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:59 INFO - 'MOZ_NO_REMOTE': '1', 02:52:59 INFO - 'NO_EM_RESTART': '1', 02:52:59 INFO - 'PAGER': '/bin/cat', 02:52:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:59 INFO - 'PWD': '/builds/slave/test', 02:52:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:52:59 INFO - 'SHELL': '/bin/bash', 02:52:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lce6BYeSun/Listeners', 02:52:59 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:52:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:52:59 INFO - 'USER': 'cltbld', 02:52:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:52:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:59 INFO - 'XPC_FLAGS': '0x0', 02:52:59 INFO - 'XPC_SERVICE_NAME': '0', 02:52:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:00 INFO - Downloading/unpacking jsonschema 02:53:00 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:53:00 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:53:00 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:53:00 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:53:00 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:53:00 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:53:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:53:02 INFO - Downloading/unpacking functools32 (from jsonschema) 02:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:02 INFO - Downloading functools32-3.2.3-2.tar.gz 02:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:53:03 INFO - warning: no files found matching '*.txt' 02:53:03 INFO - no previously-included directories found matching 'build' 02:53:03 INFO - no previously-included directories found matching 'dist' 02:53:03 INFO - no previously-included directories found matching '.git*' 02:53:03 INFO - Installing collected packages: jsonschema, functools32 02:53:03 INFO - Running setup.py install for functools32 02:53:03 INFO - warning: no files found matching '*.txt' 02:53:03 INFO - no previously-included directories found matching 'build' 02:53:03 INFO - no previously-included directories found matching 'dist' 02:53:03 INFO - no previously-included directories found matching '.git*' 02:53:03 INFO - Successfully installed jsonschema functools32 02:53:03 INFO - Cleaning up... 02:53:03 INFO - Return code: 0 02:53:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e267a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f5bd59f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bd30>, '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 0x10df6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e102b20>, '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.2JvIfhNkyC/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.Lce6BYeSun/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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:53:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:53:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:53:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JvIfhNkyC/Render', 02:53:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:03 INFO - 'HOME': '/Users/cltbld', 02:53:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:03 INFO - 'LOGNAME': 'cltbld', 02:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:03 INFO - 'MOZ_NO_REMOTE': '1', 02:53:03 INFO - 'NO_EM_RESTART': '1', 02:53:03 INFO - 'PAGER': '/bin/cat', 02:53:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:03 INFO - 'PWD': '/builds/slave/test', 02:53:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:03 INFO - 'SHELL': '/bin/bash', 02:53:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lce6BYeSun/Listeners', 02:53:03 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:53:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:03 INFO - 'USER': 'cltbld', 02:53:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:03 INFO - 'XPC_FLAGS': '0x0', 02:53:03 INFO - 'XPC_SERVICE_NAME': '0', 02:53:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:03 INFO - Downloading/unpacking flake8 02:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:53:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:53:05 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:53:05 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:53:05 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:53:05 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:53:05 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:53:05 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:53:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:53:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:53:06 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:53:06 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:53:06 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:53:06 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:53:06 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:53:06 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:53:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:53:06 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:53:06 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:53:06 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:53:06 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:53:06 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:53:06 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:53:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:53:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:53:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:53:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:53:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:53:07 INFO - no previously-included directories found matching 'docs/_build' 02:53:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:53:07 INFO - Running setup.py install for pep8 02:53:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:53:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:53:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:53:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:53:07 INFO - no previously-included directories found matching 'docs/_build' 02:53:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:53:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:53:07 INFO - Cleaning up... 02:53:07 INFO - Return code: 0 02:53:07 INFO - Running post-action listener: _resource_record_post_action 02:53:07 INFO - Running post-action listener: _start_resource_monitoring 02:53:07 INFO - Starting resource monitoring. 02:53:07 INFO - ##### 02:53:07 INFO - ##### Running install step. 02:53:07 INFO - ##### 02:53:07 INFO - Running pre-action listener: _resource_record_pre_action 02:53:07 INFO - Running main action method: install 02:53:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:08 INFO - Reading from file tmpfile_stdout 02:53:08 INFO - Detecting whether we're running mozinstall >=1.0... 02:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:53:08 INFO - Reading from file tmpfile_stdout 02:53:08 INFO - Output received: 02:53:08 INFO - Usage: mozinstall [options] installer 02:53:08 INFO - Options: 02:53:08 INFO - -h, --help show this help message and exit 02:53:08 INFO - -d DEST, --destination=DEST 02:53:08 INFO - Directory to install application into. [default: 02:53:08 INFO - "/builds/slave/test"] 02:53:08 INFO - --app=APP Application being installed. [default: firefox] 02:53:08 INFO - mkdir: /builds/slave/test/build/application 02:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:53:39 INFO - Reading from file tmpfile_stdout 02:53:39 INFO - Output received: 02:53:39 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:53:39 INFO - Running post-action listener: _resource_record_post_action 02:53:39 INFO - ##### 02:53:39 INFO - ##### Running run-tests step. 02:53:39 INFO - ##### 02:53:39 INFO - Running pre-action listener: _resource_record_pre_action 02:53:39 INFO - Running main action method: run_tests 02:53:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:53:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:53:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:53:39 INFO - 2016-04-20 02:53:39.724 screenresolution[1638:7312] starting screenresolution argv=screenresolution get 02:53:39 INFO - 2016-04-20 02:53:39.726 screenresolution[1638:7312] Display 0: 1600x1200x32@60 02:53:39 INFO - 2016-04-20 02:53:39.732 screenresolution[1639:7315] starting screenresolution argv=screenresolution list 02:53:39 INFO - Available Modes on Display 0 02:53:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:53:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:53:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:53:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:53:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:53:39 INFO - Intel Iris: 02:53:39 INFO - Chipset Model: Intel Iris 02:53:39 INFO - Type: GPU 02:53:39 INFO - Bus: Built-In 02:53:39 INFO - VRAM (Dynamic, Max): 1536 MB 02:53:39 INFO - Vendor: Intel (0x8086) 02:53:39 INFO - Device ID: 0x0a2e 02:53:39 INFO - Revision ID: 0x0009 02:53:39 INFO - Displays: 02:53:39 INFO - Display: 02:53:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:53:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:53:39 INFO - Display Serial Number: 1600x1200 60 02:53:39 INFO - Main Display: Yes 02:53:39 INFO - Mirror: Off 02:53:39 INFO - Online: Yes 02:53:39 INFO - Rotation: Supported 02:53:39 INFO - Return code: 0 02:53:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:53:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:53:39 INFO - Python 2.7.3 02:53:39 INFO - Return code: 0 02:53:39 INFO - grabbing minidump binary from tooltool 02:53: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:53:39 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e10bd30>, '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 0x10df6fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e102b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:53:39 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:53:39 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:53:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:53:40 INFO - Return code: 0 02:53:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:53:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:53:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:53:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:53:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:53:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:53:41 INFO - Return code: 0 02:53:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0127', '--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:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0127 --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:53:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JvIfhNkyC/Render', 02:53:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:41 INFO - 'HOME': '/Users/cltbld', 02:53:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:41 INFO - 'LOGNAME': 'cltbld', 02:53:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:53:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:41 INFO - 'MOZ_NO_REMOTE': '1', 02:53:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:53:41 INFO - 'NO_EM_RESTART': '1', 02:53:41 INFO - 'PAGER': '/bin/cat', 02:53:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:41 INFO - 'PWD': '/builds/slave/test', 02:53:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:53:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:41 INFO - 'SHELL': '/bin/bash', 02:53:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lce6BYeSun/Listeners', 02:53:41 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 02:53:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:41 INFO - 'USER': 'cltbld', 02:53:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:41 INFO - 'XPC_FLAGS': '0x0', 02:53:41 INFO - 'XPC_SERVICE_NAME': '0', 02:53:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0127', '--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:53:41 INFO - mozversion application_buildid: 20160420015738 02:53:41 INFO - mozversion application_changeset: 834fed3f42db37b6427d1140a6e32a3cb6af1ed9 02:53:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:53:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:53:41 INFO - mozversion application_name: Firefox 02:53:41 INFO - mozversion application_remotingname: firefox-dev 02:53:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:53:41 INFO - mozversion application_vendor: Mozilla 02:53:41 INFO - mozversion application_version: 47.0a2 02:53:41 INFO - mozversion platform_buildid: 20160420015738 02:53:41 INFO - mozversion platform_changeset: 834fed3f42db37b6427d1140a6e32a3cb6af1ed9 02:53:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:53:41 INFO - mozversion platform_version: 47.0a2 02:53:41 INFO - using testdate: 1461146021 02:53:41 INFO - actual date: 1461146021 02:53:41 INFO - starting webserver on 'localhost:49275' 02:53:41 INFO - SUITE-START | Running 2 tests 02:53:41 INFO - TEST-START | dromaeo_css 02:53:41 INFO - operating with platform_type : mac_ 02:53:41 INFO - Initialising browser for dromaeo_css test... 02:53:41 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpiQP3UM/profile http://localhost:49275/getInfo.html) 02:53:44 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 02:53:44 INFO - PROCESS | 1657 | colorDepth:24 02:53:44 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 02:53:44 INFO - PROCESS | 1657 | __metrics 02:53:44 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 02:53:45 INFO - TEST-INFO | 1657: exit 0 02:53:45 INFO - Browser initialized. 02:53:45 INFO - Running cycle 1/1 for dromaeo_css test... 02:53:45 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpiQP3UM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:53:57 INFO - PROCESS | 1660 | RSS: Main: 217608192 02:53:57 INFO - PROCESS | 1660 | 02:54:46 INFO - PROCESS | 1660 | 1461146086765 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:56:57 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 02:56:58 INFO - PROCESS | 1660 | RSS: Main: 228241408 02:56:58 INFO - PROCESS | 1660 | 03:00:00 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 03:00:01 INFO - PROCESS | 1660 | RSS: Main: 239824896 03:00:01 INFO - PROCESS | 1660 | 03:03:02 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 03:03:03 INFO - PROCESS | 1660 | RSS: Main: 242683904 03:03:03 INFO - PROCESS | 1660 | 03:06:04 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 03:06:05 INFO - PROCESS | 1660 | RSS: Main: 243556352 03:06:05 INFO - PROCESS | 1660 | 03:09:08 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 03:09:08 INFO - PROCESS | 1660 | RSS: Main: 246358016 03:09:08 INFO - PROCESS | 1660 | 03:12:10 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 03:12:11 INFO - PROCESS | 1660 | RSS: Main: 247664640 03:12:11 INFO - PROCESS | 1660 | 03:12:11 INFO - PROCESS | 1660 | __start_tp_report 03:12:11 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 03:12:11 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 03:12:11 INFO - PROCESS | 1660 | |i|pagename|runs| 03:12:11 INFO - PROCESS | 1660 | |0;dojo.html;3364.764466487346;3423.914402139946;3544.6455354464542;3582.014945889878;3601.9099522511933;4720.622350211984;5771.336296325924;5796.594238403313;5832.241808564881;5835.824925252244;5760.654360738348;5800.15897694834;5819.9418005819925;5837.387074357195;5839.883202335951;5220.451852555484;5266.5786737061135;5266.947330526703;5288.603354748409;5306.973465132688;5193.16909294513;5299.205119232127;5307.495787900143;5337.172738225562;5340.91988620171;4368.672349573779;5258.763355649005;5295.549878260353;5295.708736019517;5373.167159090347;4963.975180124113;4982.302477653131;5320.228566857803;5365.7853685852515;5406.83779486616;5096;5136.101182293084;5301.734913254322;5303.549198318147;5309.601779866487;5693.629914055573;5723.713814309268;5803.332616749086;5810.651360918316;5832.533397328203;6145.9692701536205;6166.414190651881;6170.7531698732;6196.132541444202;6198.876022479525;4800.423949126127;5653.57598180134;6113.962834745944;6237.750489980395;6239.65681887496;5971.910421343683;5978.850528736816;5987.161797348331;6017.789377371771;6080.787172448943;6315.021171718391;6334.936650633527;6351.491880649537;6353.5234857385885;6358.8410289742205;6105.854009884935;6167.506599472032;6243.125962365272;6308.369163083655;6309;5701.344345400249;5998.610090344114;6282.874342513215;6302.464290535264;6318;6269.8746025079245;6283.214598175228;6284.5600807943;6340.524460665469;6367.044943258548;5367.946320536745;6164.630122192682;6323.36766323364;6335.651539165298;6343.397377249154;4969.751512424365;4978.950210497848;4980.153373926441;4988.276699878497;5026.447090820006;4434.201843668106;4494.1461122386645;4532.660050496226;4552.521985191574;4562.384078149407;4721.4570324413135;4878.780454879539;5790.71046447676;5916.73374698131;5961.433663801932;6284.4344009039405;6307.432331090224;6323.051542268697;6327.905081423783;6331.303556608769;5729.226554415184;5918.032705179888;5924.229850119457;5942.10868369748;5969.582129250911;5386.245925570423;5445.455454454602;5445.673259604437;5483.506484416422;5502.449755024546;6332.303446620868;6369.299377068612;6377.840553986188;6386.361363863576;6387.169667943138;6175.876482470415;6238.220222472191;6336.904946425715;6359.3640635936035;6360.650164241011;6320.146780184617;6372.713227904663;6380.074889141141;6381.553291269566;6387.329330420424;4914.70511769295;5162.328897243335;6332.778352757631;6333.841653958688;6337.334579869047;4700.741459219776;5146.125158722951;5763.423657634371;6295.5907865988565;6336.968315158395;5439.5920305976415;6216.595921265103;6226.719797609209;6271.3415091414745;6281.780137695158;5533.6403133796175;6141.201643786279;6175.2589689237575;6240.937590624218;6260.874782504234;4854.80580776765;5848.298204215522;5899.46904778572;5921.585489015728;5993.940060599512;5094.414142373675;6194.442500175006;6261.279952805486;6271.404216599416;6273.937260627518;5058.873528161678;6066.272047354346;6120.296165940974;6132.264128304632;6132.509399247961 03:12:11 INFO - PROCESS | 1660 | |1;ext.html;542.2896006231839;590.937951515091;591.4144996453513;670.3229737964655;678.8472593666424;39128.60871391285;39949.800250998705;40022.19955600886;40084.39873401898;40190.1961960761;41836;42021.789891050576;42041.369379459335;42203.57796422043;42268.57731422685;9562.713118606436;9771.462569558671;9772.022797720207;9780.364276322016;9792.265580081486;9765.365251258645;9838.360506567085;9881.456519891402;9897.90102098977;9913.454759988197;9798.853017204749;9817.214622830192;9893.258005649604;9902.306838521306;9904.95047524765;9821.705348839547;9827;9871.358361706538;9899.109080182781;9904.752381190492;9752.756181095458;9830.557624906896;9855.310128291023;9867.60529578816;9891.851622225673;40875.97810054743;41099.97250068742;41151;41487.37768933469;41586;3431.9142021449416;3490.6683865032783;3524.1894364296354;3570.9642903570893;3985.701072419551;27738.722612773814;29829.55255671145;30181.49853662433;30207.244818879484;30653.846730766425;2750.752432281104;2801.0196431249105;2853.614762007144;2887.104997450797;2895.8407287599175;509726;510062.4496877529;513709;514831;519808;77302;77310.6134469324;77420;77956.61021694855;77983.2201677976;87237;87729;88184.23631527333;88821.11178888129;88945;16592.585185370463;19044.904775476032;19176.520586985436;19311.710324345146;19354.225830966887;14328.641783955276;14450.710985780226;14527.910406719328;14574.979751417299;14602.48891288821;23649.881750591136;23663.52672946566;24232.909519071683;24289;24302.635460468107;9242.214411775074;9424.858627120599;9425.104615061558;9461.52692365379;9528.047195280555;911.352939413011;979.4759803505233;1008.1430783833829;1032.6592224565875;1096.7916095941746;30874.228144296572;30893.845530772203;30967.380652386826;31512.842435788134;31795.728170873368;1128.802459569572;1145.1010956399352;1172.6599286207074;1213.2114125818289;1243.6952946528158;15866.968647038137;15952.2821473034;15996.280167392495;16118.516444506684;16150.273237704332;532849;533112;534494;538111;541004;64130.67934660297;65455.67272163609;65528.344716553176;65657.67171164209;66184;1534.171547364433;1549.473179119105;1572.8505791949747;1573.2448424755953;1576.8659663928465;30230.84884575563;30513.694863051085;30862.38275234438;31176;31190.532142018343;56318.718406409345;56731.149032763715;56916.14625780534;57009;57078.57303567444;512025;514352;517448;517452;520261;34247;35264.11839704028;35358.46962295516;35921.74273900401;36038;49256.75371623119;49345.01309973852;51168.74415628047;53112.4688753123;53471.732641336544;39628.2074358517;39660.60339396569;40336.39495407513;42876.78561607172;43351.78324108359;32966;37979;39171.80414097911;39322.6067739319;39590.604093959846;39717.404238937015;40300;41007;41743.7912810434;42050.78974605107;31427;33401.33197335991;33550.49674254839;33695.831520842235;33757;22649.660255096518;25958.480830383665;26120.34699132537;26265.818038187947;26396.472070558866 03:12:11 INFO - PROCESS | 1660 | |2;jquery.html;379.75316044571025;380.5490493764889;382.9081020555068;384.3907406760285;390.2526661443336;19700.60598788025;21615;22348.66477002844;22665.206717764882;22706.97818598163;21964.89017554914;22094.226702065433;22096.895155242215;22372.77627223731;22406.77593224067;5625.353084395286;5870.794522191724;5871.76512939483;6189.504839612842;6216.036514340284;4104.343305071189;5827.592068555203;6061.605830658951;6070.423309785585;6097.51219902409;5807.0998995155815;6006;6018.548608854331;6045.939540604603;6047.123167140762;5729.283839520039;6482.286948435668;6537.5423720339595;6557.475401967831;6563.7702680405955;5494.230807686927;5698.971505142489;5739.3686694463995;5759.164921086419;5835.912461313083;13452.596422107352;13636.590902272848;13813.309334533233;13815.102018368774;14868.776968345483;2136.7756385579446;2439.2804122783823;2621.5281249375107;2800.229936767385;2802.761765249956;10042.548085336104;10044.547995340226;10459.372437653765;13277.46890124394;14811.925940370229;1724.4136993422171;1759.9208035638428;1765.9449152965442;1806.7380229866726;1813.1931290575699;88972.55513722455;92311;107868.460657697;111119;114035.42982285119;11645.359505227125;11773.941130294465;11797.646070617895;11837.467313970892;11998.100142489347;14678.779818302733;14747.705045899236;14797.408103675732;14804.963652544435;14832.332545035499;9177.174054335143;9242.676506322246;9259.675911343205;9272.768180795534;9360.15758581731;9346.719598412059;9419.387739796892;9423.01058388873;9443.527823608792;9524.999875013023;3646.4894914711963;4633.652476064309;4635.258358662665;4696.131215725101;4704.50602686713;1749.2653085704035;1810.1492298619628;1825.3976187857975;1945.4552725236956;1964.870199635187;894.6510860764307;943.3302355327656;1007.9567647484818;1009.545704433008;1097.5554900265406;21070.683939740917;21463.78536214649;22382.32853014412;23119.306420807065;23200.767992320198;967.6806653804227;992.5434300221979;1018.6638409325053;1055.4986381468893;1074.6185104287865;8988.640454381883;11588.072954163647;11669.766604667859;11678.824817627743;11731.941340293244;550081;556176;572942;672592;718377.6324473481;133829;135629;138197;138419;138669.3066534681;1066.568039943824;1085.733995171188;1105.5246244115108;1111.9777604447866;1116.2465335898237;19635.509112272306;19839.80961142336;19850.90074549618;19932.60134797325;20047.899760501103;55424.168637469666;55574.72212638911;55743;57180.714096430915;57829;67569;79526;79552.20447795448;82460.76308855251;86035.56982215049;8114.797130071795;8233.094359620556;8389.706360277361;8464.746057618282;8667.959844818663;11149.665510034712;12032.217905836093;13412.262325572186;13453.730925381633;13681.863181368059;11225.4387280634;11573.884261157618;11620.012298954684;11698.76602467963;11749.530018799152;9564.4739539326;11258.83111753308;11740.765184696429;11760.529578816751;11780.52877884875;11850.466728997388;11862.22895511789;11950.342731149522;12088.093392995384;12383.133180677267;8179.304759095306;8263.091059983277;8418.87371689413;8549.316054715733;8594.871076933976;9966.750831228986;10636.52135653913;11545.942270288931;11679.708007299545;11836.644900652995 03:12:11 INFO - PROCESS | 1660 | |3;mootools.html;1547.8297387287396;1664.6753882992814;1719.8280171982794;2086.864353817001;2096.7798381169987;8390.83218335633;8532.189442003;9138.817223655531;9388.530573471333;9414.293927955396;7761.728339508119;9033.051529589397;9147.039560846115;9165.037671044543;9171.22044626206;2545.5036267927667;2575.3046677397138;2577.8453292802396;2577.9484410311784;2585.7672809447145;2161.2975782870553;2196.5606878624258;2400.711914570254;2501.5997440409537;2577.072253988572;1946.6496030714466;2177.825773938081;2276.9089236430523;2603.3621762668076;2604.9218523444233;2540.5681034224226;2572.5883858582724;2576.806739494536;2577.994582112987;2588.8835002424935;2135.6049130910674;2580.238829545289;2598.246508512529;2604.179683399742;2649.443616840466;9175;9287.814243715087;9308.627654893864;9314;9338.159565639056;5686.601937864351;5703.3441154267375;5816.1566572846705;5822.243108395924;5889.02831032879;3443.7933723976644;3489.8255087245534;3728.179800443898;3761.774293542396;3833;1055.6991257491577;1081.507913899174;1095.4960718069697;1108.5953626926114;1112.3826276416585;12462.688432789162;12508.937455312756;12522.874771252262;12557.86979171879;12617.369131543386;4358.5205627380965;5074.112030394666;5091.541761241506;5149;5228.320318358589;10575.36547807134;10652.573897044187;10690.037896589345;10714.303570267908;10757.30077544957;5737.5983681141915;5760.8271751847515;5799;5803.332616749043;5809.7966571170655;4673.719576825401;4989.525995030466;5068.062408454448;5080.161773307437;5108.978204359143;4106.630403263661;4154.148399578079;4164.3961625564725;4180.456540649696;4206.831726730958;1360.4014233737123;1375.6698392385956;1378.8896888248917;1380.758367285741;1387.9306034698225;1404.2136403614008;1438.4893362856035;1448.5726710620393;1461.4081297074702;1463.6633574277976;8572.571371431404;8606.913930860737;8623.094575069654;8631;8634.395592308603;515.2400209690676;533.6611251855022;539.6858649189237;541.9783208671608;543.9211314359475;6254.061890716429;6392.7123279452535;6412.294647588761;6447.4197322241225;6473.385028422293;9038.774030649287;10342.793144137075;10576.841347379795;10621.5220315086;10636.946815266028;10300.381977081399;10461.529231184615;10465.215108866865;10515.053645171818;10546.736331591617;8248.83502329962;8252.669893204325;8346.749597512084;8394.950631171103;8403.83192336162;7661.195574464601;7732.613369331623;7787.922120778946;7838.608069596383;7892.408069394934;9151.77120571991;9502.667406640734;9526.809463810547;9534.713958581253;9551.379160354554;9718.854217186607;9913.355631883904;9920.950395247977;10016.64941727036;10086.193104551472;7133.251008644018;7552.320291173821;7762;7782.338501227459;7917.722879699183;8540.658373664985;8598;8639.0993981324;8669.349798764992;8690.739277821422;5909.674967876808;7459.030326057577;7622.199669034893;7624.428167887541;7743.070831500256;7466.477346585687;7506.474546781891;7539.849203016019;7542.698292068256;7564.319211271012;8083.19168083187;8135.308498777434;8159.632816523389;8176.100628930932;8181.6318265677;7269.636518174176;7342.779716608296;7354.191038985814;7392.482526223328;7401.8149546261775;6329.430351268408;6493.805185844432;7287.052683151369;7439.888401673871;7443.181250062597 03:12:11 INFO - PROCESS | 1660 | |4;prototype.html;298.41957392870864;319.59890337626274;343.58769476628055;350.27318314497415;351.21678656595776;6043.6675982820925;6531.281559028509;6924.307569243073;6975.372216500514;6997.755078572244;6883.5869847809045;6892.551984121041;6912.723491060352;6915.481338899577;6952.860942781142;4809.711417314955;4860.1494738420815;5022.321986531808;5047;5076.771545280462;5005.924911126336;5014.674046186986;5016.448190699039;5029.924551131736;5034.068697290994;4334.653227741789;4939.308496810431;4976.825811096613;4993.825216117437;5031.22016087507;4074.7962601869935;4982.402111746577;4982.701037937735;5009.474005229471;5013.724245166514;4271.295236286009;4285.100128972919;4291.935620965688;4303.268444364466;4321.9135617287475;6268.592541484789;6584.868302633969;6591.406773390418;6626.602403855736;6678.09845670838;4875.658703890694;5854.5023672987845;5868.677222752747;5887.70561471929;5935.317438494585;7348.669309881068;7350.566639505299;7386.741464048786;7388.926110738931;7391.445641576904;4732.337472753818;4736;4746.169420351459;4750.786214620351;4759.357486739281;7369.115706115247;7694.807629809299;7770.689172433096;7804.063512378494;7809.765707028741;4604.861854144314;4707.976460117746;4802.73584952831;4805.711657300573;4817.9518204818205;4889.65772395936;4892.19278818998;4898.53463920927;4900.411950565884;4930.235813448921;4752.405949256343;5862.179294898718;5870.207521984477;5872;5887;5958.46373826349;7349.485536012535;7352.411807055422;7358.705651773869;7364.0426744522865;1675.6732437174878;1696.143447558975;1698.2527687817321;1702.6594681063589;1710.8460238578589;1040.9895901040893;1082.577794660083;1094.2887123369715;1094.9124070074374;1098.1708809848512;5917.31950825652;6712.228093769181;6738.59568425896;6790.287019862942;6795.626240556817;7165.319294666998;7626.23737626244;7629.427792915442;7675;7685.23147685227;5848.210491583667;6499.38255865692;6745.730170793211;6765.695543700545;6798;4001.7398869073418;4014.136960553495;4030.0327921299263;4041.1513582148077;4057.0668746187953;5818;8036.919630803734;8051.758447246592;8055.1542088079905;8098.838023239502;7911.169327220674;7943.602819858984;7979.760607181794;7983.8403231935035;7987.081485629227;6473.2232132144445;8001.799955001055;8004.959975200087;8029.237222463857;8048.476849004796;6723.428508576826;7066.152061752623;7718.343940765098;7731.806704832424;7763.573003484863;6576.914809056452;6844.110265665432;7114.608696521534;7569.053868266466;7598.962005189938;8015.679372825255;8016.95991520062;8027.397945154254;8042.919570804217;8045.919540804517;4786.8085276588545;4842.007388485282;4852.199387101089;4854.834839638532;4865.951340486691;7326.487145899736;7497.175310715707;7704.537727736354;7723.189065148304;7729.884051739341;7375.926240737524;7382.778516644509;7386.15059268191;7400.6669699864715;7401.888971665322;7375.225601311785;7381.4094872409005;7382.298681625237;7387.482876198615;7399.223081576572;6950.409215216561;7165.3551180394015;7186.46101542376;7213.242609525924;7243;7359;7365.9631701841145;7385.556866588022;7406.777796666109;7418.777436676908;7189.173245076883;7194.136703595602;7205.891911621225;7206.71173153089;7206.927930720835 03:12:11 INFO - PROCESS | 1660 | |5;yui.html;763.9847203055942;792.5165648954137;798.4849771897123;801.0467543623088;804.2520455975941;15315.157666328347;15409.229538523072;15412.229388530584;15508.689826203483;15526.146061966587;13134.21194728317;14502.637434064154;14511.709765804704;14517.419303227858;14531.055481393729;977.3695966101877;977.5405559387077;992.7270000749816;995.0646392391166;1008.7730260691359;955.7897262602216;964.5611246882652;977.9608815647366;978.3738407419222;998.5007496251874;997.997013001932;1019.0370100255262;1019.4749703902496;1023.7491814505456;1037.5745944162895;991.4992928571025;1013.159077965287;1014.1075853249131;1016.1972042086779;1036.9170466362673;741.6996116572797;748.711745977797;756.527170518426;760.7071277558125;781.9882701759421;13562.45750169992;13630.454781808716;13704.588862334145;13706.862931370659;13830.930845345709;11519.654410367702;11578.305301681927;11746.941265293704;11876.584319548774;12160.939195304056;7696.769096927045;9836.409815411098;11324.207305488619;11523.59667411645;11679.357635330054;3713.9628603713886;3887.067103895045;4055.3105971984833;4067.532233793122;4171.91656166875;54703.72648136734;79069;79386;80181.59909200417;80671;8093.9073225115035;8377.204165604258;9674.613015479303;9710;9879.703608891745;21433.89283053606;21603.56792864134;21651.891740541196;21659.35021949344;21777;7581.090269167735;7593.240675932362;7635.541867487857;7670.463067585327;7799.610019499002;4075.633193012584;4129.607687269765;4149.066460046465;4172.874813755592;4173.394857745609;2792.2600510864636;2828.8019838611513;3329.716974057184;3337.2491189482657;3339.53246545479;685.1367277230726;692.6744430117836;695.422799076765;702.2135208566336;709.8722229998547;531.2295585640966;567.5049063468645;580.8693044065052;604.2778879239355;619.1053927075333;8257.628406721711;8366.247037766509;8388.454750441202;8394.748157555283;8620.52587107715;553.0604835300365;576.4293349583882;606.5481216493653;621.3941407128013;632.4466092169351;3199.616046074486;3514.753967222321;3856.151646637735;3909.3745000799736;4115.485564304462;94787;95668;95791.52104239434;96770;96840;76425.23574764181;77438.83841742379;77508.51211695375;80324.59837700774;81113.37773244502;71738;72372.63813680898;73049;73480;73660;7725.49784264021;7939.642716077675;7969.924060252024;7986.800329991796;8084.353251739729;40021.79989100036;48525.27212091892;48542.5145748538;48704;49203;66736.66631666811;68821;69062;69598;69849.48212662735;10030.247731420026;10100.141487973604;10193.184545236512;10221.28451008452;10686.839697404701;9081.727548173565;9932.652357167464;10907.400092994643;11280.32318060919;11453.942730286295;10153.949230253802;10215.7446063849;10237.590496380062;10307.484625768531;10476.63331783384;10160.949195253976;10223.1821454282;10223.386596804216;10344.431056291976;10768;10073.546690398804;10211.489425528842;10421.583136674448;10475.371477711362;10735.677929662123;9066.95466522663;9081.409708368936;9219.49292788903;9256.814863702823;9317.580708868252;7671.309582137635;8557.700480483154;9021.729348119567;9132.680356187502;9210.907890921006 03:12:11 INFO - PROCESS | 1660 | __end_tp_report 03:12:11 INFO - PROCESS | 1660 | __start_cc_report 03:12:11 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,359 03:12:11 INFO - PROCESS | 1660 | __end_cc_report 03:12:11 INFO - PROCESS | 1660 | __startTimestamp1461147131242__endTimestamp 03:12:11 INFO - PROCESS | 1660 | 03:12:11 INFO - PROCESS | 1660 | ------- Summary: start ------- 03:12:11 INFO - PROCESS | 1660 | Number of tests: 6 03:12:11 INFO - PROCESS | 1660 | 03:12:11 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5721.23 Median:5921.59 stddev:668.50 (11.3%) stddev-sans-first:644.49 03:12:11 INFO - PROCESS | 1660 | Values: 3364.8 3423.9 3544.6 3582.0 3601.9 4720.6 5771.3 5796.6 5832.2 5835.8 5760.7 5800.2 5819.9 5837.4 5839.9 5220.5 5266.6 5266.9 5288.6 5307.0 5193.2 5299.2 5307.5 5337.2 5340.9 4368.7 5258.8 5295.5 5295.7 5373.2 4964.0 4982.3 5320.2 5365.8 5406.8 5096.0 5136.1 5301.7 5303.5 5309.6 5693.6 5723.7 5803.3 5810.7 5832.5 6146.0 6166.4 6170.8 6196.1 6198.9 4800.4 5653.6 6114.0 6237.8 6239.7 5971.9 5978.9 5987.2 6017.8 6080.8 6315.0 6334.9 6351.5 6353.5 6358.8 6105.9 6167.5 6243.1 6308.4 6309.0 5701.3 5998.6 6282.9 6302.5 6318.0 6269.9 6283.2 6284.6 6340.5 6367.0 5367.9 6164.6 6323.4 6335.7 6343.4 4969.8 4979.0 4980.2 4988.3 5026.4 4434.2 4494.1 4532.7 4552.5 4562.4 4721.5 4878.8 5790.7 5916.7 5961.4 6284.4 6307.4 6323.1 6327.9 6331.3 5729.2 5918.0 5924.2 5942.1 5969.6 5386.2 5445.5 5445.7 5483.5 5502.4 6332.3 6369.3 6377.8 6386.4 6387.2 6175.9 6238.2 6336.9 6359.4 6360.7 6320.1 6372.7 6380.1 6381.6 6387.3 4914.7 5162.3 6332.8 6333.8 6337.3 4700.7 5146.1 5763.4 6295.6 6337.0 5439.6 6216.6 6226.7 6271.3 6281.8 5533.6 6141.2 6175.3 6240.9 6260.9 4854.8 5848.3 5899.5 5921.6 5993.9 5094.4 6194.4 6261.3 6271.4 6273.9 5058.9 6066.3 6120.3 6132.3 6132.5 03:12:11 INFO - PROCESS | 1660 | 03:12:11 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:68793.97 Median:41125.49 stddev:138714.98 (337.3%) stddev-sans-first:139009.46 03:12:11 INFO - PROCESS | 1660 | Values: 542.3 590.9 591.4 670.3 678.8 39128.6 39949.8 40022.2 40084.4 40190.2 41836.0 42021.8 42041.4 42203.6 42268.6 9562.7 9771.5 9772.0 9780.4 9792.3 9765.4 9838.4 9881.5 9897.9 9913.5 9798.9 9817.2 9893.3 9902.3 9905.0 9821.7 9827.0 9871.4 9899.1 9904.8 9752.8 9830.6 9855.3 9867.6 9891.9 40876.0 41100.0 41151.0 41487.4 41586.0 3431.9 3490.7 3524.2 3571.0 3985.7 27738.7 29829.6 30181.5 30207.2 30653.8 2750.8 2801.0 2853.6 2887.1 2895.8 509726.0 510062.4 513709.0 514831.0 519808.0 77302.0 77310.6 77420.0 77956.6 77983.2 87237.0 87729.0 88184.2 88821.1 88945.0 16592.6 19044.9 19176.5 19311.7 19354.2 14328.6 14450.7 14527.9 14575.0 14602.5 23649.9 23663.5 24232.9 24289.0 24302.6 9242.2 9424.9 9425.1 9461.5 9528.0 911.4 979.5 1008.1 1032.7 1096.8 30874.2 30893.8 30967.4 31512.8 31795.7 1128.8 1145.1 1172.7 1213.2 1243.7 15867.0 15952.3 15996.3 16118.5 16150.3 532849.0 533112.0 534494.0 538111.0 541004.0 64130.7 65455.7 65528.3 65657.7 66184.0 1534.2 1549.5 1572.9 1573.2 1576.9 30230.8 30513.7 30862.4 31176.0 31190.5 56318.7 56731.1 56916.1 57009.0 57078.6 512025.0 514352.0 517448.0 517452.0 520261.0 34247.0 35264.1 35358.5 35921.7 36038.0 49256.8 49345.0 51168.7 53112.5 53471.7 39628.2 39660.6 40336.4 42876.8 43351.8 32966.0 37979.0 39171.8 39322.6 39590.6 39717.4 40300.0 41007.0 41743.8 42050.8 31427.0 33401.3 33550.5 33695.8 33757.0 22649.7 25958.5 26120.3 26265.8 26396.5 03:12:11 INFO - PROCESS | 1660 | 03:12:11 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:35462.64 Median:22377.55 stddev:102925.91 (460.0%) stddev-sans-first:103180.93 03:12:11 INFO - PROCESS | 1660 | Values: 379.8 380.5 382.9 384.4 390.3 19700.6 21615.0 22348.7 22665.2 22707.0 21964.9 22094.2 22096.9 22372.8 22406.8 5625.4 5870.8 5871.8 6189.5 6216.0 4104.3 5827.6 6061.6 6070.4 6097.5 5807.1 6006.0 6018.5 6045.9 6047.1 5729.3 6482.3 6537.5 6557.5 6563.8 5494.2 5699.0 5739.4 5759.2 5835.9 13452.6 13636.6 13813.3 13815.1 14868.8 2136.8 2439.3 2621.5 2800.2 2802.8 10042.5 10044.5 10459.4 13277.5 14811.9 1724.4 1759.9 1765.9 1806.7 1813.2 88972.6 92311.0 107868.5 111119.0 114035.4 11645.4 11773.9 11797.6 11837.5 11998.1 14678.8 14747.7 14797.4 14805.0 14832.3 9177.2 9242.7 9259.7 9272.8 9360.2 9346.7 9419.4 9423.0 9443.5 9525.0 3646.5 4633.7 4635.3 4696.1 4704.5 1749.3 1810.1 1825.4 1945.5 1964.9 894.7 943.3 1008.0 1009.5 1097.6 21070.7 21463.8 22382.3 23119.3 23200.8 967.7 992.5 1018.7 1055.5 1074.6 8988.6 11588.1 11669.8 11678.8 11731.9 550081.0 556176.0 572942.0 672592.0 718377.6 133829.0 135629.0 138197.0 138419.0 138669.3 1066.6 1085.7 1105.5 1112.0 1116.2 19635.5 19839.8 19850.9 19932.6 20047.9 55424.2 55574.7 55743.0 57180.7 57829.0 67569.0 79526.0 79552.2 82460.8 86035.6 8114.8 8233.1 8389.7 8464.7 8668.0 11149.7 12032.2 13412.3 13453.7 13681.9 11225.4 11573.9 11620.0 11698.8 11749.5 9564.5 11258.8 11740.8 11760.5 11780.5 11850.5 11862.2 11950.3 12088.1 12383.1 8179.3 8263.1 8418.9 8549.3 8594.9 9966.8 10636.5 11545.9 11679.7 11836.6 03:12:11 INFO - PROCESS | 1660 | 03:12:11 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:6195.63 Median:3115.26 stddev:3265.79 (104.8%) stddev-sans-first:3256.27 03:12:11 INFO - PROCESS | 1660 | Values: 1547.8 1664.7 1719.8 2086.9 2096.8 8390.8 8532.2 9138.8 9388.5 9414.3 7761.7 9033.1 9147.0 9165.0 9171.2 2545.5 2575.3 2577.8 2577.9 2585.8 2161.3 2196.6 2400.7 2501.6 2577.1 1946.6 2177.8 2276.9 2603.4 2604.9 2540.6 2572.6 2576.8 2578.0 2588.9 2135.6 2580.2 2598.2 2604.2 2649.4 9175.0 9287.8 9308.6 9314.0 9338.2 5686.6 5703.3 5816.2 5822.2 5889.0 3443.8 3489.8 3728.2 3761.8 3833.0 1055.7 1081.5 1095.5 1108.6 1112.4 12462.7 12508.9 12522.9 12557.9 12617.4 4358.5 5074.1 5091.5 5149.0 5228.3 10575.4 10652.6 10690.0 10714.3 10757.3 5737.6 5760.8 5799.0 5803.3 5809.8 4673.7 4989.5 5068.1 5080.2 5109.0 4106.6 4154.1 4164.4 4180.5 4206.8 1360.4 1375.7 1378.9 1380.8 1387.9 1404.2 1438.5 1448.6 1461.4 1463.7 8572.6 8606.9 8623.1 8631.0 8634.4 515.2 533.7 539.7 542.0 543.9 6254.1 6392.7 6412.3 6447.4 6473.4 9038.8 10342.8 10576.8 10621.5 10636.9 10300.4 10461.5 10465.2 10515.1 10546.7 8248.8 8252.7 8346.7 8395.0 8403.8 7661.2 7732.6 7787.9 7838.6 7892.4 9151.8 9502.7 9526.8 9534.7 9551.4 9718.9 9913.4 9921.0 10016.6 10086.2 7133.3 7552.3 7762.0 7782.3 7917.7 8540.7 8598.0 8639.1 8669.3 8690.7 5909.7 7459.0 7622.2 7624.4 7743.1 7466.5 7506.5 7539.8 7542.7 7564.3 8083.2 8135.3 8159.6 8176.1 8181.6 7269.6 7342.8 7354.2 7392.5 7401.8 6329.4 6493.8 7287.1 7439.9 7443.2 03:12:11 INFO - PROCESS | 1660 | 03:12:11 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:5960.97 Median:6731.01 stddev:1931.70 (28.7%) stddev-sans-first:1889.78 03:12:11 INFO - PROCESS | 1660 | Values: 298.4 319.6 343.6 350.3 351.2 6043.7 6531.3 6924.3 6975.4 6997.8 6883.6 6892.6 6912.7 6915.5 6952.9 4809.7 4860.1 5022.3 5047.0 5076.8 5005.9 5014.7 5016.4 5029.9 5034.1 4334.7 4939.3 4976.8 4993.8 5031.2 4074.8 4982.4 4982.7 5009.5 5013.7 4271.3 4285.1 4291.9 4303.3 4321.9 6268.6 6584.9 6591.4 6626.6 6678.1 4875.7 5854.5 5868.7 5887.7 5935.3 7348.7 7350.6 7386.7 7388.9 7391.4 4732.3 4736.0 4746.2 4750.8 4759.4 7369.1 7694.8 7770.7 7804.1 7809.8 4604.9 4708.0 4802.7 4805.7 4818.0 4889.7 4892.2 4898.5 4900.4 4930.2 4752.4 5862.2 5870.2 5872.0 5887.0 5958.5 7349.5 7352.4 7358.7 7364.0 1675.7 1696.1 1698.3 1702.7 1710.8 1041.0 1082.6 1094.3 1094.9 1098.2 5917.3 6712.2 6738.6 6790.3 6795.6 7165.3 7626.2 7629.4 7675.0 7685.2 5848.2 6499.4 6745.7 6765.7 6798.0 4001.7 4014.1 4030.0 4041.2 4057.1 5818.0 8036.9 8051.8 8055.2 8098.8 7911.2 7943.6 7979.8 7983.8 7987.1 6473.2 8001.8 8005.0 8029.2 8048.5 6723.4 7066.2 7718.3 7731.8 7763.6 6576.9 6844.1 7114.6 7569.1 7599.0 8015.7 8017.0 8027.4 8042.9 8045.9 4786.8 4842.0 4852.2 4854.8 4866.0 7326.5 7497.2 7704.5 7723.2 7729.9 7375.9 7382.8 7386.2 7400.7 7401.9 7375.2 7381.4 7382.3 7387.5 7399.2 6950.4 7165.4 7186.5 7213.2 7243.0 7359.0 7366.0 7385.6 7406.8 7418.8 7189.2 7194.1 7205.9 7206.7 7206.9 03:12:11 INFO - PROCESS | 1660 | 03:12:11 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:18067.00 Median:592.57 stddev:25882.42 (4367.8%) stddev-sans-first:25922.42 03:12:11 INFO - PROCESS | 1660 | Values: 764.0 792.5 798.5 801.0 804.3 15315.2 15409.2 15412.2 15508.7 15526.1 13134.2 14502.6 14511.7 14517.4 14531.1 977.4 977.5 992.7 995.1 1008.8 955.8 964.6 978.0 978.4 998.5 998.0 1019.0 1019.5 1023.7 1037.6 991.5 1013.2 1014.1 1016.2 1036.9 741.7 748.7 756.5 760.7 782.0 13562.5 13630.5 13704.6 13706.9 13830.9 11519.7 11578.3 11746.9 11876.6 12160.9 7696.8 9836.4 11324.2 11523.6 11679.4 3714.0 3887.1 4055.3 4067.5 4171.9 54703.7 79069.0 79386.0 80181.6 80671.0 8093.9 8377.2 9674.6 9710.0 9879.7 21433.9 21603.6 21651.9 21659.4 21777.0 7581.1 7593.2 7635.5 7670.5 7799.6 4075.6 4129.6 4149.1 4172.9 4173.4 2792.3 2828.8 3329.7 3337.2 3339.5 685.1 692.7 695.4 702.2 709.9 531.2 567.5 580.9 604.3 619.1 8257.6 8366.2 8388.5 8394.7 8620.5 553.1 576.4 606.5 621.4 632.4 3199.6 3514.8 3856.2 3909.4 4115.5 94787.0 95668.0 95791.5 96770.0 96840.0 76425.2 77438.8 77508.5 80324.6 81113.4 71738.0 72372.6 73049.0 73480.0 73660.0 7725.5 7939.6 7969.9 7986.8 8084.4 40021.8 48525.3 48542.5 48704.0 49203.0 66736.7 68821.0 69062.0 69598.0 69849.5 10030.2 10100.1 10193.2 10221.3 10686.8 9081.7 9932.7 10907.4 11280.3 11453.9 10153.9 10215.7 10237.6 10307.5 10476.6 10160.9 10223.2 10223.4 10344.4 10768.0 10073.5 10211.5 10421.6 10475.4 10735.7 9067.0 9081.4 9219.5 9256.8 9317.6 7671.3 8557.7 9021.7 9132.7 9210.9 03:12:11 INFO - PROCESS | 1660 | -------- Summary: end -------- 03:12:11 INFO - PROCESS | 1660 | 03:12:11 INFO - TEST-INFO | 1660: exit 0 03:12:11 INFO - TEST-OK | dromaeo_css | took 1110251ms 03:12:11 INFO - TEST-START | kraken 03:12:11 INFO - operating with platform_type : mac_ 03:12:11 INFO - Initialising browser for kraken test... 03:12:11 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpeeBPge/profile http://localhost:49275/getInfo.html) 03:12:14 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 03:12:14 INFO - PROCESS | 1672 | colorDepth:24 03:12:14 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 03:12:14 INFO - PROCESS | 1672 | __metrics 03:12:14 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 03:12:14 INFO - TEST-INFO | 1672: exit 0 03:12:14 INFO - Browser initialized. 03:12:14 INFO - Running cycle 1/1 for kraken test... 03:12:14 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpeeBPge/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:26 INFO - PROCESS | 1675 | RSS: Main: 217935872 03:12:26 INFO - PROCESS | 1675 | 03:12:29 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 03:12:30 INFO - PROCESS | 1675 | RSS: Main: 230166528 03:12:30 INFO - PROCESS | 1675 | 03:12:32 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 03:12:33 INFO - PROCESS | 1675 | RSS: Main: 238968832 03:12:33 INFO - PROCESS | 1675 | 03:12:36 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 03:12:37 INFO - PROCESS | 1675 | RSS: Main: 243560448 03:12:37 INFO - PROCESS | 1675 | 03:12:39 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 03:12:40 INFO - PROCESS | 1675 | RSS: Main: 245010432 03:12:40 INFO - PROCESS | 1675 | 03:12:42 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:12:42 INFO - PROCESS | 1675 | RSS: Main: 245133312 03:12:42 INFO - PROCESS | 1675 | 03:12:45 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 03:12:46 INFO - PROCESS | 1675 | RSS: Main: 244727808 03:12:46 INFO - PROCESS | 1675 | 03:12:49 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 03:12:49 INFO - PROCESS | 1675 | RSS: Main: 245071872 03:12:49 INFO - PROCESS | 1675 | 03:12:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 03:12:53 INFO - PROCESS | 1675 | RSS: Main: 245284864 03:12:53 INFO - PROCESS | 1675 | 03:12:54 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:12:55 INFO - PROCESS | 1675 | RSS: Main: 244748288 03:12:55 INFO - PROCESS | 1675 | 03:12:57 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:12:57 INFO - PROCESS | 1675 | RSS: Main: 245059584 03:12:57 INFO - PROCESS | 1675 | 03:13:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:13:00 INFO - PROCESS | 1675 | RSS: Main: 245153792 03:13:00 INFO - PROCESS | 1675 | 03:13:03 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:13:03 INFO - PROCESS | 1675 | RSS: Main: 245293056 03:13:03 INFO - PROCESS | 1675 | 03:13:06 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:13:06 INFO - PROCESS | 1675 | RSS: Main: 244801536 03:13:06 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 03:13:08 INFO - PROCESS | 1675 | RSS: Main: 246775808 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | __start_tp_report 03:13:08 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 03:13:08 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 03:13:08 INFO - PROCESS | 1675 | |i|pagename|runs| 03:13:08 INFO - PROCESS | 1675 | |0;ai-astar;114;110;116;116;117;130;116;115;115;114 03:13:08 INFO - PROCESS | 1675 | |1;audio-beat-detection;173;151;144;150;143;173;168;121;154;124 03:13:08 INFO - PROCESS | 1675 | |2;audio-dft;195;195;235;197;194;197;195;194;194;196 03:13:08 INFO - PROCESS | 1675 | |3;audio-fft;70;87;107;161;48;78;90;90;145;55 03:13:08 INFO - PROCESS | 1675 | |4;audio-oscillator;86;85;112;80;102;82;115;77;114;152 03:13:08 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;91;87;88;86;89;101;137;75;116;132 03:13:08 INFO - PROCESS | 1675 | |6;imaging-darkroom;151;94;94;118;98;151;130;95;104;124 03:13:08 INFO - PROCESS | 1675 | |7;imaging-desaturate;89;93;92;92;92;90;108;94;91;90 03:13:08 INFO - PROCESS | 1675 | |8;json-parse-financial;53;60;60;80;90;91;90;94;56;51 03:13:08 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;63;64;71;66;78;70;67;64;66;64 03:13:08 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;80;83;83;84;81;82;84;109;70;108 03:13:08 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;122;119;130;128;118;120;120;130;120;124 03:13:08 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;137;171;176;171;133;136;132;136;135;136 03:13:08 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;65;64;67;66;66;64;81;99;97;75 03:13:08 INFO - PROCESS | 1675 | __end_tp_report 03:13:08 INFO - PROCESS | 1675 | __start_cc_report 03:13:08 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,925 03:13:08 INFO - PROCESS | 1675 | __end_cc_report 03:13:08 INFO - PROCESS | 1675 | __startTimestamp1461147188949__endTimestamp 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | ------- Summary: start ------- 03:13:08 INFO - PROCESS | 1675 | Number of tests: 14 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:116.30 Median:116.00 stddev:5.19 (4.5%) stddev-sans-first:5.43 03:13:08 INFO - PROCESS | 1675 | Values: 114.0 110.0 116.0 116.0 117.0 130.0 116.0 115.0 115.0 114.0 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:152.50 stddev:18.26 (12.0%) stddev-sans-first:17.39 03:13:08 INFO - PROCESS | 1675 | Values: 173.0 151.0 144.0 150.0 143.0 173.0 168.0 121.0 154.0 124.0 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:199.20 Median:195.50 stddev:12.63 (6.5%) stddev-sans-first:13.30 03:13:08 INFO - PROCESS | 1675 | Values: 195.0 195.0 235.0 197.0 194.0 197.0 195.0 194.0 194.0 196.0 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:93.10 Median:74.00 stddev:36.21 (48.9%) stddev-sans-first:37.43 03:13:08 INFO - PROCESS | 1675 | Values: 70.0 87.0 107.0 161.0 48.0 78.0 90.0 90.0 145.0 55.0 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:100.50 Median:78.50 stddev:23.44 (29.9%) stddev-sans-first:24.27 03:13:08 INFO - PROCESS | 1675 | Values: 86.0 85.0 112.0 80.0 102.0 82.0 115.0 77.0 114.0 152.0 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:100.20 Median:86.50 stddev:21.04 (24.3%) stddev-sans-first:22.06 03:13:08 INFO - PROCESS | 1675 | Values: 91.0 87.0 88.0 86.0 89.0 101.0 137.0 75.0 116.0 132.0 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:115.90 Median:122.50 stddev:22.59 (18.4%) stddev-sans-first:20.07 03:13:08 INFO - PROCESS | 1675 | Values: 151.0 94.0 94.0 118.0 98.0 151.0 130.0 95.0 104.0 124.0 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:93.10 Median:92.00 stddev:5.45 (5.9%) stddev-sans-first:5.57 03:13:08 INFO - PROCESS | 1675 | Values: 89.0 93.0 92.0 92.0 92.0 90.0 108.0 94.0 91.0 90.0 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:72.50 Median:85.00 stddev:17.95 (21.1%) stddev-sans-first:17.60 03:13:08 INFO - PROCESS | 1675 | Values: 53.0 60.0 60.0 80.0 90.0 91.0 90.0 94.0 56.0 51.0 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:66.50 stddev:4.60 (6.9%) stddev-sans-first:4.60 03:13:08 INFO - PROCESS | 1675 | Values: 63.0 64.0 71.0 66.0 78.0 70.0 67.0 64.0 66.0 64.0 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:82.50 stddev:12.34 (15.0%) stddev-sans-first:12.87 03:13:08 INFO - PROCESS | 1675 | Values: 80.0 83.0 83.0 84.0 81.0 82.0 84.0 109.0 70.0 108.0 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:123.00 stddev:4.63 (3.8%) stddev-sans-first:4.89 03:13:08 INFO - PROCESS | 1675 | Values: 122.0 119.0 130.0 128.0 118.0 120.0 120.0 130.0 120.0 124.0 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.30 Median:136.50 stddev:18.31 (13.4%) stddev-sans-first:19.10 03:13:08 INFO - PROCESS | 1675 | Values: 137.0 171.0 176.0 171.0 133.0 136.0 132.0 136.0 135.0 136.0 03:13:08 INFO - PROCESS | 1675 | 03:13:08 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:71.00 stddev:13.58 (19.1%) stddev-sans-first:13.97 03:13:08 INFO - PROCESS | 1675 | Values: 65.0 64.0 67.0 66.0 66.0 64.0 81.0 99.0 97.0 75.0 03:13:08 INFO - PROCESS | 1675 | -------- Summary: end -------- 03:13:08 INFO - PROCESS | 1675 | 03:13:09 INFO - TEST-INFO | 1675: exit 0 03:13:09 INFO - TEST-OK | kraken | took 57912ms 03:13:09 INFO - SUITE-END | took 1168s 03:13:10 INFO - Completed test suite (00:19:28) 03:13:10 INFO - javascript benchmark 03:13:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3364.764466487346, 3423.914402139946, 3544.6455354464542, 3582.014945889878, 3601.9099522511933, 4720.622350211984, 5771.336296325924, 5796.594238403313, 5832.241808564881, 5835.824925252244, 5760.654360738348, 5800.15897694834, 5819.9418005819925, 5837.387074357195, 5839.883202335951, 5220.451852555484, 5266.5786737061135, 5266.947330526703, 5288.603354748409, 5306.973465132688, 5193.16909294513, 5299.205119232127, 5307.495787900143, 5337.172738225562, 5340.91988620171, 4368.672349573779, 5258.763355649005, 5295.549878260353, 5295.708736019517, 5373.167159090347, 4963.975180124113, 4982.302477653131, 5320.228566857803, 5365.7853685852515, 5406.83779486616, 5096.0, 5136.101182293084, 5301.734913254322, 5303.549198318147, 5309.601779866487, 5693.629914055573, 5723.713814309268, 5803.332616749086, 5810.651360918316, 5832.533397328203, 6145.9692701536205, 6166.414190651881, 6170.7531698732, 6196.132541444202, 6198.876022479525, 4800.423949126127, 5653.57598180134, 6113.962834745944, 6237.750489980395, 6239.65681887496, 5971.910421343683, 5978.850528736816, 5987.161797348331, 6017.789377371771, 6080.787172448943, 6315.021171718391, 6334.936650633527, 6351.491880649537, 6353.5234857385885, 6358.8410289742205, 6105.854009884935, 6167.506599472032, 6243.125962365272, 6308.369163083655, 6309.0, 5701.344345400249, 5998.610090344114, 6282.874342513215, 6302.464290535264, 6318.0, 6269.8746025079245, 6283.214598175228, 6284.5600807943, 6340.524460665469, 6367.044943258548, 5367.946320536745, 6164.630122192682, 6323.36766323364, 6335.651539165298, 6343.397377249154, 4969.751512424365, 4978.950210497848, 4980.153373926441, 4988.276699878497, 5026.447090820006, 4434.201843668106, 4494.1461122386645, 4532.660050496226, 4552.521985191574, 4562.384078149407, 4721.4570324413135, 4878.780454879539, 5790.71046447676, 5916.73374698131, 5961.433663801932, 6284.4344009039405, 6307.432331090224, 6323.051542268697, 6327.905081423783, 6331.303556608769, 5729.226554415184, 5918.032705179888, 5924.229850119457, 5942.10868369748, 5969.582129250911, 5386.245925570423, 5445.455454454602, 5445.673259604437, 5483.506484416422, 5502.449755024546, 6332.303446620868, 6369.299377068612, 6377.840553986188, 6386.361363863576, 6387.169667943138, 6175.876482470415, 6238.220222472191, 6336.904946425715, 6359.3640635936035, 6360.650164241011, 6320.146780184617, 6372.713227904663, 6380.074889141141, 6381.553291269566, 6387.329330420424, 4914.70511769295, 5162.328897243335, 6332.778352757631, 6333.841653958688, 6337.334579869047, 4700.741459219776, 5146.125158722951, 5763.423657634371, 6295.5907865988565, 6336.968315158395, 5439.5920305976415, 6216.595921265103, 6226.719797609209, 6271.3415091414745, 6281.780137695158, 5533.6403133796175, 6141.201643786279, 6175.2589689237575, 6240.937590624218, 6260.874782504234, 4854.80580776765, 5848.298204215522, 5899.46904778572, 5921.585489015728, 5993.940060599512, 5094.414142373675, 6194.442500175006, 6261.279952805486, 6271.404216599416, 6273.937260627518, 5058.873528161678, 6066.272047354346, 6120.296165940974, 6132.264128304632, 6132.509399247961], "unit": "score", "name": "dojo.html", "value": 5684.660957191854}, {"lowerIsBetter": false, "replicates": [542.2896006231839, 590.937951515091, 591.4144996453513, 670.3229737964655, 678.8472593666424, 39128.60871391285, 39949.800250998705, 40022.19955600886, 40084.39873401898, 40190.1961960761, 41836.0, 42021.789891050576, 42041.369379459335, 42203.57796422043, 42268.57731422685, 9562.713118606436, 9771.462569558671, 9772.022797720207, 9780.364276322016, 9792.265580081486, 9765.365251258645, 9838.360506567085, 9881.456519891402, 9897.90102098977, 9913.454759988197, 9798.853017204749, 9817.214622830192, 9893.258005649604, 9902.306838521306, 9904.95047524765, 9821.705348839547, 9827.0, 9871.358361706538, 9899.109080182781, 9904.752381190492, 9752.756181095458, 9830.557624906896, 9855.310128291023, 9867.60529578816, 9891.851622225673, 40875.97810054743, 41099.97250068742, 41151.0, 41487.37768933469, 41586.0, 3431.9142021449416, 3490.6683865032783, 3524.1894364296354, 3570.9642903570893, 3985.701072419551, 27738.722612773814, 29829.55255671145, 30181.49853662433, 30207.244818879484, 30653.846730766425, 2750.752432281104, 2801.0196431249105, 2853.614762007144, 2887.104997450797, 2895.8407287599175, 509726.0, 510062.4496877529, 513709.0, 514831.0, 519808.0, 77302.0, 77310.6134469324, 77420.0, 77956.61021694855, 77983.2201677976, 87237.0, 87729.0, 88184.23631527333, 88821.11178888129, 88945.0, 16592.585185370463, 19044.904775476032, 19176.520586985436, 19311.710324345146, 19354.225830966887, 14328.641783955276, 14450.710985780226, 14527.910406719328, 14574.979751417299, 14602.48891288821, 23649.881750591136, 23663.52672946566, 24232.909519071683, 24289.0, 24302.635460468107, 9242.214411775074, 9424.858627120599, 9425.104615061558, 9461.52692365379, 9528.047195280555, 911.352939413011, 979.4759803505233, 1008.1430783833829, 1032.6592224565875, 1096.7916095941746, 30874.228144296572, 30893.845530772203, 30967.380652386826, 31512.842435788134, 31795.728170873368, 1128.802459569572, 1145.1010956399352, 1172.6599286207074, 1213.2114125818289, 1243.6952946528158, 15866.968647038137, 15952.2821473034, 15996.280167392495, 16118.516444506684, 16150.273237704332, 532849.0, 533112.0, 534494.0, 538111.0, 541004.0, 64130.67934660297, 65455.67272163609, 65528.344716553176, 65657.67171164209, 66184.0, 1534.171547364433, 1549.473179119105, 1572.8505791949747, 1573.2448424755953, 1576.8659663928465, 30230.84884575563, 30513.694863051085, 30862.38275234438, 31176.0, 31190.532142018343, 56318.718406409345, 56731.149032763715, 56916.14625780534, 57009.0, 57078.57303567444, 512025.0, 514352.0, 517448.0, 517452.0, 520261.0, 34247.0, 35264.11839704028, 35358.46962295516, 35921.74273900401, 36038.0, 49256.75371623119, 49345.01309973852, 51168.74415628047, 53112.4688753123, 53471.732641336544, 39628.2074358517, 39660.60339396569, 40336.39495407513, 42876.78561607172, 43351.78324108359, 32966.0, 37979.0, 39171.80414097911, 39322.6067739319, 39590.604093959846, 39717.404238937015, 40300.0, 41007.0, 41743.7912810434, 42050.78974605107, 31427.0, 33401.33197335991, 33550.49674254839, 33695.831520842235, 33757.0, 22649.660255096518, 25958.480830383665, 26120.34699132537, 26265.818038187947, 26396.472070558866], "unit": "score", "name": "ext.html", "value": 21361.9632687419}, {"lowerIsBetter": false, "replicates": [379.75316044571025, 380.5490493764889, 382.9081020555068, 384.3907406760285, 390.2526661443336, 19700.60598788025, 21615.0, 22348.66477002844, 22665.206717764882, 22706.97818598163, 21964.89017554914, 22094.226702065433, 22096.895155242215, 22372.77627223731, 22406.77593224067, 5625.353084395286, 5870.794522191724, 5871.76512939483, 6189.504839612842, 6216.036514340284, 4104.343305071189, 5827.592068555203, 6061.605830658951, 6070.423309785585, 6097.51219902409, 5807.0998995155815, 6006.0, 6018.548608854331, 6045.939540604603, 6047.123167140762, 5729.283839520039, 6482.286948435668, 6537.5423720339595, 6557.475401967831, 6563.7702680405955, 5494.230807686927, 5698.971505142489, 5739.3686694463995, 5759.164921086419, 5835.912461313083, 13452.596422107352, 13636.590902272848, 13813.309334533233, 13815.102018368774, 14868.776968345483, 2136.7756385579446, 2439.2804122783823, 2621.5281249375107, 2800.229936767385, 2802.761765249956, 10042.548085336104, 10044.547995340226, 10459.372437653765, 13277.46890124394, 14811.925940370229, 1724.4136993422171, 1759.9208035638428, 1765.9449152965442, 1806.7380229866726, 1813.1931290575699, 88972.55513722455, 92311.0, 107868.460657697, 111119.0, 114035.42982285119, 11645.359505227125, 11773.941130294465, 11797.646070617895, 11837.467313970892, 11998.100142489347, 14678.779818302733, 14747.705045899236, 14797.408103675732, 14804.963652544435, 14832.332545035499, 9177.174054335143, 9242.676506322246, 9259.675911343205, 9272.768180795534, 9360.15758581731, 9346.719598412059, 9419.387739796892, 9423.01058388873, 9443.527823608792, 9524.999875013023, 3646.4894914711963, 4633.652476064309, 4635.258358662665, 4696.131215725101, 4704.50602686713, 1749.2653085704035, 1810.1492298619628, 1825.3976187857975, 1945.4552725236956, 1964.870199635187, 894.6510860764307, 943.3302355327656, 1007.9567647484818, 1009.545704433008, 1097.5554900265406, 21070.683939740917, 21463.78536214649, 22382.32853014412, 23119.306420807065, 23200.767992320198, 967.6806653804227, 992.5434300221979, 1018.6638409325053, 1055.4986381468893, 1074.6185104287865, 8988.640454381883, 11588.072954163647, 11669.766604667859, 11678.824817627743, 11731.941340293244, 550081.0, 556176.0, 572942.0, 672592.0, 718377.6324473481, 133829.0, 135629.0, 138197.0, 138419.0, 138669.3066534681, 1066.568039943824, 1085.733995171188, 1105.5246244115108, 1111.9777604447866, 1116.2465335898237, 19635.509112272306, 19839.80961142336, 19850.90074549618, 19932.60134797325, 20047.899760501103, 55424.168637469666, 55574.72212638911, 55743.0, 57180.714096430915, 57829.0, 67569.0, 79526.0, 79552.20447795448, 82460.76308855251, 86035.56982215049, 8114.797130071795, 8233.094359620556, 8389.706360277361, 8464.746057618282, 8667.959844818663, 11149.665510034712, 12032.217905836093, 13412.262325572186, 13453.730925381633, 13681.863181368059, 11225.4387280634, 11573.884261157618, 11620.012298954684, 11698.76602467963, 11749.530018799152, 9564.4739539326, 11258.83111753308, 11740.765184696429, 11760.529578816751, 11780.52877884875, 11850.466728997388, 11862.22895511789, 11950.342731149522, 12088.093392995384, 12383.133180677267, 8179.304759095306, 8263.091059983277, 8418.87371689413, 8549.316054715733, 8594.871076933976, 9966.750831228986, 10636.52135653913, 11545.942270288931, 11679.708007299545, 11836.644900652995], "unit": "score", "name": "jquery.html", "value": 9761.341593027113}, {"lowerIsBetter": false, "replicates": [1547.8297387287396, 1664.6753882992814, 1719.8280171982794, 2086.864353817001, 2096.7798381169987, 8390.83218335633, 8532.189442003, 9138.817223655531, 9388.530573471333, 9414.293927955396, 7761.728339508119, 9033.051529589397, 9147.039560846115, 9165.037671044543, 9171.22044626206, 2545.5036267927667, 2575.3046677397138, 2577.8453292802396, 2577.9484410311784, 2585.7672809447145, 2161.2975782870553, 2196.5606878624258, 2400.711914570254, 2501.5997440409537, 2577.072253988572, 1946.6496030714466, 2177.825773938081, 2276.9089236430523, 2603.3621762668076, 2604.9218523444233, 2540.5681034224226, 2572.5883858582724, 2576.806739494536, 2577.994582112987, 2588.8835002424935, 2135.6049130910674, 2580.238829545289, 2598.246508512529, 2604.179683399742, 2649.443616840466, 9175.0, 9287.814243715087, 9308.627654893864, 9314.0, 9338.159565639056, 5686.601937864351, 5703.3441154267375, 5816.1566572846705, 5822.243108395924, 5889.02831032879, 3443.7933723976644, 3489.8255087245534, 3728.179800443898, 3761.774293542396, 3833.0, 1055.6991257491577, 1081.507913899174, 1095.4960718069697, 1108.5953626926114, 1112.3826276416585, 12462.688432789162, 12508.937455312756, 12522.874771252262, 12557.86979171879, 12617.369131543386, 4358.5205627380965, 5074.112030394666, 5091.541761241506, 5149.0, 5228.320318358589, 10575.36547807134, 10652.573897044187, 10690.037896589345, 10714.303570267908, 10757.30077544957, 5737.5983681141915, 5760.8271751847515, 5799.0, 5803.332616749043, 5809.7966571170655, 4673.719576825401, 4989.525995030466, 5068.062408454448, 5080.161773307437, 5108.978204359143, 4106.630403263661, 4154.148399578079, 4164.3961625564725, 4180.456540649696, 4206.831726730958, 1360.4014233737123, 1375.6698392385956, 1378.8896888248917, 1380.758367285741, 1387.9306034698225, 1404.2136403614008, 1438.4893362856035, 1448.5726710620393, 1461.4081297074702, 1463.6633574277976, 8572.571371431404, 8606.913930860737, 8623.094575069654, 8631.0, 8634.395592308603, 515.2400209690676, 533.6611251855022, 539.6858649189237, 541.9783208671608, 543.9211314359475, 6254.061890716429, 6392.7123279452535, 6412.294647588761, 6447.4197322241225, 6473.385028422293, 9038.774030649287, 10342.793144137075, 10576.841347379795, 10621.5220315086, 10636.946815266028, 10300.381977081399, 10461.529231184615, 10465.215108866865, 10515.053645171818, 10546.736331591617, 8248.83502329962, 8252.669893204325, 8346.749597512084, 8394.950631171103, 8403.83192336162, 7661.195574464601, 7732.613369331623, 7787.922120778946, 7838.608069596383, 7892.408069394934, 9151.77120571991, 9502.667406640734, 9526.809463810547, 9534.713958581253, 9551.379160354554, 9718.854217186607, 9913.355631883904, 9920.950395247977, 10016.64941727036, 10086.193104551472, 7133.251008644018, 7552.320291173821, 7762.0, 7782.338501227459, 7917.722879699183, 8540.658373664985, 8598.0, 8639.0993981324, 8669.349798764992, 8690.739277821422, 5909.674967876808, 7459.030326057577, 7622.199669034893, 7624.428167887541, 7743.070831500256, 7466.477346585687, 7506.474546781891, 7539.849203016019, 7542.698292068256, 7564.319211271012, 8083.19168083187, 8135.308498777434, 8159.632816523389, 8176.100628930932, 8181.6318265677, 7269.636518174176, 7342.779716608296, 7354.191038985814, 7392.482526223328, 7401.8149546261775, 6329.430351268408, 6493.805185844432, 7287.052683151369, 7439.888401673871, 7443.181250062597], "unit": "score", "name": "mootools.html", "value": 4985.32044221841}, {"lowerIsBetter": false, "replicates": [298.41957392870864, 319.59890337626274, 343.58769476628055, 350.27318314497415, 351.21678656595776, 6043.6675982820925, 6531.281559028509, 6924.307569243073, 6975.372216500514, 6997.755078572244, 6883.5869847809045, 6892.551984121041, 6912.723491060352, 6915.481338899577, 6952.860942781142, 4809.711417314955, 4860.1494738420815, 5022.321986531808, 5047.0, 5076.771545280462, 5005.924911126336, 5014.674046186986, 5016.448190699039, 5029.924551131736, 5034.068697290994, 4334.653227741789, 4939.308496810431, 4976.825811096613, 4993.825216117437, 5031.22016087507, 4074.7962601869935, 4982.402111746577, 4982.701037937735, 5009.474005229471, 5013.724245166514, 4271.295236286009, 4285.100128972919, 4291.935620965688, 4303.268444364466, 4321.9135617287475, 6268.592541484789, 6584.868302633969, 6591.406773390418, 6626.602403855736, 6678.09845670838, 4875.658703890694, 5854.5023672987845, 5868.677222752747, 5887.70561471929, 5935.317438494585, 7348.669309881068, 7350.566639505299, 7386.741464048786, 7388.926110738931, 7391.445641576904, 4732.337472753818, 4736.0, 4746.169420351459, 4750.786214620351, 4759.357486739281, 7369.115706115247, 7694.807629809299, 7770.689172433096, 7804.063512378494, 7809.765707028741, 4604.861854144314, 4707.976460117746, 4802.73584952831, 4805.711657300573, 4817.9518204818205, 4889.65772395936, 4892.19278818998, 4898.53463920927, 4900.411950565884, 4930.235813448921, 4752.405949256343, 5862.179294898718, 5870.207521984477, 5872.0, 5887.0, 5958.46373826349, 7349.485536012535, 7352.411807055422, 7358.705651773869, 7364.0426744522865, 1675.6732437174878, 1696.143447558975, 1698.2527687817321, 1702.6594681063589, 1710.8460238578589, 1040.9895901040893, 1082.577794660083, 1094.2887123369715, 1094.9124070074374, 1098.1708809848512, 5917.31950825652, 6712.228093769181, 6738.59568425896, 6790.287019862942, 6795.626240556817, 7165.319294666998, 7626.23737626244, 7629.427792915442, 7675.0, 7685.23147685227, 5848.210491583667, 6499.38255865692, 6745.730170793211, 6765.695543700545, 6798.0, 4001.7398869073418, 4014.136960553495, 4030.0327921299263, 4041.1513582148077, 4057.0668746187953, 5818.0, 8036.919630803734, 8051.758447246592, 8055.1542088079905, 8098.838023239502, 7911.169327220674, 7943.602819858984, 7979.760607181794, 7983.8403231935035, 7987.081485629227, 6473.2232132144445, 8001.799955001055, 8004.959975200087, 8029.237222463857, 8048.476849004796, 6723.428508576826, 7066.152061752623, 7718.343940765098, 7731.806704832424, 7763.573003484863, 6576.914809056452, 6844.110265665432, 7114.608696521534, 7569.053868266466, 7598.962005189938, 8015.679372825255, 8016.95991520062, 8027.397945154254, 8042.919570804217, 8045.919540804517, 4786.8085276588545, 4842.007388485282, 4852.199387101089, 4854.834839638532, 4865.951340486691, 7326.487145899736, 7497.175310715707, 7704.537727736354, 7723.189065148304, 7729.884051739341, 7375.926240737524, 7382.778516644509, 7386.15059268191, 7400.6669699864715, 7401.888971665322, 7375.225601311785, 7381.4094872409005, 7382.298681625237, 7387.482876198615, 7399.223081576572, 6950.409215216561, 7165.3551180394015, 7186.46101542376, 7213.242609525924, 7243.0, 7359.0, 7365.9631701841145, 7385.556866588022, 7406.777796666109, 7418.777436676908, 7189.173245076883, 7194.136703595602, 7205.891911621225, 7206.71173153089, 7206.927930720835], "unit": "score", "name": "prototype.html", "value": 5314.740674840756}, {"lowerIsBetter": false, "replicates": [763.9847203055942, 792.5165648954137, 798.4849771897123, 801.0467543623088, 804.2520455975941, 15315.157666328347, 15409.229538523072, 15412.229388530584, 15508.689826203483, 15526.146061966587, 13134.21194728317, 14502.637434064154, 14511.709765804704, 14517.419303227858, 14531.055481393729, 977.3695966101877, 977.5405559387077, 992.7270000749816, 995.0646392391166, 1008.7730260691359, 955.7897262602216, 964.5611246882652, 977.9608815647366, 978.3738407419222, 998.5007496251874, 997.997013001932, 1019.0370100255262, 1019.4749703902496, 1023.7491814505456, 1037.5745944162895, 991.4992928571025, 1013.159077965287, 1014.1075853249131, 1016.1972042086779, 1036.9170466362673, 741.6996116572797, 748.711745977797, 756.527170518426, 760.7071277558125, 781.9882701759421, 13562.45750169992, 13630.454781808716, 13704.588862334145, 13706.862931370659, 13830.930845345709, 11519.654410367702, 11578.305301681927, 11746.941265293704, 11876.584319548774, 12160.939195304056, 7696.769096927045, 9836.409815411098, 11324.207305488619, 11523.59667411645, 11679.357635330054, 3713.9628603713886, 3887.067103895045, 4055.3105971984833, 4067.532233793122, 4171.91656166875, 54703.72648136734, 79069.0, 79386.0, 80181.59909200417, 80671.0, 8093.9073225115035, 8377.204165604258, 9674.613015479303, 9710.0, 9879.703608891745, 21433.89283053606, 21603.56792864134, 21651.891740541196, 21659.35021949344, 21777.0, 7581.090269167735, 7593.240675932362, 7635.541867487857, 7670.463067585327, 7799.610019499002, 4075.633193012584, 4129.607687269765, 4149.066460046465, 4172.874813755592, 4173.394857745609, 2792.2600510864636, 2828.8019838611513, 3329.716974057184, 3337.2491189482657, 3339.53246545479, 685.1367277230726, 692.6744430117836, 695.422799076765, 702.2135208566336, 709.8722229998547, 531.2295585640966, 567.5049063468645, 580.8693044065052, 604.2778879239355, 619.1053927075333, 8257.628406721711, 8366.247037766509, 8388.454750441202, 8394.748157555283, 8620.52587107715, 553.0604835300365, 576.4293349583882, 606.5481216493653, 621.3941407128013, 632.4466092169351, 3199.616046074486, 3514.753967222321, 3856.151646637735, 3909.3745000799736, 4115.485564304462, 94787.0, 95668.0, 95791.52104239434, 96770.0, 96840.0, 76425.23574764181, 77438.83841742379, 77508.51211695375, 80324.59837700774, 81113.37773244502, 71738.0, 72372.63813680898, 73049.0, 73480.0, 73660.0, 7725.49784264021, 7939.642716077675, 7969.924060252024, 7986.800329991796, 8084.353251739729, 40021.79989100036, 48525.27212091892, 48542.5145748538, 48704.0, 49203.0, 66736.66631666811, 68821.0, 69062.0, 69598.0, 69849.48212662735, 10030.247731420026, 10100.141487973604, 10193.184545236512, 10221.28451008452, 10686.839697404701, 9081.727548173565, 9932.652357167464, 10907.400092994643, 11280.32318060919, 11453.942730286295, 10153.949230253802, 10215.7446063849, 10237.590496380062, 10307.484625768531, 10476.63331783384, 10160.949195253976, 10223.1821454282, 10223.386596804216, 10344.431056291976, 10768.0, 10073.546690398804, 10211.489425528842, 10421.583136674448, 10475.371477711362, 10735.677929662123, 9066.95466522663, 9081.409708368936, 9219.49292788903, 9256.814863702823, 9317.580708868252, 7671.309582137635, 8557.700480483154, 9021.729348119567, 9132.680356187502, 9210.907890921006], "unit": "score", "name": "yui.html", "value": 6866.479476118781}], "name": "dromaeo_css", "value": 7744.027524942294}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 116.0, 116.0, 117.0, 130.0, 116.0, 115.0, 115.0, 114.0], "unit": "score", "name": "ai-astar", "value": 116.3}, {"lowerIsBetter": true, "replicates": [173.0, 151.0, 144.0, 150.0, 143.0, 173.0, 168.0, 121.0, 154.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [195.0, 195.0, 235.0, 197.0, 194.0, 197.0, 195.0, 194.0, 194.0, 196.0], "unit": "score", "name": "audio-dft", "value": 199.2}, {"lowerIsBetter": true, "replicates": [70.0, 87.0, 107.0, 161.0, 48.0, 78.0, 90.0, 90.0, 145.0, 55.0], "unit": "score", "name": "audio-fft", "value": 93.1}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 112.0, 80.0, 102.0, 82.0, 115.0, 77.0, 114.0, 152.0], "unit": "score", "name": "audio-oscillator", "value": 100.5}, {"lowerIsBetter": true, "replicates": [91.0, 87.0, 88.0, 86.0, 89.0, 101.0, 137.0, 75.0, 116.0, 132.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 100.2}, {"lowerIsBetter": true, "replicates": [151.0, 94.0, 94.0, 118.0, 98.0, 151.0, 130.0, 95.0, 104.0, 124.0], "unit": "score", "name": "imaging-darkroom", "value": 115.9}, {"lowerIsBetter": true, "replicates": [89.0, 93.0, 92.0, 92.0, 92.0, 90.0, 108.0, 94.0, 91.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 93.1}, {"lowerIsBetter": true, "replicates": [53.0, 60.0, 60.0, 80.0, 90.0, 91.0, 90.0, 94.0, 56.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 72.5}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 71.0, 66.0, 78.0, 70.0, 67.0, 64.0, 66.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [80.0, 83.0, 83.0, 84.0, 81.0, 82.0, 84.0, 109.0, 70.0, 108.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [122.0, 119.0, 130.0, 128.0, 118.0, 120.0, 120.0, 130.0, 120.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.1}, {"lowerIsBetter": true, "replicates": [137.0, 171.0, 176.0, 171.0, 133.0, 136.0, 132.0, 136.0, 135.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.3}, {"lowerIsBetter": true, "replicates": [65.0, 64.0, 67.0, 66.0, 66.0, 64.0, 81.0, 99.0, 97.0, 75.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.4}], "name": "kraken", "value": 1538.4}]} 03:13:10 INFO - Return code: 0 03:13:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:13:10 ERROR - # TBPL SUCCESS # 03:13:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:13:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:13:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:13:10 INFO - 2016-04-20 03:13:10.263 screenresolution[1680:10153] starting screenresolution argv=screenresolution get 03:13:10 INFO - 2016-04-20 03:13:10.266 screenresolution[1680:10153] Display 0: 1600x1200x32@60 03:13:10 INFO - 2016-04-20 03:13:10.272 screenresolution[1681:10156] starting screenresolution argv=screenresolution list 03:13:10 INFO - Available Modes on Display 0 03:13:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:13:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:13:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:13:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:13:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:13:10 INFO - Intel Iris: 03:13:10 INFO - Chipset Model: Intel Iris 03:13:10 INFO - Type: GPU 03:13:10 INFO - Bus: Built-In 03:13:10 INFO - VRAM (Dynamic, Max): 1536 MB 03:13:10 INFO - Vendor: Intel (0x8086) 03:13:10 INFO - Device ID: 0x0a2e 03:13:10 INFO - Revision ID: 0x0009 03:13:10 INFO - Displays: 03:13:10 INFO - Display: 03:13:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:13:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:13:10 INFO - Display Serial Number: 1600x1200 60 03:13:10 INFO - Main Display: Yes 03:13:10 INFO - Mirror: Off 03:13:10 INFO - Online: Yes 03:13:10 INFO - Rotation: Supported 03:13:10 INFO - Return code: 0 03:13:10 INFO - Running post-action listener: _resource_record_post_action 03:13:10 INFO - Running post-run listener: _resource_record_post_run 03:13:11 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 37656064; Write bytes: 664549888; Read time: 394; Write time: 1947 03:13:11 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 351707648; Write bytes: 352171520; Read time: 27122; Write time: 602 03:13:11 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 36697600; Write bytes: 300901376; Read time: 378; Write time: 1309 03:13:11 INFO - Running post-run listener: _upload_blobber_files 03:13:11 INFO - Blob upload gear active. 03:13:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:13:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:13:11 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:13:11 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:13:11 INFO - (blobuploader) - INFO - Open directory for files ... 03:13:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:13:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:13:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:13 INFO - (blobuploader) - INFO - Done attempting. 03:13:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:13:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:13:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:14 INFO - (blobuploader) - INFO - Done attempting. 03:13:14 INFO - (blobuploader) - INFO - Iteration through files over. 03:13:14 INFO - Return code: 0 03:13:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:13:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:13:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61b0645989b4ee48e2d17beaf541019d967dbd4090c313f570b2483e850d556e974c1ad02dc4f5bf5aa289b368528c257b37f83ae532d8890d585d0e039fb5d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47fd5624dc209e2e96752f6b667c7b4332cdf6a31f85651cf0b71df3188bdf34327ff1f30a6a92a49a1362f550123dbe20307cf1a7e368e2b3682bdbaa10c967"} 03:13:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:13:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:13:14 INFO - Contents: 03:13:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61b0645989b4ee48e2d17beaf541019d967dbd4090c313f570b2483e850d556e974c1ad02dc4f5bf5aa289b368528c257b37f83ae532d8890d585d0e039fb5d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47fd5624dc209e2e96752f6b667c7b4332cdf6a31f85651cf0b71df3188bdf34327ff1f30a6a92a49a1362f550123dbe20307cf1a7e368e2b3682bdbaa10c967"} 03:13:14 INFO - Running post-run listener: copy_logs_to_upload_dir 03:13:14 INFO - Copying logs to upload dir... 03:13:14 INFO - mkdir: /builds/slave/test/build/upload/logs 03:13:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.236677 ========= master_lag: 3.42 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-20 03:13:17.797682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 03:13:17.801322) ========= 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.2JvIfhNkyC/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.Lce6BYeSun/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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/Mozilla-Aurora/sha512/61b0645989b4ee48e2d17beaf541019d967dbd4090c313f570b2483e850d556e974c1ad02dc4f5bf5aa289b368528c257b37f83ae532d8890d585d0e039fb5d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47fd5624dc209e2e96752f6b667c7b4332cdf6a31f85651cf0b71df3188bdf34327ff1f30a6a92a49a1362f550123dbe20307cf1a7e368e2b3682bdbaa10c967"} build_url:https://queue.taskcluster.net/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011200 build_url: 'https://queue.taskcluster.net/v1/task/fWbnIgohQ02mIB69GOBT1Q/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/61b0645989b4ee48e2d17beaf541019d967dbd4090c313f570b2483e850d556e974c1ad02dc4f5bf5aa289b368528c257b37f83ae532d8890d585d0e039fb5d4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47fd5624dc209e2e96752f6b667c7b4332cdf6a31f85651cf0b71df3188bdf34327ff1f30a6a92a49a1362f550123dbe20307cf1a7e368e2b3682bdbaa10c967"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 03:13:17.884068) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 03:13:17.884557) ========= 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.2JvIfhNkyC/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.Lce6BYeSun/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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.005161 ========= master_lag: 0.35 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 03:13:18.242915) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 03:13:18.243233) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 03:13:18.250584) ========= ========= Total master_lag: 3.90 =========