builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0035 starttime: 1462963087.94 results: success (0) buildid: 20160510170209 builduid: 8ec55d59aa8b4e91b360aca0ab4b190b revision: f6940851d82da2fb15ab510cff1a8e0c9ce6a49b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:07.941696) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:07.942179) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:07.942505) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:07.961622) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:07.961897) ========= 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.S4K97vIQN8/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.Tikd0ok7eQ/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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-05-11 03:38:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 165M=0s 2016-05-11 03:38:08 (165 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126850 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:08.105749) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:08.106119) ========= 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.S4K97vIQN8/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.Tikd0ok7eQ/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.026064 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:08.153767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 03:38:08.154160) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f6940851d82da2fb15ab510cff1a8e0c9ce6a49b --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-beta --rev f6940851d82da2fb15ab510cff1a8e0c9ce6a49b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.S4K97vIQN8/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.Tikd0ok7eQ/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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-05-11 03:38:08,232 truncating revision to first 12 chars 2016-05-11 03:38:08,232 Setting DEBUG logging. 2016-05-11 03:38:08,232 attempt 1/10 2016-05-11 03:38:08,232 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f6940851d82d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-11 03:38:09,529 unpacking tar archive at: mozilla-beta-f6940851d82d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.546292 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-11 03:38:09.716800) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:09.717126) ========= script_repo_revision: f6940851d82da2fb15ab510cff1a8e0c9ce6a49b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:09.717488) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:09.717745) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-11 03:38:09.730527) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-11 03:38:09.730790) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.S4K97vIQN8/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.Tikd0ok7eQ/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:38:09 INFO - MultiFileLogger online at 20160511 03:38:09 in /builds/slave/test 03:38:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 03:38:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:38:09 INFO - {'append_to_log': False, 03:38:09 INFO - 'base_work_dir': '/builds/slave/test', 03:38:09 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:38:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:38:09 INFO - 'branch': 'Mozilla-Beta', 03:38:09 INFO - 'buildbot_json_path': 'buildprops.json', 03:38:09 INFO - 'config_files': ('talos/mac_config.py',), 03:38:09 INFO - 'default_actions': ('clobber', 03:38:09 INFO - 'read-buildbot-config', 03:38:09 INFO - 'download-and-extract', 03:38:09 INFO - 'populate-webroot', 03:38:09 INFO - 'create-virtualenv', 03:38:09 INFO - 'install', 03:38:09 INFO - 'run-tests'), 03:38:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:38:09 INFO - 'download_minidump_stackwalk': True, 03:38:09 INFO - 'download_symbols': 'ondemand', 03:38:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:38:09 INFO - 'tooltool.py': '/tools/tooltool.py', 03:38:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:38:09 INFO - '/tools/misc-python/virtualenv.py')}, 03:38:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:38:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:38:09 INFO - 'installer_path': 'installer.exe', 03:38:09 INFO - 'log_level': 'info', 03:38:09 INFO - 'log_name': 'talos', 03:38:09 INFO - 'log_to_console': True, 03:38:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:38:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:38:09 INFO - 'opt_config_files': (), 03:38:09 INFO - 'pip_index': False, 03:38:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:38:09 INFO - 'cmd': ('bash', 03:38:09 INFO - '-c', 03:38:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:38:09 INFO - 'enabled': True, 03:38:09 INFO - 'halt_on_failure': False, 03:38:09 INFO - 'name': 'check_screen_resolution'},), 03:38:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:38:09 INFO - 'cmd': ('bash', 03:38:09 INFO - '-c', 03:38:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:38:09 INFO - 'enabled': True, 03:38:09 INFO - 'halt_on_failure': False, 03:38:09 INFO - 'name': 'check_screen_resolution'},), 03:38:09 INFO - 'run_cmd_checks_enabled': True, 03:38:09 INFO - 'sps_profile': False, 03:38:09 INFO - 'sps_profile_interval': 0, 03:38:09 INFO - 'suite': 'dromaeojs', 03:38:09 INFO - 'system_bits': '32', 03:38:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:38:09 INFO - 'title': 't-yosemite-r7-0035', 03:38:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:38:09 INFO - 'use_talos_json': True, 03:38:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:38:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:38:09 INFO - 'work_dir': 'build'} 03:38:09 INFO - ##### 03:38:09 INFO - ##### Running clobber step. 03:38:09 INFO - ##### 03:38:09 INFO - Running pre-action listener: _resource_record_pre_action 03:38:09 INFO - Running main action method: clobber 03:38:09 INFO - rmtree: /builds/slave/test/build 03:38:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:38:11 INFO - Running post-action listener: _resource_record_post_action 03:38:11 INFO - ##### 03:38:11 INFO - ##### Running read-buildbot-config step. 03:38:11 INFO - ##### 03:38:11 INFO - Running pre-action listener: _resource_record_pre_action 03:38:11 INFO - Running main action method: read_buildbot_config 03:38:11 INFO - Using buildbot properties: 03:38:11 INFO - { 03:38:11 INFO - "project": "", 03:38:11 INFO - "product": "firefox", 03:38:11 INFO - "script_repo_revision": "production", 03:38:11 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 03:38:11 INFO - "repository": "", 03:38:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 03:38:11 INFO - "buildid": "20160510170209", 03:38:11 INFO - "pgo_build": "False", 03:38:11 INFO - "basedir": "/builds/slave/test", 03:38:11 INFO - "buildnumber": 2, 03:38:11 INFO - "slavename": "t-yosemite-r7-0035", 03:38:11 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:38:11 INFO - "platform": "yosemite_r7", 03:38:11 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 03:38:11 INFO - "branch": "mozilla-beta", 03:38:11 INFO - "repo_path": "releases/mozilla-beta", 03:38:11 INFO - "revision": "f6940851d82da2fb15ab510cff1a8e0c9ce6a49b", 03:38:11 INFO - "stage_platform": "macosx64", 03:38:11 INFO - "builduid": "8ec55d59aa8b4e91b360aca0ab4b190b", 03:38:11 INFO - "slavebuilddir": "test" 03:38:11 INFO - } 03:38:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 03:38:11 INFO - Running post-action listener: _resource_record_post_action 03:38:11 INFO - ##### 03:38:11 INFO - ##### Running download-and-extract step. 03:38:11 INFO - ##### 03:38:11 INFO - Running pre-action listener: _resource_record_pre_action 03:38:11 INFO - Running main action method: download_and_extract 03:38:11 INFO - mkdir: /builds/slave/test/build/tests 03:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:11 INFO - https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:38:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 03:38:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 03:38:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 03:38:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 03:38:13 INFO - Downloaded 1241 bytes. 03:38:13 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 03:38:13 INFO - Using the following test package requirements: 03:38:13 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 03:38:13 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 03:38:13 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 03:38:13 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 03:38:13 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 03:38:13 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 03:38:13 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 03:38:13 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 03:38:13 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 03:38:13 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 03:38:13 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 03:38:13 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 03:38:13 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 03:38:13 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 03:38:13 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 03:38:13 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 03:38:13 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 03:38:13 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 03:38:13 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 03:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:13 INFO - https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:38:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 03:38:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 03:38:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 03:38:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 03:38:14 INFO - Downloaded 17747453 bytes. 03:38:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:38:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:38:17 INFO - Return code: 0 03:38:17 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 03:38: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')]} 03:38:17 INFO - https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:38:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 03:38:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 03:38:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 03:38:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 03:38:18 INFO - Downloaded 17747453 bytes. 03:38:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:38:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:38:21 INFO - Return code: 0 03:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:21 INFO - https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:38:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 03:38:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 03:38:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 03:38:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 03:38:22 INFO - Downloaded 10845194 bytes. 03:38:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:38:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:38:23 INFO - Return code: 0 03:38: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')]} 03:38:23 INFO - https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 03:38:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 03:38:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 03:38:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 03:38:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 03:38:25 INFO - Downloaded 88362263 bytes. 03:38:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 03:38:25 INFO - mkdir: /builds/slave/test/properties 03:38:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:38:25 INFO - Writing to file /builds/slave/test/properties/build_url 03:38:25 INFO - Contents: 03:38:25 INFO - build_url:https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg 03:38:26 INFO - Running post-action listener: _resource_record_post_action 03:38:26 INFO - Running post-action listener: set_extra_try_arguments 03:38:26 INFO - ##### 03:38:26 INFO - ##### Running populate-webroot step. 03:38:26 INFO - ##### 03:38:26 INFO - Running pre-action listener: _resource_record_pre_action 03:38:26 INFO - Running main action method: populate_webroot 03:38:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:38:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:38:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:38:26 INFO - '--tppagecycles', 03:38:26 INFO - '7'], 03:38:26 INFO - 'tests': ['tsvgm']}}, 03:38:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:38:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:38:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:38:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:38:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:38:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:38:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:26 INFO - 'talos_options': ['--e10s'], 03:38:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:26 INFO - 'tests': ['damp', 'tps']}, 03:38:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:26 INFO - 'talos_options': ['--e10s'], 03:38:26 INFO - 'tests': ['damp', 'tps']}, 03:38:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:38:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:38:26 INFO - 'other': {'tests': ['a11yr', 03:38:26 INFO - 'ts_paint', 03:38:26 INFO - 'tpaint', 03:38:26 INFO - 'sessionrestore', 03:38:26 INFO - 'sessionrestore_no_auto_restore', 03:38:26 INFO - 'tabpaint']}, 03:38:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:38:26 INFO - 'tests': ['a11yr', 03:38:26 INFO - 'ts_paint', 03:38:26 INFO - 'tpaint', 03:38:26 INFO - 'sessionrestore', 03:38:26 INFO - 'sessionrestore_no_auto_restore', 03:38:26 INFO - 'tabpaint']}, 03:38:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:38:26 INFO - 'tests': ['a11yr', 03:38:26 INFO - 'ts_paint', 03:38:26 INFO - 'tpaint', 03:38:26 INFO - 'sessionrestore', 03:38:26 INFO - 'sessionrestore_no_auto_restore', 03:38:26 INFO - 'tabpaint']}, 03:38:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:38:26 INFO - 'tests': ['a11yr', 03:38:26 INFO - 'ts_paint', 03:38:26 INFO - 'tpaint', 03:38:26 INFO - 'sessionrestore', 03:38:26 INFO - 'sessionrestore_no_auto_restore', 03:38:26 INFO - 'tabpaint']}, 03:38:26 INFO - 'other_l64': {'tests': ['a11yr', 03:38:26 INFO - 'ts_paint', 03:38:26 INFO - 'tpaint', 03:38:26 INFO - 'sessionrestore', 03:38:26 INFO - 'sessionrestore_no_auto_restore', 03:38:26 INFO - 'tabpaint']}, 03:38:26 INFO - 'other_nol64': {'tests': ['a11yr', 03:38:26 INFO - 'ts_paint', 03:38:26 INFO - 'tpaint', 03:38:26 INFO - 'sessionrestore', 03:38:26 INFO - 'sessionrestore_no_auto_restore', 03:38:26 INFO - 'tabpaint']}, 03:38:26 INFO - 'svgr': {'tests': ['tsvgx', 03:38:26 INFO - 'tsvgr_opacity', 03:38:26 INFO - 'tart', 03:38:26 INFO - 'tscrollx', 03:38:26 INFO - 'cart']}, 03:38:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:38:26 INFO - 'tests': ['tsvgx', 03:38:26 INFO - 'tsvgr_opacity', 03:38:26 INFO - 'tart', 03:38:26 INFO - 'tscrollx', 03:38:26 INFO - 'cart']}, 03:38:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:26 INFO - 'tests': ['tp5o']}, 03:38:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:26 INFO - 'talos_options': ['--e10s'], 03:38:26 INFO - 'tests': ['tp5o']}, 03:38:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:26 INFO - 'talos_options': ['--xperf_path', 03:38:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:26 INFO - 'tests': ['tp5n']}, 03:38:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:38:26 INFO - 'talos_options': ['--e10s', 03:38:26 INFO - '--xperf_path', 03:38:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:26 INFO - 'tests': ['tp5n']}}, 03:38:26 INFO - 'talos.zip': {'path': '', 03:38:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:38:26 INFO - Running post-action listener: _resource_record_post_action 03:38:26 INFO - ##### 03:38:26 INFO - ##### Running create-virtualenv step. 03:38:26 INFO - ##### 03:38:26 INFO - Running pre-action listener: _resource_record_pre_action 03:38:26 INFO - Running main action method: create_virtualenv 03:38:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:38:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:38:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:38:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:38:26 INFO - Using real prefix '/tools/python27' 03:38:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:38:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:38:30 INFO - Installing pip.................done. 03:38:30 INFO - Return code: 0 03:38:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:30 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 0x102f90a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bad6b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e34d30>, '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 0x102c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e2bb20>, '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.S4K97vIQN8/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.Tikd0ok7eQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:38:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4K97vIQN8/Render', 03:38:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:30 INFO - 'HOME': '/Users/cltbld', 03:38:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:30 INFO - 'LOGNAME': 'cltbld', 03:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:30 INFO - 'MOZ_NO_REMOTE': '1', 03:38:30 INFO - 'NO_EM_RESTART': '1', 03:38:30 INFO - 'PAGER': '/bin/cat', 03:38:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:30 INFO - 'PWD': '/builds/slave/test', 03:38:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:30 INFO - 'SHELL': '/bin/bash', 03:38:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tikd0ok7eQ/Listeners', 03:38:30 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:38:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:30 INFO - 'USER': 'cltbld', 03:38:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:30 INFO - 'XPC_FLAGS': '0x0', 03:38:30 INFO - 'XPC_SERVICE_NAME': '0', 03:38:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:38:30 INFO - Cleaning up... 03:38:30 INFO - Return code: 0 03:38:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:30 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 0x102f90a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bad6b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e34d30>, '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 0x102c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e2bb20>, '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.S4K97vIQN8/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.Tikd0ok7eQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:30 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 03:38:30 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 03:38:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4K97vIQN8/Render', 03:38:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:30 INFO - 'HOME': '/Users/cltbld', 03:38:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:30 INFO - 'LOGNAME': 'cltbld', 03:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:30 INFO - 'MOZ_NO_REMOTE': '1', 03:38:30 INFO - 'NO_EM_RESTART': '1', 03:38:30 INFO - 'PAGER': '/bin/cat', 03:38:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:30 INFO - 'PWD': '/builds/slave/test', 03:38:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:30 INFO - 'SHELL': '/bin/bash', 03:38:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tikd0ok7eQ/Listeners', 03:38:30 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:38:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:30 INFO - 'USER': 'cltbld', 03:38:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:30 INFO - 'XPC_FLAGS': '0x0', 03:38:30 INFO - 'XPC_SERVICE_NAME': '0', 03:38:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:30 INFO - Downloading/unpacking psutil>=0.7.1 03:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:38:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:33 INFO - Installing collected packages: psutil 03:38:33 INFO - Running setup.py install for psutil 03:38:33 INFO - building 'psutil._psutil_osx' extension 03:38:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:38:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:38:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:38:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:38:34 INFO - building 'psutil._psutil_posix' extension 03:38:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:38:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:38:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:38:34 INFO - ^ 03:38:34 INFO - 1 warning generated. 03:38:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:38:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:38:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:38:34 INFO - Successfully installed psutil 03:38:34 INFO - Cleaning up... 03:38:34 INFO - Return code: 0 03:38:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:34 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 0x102f90a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bad6b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e34d30>, '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 0x102c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e2bb20>, '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.S4K97vIQN8/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.Tikd0ok7eQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:34 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 03:38:34 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 03:38:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4K97vIQN8/Render', 03:38:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:34 INFO - 'HOME': '/Users/cltbld', 03:38:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:34 INFO - 'LOGNAME': 'cltbld', 03:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:34 INFO - 'MOZ_NO_REMOTE': '1', 03:38:34 INFO - 'NO_EM_RESTART': '1', 03:38:34 INFO - 'PAGER': '/bin/cat', 03:38:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:34 INFO - 'PWD': '/builds/slave/test', 03:38:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:34 INFO - 'SHELL': '/bin/bash', 03:38:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tikd0ok7eQ/Listeners', 03:38:34 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:38:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:34 INFO - 'USER': 'cltbld', 03:38:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:34 INFO - 'XPC_FLAGS': '0x0', 03:38:34 INFO - 'XPC_SERVICE_NAME': '0', 03:38:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:38:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:38:37 INFO - Installing collected packages: mozsystemmonitor 03:38:37 INFO - Running setup.py install for mozsystemmonitor 03:38:37 INFO - Successfully installed mozsystemmonitor 03:38:37 INFO - Cleaning up... 03:38:37 INFO - Return code: 0 03:38:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:38: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')]} 03:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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')]} 03:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38: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', '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 0x102f90a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bad6b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e34d30>, '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 0x102c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e2bb20>, '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.S4K97vIQN8/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.Tikd0ok7eQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:38: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 blobuploader==1.2.4 03:38:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4K97vIQN8/Render', 03:38:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:37 INFO - 'HOME': '/Users/cltbld', 03:38:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:37 INFO - 'LOGNAME': 'cltbld', 03:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:37 INFO - 'MOZ_NO_REMOTE': '1', 03:38:37 INFO - 'NO_EM_RESTART': '1', 03:38:37 INFO - 'PAGER': '/bin/cat', 03:38:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:37 INFO - 'PWD': '/builds/slave/test', 03:38:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:37 INFO - 'SHELL': '/bin/bash', 03:38:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tikd0ok7eQ/Listeners', 03:38:37 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:38:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:37 INFO - 'USER': 'cltbld', 03:38:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:37 INFO - 'XPC_FLAGS': '0x0', 03:38:37 INFO - 'XPC_SERVICE_NAME': '0', 03:38:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:38 INFO - Downloading/unpacking blobuploader==1.2.4 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38:40 INFO - Downloading blobuploader-1.2.4.tar.gz 03:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:38:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:38:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:41 INFO - Downloading docopt-0.6.1.tar.gz 03:38:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:38:41 INFO - Installing collected packages: blobuploader, requests, docopt 03:38:41 INFO - Running setup.py install for blobuploader 03:38:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:38:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:38:41 INFO - Running setup.py install for requests 03:38:42 INFO - Running setup.py install for docopt 03:38:42 INFO - Successfully installed blobuploader requests docopt 03:38:42 INFO - Cleaning up... 03:38:42 INFO - Return code: 0 03:38:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:42 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 0x102f90a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bad6b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e34d30>, '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 0x102c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e2bb20>, '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.S4K97vIQN8/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.Tikd0ok7eQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:38:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:38:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4K97vIQN8/Render', 03:38:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:42 INFO - 'HOME': '/Users/cltbld', 03:38:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:42 INFO - 'LOGNAME': 'cltbld', 03:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:42 INFO - 'MOZ_NO_REMOTE': '1', 03:38:42 INFO - 'NO_EM_RESTART': '1', 03:38:42 INFO - 'PAGER': '/bin/cat', 03:38:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:42 INFO - 'PWD': '/builds/slave/test', 03:38:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:42 INFO - 'SHELL': '/bin/bash', 03:38:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tikd0ok7eQ/Listeners', 03:38:42 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:38:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:42 INFO - 'USER': 'cltbld', 03:38:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:42 INFO - 'XPC_FLAGS': '0x0', 03:38:42 INFO - 'XPC_SERVICE_NAME': '0', 03:38:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:38:42 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-mg3YQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:38:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-wN9jjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:38:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-nL9rpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:38:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-kPPCdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:38:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-Oy4N1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:38:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-wq12Aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:38:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-gXPUee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:38:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-o5c_h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:38:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-z14PDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:38:43 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-Zxtnku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:38:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:38:44 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-h5RaGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:38:44 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-prjEOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:38:44 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-D5H0FI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:38:44 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-hggNv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:44 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-o0EfEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:38:44 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-iIg98A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:38:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:38:44 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-rUi7n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:38:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:38:44 INFO - Running setup.py install for manifestparser 03:38:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:38:44 INFO - Running setup.py install for mozcrash 03:38:45 INFO - Running setup.py install for mozdebug 03:38:45 INFO - Running setup.py install for mozdevice 03:38:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:38:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:38:45 INFO - Running setup.py install for mozfile 03:38:45 INFO - Running setup.py install for mozhttpd 03:38:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:38:45 INFO - Running setup.py install for mozinfo 03:38:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:38:45 INFO - Running setup.py install for mozInstall 03:38:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:38:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:38:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:38:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:38:45 INFO - Running setup.py install for mozleak 03:38:46 INFO - Running setup.py install for mozlog 03:38:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:38:46 INFO - Running setup.py install for moznetwork 03:38:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:38:46 INFO - Running setup.py install for mozprocess 03:38:46 INFO - Running setup.py install for mozprofile 03:38:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:38:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:38:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:38:46 INFO - Running setup.py install for mozrunner 03:38:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:38:46 INFO - Running setup.py install for mozscreenshot 03:38:46 INFO - Running setup.py install for moztest 03:38:47 INFO - Running setup.py install for mozversion 03:38:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:38:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:38:47 INFO - Cleaning up... 03:38:47 INFO - Return code: 0 03:38:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:47 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 0x102f90a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bad6b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e34d30>, '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 0x102c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e2bb20>, '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.S4K97vIQN8/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.Tikd0ok7eQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:38:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4K97vIQN8/Render', 03:38:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:47 INFO - 'HOME': '/Users/cltbld', 03:38:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:47 INFO - 'LOGNAME': 'cltbld', 03:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:47 INFO - 'MOZ_NO_REMOTE': '1', 03:38:47 INFO - 'NO_EM_RESTART': '1', 03:38:47 INFO - 'PAGER': '/bin/cat', 03:38:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:47 INFO - 'PWD': '/builds/slave/test', 03:38:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:47 INFO - 'SHELL': '/bin/bash', 03:38:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tikd0ok7eQ/Listeners', 03:38:47 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:38:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:47 INFO - 'USER': 'cltbld', 03:38:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:47 INFO - 'XPC_FLAGS': '0x0', 03:38:47 INFO - 'XPC_SERVICE_NAME': '0', 03:38:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:38:47 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-hyxnVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:38:47 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ud1zoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:38:47 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-Ilx7tU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:38:47 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-YYduTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:38:47 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-gEE4Q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:38:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:38:48 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-cglFGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:38:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:38:48 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-n6Nxw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:38:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:38:48 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-axE2ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:38:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:38:48 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-a4yguO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:38:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:38:48 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-eQBt1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:38:48 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)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:38:48 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-WBo_5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:38:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:38:48 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-EfmO1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:38:48 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)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:38:48 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-5OT1Dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:38:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:38:48 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-5Evwsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:38:49 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)) 03:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:49 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-dS4YnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:38:49 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-8v5h71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:38:49 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-HE36sI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:38:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:38:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:51 INFO - Downloading blessings-1.6.tar.gz 03:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:38:51 INFO - Installing collected packages: blessings 03:38:51 INFO - Running setup.py install for blessings 03:38:52 INFO - Successfully installed blessings 03:38:52 INFO - Cleaning up... 03:38:52 INFO - Return code: 0 03:38:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:38:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:38:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:38:52 INFO - Reading from file tmpfile_stdout 03:38:52 INFO - Current package versions: 03:38:52 INFO - blessings == 1.6 03:38:52 INFO - blobuploader == 1.2.4 03:38:52 INFO - docopt == 0.6.1 03:38:52 INFO - manifestparser == 1.1 03:38:52 INFO - mozInstall == 1.12 03:38:52 INFO - mozcrash == 0.17 03:38:52 INFO - mozdebug == 0.1 03:38:52 INFO - mozdevice == 0.48 03:38:52 INFO - mozfile == 1.2 03:38:52 INFO - mozhttpd == 0.7 03:38:52 INFO - mozinfo == 0.9 03:38:52 INFO - mozleak == 0.1 03:38:52 INFO - mozlog == 3.1 03:38:52 INFO - moznetwork == 0.27 03:38:52 INFO - mozprocess == 0.22 03:38:52 INFO - mozprofile == 0.28 03:38:52 INFO - mozrunner == 6.11 03:38:52 INFO - mozscreenshot == 0.1 03:38:52 INFO - mozsystemmonitor == 0.0 03:38:52 INFO - moztest == 0.7 03:38:52 INFO - mozversion == 1.4 03:38:52 INFO - psutil == 3.1.1 03:38:52 INFO - requests == 1.2.3 03:38:52 INFO - wsgiref == 0.1.2 03:38:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:52 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 0x102f90a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bad6b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e34d30>, '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 0x102c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e2bb20>, '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.S4K97vIQN8/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.Tikd0ok7eQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:38:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:38:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4K97vIQN8/Render', 03:38:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:52 INFO - 'HOME': '/Users/cltbld', 03:38:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:52 INFO - 'LOGNAME': 'cltbld', 03:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:52 INFO - 'MOZ_NO_REMOTE': '1', 03:38:52 INFO - 'NO_EM_RESTART': '1', 03:38:52 INFO - 'PAGER': '/bin/cat', 03:38:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:52 INFO - 'PWD': '/builds/slave/test', 03:38:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:52 INFO - 'SHELL': '/bin/bash', 03:38:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tikd0ok7eQ/Listeners', 03:38:52 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:38:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:52 INFO - 'USER': 'cltbld', 03:38:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:52 INFO - 'XPC_FLAGS': '0x0', 03:38:52 INFO - 'XPC_SERVICE_NAME': '0', 03:38:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:38:52 INFO - Cleaning up... 03:38:52 INFO - Return code: 0 03:38:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:52 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 0x102f90a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bad6b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e34d30>, '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 0x102c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e2bb20>, '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.S4K97vIQN8/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.Tikd0ok7eQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:38:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:38:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4K97vIQN8/Render', 03:38:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:52 INFO - 'HOME': '/Users/cltbld', 03:38:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:52 INFO - 'LOGNAME': 'cltbld', 03:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:52 INFO - 'MOZ_NO_REMOTE': '1', 03:38:52 INFO - 'NO_EM_RESTART': '1', 03:38:52 INFO - 'PAGER': '/bin/cat', 03:38:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:52 INFO - 'PWD': '/builds/slave/test', 03:38:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:52 INFO - 'SHELL': '/bin/bash', 03:38:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tikd0ok7eQ/Listeners', 03:38:52 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:38:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:52 INFO - 'USER': 'cltbld', 03:38:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:52 INFO - 'XPC_FLAGS': '0x0', 03:38:52 INFO - 'XPC_SERVICE_NAME': '0', 03:38:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:52 INFO - Downloading/unpacking jsonschema 03:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:38:55 INFO - Downloading/unpacking functools32 (from jsonschema) 03:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:55 INFO - Downloading functools32-3.2.3-2.tar.gz 03:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:38:55 INFO - warning: no files found matching '*.txt' 03:38:55 INFO - no previously-included directories found matching 'build' 03:38:55 INFO - no previously-included directories found matching 'dist' 03:38:55 INFO - no previously-included directories found matching '.git*' 03:38:55 INFO - Installing collected packages: jsonschema, functools32 03:38:55 INFO - Running setup.py install for functools32 03:38:56 INFO - warning: no files found matching '*.txt' 03:38:56 INFO - no previously-included directories found matching 'build' 03:38:56 INFO - no previously-included directories found matching 'dist' 03:38:56 INFO - no previously-included directories found matching '.git*' 03:38:56 INFO - Successfully installed jsonschema functools32 03:38:56 INFO - Cleaning up... 03:38:56 INFO - Return code: 0 03:38:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:38:56 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 0x102f90a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f974c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87bad6b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e34d30>, '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 0x102c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e2bb20>, '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.S4K97vIQN8/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.Tikd0ok7eQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:38:56 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 03:38:56 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 03:38:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4K97vIQN8/Render', 03:38:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:56 INFO - 'HOME': '/Users/cltbld', 03:38:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:56 INFO - 'LOGNAME': 'cltbld', 03:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:56 INFO - 'MOZ_NO_REMOTE': '1', 03:38:56 INFO - 'NO_EM_RESTART': '1', 03:38:56 INFO - 'PAGER': '/bin/cat', 03:38:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:56 INFO - 'PWD': '/builds/slave/test', 03:38:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:56 INFO - 'SHELL': '/bin/bash', 03:38:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tikd0ok7eQ/Listeners', 03:38:56 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:38:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:56 INFO - 'USER': 'cltbld', 03:38:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:56 INFO - 'XPC_FLAGS': '0x0', 03:38:56 INFO - 'XPC_SERVICE_NAME': '0', 03:38:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:38:56 INFO - Downloading/unpacking flake8 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38: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 03:38:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:38:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:38:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:38:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:38:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:39:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:39:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:39:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:39:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:39:00 INFO - no previously-included directories found matching 'docs/_build' 03:39:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:39:00 INFO - Running setup.py install for pep8 03:39:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:39:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:39:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:39:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:39:00 INFO - no previously-included directories found matching 'docs/_build' 03:39:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:39:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:39:00 INFO - Cleaning up... 03:39:00 INFO - Return code: 0 03:39:00 INFO - Running post-action listener: _resource_record_post_action 03:39:00 INFO - Running post-action listener: _start_resource_monitoring 03:39:00 INFO - Starting resource monitoring. 03:39:00 INFO - ##### 03:39:00 INFO - ##### Running install step. 03:39:00 INFO - ##### 03:39:00 INFO - Running pre-action listener: _resource_record_pre_action 03:39:00 INFO - Running main action method: install 03:39:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:39:00 INFO - Reading from file tmpfile_stdout 03:39:00 INFO - Detecting whether we're running mozinstall >=1.0... 03:39:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:39:00 INFO - Reading from file tmpfile_stdout 03:39:00 INFO - Output received: 03:39:00 INFO - Usage: mozinstall [options] installer 03:39:00 INFO - Options: 03:39:00 INFO - -h, --help show this help message and exit 03:39:00 INFO - -d DEST, --destination=DEST 03:39:00 INFO - Directory to install application into. [default: 03:39:00 INFO - "/builds/slave/test"] 03:39:00 INFO - --app=APP Application being installed. [default: firefox] 03:39:00 INFO - mkdir: /builds/slave/test/build/application 03:39:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 03:39:23 INFO - Reading from file tmpfile_stdout 03:39:23 INFO - Output received: 03:39:23 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 03:39:23 INFO - Running post-action listener: _resource_record_post_action 03:39:23 INFO - ##### 03:39:23 INFO - ##### Running run-tests step. 03:39:23 INFO - ##### 03:39:23 INFO - Running pre-action listener: _resource_record_pre_action 03:39:23 INFO - Running main action method: run_tests 03:39:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:39:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:39:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:39:23 INFO - 2016-05-11 03:39:23.294 screenresolution[1691:7662] starting screenresolution argv=screenresolution get 03:39:23 INFO - 2016-05-11 03:39:23.297 screenresolution[1691:7662] Display 0: 1600x1200x32@60 03:39:23 INFO - 2016-05-11 03:39:23.302 screenresolution[1692:7664] starting screenresolution argv=screenresolution list 03:39:23 INFO - Available Modes on Display 0 03:39:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:39:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:39:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:39:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:39:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:39:23 INFO - Intel Iris: 03:39:23 INFO - Chipset Model: Intel Iris 03:39:23 INFO - Type: GPU 03:39:23 INFO - Bus: Built-In 03:39:23 INFO - VRAM (Dynamic, Max): 1536 MB 03:39:23 INFO - Vendor: Intel (0x8086) 03:39:23 INFO - Device ID: 0x0a2e 03:39:23 INFO - Revision ID: 0x0009 03:39:23 INFO - Displays: 03:39:23 INFO - Display: 03:39:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:39:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:39:23 INFO - Display Serial Number: 1600x1200 60 03:39:23 INFO - Main Display: Yes 03:39:23 INFO - Mirror: Off 03:39:23 INFO - Online: Yes 03:39:23 INFO - Rotation: Supported 03:39:23 INFO - Return code: 0 03:39:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:39:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:39:23 INFO - Python 2.7.3 03:39:23 INFO - Return code: 0 03:39:23 INFO - grabbing minidump binary from tooltool 03:39: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')]} 03:39:23 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 0x102e34d30>, '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 0x102c98db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e2bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:39:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:39:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:39:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:39:23 INFO - Return code: 0 03:39:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:39:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:39:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:39:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:39:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:39:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:39:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:39:24 INFO - Return code: 0 03:39:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:39:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S4K97vIQN8/Render', 03:39:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:24 INFO - 'HOME': '/Users/cltbld', 03:39:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:24 INFO - 'LOGNAME': 'cltbld', 03:39:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:39:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:24 INFO - 'MOZ_NO_REMOTE': '1', 03:39:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:39:24 INFO - 'NO_EM_RESTART': '1', 03:39:24 INFO - 'PAGER': '/bin/cat', 03:39:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:24 INFO - 'PWD': '/builds/slave/test', 03:39:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:39:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:24 INFO - 'SHELL': '/bin/bash', 03:39:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tikd0ok7eQ/Listeners', 03:39:24 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 03:39:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:24 INFO - 'USER': 'cltbld', 03:39:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:24 INFO - 'XPC_FLAGS': '0x0', 03:39:24 INFO - 'XPC_SERVICE_NAME': '0', 03:39:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:39:25 INFO - mozversion application_buildid: 20160510170209 03:39:25 INFO - mozversion application_changeset: f6940851d82da2fb15ab510cff1a8e0c9ce6a49b 03:39:25 INFO - mozversion application_display_name: Firefox 03:39:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:39:25 INFO - mozversion application_name: Firefox 03:39:25 INFO - mozversion application_remotingname: firefox 03:39:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:39:25 INFO - mozversion application_vendor: Mozilla 03:39:25 INFO - mozversion application_version: 47.0 03:39:25 INFO - mozversion platform_buildid: 20160510170209 03:39:25 INFO - mozversion platform_changeset: f6940851d82da2fb15ab510cff1a8e0c9ce6a49b 03:39:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:39:25 INFO - mozversion platform_version: 47.0 03:39:25 INFO - using testdate: 1462963165 03:39:25 INFO - actual date: 1462963165 03:39:25 INFO - starting webserver on 'localhost:49275' 03:39:25 INFO - SUITE-START | Running 2 tests 03:39:25 INFO - TEST-START | dromaeo_css 03:39:25 INFO - operating with platform_type : mac_ 03:39:25 INFO - Initialising browser for dromaeo_css test... 03:39:25 INFO - TEST-INFO | started process 1710 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpefT9sA/profile http://localhost:49275/getInfo.html) 03:39:27 INFO - PROCESS | 1710 | __metrics Screen width/height:1600/1200 03:39:27 INFO - PROCESS | 1710 | colorDepth:24 03:39:27 INFO - PROCESS | 1710 | Browser inner width/height: 1024/689 03:39:27 INFO - PROCESS | 1710 | __metrics 03:39:27 INFO - PROCESS | 1710 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:39:27 INFO - PROCESS | 1710 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:39:28 INFO - TEST-INFO | 1710: exit 0 03:39:28 INFO - Browser initialized. 03:39:28 INFO - Running cycle 1/1 for dromaeo_css test... 03:39:28 INFO - TEST-INFO | started process 1713 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpefT9sA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:39 INFO - PROCESS | 1713 | RSS: Main: 156934144 03:39:39 INFO - PROCESS | 1713 | 03:40:30 INFO - PROCESS | 1713 | 1462963230793 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:42:41 INFO - PROCESS | 1713 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 03:42:42 INFO - PROCESS | 1713 | RSS: Main: 265633792 03:42:42 INFO - PROCESS | 1713 | 03:45:44 INFO - PROCESS | 1713 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 03:45:45 INFO - PROCESS | 1713 | RSS: Main: 289656832 03:45:45 INFO - PROCESS | 1713 | 03:48:46 INFO - PROCESS | 1713 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 03:48:47 INFO - PROCESS | 1713 | RSS: Main: 299388928 03:48:47 INFO - PROCESS | 1713 | 03:51:49 INFO - PROCESS | 1713 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 03:51:50 INFO - PROCESS | 1713 | RSS: Main: 257409024 03:51:50 INFO - PROCESS | 1713 | 03:54:53 INFO - PROCESS | 1713 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 03:54:53 INFO - PROCESS | 1713 | RSS: Main: 254111744 03:54:53 INFO - PROCESS | 1713 | 03:57:56 INFO - PROCESS | 1713 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 03:57:56 INFO - PROCESS | 1713 | RSS: Main: 305156096 03:57:56 INFO - PROCESS | 1713 | 03:57:56 INFO - PROCESS | 1713 | __start_tp_report 03:57:56 INFO - PROCESS | 1713 | _x_x_mozilla_page_load 03:57:56 INFO - PROCESS | 1713 | _x_x_mozilla_page_load_details 03:57:56 INFO - PROCESS | 1713 | |i|pagename|runs| 03:57:56 INFO - PROCESS | 1713 | |0;dojo.html;3530.7351948603855;3605.2248766515195;3608.386574282372;3628.292482965821;3670.706343492521;5892.587518873681;5903.557233207511;5911.320198177211;5911.511655133588;5959.731812068462;5858.297004359472;5898.085796701507;5912.526997840173;5925.585209035369;5933.13969474426;5249.107651699202;5304.389995150568;5316.9734151329185;5391.218273350361;5446.645968012086;5431.972840135793;5444.972775136119;5445.591580631469;5454.318210223722;5464.726763661821;5376.623636345457;5411.675299482024;5428.782848686048;5431.891362172754;5439.3200849893765;5440.782368705247;5443.673379597237;5450.29146210992;5461.590380721462;5526.889462210774;5228;5400.973814975142;5408.513233808937;5410.08028635133;5411.242426060355;5773.336066352381;5803.680797556132;5807.88384232313;5818.040023396177;5860.062390017577;6203.131561581382;6308.526860485482;6309.495240380758;6311.2426508819235;6314.494840412756;6255.530835187379;6258.843528911768;6285.0886621440095;6304.936950630481;6361.395667411589;6053.939460605426;6079.513638908877;6097.512199024068;6104.328523862371;6115.816525504242;5620.1288800236025;6526.2494813096155;6527.5757075789925;6533.869322613521;6539;6181.907271390933;6232.189815323979;6351.04734289851;6353.396427339396;6358.968205159037;6311.905321420182;6334.144890439824;6335.873282534323;6337.873242535124;6362.045693146065;6267.592606480564;6286.465650419674;6321.399467050623;6370.713317900706;6372.776952806722;6275.246970363585;6326.145970294044;6351.936480635134;6353.555251132469;6396.360363963567;5055;5055.292259083732;5060.620453466005;5070.974645126825;5084.872878178076;4532.365468834366;4538.500764915857;4565.338025986213;4576.748278844696;4621.930671039937;5911.467967882825;6001.849953751192;6002.249718785152;6086.329862578003;6124.112003759519;6299.464545513591;6308.621482711052;6350.872982540416;6367.713452894631;6368.681565921685;6011.789587364508;6036.9094463582205;6055.031195008777;6072.332043475214;6078.574499784972;5422.213779002022;5509.063459211863;5558.166275058774;5568.053430916754;5609.046462101453;6163.3528479509005;6576.704048317742;6600.141981542369;6617.205935287796;6633.1045308882685;5894.734736936763;6270.372962703693;6346.01636746305;6346.714397852015;6364.013577895434;6471.676416179078;6533.18335208099;6548.246951600627;6551.475881929529;6562.573432726857;6314.652694101868;6320.304766475776;6346.619202847844;6350.872982540231;6366.936330636634;6259.436650701458;6279.874402511833;6303.180586523723;6344.651044192429;6362.713677884413;6295.496360291258;6330.240371155491;6335.904961425675;6345.17512723343;6352.491800656029;6291;6302.275238347649;6308.842278943063;6311.179546658905;6314.494840412664;4559.612432943237;6006.129111278753;6156.107364432221;6165.506759459322;6169.136320914986;6265.718042687999;6306.243250809932;6316.557840951089;6333.619982801047;6337.207849018872;6184.628922264678;6211.16149319836;6216.098665693358;6221.968890155701;6226.875462490815 03:57:56 INFO - PROCESS | 1713 | |1;ext.html;519.7816916894903;563.0175344024677;649.4609474136467;672.9327067293272;675.6317806795296;40029.79985100074;40740;40743.18513629726;40800.38799418011;40815;44044.33933491;44736.55263447364;44770.99999999992;44780;44806.77596612021;9617.71146865595;9834.606615735362;9855.655052073143;9858.063483969012;9864.358816676893;9722.22222222224;9877.654282100128;9894.307398482073;9901.851472227921;9903.356281841658;9949.55227014786;9950.800983980316;9984.700458986206;10067.194624430029;10078.344907580984;9913.653022144226;9996;10008.849867252033;10009.849852252222;10045.347052441568;9794.363366381162;9911.65309214174;9949.850752238723;9950.601975920954;9959.103680668703;43096.78451607753;43654.563454365365;43679.90800229988;43714.56285437169;43716.562834371565;3424.6575342465803;3535.8585656573705;3592.8562857485667;3625.873094441682;3632.20091579852;27493.587596185873;28429.85785071082;28786.280342991384;30045.399092018037;30270;2874.1664917173994;2894.623698919148;2920.119733814916;2937.500624893773;2946.2487065798086;521164;531266;532412;532478;533090;47465.52534474611;47895.04209915782;72025.27974720186;73320;73343;47162;47301.763491182326;47384.5261547387;47435;47456.5254347459;17099.829001710073;17208.569785755204;17213.913930430517;17310.913445432692;17354.39259625907;13774.862251377559;13823;13830.23933683637;13831.30843457823;13852.515161969484;15085.924570377078;15301.234938253043;15332.616684582974;15342.386304547694;15399.769003464957;6637.86724265512;6784.491163162783;6805.6597170141295;6814.478642902059;6831.555948863407;954.9713508594754;1035.9430231337199;1047.3297089862494;1115.9175599668308;1217.178404576907;23792.757292899532;26912.865435672695;30106.54840177399;30871.536926946115;31347.37305253882;1106.8007758603367;1173.8239264110452;1192.0225415159487;1197.7843988082054;1313.4947131339406;13069.215847049207;16248.350065997463;16460.588485287724;16635.334586616398;17140.40008599693;541045;547928.7810682843;548938;549065;551501;61662;62356;62491.68754156291;62569;62610.68694656497;1449.14500444736;1466.2815220541859;1546.6442718174883;1561.2896132259796;1587.2143289071753;30353.544696829125;31796.841015794773;31937;32773.67226327706;33224.50163247505;55630.44369556253;57209;57783.84432311246;57875.13187302278;57916.71041644765;357785;395374;415168;416249.8375016211;417082;39104.21791564096;44872.32691509565;47362.05275894532;47512.04975900394;48276.758616206695;45795.93918273619;45927;46013.76993115013;46119.077618448115;47293.054138917716;35874.4618830723;36521.63478365289;37543.43684844675;38188.618113818506;38490;37196.64210112463;37249;37351.43972840464;37826.24347513089;38221.80889095537;39659;39998.80000599979;40258.597414026655;40684.3897341546;41515;32563;33183.83408082944;33496.33007339888;33527;33735.493967591;22300;25455.109071182418;26232.34419139537;26309.60535592006;26961.59557606598 03:57:56 INFO - PROCESS | 1713 | |2;jquery.html;384.5635204043411;386.45702787583446;386.8201286401824;397.72954391014133;399.14582792823364;19332.51668708281;20559;21055.57888842226;21103.577928441442;21127.471813204676;12233.755324893496;12605.747885042294;21128.260510882123;21430.785692143072;21469.67795483069;5245.318108645871;5388.838334849961;5437.619366644337;5445.863853403657;5456.045192091368;4161.875143745692;4355.5644435556505;5574.721263936807;6146.66193359365;6156.630602163862;6047.879042419149;6116.388361163892;6136.877262454748;6149.754009839601;6155.72299246535;6606.174228221473;6644.867102657968;6660.134182556237;6664.966675166617;6671.799846004627;4062.065724883264;5607.887842243133;5802.506786923117;5820.417958204188;5821.476067153976;14001.019928605001;14015.369308381147;14139.9395045372;20476.488087797774;26127.869360653265;2122.9575408491896;2199.3292045925987;2207.172310383606;2321.500877311369;2553.1957433408415;10124.797504049951;10149.39103653783;10391.740206494822;10413.958604139601;10813.67558973232;1795.7788703681492;1817.4275103342536;1832.3220408448826;1839.7976222615503;1855.3877220517197;105831.4708426453;106341.46829265881;108852;112677.30984035246;113192;11356.274494121517;11686.94156529212;11720.824187637192;11724.413779311;11809.704757381134;14672.633184170481;14691;14701.485448009269;14724.33740481681;14742.189179595225;8956.417832840974;8967.282617390592;9044.050374710692;9075.092490751003;9103.772405689911;9178.173964343241;9187.63249470027;9195.264378849675;9261.629534818667;9283.350165488486;3749.343864823645;3911.9608803911597;4607.101615185074;4640.350350950869;4644.187267228222;1691.6193856382215;1799.9930077962977;1839.688560590931;1860.5069656541027;1898.477918572376;980.5930538826307;997.8303688372849;1003.3879333606494;1052.1687866585312;1064.8509208710786;20648.58702825935;21680.241191558536;22199.66700499494;22319.218827340967;22427.887860560593;913.59345091435;1008.6534476473843;1026.6971243483042;1033.607229252894;1049.5172220778527;11318.207725459139;11473.655790326136;11506.539738410538;11597.478113484913;11659.358735269472;627845;648517;675017;676907.6927692177;690952;116517.83482165239;121454.78545214611;121793.99999999822;122040;123753;1112.6828853776635;1125.9493322800495;1181.710480932177;1194.2297218294325;1205.8311836342918;18799.060046997867;19589.80410195937;19609.313674021912;19634.80365196387;19661.410157695293;45484.31773523334;53861.46138538564;54345;55930.44069559415;56612;79312;79566;80046;80845;80930.59534702289;8316.5425901576;8327.583620818814;8334;8539.14608539141;8721.345899057724;9043.819123617359;12524.121381792804;13525;13805.792913106512;13986.020978531405;10828.13374929988;11269.436528173723;11566.074714023027;11884.34636095023;12118.333491658044;11195.832062519232;11510;11651.41742912834;11887.46506407231;12131.818022729844;5991.910121348271;8337.916620833714;11051.060659844003;11287.661370158909;11426;8319.958400207961;8433.620487077973;8439.240468357877;8536.274416674652;8609.913900861162;11072.778544429228;11748;11790.351530665896;11982;12102.334371609646 03:57:56 INFO - PROCESS | 1713 | |3;mootools.html;1525.8703010244128;1668.2993142879989;1694.508592508173;2061.4537147655874;2114.4713821544615;8416.410851240416;9070.365074444784;9257.120573545502;9258.30562707798;9268.814623707522;7408.481406301561;9073;9073.954630226855;9074.137956894101;9117.042710515383;2578.845269283844;2609;2618.371590818209;2622.5934980078023;2623.0556999480173;2556.284240412678;2635.499255141517;2637.4725054988985;2638.0634874619523;2645.894164233438;2227.6992605998144;2603.0889188783867;2619.607058941155;2645.0742240215964;2653.8275012124245;2593.8703064846777;2624.3045592917892;2630.684317881847;2644.0613582178244;2645.7883369330407;2434.9634755478683;2600.3109176068356;2614.516314481808;2633.2890119667773;2653.7744291735225;9098.363114581982;9154.81690366189;9158.679446219418;9163;9172.174504294646;4730.597899178574;5914.704264786744;5917.023691090965;5927.762889484416;5952.285725712899;3688.0411093115713;3755.117547376364;3818.4081467372603;3825.9234815303817;3836.693064554829;1068.4444089073716;1091.6288461922904;1094.584058057933;1132.5016992523347;1132.7168207948014;12576.496940122384;12583.119181657288;12586.81119783204;12602.928751056172;12623.495060197582;4752.1683705351425;5143.151380022255;5203.687778733288;5235.1623740201385;5248.422673505911;10798.460076996276;10833.29583577065;10847.566097356017;10847.891521084846;10853.620123295646;5984.850378740566;6006.249218847644;6025.307089684655;6031.60794548353;6035.698215089228;4588.908221835544;4757.072370887644;5070.2141168119;5273.920891186635;5359.651622644516;4122.299209134454;4137.855883343544;4170.757843845778;4204.495460544754;4219.746815191098;1152.4525850221078;1381.9239941803096;1387.0983860490762;1399.0276757653332;1407.3877863129571;1367.47352269377;1370.8903287736957;1386.9029167958347;1416.2635429576562;1442.9639259018609;8597.785055373666;8747.475151490804;8747.693830715894;8751.606177722018;8771.780705482413;546.2980070609327;548.14763043467;559.7621011070279;560.019965061143;563.0934195944526;6414.518911081687;6422.197225346832;6457.935420645827;6481.708323125471;6486.059521369375;11182;11592.246503977214;11627.418629068681;11750.412479376168;11769.117316201318;10276.383416995004;10718.571257149626;11256;11357.148213883827;11525;8868;8908.821823563492;8960.462372257685;8963.596638151168;8983.640654373752;8281.254687077952;8333.83332333362;8368.623411946355;8430.45202061864;8431.451955622864;10207.948960255151;10210.285280030326;10286.845697314397;10334.586616535255;10429.53067111997;10327.638532651321;10335;10658.307210031324;10856.185786065918;10867.967543083394;7008.369246767816;7195.316444937723;7197.676104575202;7868.095169055632;7957.5225486471;8005.3995950305125;8492.532910689724;8532.744017679479;8563.914360856561;8572.185642363966;7490.737824176345;7613;7659.234076592296;7676.846463070596;7735.651895664596;7472.663730132266;7478.364339031244;7480.625968701434;7589.279018493235;7607.087149542091;6520.673966301571;7940.16628254025;8024.037115546172;8031.759047228593;8039.477433966774;7303.087114110736;7304.671289791866;7314.96342518284;7352.154502232098;7364.189939106801;7432.516886402366;7465.962670186615;7511.06111736033;7515.13575938774;7520.849583008418 03:57:56 INFO - PROCESS | 1713 | |4;prototype.html;344.9448088305871;354.9432090865462;356.60060731980184;356.95894972078213;362.54319557357735;5572.3870374258795;6524.15186025816;6591.209054913411;6592.2418921824;6603.966980165099;6580.27616962135;6581.243157036942;6584.341565843413;6593.967030164855;6615.305392933745;4795.304680821278;4867.586255168315;4898.363212782351;4965.404151501825;5012.523810238022;4927.48261432548;4952.133376659088;4973.229149481836;4976.303317535548;4980.27785971034;4931.778069986841;4934.6299027572895;4936.851894443173;4958.281049247875;5009.198528235483;4779.330893674888;4806.7836947337455;4867.050925069613;4928.950710492921;4931.358923339979;4216.79821250942;4220.6412454941365;4230.978845105786;4233.957660423387;4289.6997210195295;6312.179416675849;6347.206599175103;6354.332795056545;6359;6373.8406539836415;5764.913526297109;5782.537397008229;5782.653040817564;5787.363390027093;5790.739416726257;6737.966310168418;6992.2658120897595;6995.930040699579;6996.6851491683;7001.754938577125;3701.3152566775234;3894.844206231747;4728.739919304437;4747.382840230783;4754.762261886892;7350.96324518374;7372.483926125174;7385.298396652363;7389.224131466172;7391.115265607344;3972.2849887020616;4818.927716084261;4820.7107573545;4828.830990915301;4829.806807727722;4871.098846713369;4886.682365646222;4890.021995600894;4902;4904.950950490521;5747.39652336507;5748;5756.5682573807135;5762.510186634183;5769.624974376652;5680.403557626472;6707.429868461138;6995.720171193096;7033.085698859116;7054.823629409306;1676.6143786929074;1705.360489816319;1709.5555155659617;1711.144427786107;1712.5119340987758;924.611663101499;1054.9789004220027;1073.8120828855076;1106.0709004436312;1113.560143743233;5127;6644.568103073285;6678.53250272486;6687.531872768956;6691.464682825363;6263.812085637438;6917.962305654091;7258.745943892044;7271;7278.199398066208;5310.522053015247;6662.167229096363;6662.533622646465;6670.4997125215805;6684.097646817715;3774.3960966245268;3884.4755957945317;3884.7863367515056;3885.630865067814;3890.2997460456822;7061;7271.636418179176;7459.291367320096;7514.173440921494;7695.153533111354;7264.418846492374;7413.592252426169;7463.776086717407;7469.551826890404;7515.699372025167;7570.318671319607;7596.772096837104;7600.619969001527;7601.049868766515;7609.934609154723;7211.206767255702;7232.602206878672;7235.782926512213;7239.746608868875;7245.818854528679;7126.608036558039;7128.857422851617;7130.180029296697;7134.286571342825;7138.107736532934;7359.1169059713175;7610.581418022062;7624.504407213513;7627.046619172604;7634.732784352521;4625.491195968508;4690.460597031385;4703.176944034849;4704.035672687022;4721.9055618888115;5985.790497332572;7216.603086830275;7278.272172782679;7284.599347035752;7288.781336559911;7050.365467107985;7053.365197132282;7060.6116663584;7062.505624606229;7065.293470652894;6750.561213521106;6959.130108736408;6969.616671083139;6982.720691172296;6986.196587392515;6776.796696099125;6861.245263021164;6865.450763938973;6870;6897.172339319314;7003.7548685795755;7011.4390848733;7014.298570142945;7023.719051238098;7034.0656319512545;6821.522493425413;6870.3473170048765;6874.828129296808;6879.793606191823;6879.965600172167 03:57:56 INFO - PROCESS | 1713 | |5;yui.html;712.5048091576355;791.1218547412371;799.1169757418053;805.1063319715118;813.178689523581;12348.382580870953;15910.124943128123;16269.267882945267;16286.941348812334;16291.918540407296;15058.021228620131;15175;15179.468718594851;15186.0888346699;15236.771448428255;828.3952714518405;839.5340585974782;917.6788124156525;1023.8003589300052;1040.1678657074349;996.3573495095659;1001.5643195210107;1001.8747656542932;1002.013017178079;1032.385730490357;1029.7785976015155;1032.7779527401608;1034.5965073621294;1037.4190453346112;1062.4634559547417;865.9134086591354;1059.8357254625507;1071.073521403984;1077.9920774076263;1079.271491743078;799.7280924485644;805.9153788852145;807.2452257139535;807.3783186946077;808.2281421242699;15740.212989350486;15797.447089351817;15830;15839.762403563956;15858.920705396398;13243.668908277274;13336.533221337206;13477.932610336984;13695.794563081561;13737.519186828513;9018.09819018093;10351.896481035245;10462.581496740122;10500.2649814513;10591.25861189717;3600.747947643666;3625.873094441682;3656.049427148934;3736.5889752127246;3800.6959443244473;87001.69497457544;87728.99999999936;87777.12222877817;87899.68150477747;88114;10007.349522281029;10021.39871607706;10138.695839124837;10182.796344073076;10609.734756631146;23880.805959701946;23913.282601521983;23938.52122957566;23971.04115835347;24033.399165021016;7588.81027974305;7669.7315593953945;7695.268949449794;7730.420218483636;7922.4850384724805;4202.579742025773;4289.099289149313;4370.169667763115;4381.123775244963;4574.565416285448;3704.2591481703766;3774.9245015099546;3779.773213607137;3780.4707340972286;3787.0532366908274;663.1213641924469;673.6732684647942;677.0994577212394;685.8456847209338;702.6556987076295;531.8670332416896;605.5617907469759;611.9571629985858;618.3136718242747;628.8899442597527;7155.606441645759;8670.78323041929;8689.565521724015;8703.521306328086;8853.29173666105;614.1524695919692;621.8196722950385;628.5568674084759;630.5586089737202;638.4796390941368;3730.5336832895887;3800.3729384651774;3938.3501722215515;4031.133306339151;4119.402686610425;86231.70652440218;87688;89284;89900.20199596102;98367.50816245873;74326.25673743301;78514.60742696364;79919.60040199762;80322.19677803264;81661.95845103801;69136.65431672809;69473.65263173652;71744.64127679433;72080.63959680274;72981.6350918242;8895;8926.642934282556;9017.819643607223;9073.500957447404;9134.040925702706;50072.99854002827;50253.748731256106;50673;51101.72245693887;52132.73933630308;64628;67577.66211168913;70337;70585;70963.64518177375;8791.912080879109;10566.31318964265;10981.945090274497;11088.611898583511;11326.603568875049;12128.575499857463;12275.2021118627;12360.629181124581;12489.500419983098;12655.746885062063;11475.13936454786;11786.410679466164;11823.068208473158;12010.819837702616;12170.269783812999;11774.3524106175;11891.524339026342;12036.879631203576;12089.093318001009;12254.080943929062;11512.251703639236;11681.941590291994;11866.82199766987;11900.583479578174;11976.221545599508;9736.539519072196;10098.798024039625;10116.08955194036;10219.948900255451;10388.740281493023;8434.915650843659;9961.850572241277;10016.499175041365;10082.899171008195;10156.085952264037 03:57:56 INFO - PROCESS | 1713 | __end_tp_report 03:57:56 INFO - PROCESS | 1713 | __start_cc_report 03:57:56 INFO - PROCESS | 1713 | _x_x_mozilla_cycle_collect,977 03:57:56 INFO - PROCESS | 1713 | __end_cc_report 03:57:56 INFO - PROCESS | 1713 | __startTimestamp1462964276418__endTimestamp 03:57:56 INFO - PROCESS | 1713 | 03:57:56 INFO - PROCESS | 1713 | ------- Summary: start ------- 03:57:56 INFO - PROCESS | 1713 | Number of tests: 6 03:57:56 INFO - PROCESS | 1713 | 03:57:56 INFO - PROCESS | 1713 | [#0] dojo.html Cycles:165 Average:5912.25 Median:6169.14 stddev:631.99 (10.2%) stddev-sans-first:605.68 03:57:56 INFO - PROCESS | 1713 | Values: 3530.7 3605.2 3608.4 3628.3 3670.7 5892.6 5903.6 5911.3 5911.5 5959.7 5858.3 5898.1 5912.5 5925.6 5933.1 5249.1 5304.4 5317.0 5391.2 5446.6 5432.0 5445.0 5445.6 5454.3 5464.7 5376.6 5411.7 5428.8 5431.9 5439.3 5440.8 5443.7 5450.3 5461.6 5526.9 5228.0 5401.0 5408.5 5410.1 5411.2 5773.3 5803.7 5807.9 5818.0 5860.1 6203.1 6308.5 6309.5 6311.2 6314.5 6255.5 6258.8 6285.1 6304.9 6361.4 6053.9 6079.5 6097.5 6104.3 6115.8 5620.1 6526.2 6527.6 6533.9 6539.0 6181.9 6232.2 6351.0 6353.4 6359.0 6311.9 6334.1 6335.9 6337.9 6362.0 6267.6 6286.5 6321.4 6370.7 6372.8 6275.2 6326.1 6351.9 6353.6 6396.4 5055.0 5055.3 5060.6 5071.0 5084.9 4532.4 4538.5 4565.3 4576.7 4621.9 5911.5 6001.8 6002.2 6086.3 6124.1 6299.5 6308.6 6350.9 6367.7 6368.7 6011.8 6036.9 6055.0 6072.3 6078.6 5422.2 5509.1 5558.2 5568.1 5609.0 6163.4 6576.7 6600.1 6617.2 6633.1 5894.7 6270.4 6346.0 6346.7 6364.0 6471.7 6533.2 6548.2 6551.5 6562.6 6314.7 6320.3 6346.6 6350.9 6366.9 6259.4 6279.9 6303.2 6344.7 6362.7 6295.5 6330.2 6335.9 6345.2 6352.5 6291.0 6302.3 6308.8 6311.2 6314.5 4559.6 6006.1 6156.1 6165.5 6169.1 6265.7 6306.2 6316.6 6333.6 6337.2 6184.6 6211.2 6216.1 6222.0 6226.9 03:57:56 INFO - PROCESS | 1713 | 03:57:56 INFO - PROCESS | 1713 | [#1] ext.html Cycles:180 Average:64488.06 Median:40471.49 stddev:132209.09 (326.7%) stddev-sans-first:132492.73 03:57:56 INFO - PROCESS | 1713 | Values: 519.8 563.0 649.5 672.9 675.6 40029.8 40740.0 40743.2 40800.4 40815.0 44044.3 44736.6 44771.0 44780.0 44806.8 9617.7 9834.6 9855.7 9858.1 9864.4 9722.2 9877.7 9894.3 9901.9 9903.4 9949.6 9950.8 9984.7 10067.2 10078.3 9913.7 9996.0 10008.8 10009.8 10045.3 9794.4 9911.7 9949.9 9950.6 9959.1 43096.8 43654.6 43679.9 43714.6 43716.6 3424.7 3535.9 3592.9 3625.9 3632.2 27493.6 28429.9 28786.3 30045.4 30270.0 2874.2 2894.6 2920.1 2937.5 2946.2 521164.0 531266.0 532412.0 532478.0 533090.0 47465.5 47895.0 72025.3 73320.0 73343.0 47162.0 47301.8 47384.5 47435.0 47456.5 17099.8 17208.6 17213.9 17310.9 17354.4 13774.9 13823.0 13830.2 13831.3 13852.5 15085.9 15301.2 15332.6 15342.4 15399.8 6637.9 6784.5 6805.7 6814.5 6831.6 955.0 1035.9 1047.3 1115.9 1217.2 23792.8 26912.9 30106.5 30871.5 31347.4 1106.8 1173.8 1192.0 1197.8 1313.5 13069.2 16248.4 16460.6 16635.3 17140.4 541045.0 547928.8 548938.0 549065.0 551501.0 61662.0 62356.0 62491.7 62569.0 62610.7 1449.1 1466.3 1546.6 1561.3 1587.2 30353.5 31796.8 31937.0 32773.7 33224.5 55630.4 57209.0 57783.8 57875.1 57916.7 357785.0 395374.0 415168.0 416249.8 417082.0 39104.2 44872.3 47362.1 47512.0 48276.8 45795.9 45927.0 46013.8 46119.1 47293.1 35874.5 36521.6 37543.4 38188.6 38490.0 37196.6 37249.0 37351.4 37826.2 38221.8 39659.0 39998.8 40258.6 40684.4 41515.0 32563.0 33183.8 33496.3 33527.0 33735.5 22300.0 25455.1 26232.3 26309.6 26961.6 03:57:56 INFO - PROCESS | 1713 | 03:57:56 INFO - PROCESS | 1713 | [#2] jquery.html Cycles:180 Average:36345.90 Median:21127.87 stddev:110015.17 (520.7%) stddev-sans-first:110290.65 03:57:56 INFO - PROCESS | 1713 | Values: 384.6 386.5 386.8 397.7 399.1 19332.5 20559.0 21055.6 21103.6 21127.5 12233.8 12605.7 21128.3 21430.8 21469.7 5245.3 5388.8 5437.6 5445.9 5456.0 4161.9 4355.6 5574.7 6146.7 6156.6 6047.9 6116.4 6136.9 6149.8 6155.7 6606.2 6644.9 6660.1 6665.0 6671.8 4062.1 5607.9 5802.5 5820.4 5821.5 14001.0 14015.4 14139.9 20476.5 26127.9 2123.0 2199.3 2207.2 2321.5 2553.2 10124.8 10149.4 10391.7 10414.0 10813.7 1795.8 1817.4 1832.3 1839.8 1855.4 105831.5 106341.5 108852.0 112677.3 113192.0 11356.3 11686.9 11720.8 11724.4 11809.7 14672.6 14691.0 14701.5 14724.3 14742.2 8956.4 8967.3 9044.1 9075.1 9103.8 9178.2 9187.6 9195.3 9261.6 9283.4 3749.3 3912.0 4607.1 4640.4 4644.2 1691.6 1800.0 1839.7 1860.5 1898.5 980.6 997.8 1003.4 1052.2 1064.9 20648.6 21680.2 22199.7 22319.2 22427.9 913.6 1008.7 1026.7 1033.6 1049.5 11318.2 11473.7 11506.5 11597.5 11659.4 627845.0 648517.0 675017.0 676907.7 690952.0 116517.8 121454.8 121794.0 122040.0 123753.0 1112.7 1125.9 1181.7 1194.2 1205.8 18799.1 19589.8 19609.3 19634.8 19661.4 45484.3 53861.5 54345.0 55930.4 56612.0 79312.0 79566.0 80046.0 80845.0 80930.6 8316.5 8327.6 8334.0 8539.1 8721.3 9043.8 12524.1 13525.0 13805.8 13986.0 10828.1 11269.4 11566.1 11884.3 12118.3 11195.8 11510.0 11651.4 11887.5 12131.8 5991.9 8337.9 11051.1 11287.7 11426.0 8320.0 8433.6 8439.2 8536.3 8609.9 11072.8 11748.0 11790.4 11982.0 12102.3 03:57:56 INFO - PROCESS | 1713 | 03:57:56 INFO - PROCESS | 1713 | [#3] mootools.html Cycles:180 Average:6359.64 Median:5173.42 stddev:3387.35 (65.5%) stddev-sans-first:3377.36 03:57:56 INFO - PROCESS | 1713 | Values: 1525.9 1668.3 1694.5 2061.5 2114.5 8416.4 9070.4 9257.1 9258.3 9268.8 7408.5 9073.0 9074.0 9074.1 9117.0 2578.8 2609.0 2618.4 2622.6 2623.1 2556.3 2635.5 2637.5 2638.1 2645.9 2227.7 2603.1 2619.6 2645.1 2653.8 2593.9 2624.3 2630.7 2644.1 2645.8 2435.0 2600.3 2614.5 2633.3 2653.8 9098.4 9154.8 9158.7 9163.0 9172.2 4730.6 5914.7 5917.0 5927.8 5952.3 3688.0 3755.1 3818.4 3825.9 3836.7 1068.4 1091.6 1094.6 1132.5 1132.7 12576.5 12583.1 12586.8 12602.9 12623.5 4752.2 5143.2 5203.7 5235.2 5248.4 10798.5 10833.3 10847.6 10847.9 10853.6 5984.9 6006.2 6025.3 6031.6 6035.7 4588.9 4757.1 5070.2 5273.9 5359.7 4122.3 4137.9 4170.8 4204.5 4219.7 1152.5 1381.9 1387.1 1399.0 1407.4 1367.5 1370.9 1386.9 1416.3 1443.0 8597.8 8747.5 8747.7 8751.6 8771.8 546.3 548.1 559.8 560.0 563.1 6414.5 6422.2 6457.9 6481.7 6486.1 11182.0 11592.2 11627.4 11750.4 11769.1 10276.4 10718.6 11256.0 11357.1 11525.0 8868.0 8908.8 8960.5 8963.6 8983.6 8281.3 8333.8 8368.6 8430.5 8431.5 10207.9 10210.3 10286.8 10334.6 10429.5 10327.6 10335.0 10658.3 10856.2 10868.0 7008.4 7195.3 7197.7 7868.1 7957.5 8005.4 8492.5 8532.7 8563.9 8572.2 7490.7 7613.0 7659.2 7676.8 7735.7 7472.7 7478.4 7480.6 7589.3 7607.1 6520.7 7940.2 8024.0 8031.8 8039.5 7303.1 7304.7 7315.0 7352.2 7364.2 7432.5 7466.0 7511.1 7515.1 7520.8 03:57:56 INFO - PROCESS | 1713 | 03:57:56 INFO - PROCESS | 1713 | [#4] prototype.html Cycles:180 Average:5756.35 Median:6593.10 stddev:1807.70 (27.4%) stddev-sans-first:1766.56 03:57:56 INFO - PROCESS | 1713 | Values: 344.9 354.9 356.6 357.0 362.5 5572.4 6524.2 6591.2 6592.2 6604.0 6580.3 6581.2 6584.3 6594.0 6615.3 4795.3 4867.6 4898.4 4965.4 5012.5 4927.5 4952.1 4973.2 4976.3 4980.3 4931.8 4934.6 4936.9 4958.3 5009.2 4779.3 4806.8 4867.1 4929.0 4931.4 4216.8 4220.6 4231.0 4234.0 4289.7 6312.2 6347.2 6354.3 6359.0 6373.8 5764.9 5782.5 5782.7 5787.4 5790.7 6738.0 6992.3 6995.9 6996.7 7001.8 3701.3 3894.8 4728.7 4747.4 4754.8 7351.0 7372.5 7385.3 7389.2 7391.1 3972.3 4818.9 4820.7 4828.8 4829.8 4871.1 4886.7 4890.0 4902.0 4905.0 5747.4 5748.0 5756.6 5762.5 5769.6 5680.4 6707.4 6995.7 7033.1 7054.8 1676.6 1705.4 1709.6 1711.1 1712.5 924.6 1055.0 1073.8 1106.1 1113.6 5127.0 6644.6 6678.5 6687.5 6691.5 6263.8 6918.0 7258.7 7271.0 7278.2 5310.5 6662.2 6662.5 6670.5 6684.1 3774.4 3884.5 3884.8 3885.6 3890.3 7061.0 7271.6 7459.3 7514.2 7695.2 7264.4 7413.6 7463.8 7469.6 7515.7 7570.3 7596.8 7600.6 7601.0 7609.9 7211.2 7232.6 7235.8 7239.7 7245.8 7126.6 7128.9 7130.2 7134.3 7138.1 7359.1 7610.6 7624.5 7627.0 7634.7 4625.5 4690.5 4703.2 4704.0 4721.9 5985.8 7216.6 7278.3 7284.6 7288.8 7050.4 7053.4 7060.6 7062.5 7065.3 6750.6 6959.1 6969.6 6982.7 6986.2 6776.8 6861.2 6865.5 6870.0 6897.2 7003.8 7011.4 7014.3 7023.7 7034.1 6821.5 6870.3 6874.8 6879.8 6880.0 03:57:56 INFO - PROCESS | 1713 | 03:57:56 INFO - PROCESS | 1713 | [#5] yui.html Cycles:180 Average:18853.64 Median:3800.53 stddev:26181.70 (688.9%) stddev-sans-first:26219.71 03:57:56 INFO - PROCESS | 1713 | Values: 712.5 791.1 799.1 805.1 813.2 12348.4 15910.1 16269.3 16286.9 16291.9 15058.0 15175.0 15179.5 15186.1 15236.8 828.4 839.5 917.7 1023.8 1040.2 996.4 1001.6 1001.9 1002.0 1032.4 1029.8 1032.8 1034.6 1037.4 1062.5 865.9 1059.8 1071.1 1078.0 1079.3 799.7 805.9 807.2 807.4 808.2 15740.2 15797.4 15830.0 15839.8 15858.9 13243.7 13336.5 13477.9 13695.8 13737.5 9018.1 10351.9 10462.6 10500.3 10591.3 3600.7 3625.9 3656.0 3736.6 3800.7 87001.7 87729.0 87777.1 87899.7 88114.0 10007.3 10021.4 10138.7 10182.8 10609.7 23880.8 23913.3 23938.5 23971.0 24033.4 7588.8 7669.7 7695.3 7730.4 7922.5 4202.6 4289.1 4370.2 4381.1 4574.6 3704.3 3774.9 3779.8 3780.5 3787.1 663.1 673.7 677.1 685.8 702.7 531.9 605.6 612.0 618.3 628.9 7155.6 8670.8 8689.6 8703.5 8853.3 614.2 621.8 628.6 630.6 638.5 3730.5 3800.4 3938.4 4031.1 4119.4 86231.7 87688.0 89284.0 89900.2 98367.5 74326.3 78514.6 79919.6 80322.2 81662.0 69136.7 69473.7 71744.6 72080.6 72981.6 8895.0 8926.6 9017.8 9073.5 9134.0 50073.0 50253.7 50673.0 51101.7 52132.7 64628.0 67577.7 70337.0 70585.0 70963.6 8791.9 10566.3 10981.9 11088.6 11326.6 12128.6 12275.2 12360.6 12489.5 12655.7 11475.1 11786.4 11823.1 12010.8 12170.3 11774.4 11891.5 12036.9 12089.1 12254.1 11512.3 11681.9 11866.8 11900.6 11976.2 9736.5 10098.8 10116.1 10219.9 10388.7 8434.9 9961.9 10016.5 10082.9 10156.1 03:57:56 INFO - PROCESS | 1713 | -------- Summary: end -------- 03:57:56 INFO - PROCESS | 1713 | 03:57:56 INFO - TEST-INFO | 1713: exit 0 03:57:56 INFO - TEST-OK | dromaeo_css | took 1111890ms 03:57:56 INFO - TEST-START | kraken 03:57:56 INFO - operating with platform_type : mac_ 03:57:56 INFO - Initialising browser for kraken test... 03:57:56 INFO - TEST-INFO | started process 1834 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmp01wQNy/profile http://localhost:49275/getInfo.html) 03:57:58 INFO - PROCESS | 1834 | __metrics Screen width/height:1600/1200 03:57:58 INFO - PROCESS | 1834 | colorDepth:24 03:57:58 INFO - PROCESS | 1834 | Browser inner width/height: 1024/689 03:57:58 INFO - PROCESS | 1834 | __metrics 03:57:58 INFO - PROCESS | 1834 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:57:58 INFO - PROCESS | 1834 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:57:59 INFO - TEST-INFO | 1834: exit 0 03:57:59 INFO - Browser initialized. 03:57:59 INFO - Running cycle 1/1 for kraken test... 03:57:59 INFO - TEST-INFO | started process 1837 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmp01wQNy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:58:11 INFO - PROCESS | 1837 | RSS: Main: 157044736 03:58:11 INFO - PROCESS | 1837 | 03:58:14 INFO - PROCESS | 1837 | 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:58:14 INFO - PROCESS | 1837 | RSS: Main: 212791296 03:58:14 INFO - PROCESS | 1837 | 03:58:17 INFO - PROCESS | 1837 | 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:58:17 INFO - PROCESS | 1837 | RSS: Main: 223080448 03:58:17 INFO - PROCESS | 1837 | 03:58:20 INFO - PROCESS | 1837 | 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:58:21 INFO - PROCESS | 1837 | RSS: Main: 213413888 03:58:21 INFO - PROCESS | 1837 | 03:58:23 INFO - PROCESS | 1837 | 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:58:23 INFO - PROCESS | 1837 | RSS: Main: 215674880 03:58:23 INFO - PROCESS | 1837 | 03:58:26 INFO - PROCESS | 1837 | 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:58:26 INFO - PROCESS | 1837 | RSS: Main: 215670784 03:58:26 INFO - PROCESS | 1837 | 03:58:29 INFO - PROCESS | 1837 | 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:58:29 INFO - PROCESS | 1837 | RSS: Main: 215576576 03:58:29 INFO - PROCESS | 1837 | 03:58:32 INFO - PROCESS | 1837 | 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:58:33 INFO - PROCESS | 1837 | RSS: Main: 215642112 03:58:33 INFO - PROCESS | 1837 | 03:58:35 INFO - PROCESS | 1837 | 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:58:36 INFO - PROCESS | 1837 | RSS: Main: 216539136 03:58:36 INFO - PROCESS | 1837 | 03:58:38 INFO - PROCESS | 1837 | 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:58:38 INFO - PROCESS | 1837 | RSS: Main: 248774656 03:58:38 INFO - PROCESS | 1837 | 03:58:40 INFO - PROCESS | 1837 | 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:58:41 INFO - PROCESS | 1837 | RSS: Main: 248578048 03:58:41 INFO - PROCESS | 1837 | 03:58:43 INFO - PROCESS | 1837 | 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:58:43 INFO - PROCESS | 1837 | RSS: Main: 253124608 03:58:43 INFO - PROCESS | 1837 | 03:58:46 INFO - PROCESS | 1837 | 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:58:46 INFO - PROCESS | 1837 | RSS: Main: 255143936 03:58:46 INFO - PROCESS | 1837 | 03:58:49 INFO - PROCESS | 1837 | 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:58:49 INFO - PROCESS | 1837 | RSS: Main: 255348736 03:58:49 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | 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:58:51 INFO - PROCESS | 1837 | RSS: Main: 318431232 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | __start_tp_report 03:58:51 INFO - PROCESS | 1837 | _x_x_mozilla_page_load 03:58:51 INFO - PROCESS | 1837 | _x_x_mozilla_page_load_details 03:58:51 INFO - PROCESS | 1837 | |i|pagename|runs| 03:58:51 INFO - PROCESS | 1837 | |0;ai-astar;111;107;110;110;111;113;120;109;109;110 03:58:51 INFO - PROCESS | 1837 | |1;audio-beat-detection;180;150;142;159;116;143;120;152;147;110 03:58:51 INFO - PROCESS | 1837 | |2;audio-dft;183;183;184;181;183;181;183;180;182;182 03:58:51 INFO - PROCESS | 1837 | |3;audio-fft;73;71;75;116;54;55;58;57;119;56 03:58:51 INFO - PROCESS | 1837 | |4;audio-oscillator;89;93;126;79;77;85;116;76;78;115 03:58:51 INFO - PROCESS | 1837 | |5;imaging-gaussian-blur;86;83;86;83;86;83;85;83;85;83 03:58:51 INFO - PROCESS | 1837 | |6;imaging-darkroom;104;123;92;92;92;92;93;100;92;92 03:58:51 INFO - PROCESS | 1837 | |7;imaging-desaturate;87;85;88;83;83;83;91;130;87;90 03:58:51 INFO - PROCESS | 1837 | |8;json-parse-financial;55;58;57;58;57;57;57;58;54;53 03:58:51 INFO - PROCESS | 1837 | |9;json-stringify-tinderbox;65;61;66;73;77;71;67;66;66;67 03:58:51 INFO - PROCESS | 1837 | |10;stanford-crypto-aes;80;79;80;81;80;79;66;77;87;105 03:58:51 INFO - PROCESS | 1837 | |11;stanford-crypto-ccm;119;131;131;120;117;123;126;116;105;123 03:58:51 INFO - PROCESS | 1837 | |12;stanford-crypto-pbkdf2;141;120;135;129;140;133;132;131;133;131 03:58:51 INFO - PROCESS | 1837 | |13;stanford-crypto-sha256-iterative;67;68;65;65;66;65;65;69;65;64 03:58:51 INFO - PROCESS | 1837 | __end_tp_report 03:58:51 INFO - PROCESS | 1837 | __start_cc_report 03:58:51 INFO - PROCESS | 1837 | _x_x_mozilla_cycle_collect,1203 03:58:51 INFO - PROCESS | 1837 | __end_cc_report 03:58:51 INFO - PROCESS | 1837 | __startTimestamp1462964331833__endTimestamp 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | ------- Summary: start ------- 03:58:51 INFO - PROCESS | 1837 | Number of tests: 14 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | [#0] ai-astar Cycles:10 Average:111.00 Median:110.50 stddev:3.53 (3.2%) stddev-sans-first:3.74 03:58:51 INFO - PROCESS | 1837 | Values: 111.0 107.0 110.0 110.0 111.0 113.0 120.0 109.0 109.0 110.0 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:148.50 stddev:21.36 (14.4%) stddev-sans-first:17.66 03:58:51 INFO - PROCESS | 1837 | Values: 180.0 150.0 142.0 159.0 116.0 143.0 120.0 152.0 147.0 110.0 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | [#2] audio-dft Cycles:10 Average:182.20 Median:183.00 stddev:1.23 (0.7%) stddev-sans-first:1.27 03:58:51 INFO - PROCESS | 1837 | Values: 183.0 183.0 184.0 181.0 183.0 181.0 183.0 180.0 182.0 182.0 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | [#3] audio-fft Cycles:10 Average:73.40 Median:57.50 stddev:24.55 (42.7%) stddev-sans-first:26.04 03:58:51 INFO - PROCESS | 1837 | Values: 73.0 71.0 75.0 116.0 54.0 55.0 58.0 57.0 119.0 56.0 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:78.50 stddev:18.70 (23.8%) stddev-sans-first:19.76 03:58:51 INFO - PROCESS | 1837 | Values: 89.0 93.0 126.0 79.0 77.0 85.0 116.0 76.0 78.0 115.0 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | [#5] imaging-gaussian-blur Cycles:10 Average:84.30 Median:85.00 stddev:1.42 (1.7%) stddev-sans-first:1.36 03:58:51 INFO - PROCESS | 1837 | Values: 86.0 83.0 86.0 83.0 86.0 83.0 85.0 83.0 85.0 83.0 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | [#6] imaging-darkroom Cycles:10 Average:97.20 Median:92.00 stddev:10.00 (10.9%) stddev-sans-first:10.30 03:58:51 INFO - PROCESS | 1837 | Values: 104.0 123.0 92.0 92.0 92.0 92.0 93.0 100.0 92.0 92.0 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | [#7] imaging-desaturate Cycles:10 Average:90.70 Median:87.00 stddev:14.10 (16.2%) stddev-sans-first:14.90 03:58:51 INFO - PROCESS | 1837 | Values: 87.0 85.0 88.0 83.0 83.0 83.0 91.0 130.0 87.0 90.0 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:1.78 (3.1%) stddev-sans-first:1.81 03:58:51 INFO - PROCESS | 1837 | Values: 55.0 58.0 57.0 58.0 57.0 57.0 57.0 58.0 54.0 53.0 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:67.00 stddev:4.56 (6.8%) stddev-sans-first:4.71 03:58:51 INFO - PROCESS | 1837 | Values: 65.0 61.0 66.0 73.0 77.0 71.0 67.0 66.0 66.0 67.0 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:80.00 stddev:9.79 (12.2%) stddev-sans-first:10.37 03:58:51 INFO - PROCESS | 1837 | Values: 80.0 79.0 80.0 81.0 80.0 79.0 66.0 77.0 87.0 105.0 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:123.00 stddev:7.71 (6.3%) stddev-sans-first:8.14 03:58:51 INFO - PROCESS | 1837 | Values: 119.0 131.0 131.0 120.0 117.0 123.0 126.0 116.0 105.0 123.0 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.50 Median:133.00 stddev:5.85 (4.4%) stddev-sans-first:5.34 03:58:51 INFO - PROCESS | 1837 | Values: 141.0 120.0 135.0 129.0 140.0 133.0 132.0 131.0 133.0 131.0 03:58:51 INFO - PROCESS | 1837 | 03:58:51 INFO - PROCESS | 1837 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:65.50 stddev:1.60 (2.4%) stddev-sans-first:1.64 03:58:51 INFO - PROCESS | 1837 | Values: 67.0 68.0 65.0 65.0 66.0 65.0 65.0 69.0 65.0 64.0 03:58:51 INFO - PROCESS | 1837 | -------- Summary: end -------- 03:58:51 INFO - PROCESS | 1837 | 03:58:52 INFO - TEST-INFO | 1837: exit 0 03:58:52 INFO - TEST-OK | kraken | took 55622ms 03:58:52 INFO - SUITE-END | took 1167s 03:58:52 INFO - Completed test suite (00:19:27) 03:58:52 INFO - javascript benchmark 03:58:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3530.7351948603855, 3605.2248766515195, 3608.386574282372, 3628.292482965821, 3670.706343492521, 5892.587518873681, 5903.557233207511, 5911.320198177211, 5911.511655133588, 5959.731812068462, 5858.297004359472, 5898.085796701507, 5912.526997840173, 5925.585209035369, 5933.13969474426, 5249.107651699202, 5304.389995150568, 5316.9734151329185, 5391.218273350361, 5446.645968012086, 5431.972840135793, 5444.972775136119, 5445.591580631469, 5454.318210223722, 5464.726763661821, 5376.623636345457, 5411.675299482024, 5428.782848686048, 5431.891362172754, 5439.3200849893765, 5440.782368705247, 5443.673379597237, 5450.29146210992, 5461.590380721462, 5526.889462210774, 5228.0, 5400.973814975142, 5408.513233808937, 5410.08028635133, 5411.242426060355, 5773.336066352381, 5803.680797556132, 5807.88384232313, 5818.040023396177, 5860.062390017577, 6203.131561581382, 6308.526860485482, 6309.495240380758, 6311.2426508819235, 6314.494840412756, 6255.530835187379, 6258.843528911768, 6285.0886621440095, 6304.936950630481, 6361.395667411589, 6053.939460605426, 6079.513638908877, 6097.512199024068, 6104.328523862371, 6115.816525504242, 5620.1288800236025, 6526.2494813096155, 6527.5757075789925, 6533.869322613521, 6539.0, 6181.907271390933, 6232.189815323979, 6351.04734289851, 6353.396427339396, 6358.968205159037, 6311.905321420182, 6334.144890439824, 6335.873282534323, 6337.873242535124, 6362.045693146065, 6267.592606480564, 6286.465650419674, 6321.399467050623, 6370.713317900706, 6372.776952806722, 6275.246970363585, 6326.145970294044, 6351.936480635134, 6353.555251132469, 6396.360363963567, 5055.0, 5055.292259083732, 5060.620453466005, 5070.974645126825, 5084.872878178076, 4532.365468834366, 4538.500764915857, 4565.338025986213, 4576.748278844696, 4621.930671039937, 5911.467967882825, 6001.849953751192, 6002.249718785152, 6086.329862578003, 6124.112003759519, 6299.464545513591, 6308.621482711052, 6350.872982540416, 6367.713452894631, 6368.681565921685, 6011.789587364508, 6036.9094463582205, 6055.031195008777, 6072.332043475214, 6078.574499784972, 5422.213779002022, 5509.063459211863, 5558.166275058774, 5568.053430916754, 5609.046462101453, 6163.3528479509005, 6576.704048317742, 6600.141981542369, 6617.205935287796, 6633.1045308882685, 5894.734736936763, 6270.372962703693, 6346.01636746305, 6346.714397852015, 6364.013577895434, 6471.676416179078, 6533.18335208099, 6548.246951600627, 6551.475881929529, 6562.573432726857, 6314.652694101868, 6320.304766475776, 6346.619202847844, 6350.872982540231, 6366.936330636634, 6259.436650701458, 6279.874402511833, 6303.180586523723, 6344.651044192429, 6362.713677884413, 6295.496360291258, 6330.240371155491, 6335.904961425675, 6345.17512723343, 6352.491800656029, 6291.0, 6302.275238347649, 6308.842278943063, 6311.179546658905, 6314.494840412664, 4559.612432943237, 6006.129111278753, 6156.107364432221, 6165.506759459322, 6169.136320914986, 6265.718042687999, 6306.243250809932, 6316.557840951089, 6333.619982801047, 6337.207849018872, 6184.628922264678, 6211.16149319836, 6216.098665693358, 6221.968890155701, 6226.875462490815], "unit": "score", "name": "dojo.html", "value": 5874.518557003066}, {"lowerIsBetter": false, "replicates": [519.7816916894903, 563.0175344024677, 649.4609474136467, 672.9327067293272, 675.6317806795296, 40029.79985100074, 40740.0, 40743.18513629726, 40800.38799418011, 40815.0, 44044.33933491, 44736.55263447364, 44770.99999999992, 44780.0, 44806.77596612021, 9617.71146865595, 9834.606615735362, 9855.655052073143, 9858.063483969012, 9864.358816676893, 9722.22222222224, 9877.654282100128, 9894.307398482073, 9901.851472227921, 9903.356281841658, 9949.55227014786, 9950.800983980316, 9984.700458986206, 10067.194624430029, 10078.344907580984, 9913.653022144226, 9996.0, 10008.849867252033, 10009.849852252222, 10045.347052441568, 9794.363366381162, 9911.65309214174, 9949.850752238723, 9950.601975920954, 9959.103680668703, 43096.78451607753, 43654.563454365365, 43679.90800229988, 43714.56285437169, 43716.562834371565, 3424.6575342465803, 3535.8585656573705, 3592.8562857485667, 3625.873094441682, 3632.20091579852, 27493.587596185873, 28429.85785071082, 28786.280342991384, 30045.399092018037, 30270.0, 2874.1664917173994, 2894.623698919148, 2920.119733814916, 2937.500624893773, 2946.2487065798086, 521164.0, 531266.0, 532412.0, 532478.0, 533090.0, 47465.52534474611, 47895.04209915782, 72025.27974720186, 73320.0, 73343.0, 47162.0, 47301.763491182326, 47384.5261547387, 47435.0, 47456.5254347459, 17099.829001710073, 17208.569785755204, 17213.913930430517, 17310.913445432692, 17354.39259625907, 13774.862251377559, 13823.0, 13830.23933683637, 13831.30843457823, 13852.515161969484, 15085.924570377078, 15301.234938253043, 15332.616684582974, 15342.386304547694, 15399.769003464957, 6637.86724265512, 6784.491163162783, 6805.6597170141295, 6814.478642902059, 6831.555948863407, 954.9713508594754, 1035.9430231337199, 1047.3297089862494, 1115.9175599668308, 1217.178404576907, 23792.757292899532, 26912.865435672695, 30106.54840177399, 30871.536926946115, 31347.37305253882, 1106.8007758603367, 1173.8239264110452, 1192.0225415159487, 1197.7843988082054, 1313.4947131339406, 13069.215847049207, 16248.350065997463, 16460.588485287724, 16635.334586616398, 17140.40008599693, 541045.0, 547928.7810682843, 548938.0, 549065.0, 551501.0, 61662.0, 62356.0, 62491.68754156291, 62569.0, 62610.68694656497, 1449.14500444736, 1466.2815220541859, 1546.6442718174883, 1561.2896132259796, 1587.2143289071753, 30353.544696829125, 31796.841015794773, 31937.0, 32773.67226327706, 33224.50163247505, 55630.44369556253, 57209.0, 57783.84432311246, 57875.13187302278, 57916.71041644765, 357785.0, 395374.0, 415168.0, 416249.8375016211, 417082.0, 39104.21791564096, 44872.32691509565, 47362.05275894532, 47512.04975900394, 48276.758616206695, 45795.93918273619, 45927.0, 46013.76993115013, 46119.077618448115, 47293.054138917716, 35874.4618830723, 36521.63478365289, 37543.43684844675, 38188.618113818506, 38490.0, 37196.64210112463, 37249.0, 37351.43972840464, 37826.24347513089, 38221.80889095537, 39659.0, 39998.80000599979, 40258.597414026655, 40684.3897341546, 41515.0, 32563.0, 33183.83408082944, 33496.33007339888, 33527.0, 33735.493967591, 22300.0, 25455.109071182418, 26232.34419139537, 26309.60535592006, 26961.59557606598], "unit": "score", "name": "ext.html", "value": 20329.206061547862}, {"lowerIsBetter": false, "replicates": [384.5635204043411, 386.45702787583446, 386.8201286401824, 397.72954391014133, 399.14582792823364, 19332.51668708281, 20559.0, 21055.57888842226, 21103.577928441442, 21127.471813204676, 12233.755324893496, 12605.747885042294, 21128.260510882123, 21430.785692143072, 21469.67795483069, 5245.318108645871, 5388.838334849961, 5437.619366644337, 5445.863853403657, 5456.045192091368, 4161.875143745692, 4355.5644435556505, 5574.721263936807, 6146.66193359365, 6156.630602163862, 6047.879042419149, 6116.388361163892, 6136.877262454748, 6149.754009839601, 6155.72299246535, 6606.174228221473, 6644.867102657968, 6660.134182556237, 6664.966675166617, 6671.799846004627, 4062.065724883264, 5607.887842243133, 5802.506786923117, 5820.417958204188, 5821.476067153976, 14001.019928605001, 14015.369308381147, 14139.9395045372, 20476.488087797774, 26127.869360653265, 2122.9575408491896, 2199.3292045925987, 2207.172310383606, 2321.500877311369, 2553.1957433408415, 10124.797504049951, 10149.39103653783, 10391.740206494822, 10413.958604139601, 10813.67558973232, 1795.7788703681492, 1817.4275103342536, 1832.3220408448826, 1839.7976222615503, 1855.3877220517197, 105831.4708426453, 106341.46829265881, 108852.0, 112677.30984035246, 113192.0, 11356.274494121517, 11686.94156529212, 11720.824187637192, 11724.413779311, 11809.704757381134, 14672.633184170481, 14691.0, 14701.485448009269, 14724.33740481681, 14742.189179595225, 8956.417832840974, 8967.282617390592, 9044.050374710692, 9075.092490751003, 9103.772405689911, 9178.173964343241, 9187.63249470027, 9195.264378849675, 9261.629534818667, 9283.350165488486, 3749.343864823645, 3911.9608803911597, 4607.101615185074, 4640.350350950869, 4644.187267228222, 1691.6193856382215, 1799.9930077962977, 1839.688560590931, 1860.5069656541027, 1898.477918572376, 980.5930538826307, 997.8303688372849, 1003.3879333606494, 1052.1687866585312, 1064.8509208710786, 20648.58702825935, 21680.241191558536, 22199.66700499494, 22319.218827340967, 22427.887860560593, 913.59345091435, 1008.6534476473843, 1026.6971243483042, 1033.607229252894, 1049.5172220778527, 11318.207725459139, 11473.655790326136, 11506.539738410538, 11597.478113484913, 11659.358735269472, 627845.0, 648517.0, 675017.0, 676907.6927692177, 690952.0, 116517.83482165239, 121454.78545214611, 121793.99999999822, 122040.0, 123753.0, 1112.6828853776635, 1125.9493322800495, 1181.710480932177, 1194.2297218294325, 1205.8311836342918, 18799.060046997867, 19589.80410195937, 19609.313674021912, 19634.80365196387, 19661.410157695293, 45484.31773523334, 53861.46138538564, 54345.0, 55930.44069559415, 56612.0, 79312.0, 79566.0, 80046.0, 80845.0, 80930.59534702289, 8316.5425901576, 8327.583620818814, 8334.0, 8539.14608539141, 8721.345899057724, 9043.819123617359, 12524.121381792804, 13525.0, 13805.792913106512, 13986.020978531405, 10828.13374929988, 11269.436528173723, 11566.074714023027, 11884.34636095023, 12118.333491658044, 11195.832062519232, 11510.0, 11651.41742912834, 11887.46506407231, 12131.818022729844, 5991.910121348271, 8337.916620833714, 11051.060659844003, 11287.661370158909, 11426.0, 8319.958400207961, 8433.620487077973, 8439.240468357877, 8536.274416674652, 8609.913900861162, 11072.778544429228, 11748.0, 11790.351530665896, 11982.0, 12102.334371609646], "unit": "score", "name": "jquery.html", "value": 9604.536563845244}, {"lowerIsBetter": false, "replicates": [1525.8703010244128, 1668.2993142879989, 1694.508592508173, 2061.4537147655874, 2114.4713821544615, 8416.410851240416, 9070.365074444784, 9257.120573545502, 9258.30562707798, 9268.814623707522, 7408.481406301561, 9073.0, 9073.954630226855, 9074.137956894101, 9117.042710515383, 2578.845269283844, 2609.0, 2618.371590818209, 2622.5934980078023, 2623.0556999480173, 2556.284240412678, 2635.499255141517, 2637.4725054988985, 2638.0634874619523, 2645.894164233438, 2227.6992605998144, 2603.0889188783867, 2619.607058941155, 2645.0742240215964, 2653.8275012124245, 2593.8703064846777, 2624.3045592917892, 2630.684317881847, 2644.0613582178244, 2645.7883369330407, 2434.9634755478683, 2600.3109176068356, 2614.516314481808, 2633.2890119667773, 2653.7744291735225, 9098.363114581982, 9154.81690366189, 9158.679446219418, 9163.0, 9172.174504294646, 4730.597899178574, 5914.704264786744, 5917.023691090965, 5927.762889484416, 5952.285725712899, 3688.0411093115713, 3755.117547376364, 3818.4081467372603, 3825.9234815303817, 3836.693064554829, 1068.4444089073716, 1091.6288461922904, 1094.584058057933, 1132.5016992523347, 1132.7168207948014, 12576.496940122384, 12583.119181657288, 12586.81119783204, 12602.928751056172, 12623.495060197582, 4752.1683705351425, 5143.151380022255, 5203.687778733288, 5235.1623740201385, 5248.422673505911, 10798.460076996276, 10833.29583577065, 10847.566097356017, 10847.891521084846, 10853.620123295646, 5984.850378740566, 6006.249218847644, 6025.307089684655, 6031.60794548353, 6035.698215089228, 4588.908221835544, 4757.072370887644, 5070.2141168119, 5273.920891186635, 5359.651622644516, 4122.299209134454, 4137.855883343544, 4170.757843845778, 4204.495460544754, 4219.746815191098, 1152.4525850221078, 1381.9239941803096, 1387.0983860490762, 1399.0276757653332, 1407.3877863129571, 1367.47352269377, 1370.8903287736957, 1386.9029167958347, 1416.2635429576562, 1442.9639259018609, 8597.785055373666, 8747.475151490804, 8747.693830715894, 8751.606177722018, 8771.780705482413, 546.2980070609327, 548.14763043467, 559.7621011070279, 560.019965061143, 563.0934195944526, 6414.518911081687, 6422.197225346832, 6457.935420645827, 6481.708323125471, 6486.059521369375, 11182.0, 11592.246503977214, 11627.418629068681, 11750.412479376168, 11769.117316201318, 10276.383416995004, 10718.571257149626, 11256.0, 11357.148213883827, 11525.0, 8868.0, 8908.821823563492, 8960.462372257685, 8963.596638151168, 8983.640654373752, 8281.254687077952, 8333.83332333362, 8368.623411946355, 8430.45202061864, 8431.451955622864, 10207.948960255151, 10210.285280030326, 10286.845697314397, 10334.586616535255, 10429.53067111997, 10327.638532651321, 10335.0, 10658.307210031324, 10856.185786065918, 10867.967543083394, 7008.369246767816, 7195.316444937723, 7197.676104575202, 7868.095169055632, 7957.5225486471, 8005.3995950305125, 8492.532910689724, 8532.744017679479, 8563.914360856561, 8572.185642363966, 7490.737824176345, 7613.0, 7659.234076592296, 7676.846463070596, 7735.651895664596, 7472.663730132266, 7478.364339031244, 7480.625968701434, 7589.279018493235, 7607.087149542091, 6520.673966301571, 7940.16628254025, 8024.037115546172, 8031.759047228593, 8039.477433966774, 7303.087114110736, 7304.671289791866, 7314.96342518284, 7352.154502232098, 7364.189939106801, 7432.516886402366, 7465.962670186615, 7511.06111736033, 7515.13575938774, 7520.849583008418], "unit": "score", "name": "mootools.html", "value": 5104.123164384803}, {"lowerIsBetter": false, "replicates": [344.9448088305871, 354.9432090865462, 356.60060731980184, 356.95894972078213, 362.54319557357735, 5572.3870374258795, 6524.15186025816, 6591.209054913411, 6592.2418921824, 6603.966980165099, 6580.27616962135, 6581.243157036942, 6584.341565843413, 6593.967030164855, 6615.305392933745, 4795.304680821278, 4867.586255168315, 4898.363212782351, 4965.404151501825, 5012.523810238022, 4927.48261432548, 4952.133376659088, 4973.229149481836, 4976.303317535548, 4980.27785971034, 4931.778069986841, 4934.6299027572895, 4936.851894443173, 4958.281049247875, 5009.198528235483, 4779.330893674888, 4806.7836947337455, 4867.050925069613, 4928.950710492921, 4931.358923339979, 4216.79821250942, 4220.6412454941365, 4230.978845105786, 4233.957660423387, 4289.6997210195295, 6312.179416675849, 6347.206599175103, 6354.332795056545, 6359.0, 6373.8406539836415, 5764.913526297109, 5782.537397008229, 5782.653040817564, 5787.363390027093, 5790.739416726257, 6737.966310168418, 6992.2658120897595, 6995.930040699579, 6996.6851491683, 7001.754938577125, 3701.3152566775234, 3894.844206231747, 4728.739919304437, 4747.382840230783, 4754.762261886892, 7350.96324518374, 7372.483926125174, 7385.298396652363, 7389.224131466172, 7391.115265607344, 3972.2849887020616, 4818.927716084261, 4820.7107573545, 4828.830990915301, 4829.806807727722, 4871.098846713369, 4886.682365646222, 4890.021995600894, 4902.0, 4904.950950490521, 5747.39652336507, 5748.0, 5756.5682573807135, 5762.510186634183, 5769.624974376652, 5680.403557626472, 6707.429868461138, 6995.720171193096, 7033.085698859116, 7054.823629409306, 1676.6143786929074, 1705.360489816319, 1709.5555155659617, 1711.144427786107, 1712.5119340987758, 924.611663101499, 1054.9789004220027, 1073.8120828855076, 1106.0709004436312, 1113.560143743233, 5127.0, 6644.568103073285, 6678.53250272486, 6687.531872768956, 6691.464682825363, 6263.812085637438, 6917.962305654091, 7258.745943892044, 7271.0, 7278.199398066208, 5310.522053015247, 6662.167229096363, 6662.533622646465, 6670.4997125215805, 6684.097646817715, 3774.3960966245268, 3884.4755957945317, 3884.7863367515056, 3885.630865067814, 3890.2997460456822, 7061.0, 7271.636418179176, 7459.291367320096, 7514.173440921494, 7695.153533111354, 7264.418846492374, 7413.592252426169, 7463.776086717407, 7469.551826890404, 7515.699372025167, 7570.318671319607, 7596.772096837104, 7600.619969001527, 7601.049868766515, 7609.934609154723, 7211.206767255702, 7232.602206878672, 7235.782926512213, 7239.746608868875, 7245.818854528679, 7126.608036558039, 7128.857422851617, 7130.180029296697, 7134.286571342825, 7138.107736532934, 7359.1169059713175, 7610.581418022062, 7624.504407213513, 7627.046619172604, 7634.732784352521, 4625.491195968508, 4690.460597031385, 4703.176944034849, 4704.035672687022, 4721.9055618888115, 5985.790497332572, 7216.603086830275, 7278.272172782679, 7284.599347035752, 7288.781336559911, 7050.365467107985, 7053.365197132282, 7060.6116663584, 7062.505624606229, 7065.293470652894, 6750.561213521106, 6959.130108736408, 6969.616671083139, 6982.720691172296, 6986.196587392515, 6776.796696099125, 6861.245263021164, 6865.450763938973, 6870.0, 6897.172339319314, 7003.7548685795755, 7011.4390848733, 7014.298570142945, 7023.719051238098, 7034.0656319512545, 6821.522493425413, 6870.3473170048765, 6874.828129296808, 6879.793606191823, 6879.965600172167], "unit": "score", "name": "prototype.html", "value": 5162.139799949711}, {"lowerIsBetter": false, "replicates": [712.5048091576355, 791.1218547412371, 799.1169757418053, 805.1063319715118, 813.178689523581, 12348.382580870953, 15910.124943128123, 16269.267882945267, 16286.941348812334, 16291.918540407296, 15058.021228620131, 15175.0, 15179.468718594851, 15186.0888346699, 15236.771448428255, 828.3952714518405, 839.5340585974782, 917.6788124156525, 1023.8003589300052, 1040.1678657074349, 996.3573495095659, 1001.5643195210107, 1001.8747656542932, 1002.013017178079, 1032.385730490357, 1029.7785976015155, 1032.7779527401608, 1034.5965073621294, 1037.4190453346112, 1062.4634559547417, 865.9134086591354, 1059.8357254625507, 1071.073521403984, 1077.9920774076263, 1079.271491743078, 799.7280924485644, 805.9153788852145, 807.2452257139535, 807.3783186946077, 808.2281421242699, 15740.212989350486, 15797.447089351817, 15830.0, 15839.762403563956, 15858.920705396398, 13243.668908277274, 13336.533221337206, 13477.932610336984, 13695.794563081561, 13737.519186828513, 9018.09819018093, 10351.896481035245, 10462.581496740122, 10500.2649814513, 10591.25861189717, 3600.747947643666, 3625.873094441682, 3656.049427148934, 3736.5889752127246, 3800.6959443244473, 87001.69497457544, 87728.99999999936, 87777.12222877817, 87899.68150477747, 88114.0, 10007.349522281029, 10021.39871607706, 10138.695839124837, 10182.796344073076, 10609.734756631146, 23880.805959701946, 23913.282601521983, 23938.52122957566, 23971.04115835347, 24033.399165021016, 7588.81027974305, 7669.7315593953945, 7695.268949449794, 7730.420218483636, 7922.4850384724805, 4202.579742025773, 4289.099289149313, 4370.169667763115, 4381.123775244963, 4574.565416285448, 3704.2591481703766, 3774.9245015099546, 3779.773213607137, 3780.4707340972286, 3787.0532366908274, 663.1213641924469, 673.6732684647942, 677.0994577212394, 685.8456847209338, 702.6556987076295, 531.8670332416896, 605.5617907469759, 611.9571629985858, 618.3136718242747, 628.8899442597527, 7155.606441645759, 8670.78323041929, 8689.565521724015, 8703.521306328086, 8853.29173666105, 614.1524695919692, 621.8196722950385, 628.5568674084759, 630.5586089737202, 638.4796390941368, 3730.5336832895887, 3800.3729384651774, 3938.3501722215515, 4031.133306339151, 4119.402686610425, 86231.70652440218, 87688.0, 89284.0, 89900.20199596102, 98367.50816245873, 74326.25673743301, 78514.60742696364, 79919.60040199762, 80322.19677803264, 81661.95845103801, 69136.65431672809, 69473.65263173652, 71744.64127679433, 72080.63959680274, 72981.6350918242, 8895.0, 8926.642934282556, 9017.819643607223, 9073.500957447404, 9134.040925702706, 50072.99854002827, 50253.748731256106, 50673.0, 51101.72245693887, 52132.73933630308, 64628.0, 67577.66211168913, 70337.0, 70585.0, 70963.64518177375, 8791.912080879109, 10566.31318964265, 10981.945090274497, 11088.611898583511, 11326.603568875049, 12128.575499857463, 12275.2021118627, 12360.629181124581, 12489.500419983098, 12655.746885062063, 11475.13936454786, 11786.410679466164, 11823.068208473158, 12010.819837702616, 12170.269783812999, 11774.3524106175, 11891.524339026342, 12036.879631203576, 12089.093318001009, 12254.080943929062, 11512.251703639236, 11681.941590291994, 11866.82199766987, 11900.583479578174, 11976.221545599508, 9736.539519072196, 10098.798024039625, 10116.08955194036, 10219.948900255451, 10388.740281493023, 8434.915650843659, 9961.850572241277, 10016.499175041365, 10082.899171008195, 10156.085952264037], "unit": "score", "name": "yui.html", "value": 7251.709445462281}], "name": "dromaeo_css", "value": 7764.838119906761}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 110.0, 110.0, 111.0, 113.0, 120.0, 109.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [180.0, 150.0, 142.0, 159.0, 116.0, 143.0, 120.0, 152.0, 147.0, 110.0], "unit": "score", "name": "audio-beat-detection", "value": 141.9}, {"lowerIsBetter": true, "replicates": [183.0, 183.0, 184.0, 181.0, 183.0, 181.0, 183.0, 180.0, 182.0, 182.0], "unit": "score", "name": "audio-dft", "value": 182.2}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 75.0, 116.0, 54.0, 55.0, 58.0, 57.0, 119.0, 56.0], "unit": "score", "name": "audio-fft", "value": 73.4}, {"lowerIsBetter": true, "replicates": [89.0, 93.0, 126.0, 79.0, 77.0, 85.0, 116.0, 76.0, 78.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 93.4}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 86.0, 83.0, 86.0, 83.0, 85.0, 83.0, 85.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.3}, {"lowerIsBetter": true, "replicates": [104.0, 123.0, 92.0, 92.0, 92.0, 92.0, 93.0, 100.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 97.2}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 88.0, 83.0, 83.0, 83.0, 91.0, 130.0, 87.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 90.7}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 57.0, 58.0, 57.0, 57.0, 57.0, 58.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [65.0, 61.0, 66.0, 73.0, 77.0, 71.0, 67.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [80.0, 79.0, 80.0, 81.0, 80.0, 79.0, 66.0, 77.0, 87.0, 105.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.4}, {"lowerIsBetter": true, "replicates": [119.0, 131.0, 131.0, 120.0, 117.0, 123.0, 126.0, 116.0, 105.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.1}, {"lowerIsBetter": true, "replicates": [141.0, 120.0, 135.0, 129.0, 140.0, 133.0, 132.0, 131.0, 133.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 132.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 65.0, 65.0, 66.0, 65.0, 65.0, 69.0, 65.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1399.3}]} 03:58:53 INFO - Return code: 0 03:58:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:58:53 INFO - # TBPL SUCCESS # 03:58:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:58:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:58:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:58:53 INFO - 2016-05-11 03:58:53.121 screenresolution[1846:9991] starting screenresolution argv=screenresolution get 03:58:53 INFO - 2016-05-11 03:58:53.123 screenresolution[1846:9991] Display 0: 1600x1200x32@60 03:58:53 INFO - 2016-05-11 03:58:53.129 screenresolution[1847:9994] starting screenresolution argv=screenresolution list 03:58:53 INFO - Available Modes on Display 0 03:58:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:58:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:58:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:58:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:58:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:58:53 INFO - Intel Iris: 03:58:53 INFO - Chipset Model: Intel Iris 03:58:53 INFO - Type: GPU 03:58:53 INFO - Bus: Built-In 03:58:53 INFO - VRAM (Dynamic, Max): 1536 MB 03:58:53 INFO - Vendor: Intel (0x8086) 03:58:53 INFO - Device ID: 0x0a2e 03:58:53 INFO - Revision ID: 0x0009 03:58:53 INFO - Displays: 03:58:53 INFO - Display: 03:58:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:58:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:58:53 INFO - Display Serial Number: 1600x1200 60 03:58:53 INFO - Main Display: Yes 03:58:53 INFO - Mirror: Off 03:58:53 INFO - Online: Yes 03:58:53 INFO - Rotation: Supported 03:58:53 INFO - Return code: 0 03:58:53 INFO - Running post-action listener: _resource_record_post_action 03:58:53 INFO - Running post-run listener: _resource_record_post_run 03:58:54 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 32755200; Write bytes: 510282240; Read time: 331; Write time: 1776 03:58:54 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 198613504; Write bytes: 198080000; Read time: 17935; Write time: 444 03:58:54 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 30989824; Write bytes: 301409280; Read time: 309; Write time: 1292 03:58:54 INFO - Running post-run listener: _upload_blobber_files 03:58:54 INFO - Blob upload gear active. 03:58:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:58:54 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:58:54 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:58:54 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:58:54 INFO - (blobuploader) - INFO - Open directory for files ... 03:58:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:58:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:58:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:55 INFO - (blobuploader) - INFO - Done attempting. 03:58:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:58:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:58:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:58:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:58:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:58:56 INFO - (blobuploader) - INFO - Done attempting. 03:58:56 INFO - (blobuploader) - INFO - Iteration through files over. 03:58:56 INFO - Return code: 0 03:58:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:58:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:58:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45b39a35d36da29830b5b3296c60806dd2628439cf234ba62c9759da3950547ac4b16b6834cbd6f5589417f0bec21f5e6d35e8a60e916ab32c55a66592564440", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/805eb20bc1c452382939702fd8dc6e6167736bb843f4c8e19eb9f23cbac678956179b2e4ac713f2c51ba17d15e90799175ab4a2009554d6c2b3b5cf8cd04ddb4"} 03:58:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:58:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:58:56 INFO - Contents: 03:58:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45b39a35d36da29830b5b3296c60806dd2628439cf234ba62c9759da3950547ac4b16b6834cbd6f5589417f0bec21f5e6d35e8a60e916ab32c55a66592564440", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/805eb20bc1c452382939702fd8dc6e6167736bb843f4c8e19eb9f23cbac678956179b2e4ac713f2c51ba17d15e90799175ab4a2009554d6c2b3b5cf8cd04ddb4"} 03:58:56 INFO - Running post-run listener: copy_logs_to_upload_dir 03:58:56 INFO - Copying logs to upload dir... 03:58:56 INFO - mkdir: /builds/slave/test/build/upload/logs 03:58:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.923458 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-11 03:58:56.699528) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 03:58:56.703583) ========= 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.S4K97vIQN8/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.Tikd0ok7eQ/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45b39a35d36da29830b5b3296c60806dd2628439cf234ba62c9759da3950547ac4b16b6834cbd6f5589417f0bec21f5e6d35e8a60e916ab32c55a66592564440", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/805eb20bc1c452382939702fd8dc6e6167736bb843f4c8e19eb9f23cbac678956179b2e4ac713f2c51ba17d15e90799175ab4a2009554d6c2b3b5cf8cd04ddb4"} build_url:https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010949 build_url: 'https://queue.taskcluster.net/v1/task/B3j_8dI4R3a8losG2wK-WA/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/45b39a35d36da29830b5b3296c60806dd2628439cf234ba62c9759da3950547ac4b16b6834cbd6f5589417f0bec21f5e6d35e8a60e916ab32c55a66592564440", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/805eb20bc1c452382939702fd8dc6e6167736bb843f4c8e19eb9f23cbac678956179b2e4ac713f2c51ba17d15e90799175ab4a2009554d6c2b3b5cf8cd04ddb4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-11 03:58:56.732474) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:58:56.733038) ========= 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.S4K97vIQN8/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.Tikd0ok7eQ/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.004952 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-11 03:58:56.782997) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 03:58:56.783337) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-11 03:58:56.783885) ========= ========= Total master_lag: 0.16 =========