builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0283 starttime: 1466520075.45 results: success (0) buildid: 20160621055904 builduid: aaa87a9ab85f4e26a03835bfe826c945 revision: 5f7dcce004111d3e2f78cdae83bafb8551937018 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 07:41:15.447822) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 07:41:15.448777) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 07:41:15.449079) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 07:41:15.474213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:41:15.474892) ========= 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.LlfvfJQX7P/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.Xwl9kRFBFC/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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-06-21 07:41:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 22.1M=0.001s 2016-06-21 07:41:16 (22.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.549612 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:41:16.062378) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:41:16.062710) ========= 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.LlfvfJQX7P/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.Xwl9kRFBFC/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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.020459 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 07:41:16.133336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 07:41:16.133857) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5f7dcce004111d3e2f78cdae83bafb8551937018 --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 5f7dcce004111d3e2f78cdae83bafb8551937018 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LlfvfJQX7P/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.Xwl9kRFBFC/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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-06-21 07:41:16,218 truncating revision to first 12 chars 2016-06-21 07:41:16,218 Setting DEBUG logging. 2016-06-21 07:41:16,218 attempt 1/10 2016-06-21 07:41:16,218 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5f7dcce00411?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 07:41:17,392 unpacking tar archive at: mozilla-beta-5f7dcce00411/testing/mozharness/ program finished with exit code 0 elapsedTime=1.446398 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 07:41:17.604131) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 07:41:17.604639) ========= script_repo_revision: 5f7dcce004111d3e2f78cdae83bafb8551937018 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 07:41:17.605305) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 07:41:17.605787) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 07:41:17.624477) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-21 07:41:17.625168) ========= /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.LlfvfJQX7P/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.Xwl9kRFBFC/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 07:41:17 INFO - MultiFileLogger online at 20160621 07:41:17 in /builds/slave/test 07:41:17 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 07:41:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:41:17 INFO - {'append_to_log': False, 07:41:17 INFO - 'base_work_dir': '/builds/slave/test', 07:41:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:41:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:41:17 INFO - 'branch': 'Mozilla-Beta', 07:41:17 INFO - 'buildbot_json_path': 'buildprops.json', 07:41:17 INFO - 'config_files': ('talos/mac_config.py',), 07:41:17 INFO - 'default_actions': ('clobber', 07:41:17 INFO - 'read-buildbot-config', 07:41:17 INFO - 'download-and-extract', 07:41:17 INFO - 'populate-webroot', 07:41:17 INFO - 'create-virtualenv', 07:41:17 INFO - 'install', 07:41:17 INFO - 'run-tests'), 07:41:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:41:17 INFO - 'download_minidump_stackwalk': True, 07:41:17 INFO - 'download_symbols': 'ondemand', 07:41:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:41:17 INFO - 'tooltool.py': '/tools/tooltool.py', 07:41:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:41:17 INFO - '/tools/misc-python/virtualenv.py')}, 07:41:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:41:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:41:17 INFO - 'installer_path': 'installer.exe', 07:41:17 INFO - 'log_level': 'info', 07:41:17 INFO - 'log_name': 'talos', 07:41:17 INFO - 'log_to_console': True, 07:41:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:41:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:41:17 INFO - 'opt_config_files': (), 07:41:17 INFO - 'pip_index': False, 07:41:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:41:17 INFO - 'cmd': ('bash', 07:41:17 INFO - '-c', 07:41:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:41:17 INFO - 'enabled': True, 07:41:17 INFO - 'halt_on_failure': False, 07:41:17 INFO - 'name': 'check_screen_resolution'},), 07:41:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:41:17 INFO - 'cmd': ('bash', 07:41:17 INFO - '-c', 07:41:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:41:17 INFO - 'enabled': True, 07:41:17 INFO - 'halt_on_failure': False, 07:41:17 INFO - 'name': 'check_screen_resolution'},), 07:41:17 INFO - 'run_cmd_checks_enabled': True, 07:41:17 INFO - 'sps_profile': False, 07:41:17 INFO - 'sps_profile_interval': 0, 07:41:17 INFO - 'suite': 'dromaeojs', 07:41:17 INFO - 'system_bits': '32', 07:41:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:41:17 INFO - 'title': 't-yosemite-r7-0283', 07:41:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:41:17 INFO - 'use_talos_json': True, 07:41:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:41:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:41:17 INFO - 'work_dir': 'build'} 07:41:17 INFO - ##### 07:41:17 INFO - ##### Running clobber step. 07:41:17 INFO - ##### 07:41:17 INFO - Running pre-action listener: _resource_record_pre_action 07:41:17 INFO - Running main action method: clobber 07:41:17 INFO - rmtree: /builds/slave/test/build 07:41:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:41:18 INFO - Running post-action listener: _resource_record_post_action 07:41:18 INFO - ##### 07:41:18 INFO - ##### Running read-buildbot-config step. 07:41:18 INFO - ##### 07:41:18 INFO - Running pre-action listener: _resource_record_pre_action 07:41:18 INFO - Running main action method: read_buildbot_config 07:41:18 INFO - Using buildbot properties: 07:41:18 INFO - { 07:41:18 INFO - "project": "", 07:41:18 INFO - "product": "firefox", 07:41:18 INFO - "script_repo_revision": "production", 07:41:18 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 07:41:18 INFO - "repository": "", 07:41:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 07:41:18 INFO - "buildid": "20160621055904", 07:41:18 INFO - "pgo_build": "False", 07:41:18 INFO - "basedir": "/builds/slave/test", 07:41:18 INFO - "buildnumber": 27, 07:41:18 INFO - "slavename": "t-yosemite-r7-0283", 07:41:18 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 07:41:18 INFO - "platform": "yosemite_r7", 07:41:18 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:41:18 INFO - "branch": "mozilla-beta", 07:41:18 INFO - "repo_path": "releases/mozilla-beta", 07:41:18 INFO - "revision": "5f7dcce004111d3e2f78cdae83bafb8551937018", 07:41:18 INFO - "stage_platform": "macosx64", 07:41:18 INFO - "builduid": "aaa87a9ab85f4e26a03835bfe826c945", 07:41:18 INFO - "slavebuilddir": "test" 07:41:18 INFO - } 07:41:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 07:41:18 INFO - Running post-action listener: _resource_record_post_action 07:41:18 INFO - ##### 07:41:18 INFO - ##### Running download-and-extract step. 07:41:18 INFO - ##### 07:41:18 INFO - Running pre-action listener: _resource_record_pre_action 07:41:18 INFO - Running main action method: download_and_extract 07:41:18 INFO - mkdir: /builds/slave/test/build/tests 07:41:18 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')]} 07:41:18 INFO - https://queue.taskcluster.net/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:41:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 07:41:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 07:41:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 07:41:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 07:41:20 INFO - Downloaded 1165 bytes. 07:41:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 07:41:20 INFO - Using the following test package requirements: 07:41:20 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 07:41:20 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:41:20 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 07:41:20 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:41:20 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 07:41:20 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:41:20 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:41:20 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 07:41:20 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 07:41:20 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:41:20 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 07:41:20 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:41:20 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 07:41:20 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:41:20 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 07:41:20 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 07:41:20 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 07:41:20 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 07:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:20 INFO - https://queue.taskcluster.net/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:41:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:41:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:41:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 07:41:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 07:41:21 INFO - Downloaded 18301149 bytes. 07:41:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:41:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:41:24 INFO - Return code: 0 07:41:24 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:41:24 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')]} 07:41:24 INFO - https://queue.taskcluster.net/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:41:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:41:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 07:41:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 07:41:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 07:41:27 INFO - Downloaded 18301149 bytes. 07:41:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:41:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:41:30 INFO - Return code: 0 07:41: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')]} 07:41:30 INFO - https://queue.taskcluster.net/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:41:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 07:41:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 07:41:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 07:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 07:41:33 INFO - Downloaded 10840145 bytes. 07:41:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:41:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:41:34 INFO - Return code: 0 07:41: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')]} 07:41:34 INFO - https://queue.taskcluster.net/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 07:41:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:41:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:41:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 07:41:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 07:41:40 INFO - Downloaded 86247846 bytes. 07:41:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:41:40 INFO - mkdir: /builds/slave/test/properties 07:41:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:41:40 INFO - Writing to file /builds/slave/test/properties/build_url 07:41:40 INFO - Contents: 07:41:40 INFO - build_url:https://queue.taskcluster.net/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 07:41:41 INFO - Running post-action listener: _resource_record_post_action 07:41:41 INFO - Running post-action listener: set_extra_try_arguments 07:41:41 INFO - ##### 07:41:41 INFO - ##### Running populate-webroot step. 07:41:41 INFO - ##### 07:41:41 INFO - Running pre-action listener: _resource_record_pre_action 07:41:41 INFO - Running main action method: populate_webroot 07:41:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:41:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:41:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:41:41 INFO - '--tppagecycles', 07:41:41 INFO - '7'], 07:41:41 INFO - 'tests': ['tsvgm']}}, 07:41:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:41:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:41:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:41:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:41:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:41:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:41:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:41 INFO - 'talos_options': ['--disable-e10s'], 07:41:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:41 INFO - 'talos_options': ['--disable-e10s'], 07:41:41 INFO - 'tests': ['damp', 'tps']}, 07:41:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:41 INFO - 'tests': ['damp', 'tps']}, 07:41:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:41:41 INFO - 'tests': ['dromaeo_dom']}, 07:41:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:41:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:41:41 INFO - 'tests': ['a11yr', 07:41:41 INFO - 'ts_paint', 07:41:41 INFO - 'tpaint', 07:41:41 INFO - 'sessionrestore', 07:41:41 INFO - 'sessionrestore_no_auto_restore', 07:41:41 INFO - 'tabpaint']}, 07:41:41 INFO - 'other-e10s': {'tests': ['a11yr', 07:41:41 INFO - 'ts_paint', 07:41:41 INFO - 'tpaint', 07:41:41 INFO - 'sessionrestore', 07:41:41 INFO - 'sessionrestore_no_auto_restore', 07:41:41 INFO - 'tabpaint']}, 07:41:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:41:41 INFO - 'ts_paint', 07:41:41 INFO - 'tpaint', 07:41:41 INFO - 'sessionrestore', 07:41:41 INFO - 'sessionrestore_no_auto_restore', 07:41:41 INFO - 'tabpaint']}, 07:41:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:41:41 INFO - 'ts_paint', 07:41:41 INFO - 'tpaint', 07:41:41 INFO - 'sessionrestore', 07:41:41 INFO - 'sessionrestore_no_auto_restore', 07:41:41 INFO - 'tabpaint']}, 07:41:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:41:41 INFO - 'tests': ['a11yr', 07:41:41 INFO - 'ts_paint', 07:41:41 INFO - 'tpaint', 07:41:41 INFO - 'sessionrestore', 07:41:41 INFO - 'sessionrestore_no_auto_restore', 07:41:41 INFO - 'tabpaint']}, 07:41:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:41:41 INFO - 'tests': ['a11yr', 07:41:41 INFO - 'ts_paint', 07:41:41 INFO - 'tpaint', 07:41:41 INFO - 'sessionrestore', 07:41:41 INFO - 'sessionrestore_no_auto_restore', 07:41:41 INFO - 'tabpaint']}, 07:41:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:41:41 INFO - 'tests': ['tsvgx', 07:41:41 INFO - 'tsvgr_opacity', 07:41:41 INFO - 'tart', 07:41:41 INFO - 'tscrollx', 07:41:41 INFO - 'cart']}, 07:41:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:41:41 INFO - 'tsvgr_opacity', 07:41:41 INFO - 'tart', 07:41:41 INFO - 'tscrollx', 07:41:41 INFO - 'cart']}, 07:41:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:41 INFO - 'talos_options': ['--disable-e10s'], 07:41:41 INFO - 'tests': ['tp5o']}, 07:41:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:41 INFO - 'tests': ['tp5o']}, 07:41:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:41 INFO - 'talos_options': ['--disable-e10s', 07:41:41 INFO - '--xperf_path', 07:41:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:41 INFO - 'tests': ['tp5n']}, 07:41:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:41 INFO - 'talos_options': ['--xperf_path', 07:41:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:41 INFO - 'tests': ['tp5n']}}, 07:41:41 INFO - 'talos.zip': {'path': '', 07:41:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:41:41 INFO - Running post-action listener: _resource_record_post_action 07:41:41 INFO - ##### 07:41:41 INFO - ##### Running create-virtualenv step. 07:41:41 INFO - ##### 07:41:41 INFO - Running pre-action listener: _resource_record_pre_action 07:41:41 INFO - Running main action method: create_virtualenv 07:41:41 INFO - Creating virtualenv /builds/slave/test/build/venv 07:41:41 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 07:41:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:41:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:41:42 INFO - Using real prefix '/tools/python27' 07:41:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:41:42 INFO - Installing distribute.............................................................................................................................................................................................done. 07:41:45 INFO - Installing pip.................done. 07:41:45 INFO - Return code: 0 07:41:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91db5ae930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d65ce00>, '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 0x10d4c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d657b20>, '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.LlfvfJQX7P/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.Xwl9kRFBFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 07:41:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:41:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LlfvfJQX7P/Render', 07:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:45 INFO - 'HOME': '/Users/cltbld', 07:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:45 INFO - 'LOGNAME': 'cltbld', 07:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:45 INFO - 'MOZ_NO_REMOTE': '1', 07:41:45 INFO - 'NO_EM_RESTART': '1', 07:41:45 INFO - 'PAGER': '/bin/cat', 07:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:45 INFO - 'PWD': '/builds/slave/test', 07:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:45 INFO - 'SHELL': '/bin/bash', 07:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xwl9kRFBFC/Listeners', 07:41:45 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 07:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:45 INFO - 'USER': 'cltbld', 07:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:45 INFO - 'XPC_FLAGS': '0x0', 07:41:45 INFO - 'XPC_SERVICE_NAME': '0', 07:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:45 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 07:41:45 INFO - Cleaning up... 07:41:45 INFO - Return code: 0 07:41:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d7bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91db5ae930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d65ce00>, '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 0x10d4c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d657b20>, '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.LlfvfJQX7P/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.Xwl9kRFBFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 07:41:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:41:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:41:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LlfvfJQX7P/Render', 07:41:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:45 INFO - 'HOME': '/Users/cltbld', 07:41:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:45 INFO - 'LOGNAME': 'cltbld', 07:41:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:45 INFO - 'MOZ_NO_REMOTE': '1', 07:41:45 INFO - 'NO_EM_RESTART': '1', 07:41:45 INFO - 'PAGER': '/bin/cat', 07:41:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:45 INFO - 'PWD': '/builds/slave/test', 07:41:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:45 INFO - 'SHELL': '/bin/bash', 07:41:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xwl9kRFBFC/Listeners', 07:41:45 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 07:41:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:45 INFO - 'USER': 'cltbld', 07:41:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:45 INFO - 'XPC_FLAGS': '0x0', 07:41:45 INFO - 'XPC_SERVICE_NAME': '0', 07:41:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:46 INFO - Downloading/unpacking psutil>=0.7.1 07:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:41:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:49 INFO - Installing collected packages: psutil 07:41:49 INFO - Running setup.py install for psutil 07:41:49 INFO - building 'psutil._psutil_osx' extension 07:41:49 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 07:41:49 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 07:41:49 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 07:41:50 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 07:41:50 INFO - building 'psutil._psutil_posix' extension 07:41:50 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 07:41:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:41:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:41:50 INFO - ^ 07:41:50 INFO - 1 warning generated. 07:41:50 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 07:41:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:50 INFO - Successfully installed psutil 07:41:50 INFO - Cleaning up... 07:41:50 INFO - Return code: 0 07:41:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d7bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91db5ae930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d65ce00>, '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 0x10d4c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d657b20>, '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.LlfvfJQX7P/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.Xwl9kRFBFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 07:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:41:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LlfvfJQX7P/Render', 07:41:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:50 INFO - 'HOME': '/Users/cltbld', 07:41:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:50 INFO - 'LOGNAME': 'cltbld', 07:41:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:50 INFO - 'MOZ_NO_REMOTE': '1', 07:41:50 INFO - 'NO_EM_RESTART': '1', 07:41:50 INFO - 'PAGER': '/bin/cat', 07:41:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:50 INFO - 'PWD': '/builds/slave/test', 07:41:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:50 INFO - 'SHELL': '/bin/bash', 07:41:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xwl9kRFBFC/Listeners', 07:41:50 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 07:41:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:50 INFO - 'USER': 'cltbld', 07:41:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:50 INFO - 'XPC_FLAGS': '0x0', 07:41:50 INFO - 'XPC_SERVICE_NAME': '0', 07:41:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:41:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:41:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:41:53 INFO - Installing collected packages: mozsystemmonitor 07:41:53 INFO - Running setup.py install for mozsystemmonitor 07:41:53 INFO - Successfully installed mozsystemmonitor 07:41:53 INFO - Cleaning up... 07:41:53 INFO - Return code: 0 07:41:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:41:53 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')]} 07:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:53 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')]} 07:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:53 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 0x10d7bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91db5ae930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d65ce00>, '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 0x10d4c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d657b20>, '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.LlfvfJQX7P/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.Xwl9kRFBFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 07:41:53 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 07:41:53 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 07:41:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LlfvfJQX7P/Render', 07:41:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:53 INFO - 'HOME': '/Users/cltbld', 07:41:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:53 INFO - 'LOGNAME': 'cltbld', 07:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:53 INFO - 'MOZ_NO_REMOTE': '1', 07:41:53 INFO - 'NO_EM_RESTART': '1', 07:41:53 INFO - 'PAGER': '/bin/cat', 07:41:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:53 INFO - 'PWD': '/builds/slave/test', 07:41:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:53 INFO - 'SHELL': '/bin/bash', 07:41:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xwl9kRFBFC/Listeners', 07:41:53 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 07:41:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:53 INFO - 'USER': 'cltbld', 07:41:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:53 INFO - 'XPC_FLAGS': '0x0', 07:41:53 INFO - 'XPC_SERVICE_NAME': '0', 07:41:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:53 INFO - Downloading/unpacking blobuploader==1.2.4 07:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:56 INFO - Downloading blobuploader-1.2.4.tar.gz 07:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:41:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:41:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:57 INFO - Downloading docopt-0.6.1.tar.gz 07:41:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:41:57 INFO - Installing collected packages: blobuploader, requests, docopt 07:41:57 INFO - Running setup.py install for blobuploader 07:41:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:41:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:41:57 INFO - Running setup.py install for requests 07:41:58 INFO - Running setup.py install for docopt 07:41:58 INFO - Successfully installed blobuploader requests docopt 07:41:58 INFO - Cleaning up... 07:41:58 INFO - Return code: 0 07:41:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41:58 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')]} 07:41:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:58 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')]} 07:41:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:58 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 0x10d7bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91db5ae930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d65ce00>, '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 0x10d4c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d657b20>, '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.LlfvfJQX7P/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.Xwl9kRFBFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 07:41:58 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 07:41:58 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 07:41:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LlfvfJQX7P/Render', 07:41:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:58 INFO - 'HOME': '/Users/cltbld', 07:41:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:58 INFO - 'LOGNAME': 'cltbld', 07:41:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:58 INFO - 'MOZ_NO_REMOTE': '1', 07:41:58 INFO - 'NO_EM_RESTART': '1', 07:41:58 INFO - 'PAGER': '/bin/cat', 07:41:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:58 INFO - 'PWD': '/builds/slave/test', 07:41:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:58 INFO - 'SHELL': '/bin/bash', 07:41:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xwl9kRFBFC/Listeners', 07:41:58 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 07:41:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:58 INFO - 'USER': 'cltbld', 07:41:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:58 INFO - 'XPC_FLAGS': '0x0', 07:41:58 INFO - 'XPC_SERVICE_NAME': '0', 07:41:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:41:58 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-w3ORmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:41:58 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-Thz0Gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:41:58 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-MfYM0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:41:58 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-g3mjiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:41:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:41:58 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-_fVv6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:41:59 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-WSHsJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:41:59 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-UXXsIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:41:59 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-uBLCwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:41:59 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-IMJwh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:41:59 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-oqmwN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:41:59 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-riUSr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:41:59 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-BOixXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:41:59 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-0u8YRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:41:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:41:59 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-wDxb3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:00 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-8pKRnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:00 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-0VVZuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:00 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-TjztvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:42:00 INFO - Running setup.py install for manifestparser 07:42:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:42:00 INFO - Running setup.py install for mozcrash 07:42:00 INFO - Running setup.py install for mozdebug 07:42:00 INFO - Running setup.py install for mozdevice 07:42:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:42:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:42:00 INFO - Running setup.py install for mozfile 07:42:01 INFO - Running setup.py install for mozhttpd 07:42:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Running setup.py install for mozinfo 07:42:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Running setup.py install for mozInstall 07:42:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Running setup.py install for mozleak 07:42:01 INFO - Running setup.py install for mozlog 07:42:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Running setup.py install for moznetwork 07:42:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:42:01 INFO - Running setup.py install for mozprocess 07:42:02 INFO - Running setup.py install for mozprofile 07:42:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:42:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:42:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:42:02 INFO - Running setup.py install for mozrunner 07:42:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:42:02 INFO - Running setup.py install for mozscreenshot 07:42:02 INFO - Running setup.py install for moztest 07:42:02 INFO - Running setup.py install for mozversion 07:42:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:42:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:42:02 INFO - Cleaning up... 07:42:02 INFO - Return code: 0 07:42:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:02 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')]} 07:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:02 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')]} 07:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:02 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 0x10d7bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91db5ae930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d65ce00>, '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 0x10d4c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d657b20>, '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.LlfvfJQX7P/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.Xwl9kRFBFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 07:42:02 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 07:42:02 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 07:42:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LlfvfJQX7P/Render', 07:42:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:02 INFO - 'HOME': '/Users/cltbld', 07:42:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:02 INFO - 'LOGNAME': 'cltbld', 07:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:02 INFO - 'MOZ_NO_REMOTE': '1', 07:42:02 INFO - 'NO_EM_RESTART': '1', 07:42:02 INFO - 'PAGER': '/bin/cat', 07:42:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:02 INFO - 'PWD': '/builds/slave/test', 07:42:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:02 INFO - 'SHELL': '/bin/bash', 07:42:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xwl9kRFBFC/Listeners', 07:42:02 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 07:42:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:02 INFO - 'USER': 'cltbld', 07:42:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:02 INFO - 'XPC_FLAGS': '0x0', 07:42:02 INFO - 'XPC_SERVICE_NAME': '0', 07:42:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:42:03 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-1p9oDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:42:03 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)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:42:03 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-e6goqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:42:03 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)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:42:03 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-6UB794-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:42:03 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)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:42:03 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-W4NlFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:42:03 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)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:42:03 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-sNSNwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:42:03 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)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:42:03 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-pWaP6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:42:03 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)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:42:03 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-59lnxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:42:03 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)) 07:42:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:42:03 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-gGiCXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:42:04 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)) 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:42:04 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-2iOFt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:42:04 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)) 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:42:04 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-AQyouw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:42:04 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)) 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:42:04 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-6L23TU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:42:04 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)) 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:42:04 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-PVrqAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:42:04 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)) 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:42:04 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-ulCGP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:42:04 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)) 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:42:04 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-5pNXEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:04 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)) 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:04 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-txDgsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:04 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)) 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:04 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-fsl0Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:04 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)) 07:42:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:04 INFO - Running setup.py (path:/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/pip-8M5ZVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42:04 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)) 07:42:04 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)) 07:42:04 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)) 07:42:04 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)) 07:42:04 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)) 07:42:04 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)) 07:42:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:42:04 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 07:42:04 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 07:42:04 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 07:42:04 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 07:42:04 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 07:42:04 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 07:42:07 INFO - Downloading blessings-1.6.tar.gz 07:42:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:42:07 INFO - Installing collected packages: blessings 07:42:07 INFO - Running setup.py install for blessings 07:42:07 INFO - Successfully installed blessings 07:42:07 INFO - Cleaning up... 07:42:07 INFO - Return code: 0 07:42:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:42:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:42:08 INFO - Reading from file tmpfile_stdout 07:42:08 INFO - Current package versions: 07:42:08 INFO - blessings == 1.6 07:42:08 INFO - blobuploader == 1.2.4 07:42:08 INFO - docopt == 0.6.1 07:42:08 INFO - manifestparser == 1.1 07:42:08 INFO - mozInstall == 1.12 07:42:08 INFO - mozcrash == 0.17 07:42:08 INFO - mozdebug == 0.1 07:42:08 INFO - mozdevice == 0.48 07:42:08 INFO - mozfile == 1.2 07:42:08 INFO - mozhttpd == 0.7 07:42:08 INFO - mozinfo == 0.9 07:42:08 INFO - mozleak == 0.1 07:42:08 INFO - mozlog == 3.1 07:42:08 INFO - moznetwork == 0.27 07:42:08 INFO - mozprocess == 0.22 07:42:08 INFO - mozprofile == 0.28 07:42:08 INFO - mozrunner == 6.11 07:42:08 INFO - mozscreenshot == 0.1 07:42:08 INFO - mozsystemmonitor == 0.0 07:42:08 INFO - moztest == 0.7 07:42:08 INFO - mozversion == 1.4 07:42:08 INFO - psutil == 3.1.1 07:42:08 INFO - requests == 1.2.3 07:42:08 INFO - wsgiref == 0.1.2 07:42:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:08 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')]} 07:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:08 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')]} 07:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:08 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 0x10d7bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91db5ae930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d65ce00>, '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 0x10d4c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d657b20>, '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.LlfvfJQX7P/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.Xwl9kRFBFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 07:42:08 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 07:42:08 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 07:42:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LlfvfJQX7P/Render', 07:42:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:08 INFO - 'HOME': '/Users/cltbld', 07:42:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:08 INFO - 'LOGNAME': 'cltbld', 07:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:08 INFO - 'MOZ_NO_REMOTE': '1', 07:42:08 INFO - 'NO_EM_RESTART': '1', 07:42:08 INFO - 'PAGER': '/bin/cat', 07:42:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:08 INFO - 'PWD': '/builds/slave/test', 07:42:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:08 INFO - 'SHELL': '/bin/bash', 07:42:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xwl9kRFBFC/Listeners', 07:42:08 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 07:42:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:08 INFO - 'USER': 'cltbld', 07:42:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:08 INFO - 'XPC_FLAGS': '0x0', 07:42:08 INFO - 'XPC_SERVICE_NAME': '0', 07:42:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:08 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)) 07:42:08 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)) 07:42:08 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)) 07:42:08 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)) 07:42:08 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)) 07:42:08 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)) 07:42:08 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)) 07:42:08 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)) 07:42:08 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)) 07:42:08 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)) 07:42:08 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)) 07:42:08 INFO - Cleaning up... 07:42:08 INFO - Return code: 0 07:42:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:42:08 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')]} 07:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:08 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')]} 07:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:08 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 0x10d7bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91db5ae930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d65ce00>, '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 0x10d4c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d657b20>, '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.LlfvfJQX7P/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.Xwl9kRFBFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 07:42:08 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 07:42:08 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 07:42:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LlfvfJQX7P/Render', 07:42:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:08 INFO - 'HOME': '/Users/cltbld', 07:42:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:08 INFO - 'LOGNAME': 'cltbld', 07:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:08 INFO - 'MOZ_NO_REMOTE': '1', 07:42:08 INFO - 'NO_EM_RESTART': '1', 07:42:08 INFO - 'PAGER': '/bin/cat', 07:42:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:08 INFO - 'PWD': '/builds/slave/test', 07:42:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:08 INFO - 'SHELL': '/bin/bash', 07:42:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xwl9kRFBFC/Listeners', 07:42:08 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 07:42:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:08 INFO - 'USER': 'cltbld', 07:42:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:08 INFO - 'XPC_FLAGS': '0x0', 07:42:08 INFO - 'XPC_SERVICE_NAME': '0', 07:42:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:08 INFO - Downloading/unpacking jsonschema 07:42:08 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 07:42:08 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 07:42:08 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 07:42:08 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 07:42:08 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 07:42:08 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 07:42:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:42:11 INFO - Downloading/unpacking functools32 (from jsonschema) 07:42:11 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 07:42:11 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 07:42:11 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 07:42:11 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 07:42:11 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 07:42:11 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 07:42:11 INFO - Downloading functools32-3.2.3-2.tar.gz 07:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:42:11 INFO - warning: no files found matching '*.txt' 07:42:11 INFO - no previously-included directories found matching 'build' 07:42:11 INFO - no previously-included directories found matching 'dist' 07:42:11 INFO - no previously-included directories found matching '.git*' 07:42:11 INFO - Installing collected packages: jsonschema, functools32 07:42:11 INFO - Running setup.py install for functools32 07:42:11 INFO - warning: no files found matching '*.txt' 07:42:11 INFO - no previously-included directories found matching 'build' 07:42:11 INFO - no previously-included directories found matching 'dist' 07:42:11 INFO - no previously-included directories found matching '.git*' 07:42:11 INFO - Successfully installed jsonschema functools32 07:42:11 INFO - Cleaning up... 07:42:11 INFO - Return code: 0 07:42:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:42: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')]} 07:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42: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')]} 07:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:11 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 0x10d7bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7cd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91db5ae930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d65ce00>, '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 0x10d4c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d657b20>, '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.LlfvfJQX7P/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.Xwl9kRFBFC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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 07:42:11 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 07:42:11 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 07:42:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LlfvfJQX7P/Render', 07:42:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:11 INFO - 'HOME': '/Users/cltbld', 07:42:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:11 INFO - 'LOGNAME': 'cltbld', 07:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:11 INFO - 'MOZ_NO_REMOTE': '1', 07:42:11 INFO - 'NO_EM_RESTART': '1', 07:42:11 INFO - 'PAGER': '/bin/cat', 07:42:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:11 INFO - 'PWD': '/builds/slave/test', 07:42:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:11 INFO - 'SHELL': '/bin/bash', 07:42:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xwl9kRFBFC/Listeners', 07:42:11 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 07:42:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:11 INFO - 'USER': 'cltbld', 07:42:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:11 INFO - 'XPC_FLAGS': '0x0', 07:42:11 INFO - 'XPC_SERVICE_NAME': '0', 07:42:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:12 INFO - Downloading/unpacking flake8 07:42:12 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 07:42:12 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 07:42:12 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 07:42:12 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 07:42:12 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 07:42:12 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 07:42:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:42:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:42:14 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 07:42:14 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 07:42:14 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 07:42:14 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 07:42:14 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 07:42:14 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 07:42:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:42:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:42:14 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 07:42:14 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 07:42:14 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 07:42:14 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 07:42:14 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 07:42:14 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 07:42:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:42:15 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 07:42:15 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 07:42:15 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 07:42:15 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 07:42:15 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 07:42:15 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 07:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:42:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:42:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:42:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:42:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:42:15 INFO - no previously-included directories found matching 'docs/_build' 07:42:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:42:15 INFO - Running setup.py install for pep8 07:42:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:42:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:42:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:42:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:42:16 INFO - no previously-included directories found matching 'docs/_build' 07:42:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:42:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:42:16 INFO - Cleaning up... 07:42:16 INFO - Return code: 0 07:42:16 INFO - Running post-action listener: _resource_record_post_action 07:42:16 INFO - Running post-action listener: _start_resource_monitoring 07:42:16 INFO - Starting resource monitoring. 07:42:16 INFO - ##### 07:42:16 INFO - ##### Running install step. 07:42:16 INFO - ##### 07:42:16 INFO - Running pre-action listener: _resource_record_pre_action 07:42:16 INFO - Running main action method: install 07:42:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:42:16 INFO - Reading from file tmpfile_stdout 07:42:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:42:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:42:16 INFO - Reading from file tmpfile_stdout 07:42:16 INFO - Output received: 07:42:16 INFO - Usage: mozinstall [options] installer 07:42:16 INFO - Options: 07:42:16 INFO - -h, --help show this help message and exit 07:42:16 INFO - -d DEST, --destination=DEST 07:42:16 INFO - Directory to install application into. [default: 07:42:16 INFO - "/builds/slave/test"] 07:42:16 INFO - --app=APP Application being installed. [default: firefox] 07:42:16 INFO - mkdir: /builds/slave/test/build/application 07:42:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:42:38 INFO - Reading from file tmpfile_stdout 07:42:38 INFO - Output received: 07:42:38 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:42:38 INFO - Running post-action listener: _resource_record_post_action 07:42:38 INFO - ##### 07:42:38 INFO - ##### Running run-tests step. 07:42:38 INFO - ##### 07:42:38 INFO - Running pre-action listener: _resource_record_pre_action 07:42:38 INFO - Running main action method: run_tests 07:42:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:42:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:42:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:42:38 INFO - 2016-06-21 07:42:38.361 screenresolution[1945:12231] starting screenresolution argv=screenresolution get 07:42:38 INFO - 2016-06-21 07:42:38.364 screenresolution[1945:12231] Display 0: 1600x1200x32@60 07:42:38 INFO - 2016-06-21 07:42:38.370 screenresolution[1946:12233] starting screenresolution argv=screenresolution list 07:42:38 INFO - Available Modes on Display 0 07:42:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:42:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:42:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:42:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:42:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:42:38 INFO - Intel Iris: 07:42:38 INFO - Chipset Model: Intel Iris 07:42:38 INFO - Type: GPU 07:42:38 INFO - Bus: Built-In 07:42:38 INFO - VRAM (Dynamic, Max): 1536 MB 07:42:38 INFO - Vendor: Intel (0x8086) 07:42:38 INFO - Device ID: 0x0a2e 07:42:38 INFO - Revision ID: 0x0009 07:42:38 INFO - Displays: 07:42:38 INFO - Display: 07:42:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:42:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:42:38 INFO - Display Serial Number: 1600x1200 60 07:42:38 INFO - Main Display: Yes 07:42:38 INFO - Mirror: Off 07:42:38 INFO - Online: Yes 07:42:38 INFO - Rotation: Supported 07:42:38 INFO - Return code: 0 07:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:42:38 INFO - Python 2.7.3 07:42:38 INFO - Return code: 0 07:42:38 INFO - grabbing minidump binary from tooltool 07:42:38 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')]} 07:42:38 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 0x10d65ce00>, '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 0x10d4c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d657b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:42:38 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 07:42:38 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 07:42:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:42:38 INFO - Return code: 0 07:42:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:42:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:42:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:42:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:42:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:42:39 INFO - Return code: 0 07:42:39 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/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0283', '--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 07:42:39 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/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0283 --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 07:42:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LlfvfJQX7P/Render', 07:42:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:39 INFO - 'HOME': '/Users/cltbld', 07:42:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:39 INFO - 'LOGNAME': 'cltbld', 07:42:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:42:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:39 INFO - 'MOZ_NO_REMOTE': '1', 07:42:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:42:39 INFO - 'NO_EM_RESTART': '1', 07:42:39 INFO - 'PAGER': '/bin/cat', 07:42:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:39 INFO - 'PWD': '/builds/slave/test', 07:42:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:42:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:39 INFO - 'SHELL': '/bin/bash', 07:42:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Xwl9kRFBFC/Listeners', 07:42:39 INFO - 'TMPDIR': '/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/', 07:42:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:39 INFO - 'USER': 'cltbld', 07:42:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:39 INFO - 'XPC_FLAGS': '0x0', 07:42:39 INFO - 'XPC_SERVICE_NAME': '0', 07:42:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:39 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/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0283', '--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 07:42:39 INFO - mozversion application_buildid: 20160621055904 07:42:39 INFO - mozversion application_changeset: 5f7dcce004111d3e2f78cdae83bafb8551937018 07:42:39 INFO - mozversion application_display_name: Firefox 07:42:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:42:39 INFO - mozversion application_name: Firefox 07:42:39 INFO - mozversion application_remotingname: firefox 07:42:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:42:39 INFO - mozversion application_vendor: Mozilla 07:42:39 INFO - mozversion application_version: 48.0 07:42:39 INFO - mozversion platform_buildid: 20160621055904 07:42:39 INFO - mozversion platform_changeset: 5f7dcce004111d3e2f78cdae83bafb8551937018 07:42:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:42:39 INFO - mozversion platform_version: 48.0 07:42:39 INFO - using testdate: 1466520159 07:42:39 INFO - actual date: 1466520159 07:42:39 INFO - starting webserver on 'localhost:49727' 07:42:39 INFO - SUITE-START | Running 2 tests 07:42:39 INFO - TEST-START | dromaeo_css 07:42:39 INFO - operating with platform_type : mac_ 07:42:39 INFO - Initialising browser for dromaeo_css test... 07:42:40 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpgIzICW/profile http://localhost:49727/getInfo.html) 07:42:42 INFO - PROCESS | 1964 | __metrics Screen width/height:1600/1200 07:42:42 INFO - PROCESS | 1964 | colorDepth:24 07:42:42 INFO - PROCESS | 1964 | Browser inner width/height: 1024/689 07:42:42 INFO - PROCESS | 1964 | __metrics 07:42:42 INFO - PROCESS | 1964 | 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" 07:42:42 ERROR - PROCESS | 1964 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:42:42 INFO - TEST-INFO | 1964: exit 0 07:42:42 INFO - Browser initialized. 07:42:42 INFO - Running cycle 1/1 for dromaeo_css test... 07:42:42 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpgIzICW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:42:54 INFO - PROCESS | 1967 | RSS: Main: 161349632 07:42:54 INFO - PROCESS | 1967 | 07:43:45 INFO - PROCESS | 1967 | 1466520225707 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] 07:45:55 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49727/tests/dromaeo/cssquery-ext.html) 07:45:56 INFO - PROCESS | 1967 | RSS: Main: 297172992 07:45:56 INFO - PROCESS | 1967 | 07:48:59 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-ext.html (next: http://localhost:49727/tests/dromaeo/cssquery-jquery.html) 07:49:00 INFO - PROCESS | 1967 | RSS: Main: 308555776 07:49:00 INFO - PROCESS | 1967 | 07:52:02 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49727/tests/dromaeo/cssquery-mootools.html) 07:52:02 INFO - PROCESS | 1967 | RSS: Main: 305688576 07:52:02 INFO - PROCESS | 1967 | 07:55:04 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49727/tests/dromaeo/cssquery-prototype.html) 07:55:05 INFO - PROCESS | 1967 | RSS: Main: 309673984 07:55:05 INFO - PROCESS | 1967 | 07:58:08 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49727/tests/dromaeo/cssquery-yui.html) 07:58:09 INFO - PROCESS | 1967 | RSS: Main: 272695296 07:58:09 INFO - PROCESS | 1967 | 08:01:11 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:49727/tests/dromaeo/cssquery-yui.html (next: http://localhost:49727/tests/dromaeo/cssquery-dojo.html) 08:01:12 INFO - PROCESS | 1967 | RSS: Main: 316628992 08:01:12 INFO - PROCESS | 1967 | 08:01:12 INFO - PROCESS | 1967 | __start_tp_report 08:01:12 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 08:01:12 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 08:01:12 INFO - PROCESS | 1967 | |i|pagename|runs| 08:01:12 INFO - PROCESS | 1967 | |0;dojo.html;3058.801177923435;3613.241219343939;3615.2407994321193;3633.963660363396;3676.3566375884216;5750.137479378095;5754.136879468071;5762.222100016496;5769.509591684701;5778.711064446771;5756.827295181151;5805.216295800065;5809.680467574292;5809.7385617647205;5814.651120932736;4179;5237.554807841338;5247.737613119329;5355.169948657965;5360.463953604647;5359.222912677659;5412.404635490093;5413.837584872441;5416.0792665247;5419.972900135514;5201.661891977009;5281.339832520935;5320.920186197211;5331.386890507602;5362.705051222181;5350.2777125088005;5372.140457526816;5377.354717433894;5379.273798037254;5411.269478620376;4204.516480604709;5188.325517682677;5221.4256431792855;5299.046171689094;5301.390340110859;5588.189712491707;5630.15547667849;5648.4633959773755;5648.548116150698;5663.716814159276;6276.905846412307;6321.6523091229965;6332.1135041094285;6332.271788744308;6338.461230795388;5242.659227150223;6221.191245138149;6223.097650840648;6331.050342448623;6356.2054743157105;5906.232189815297;5917.881642367129;5921.792737254218;5930.9406905931255;5936.5250779937505;6329.335419780857;6334.746610135635;6336.081268216175;6338.461230795342;6345.809625711236;5047.318611987408;6006.909896351558;6113.354685976905;6229.283632382243;6241.7191226394925;6326.588771729823;6333.524985626096;6340.270868850049;6346.428821406095;6348.428641422294;6242.15730876335;6276.278228003746;6287.2140982377205;6299.118123462719;6299.370062993756;6156.569040167145;6218.129461875341;6340.873182536416;6354.110424540568;6371.713272902731;4933.383327084114;4987.551120399182;4992;5000.349954505891;5018.272350509155;4527.0493196429115;4541.68208225421;4544.681872268976;4551.658625603093;4575.771211439414;5815.73829177688;5912.17229587858;5920.2007728956905;5934.970325148347;5942.494887934487;6205.162303089115;6216.844578885473;6281.7173227203975;6298.464630506367;6312.368763123743;5995.970020149872;6012.6392416455155;6018;6031.276246850406;6057.545684073712;5499;5501.807436739695;5506.944930550723;5507.421720719347;5521.1442226454965;6310.968445157745;6386.393292637192;6387.073874288295;6431.163948686641;6460.418562329319;6314.684265786784;6330.968345158245;6331.461825744863;6357.300696923242;6357.841053973688;6429.4856411486035;6455.9677201613695;6466.741330346922;6479.287278399278;6480.675966201766;6117.357677443804;6161.106639537332;6226.25284965807;6264;6283.02613094971;6335.303116657072;6373.362663733589;6373.426391624776;6374.26695929974;6375.330590287953;6176.3514830943905;6199.442050215503;6201.2868520118955;6201.906971395523;6207.596506227081;6006.339302676614;6093.512518998558;6135.875804921915;6174.44430001302;6174.44430001302;5975.492083172979;6043.2748070231855;6052.364501727256;6054.606450580698;6054.606450580698;6016.789412370546;6172.932067757351;6185.094609334978;6201.503879689704;6214.968925155526;5651.378348381592;5702.116171993348;5742.253507044057;5742.5405967521665;5985.6408615483215 08:01:12 INFO - PROCESS | 1967 | |1;ext.html;526.1975487381744;536.3885170905168;564.6809552602779;607.9300880398755;625.1466747889133;31594.052178434627;32238.67761322386;32239.83880080602;32251.51622725661;32293.031209063705;39114.60885391145;39964.40053399201;39968.60031399685;40140.59859401405;40149;9793.608255669764;9980.750481237954;9986.550605222747;9997.100260976511;10007.349522281065;9153;9433.386829856072;9750.317477776558;9889.851652225223;9900.900990990105;11941.880581194164;12193.512259509609;12195.329256890867;12202.267863928148;12217.633470995885;11739.354335511543;11917.34454604992;11919.821202681967;11922.463489143009;11928.821067683992;11723.355215463145;11850.762984740342;11862.881371186264;11872.643820685393;11896.167268291223;39084.41373379373;39503.604963950565;39513.80243098795;41395.586044139774;41425;3347.4811404232382;3464.1685995361186;3544.2734239480847;3648.945265821015;3674.356987527172;29428.70571294281;29532.8523357384;29743.70256297431;30098.84950575255;30233.395332093456;2776.5141100307364;2810.5784132380104;2818.6194863693345;2828.6747024092083;2910.447015067152;374319.12840435625;558971;559639.2018039925;561266;570703;61278.693606531684;61557.692211538655;62066.68966655138;62182.75634487285;62235;65361.346386536476;71873.6406317965;72185;72604.27395725975;72716.90924636135;18397.356092536964;18619.906900465412;18633.81366186321;18649.81350186508;18660.81339186618;13406;13408.463661453628;13434.395452204673;13445;13445.596632101053;18401;18640;18654.53363665919;18698.626027479375;18704.50363970879;6812.591244525344;7180.3537681608905;7456.50869826037;8033.357331413473;8649.697260595849;948.672707915768;1037.408677054087;1058.2010582010532;1094.141099237095;1106.43571778392;23996;30555.847220764197;30853.38293234123;31168;31486.527702084488;896.408370475483;1017.877854657431;1142.8914253145938;1146.9619993905528;1305.1190446448609;15619.375224990874;15707.68584628301;15767.842321576867;15835.445759398595;16203.594910127342;557546;631424;631796;634121;640576;56075.71962140163;56612;56726.43273567294;56799.71600141973;61479.692601536706;1539.7074555834356;1586.0721477935538;1593.6573636668172;1595.4974183132276;1637.9672406551801;24016.87991560031;28967.275818104717;29501.557476637438;29810.850945745133;30513;40870.59129408787;47849.04301914012;48802.75598621984;48910;48937.75531122321;429966;433100;435287;438916;644028;27480.17559473219;27932.44135117327;28212.85893570519;28242.15273541797;28266.85866570654;43360.78319608508;44694.88262793456;44831.551684482736;45062.3240651384;45226.32160517529;29728;35419.937401877985;36989.630103699696;37068.44397334096;37764.62235377721;32304.192395190308;32357.705691772066;36951;38055.80972095122;38670.419943700304;37630.247395052495;37948.81025594854;38268.61731382762;38358.2328353437;38399.80800095982;28572.714272857007;28619.85520579237;29253.561196581642;29279.414411712074;29662.851685741432;24830.751692483565;25107.623385649596;25141.622875657245;25473.872630636728;25506.489870202862 08:01:12 INFO - PROCESS | 1967 | |2;jquery.html;347.6783974823288;417.1927320634571;422.30109169324777;422.8118487273164;431.5921454225756;20676.689849652266;21015.789842101574;21712.34862954112;21745.91270436478;21752.673709894363;20630.587388252265;20716.896415517902;20995.370138895818;21007;21030.684539731916;5283.735813209343;5952.553558483099;5955.9702201488935;6201.596896201755;6226.501879849624;6058.666773327465;6140.53945954053;6176.104464852594;6179.81460556184;6191.628502289855;5998.97000514999;6036.547258955574;6203.2866220384785;6205.844853878644;6210.596311239778;6028.7588496460085;6071.696415179245;6089.0866370044405;6091.725872335755;6099.298580663214;5235.633505654606;5833.32916714579;5838.824835254949;5840.474357307863;5842.269716285465;11341.206115571913;15297.541073767805;26227.213183604523;26438;26514.86742566275;2249.5275992041693;2313.236631911482;2361.374235827507;2592.4555843272933;2890.6675732290846;7912.683492660287;10502.054815066604;10633.308834925705;13418.798718019238;14867.736242419407;1628.6091338078895;1744.738289256609;1810.5383127302453;1827.250827160871;1843.9170237339217;120541.39729301386;124285;124402.37798811038;124801;127282;11734.88265117355;11832.290062596272;11835.644930652094;11862.466189021514;11927.463264153133;15325.233738313264;15403.460878869186;15404.845951540565;15428.768568471482;15442.382304707686;9013.008569057398;9047.502387368626;9074.818503630022;9183.989761126271;9192.908070919339;9022.93967714518;9041.457512549268;9042.140996605312;9133.041030691682;9136.451812891248;4613.677042606985;4699.95300047002;4703.741294228782;4705.717656940595;4761.166795810719;1832.9460560177952;1837.2926423327115;1879.5489082620072;1979.3171355882198;2064.9380518584167;842.5955541340192;1013.7262939006574;1014.5434554450527;1077.719792853848;1083.2533410258654;16564.83435165657;17798.822011779976;19016.33442829522;19943.7036592621;20047.699284510745;1001.6794625719846;1007.2848277722752;1022.2128960700219;1024.7899180667946;1073.1146803886668;10475.057244848;10742.033217010507;10768.186536772377;10794.946025269823;10898.291611045257;621033;647717;651548;666862;673050;92624.07375926155;128957.06564401541;131587.02619460717;135858;138153;977.7751117243074;978.8531720242021;1002.2633364477103;1003.3879333606494;1021.5862575656722;18025.729614055537;18255.269789208814;18337.816621833612;18462.984535850657;18468.459462161565;38325.808370957966;54593.90812183813;55088;55755.72122139364;56500.71749641225;81191;81374.77937830819;81537.59231203806;82579;84725;8240.876386854321;8301.83396332058;8359.540225287668;8392.748217553482;8665.17680820321;10633.255672102878;12027.398630068637;12452.439640216393;12610.558630447891;12949.41727622278;10825.242233043926;10925.180611454332;11245.98786109254;11389.373584452604;11400.771984560428;10725.839112413163;10772.084372828398;10835.187360947803;11025.724356891142;11269.267497612629;10859.511321990687;11136.777264454828;11224.326540407601;11241.66275011751;11249.13561944379;8192.057913339804;8284;8357.456765310235;8360.958195209229;8530.573471326534;7479.4764366496;11199.66401007971;11492.54029838797;11782.705432364259;11834.940825296162 08:01:12 INFO - PROCESS | 1967 | |3;mootools.html;1461.685737566423;1609.5090997245838;1628.6009927567743;1885.9811401885986;1997.6116598963708;8217.342612590986;8811.986621538525;8961.103889611035;8982;8982.416142950704;8795.164459376349;8825.161609647073;8934.91065089349;8943.060978597252;8947.284217262619;2548.5412625727317;2565.9486810263784;2570.0876188952934;2570.318865500644;2573.819832611718;2470.419451428913;2531.227975467482;2535.4422027153996;2538.2639034680014;2543.694756629198;2503.198976327567;2532.075792335803;2545.529077120729;2547.745225477456;2550.821442499026;2445.315311712723;2508.272600945714;2548.719640839506;2550.5409026375246;2557.7825884799813;2506.987465062681;2554.961675574868;2556.322574517754;2558.756918092778;2561.705403878559;8672.306215502746;8982.640694372218;9067.68263110788;9075.909240907573;9077.68228112013;5586.692731899744;5689.886202275973;5700.030994730864;5740.712964351766;5746.310442746855;3588.910277243064;3638.43604241343;3683.0055884911194;3738.8691395801015;3778.886633401002;1069.0592278794688;1086.256558224047;1090.2422816142785;1107.3521989636072;1127.3912087472754;12199.878001220051;12308.75382492354;12512.311822849832;12518.937405313007;12526.874731252661;4806.375171227718;4838.491958344393;4843.418789745253;4857.149998750205;4931.876703082452;9749.220062394992;9774.462404567676;9774.853377199348;9790.5594248259;9822.950885245527;5616.438356164351;5616.606837521416;5625.746841392065;5628.212050312959;5633.464820842013;4649;4744.833930812405;4748.810047598126;4759.6668233223345;5198.870028249324;3651.6348365163803;3972.8013599320498;4072.0430698785763;4079.551759125527;4084.7344922579937;1235.1971218707731;1263.9431225594687;1270.358468973181;1274.20362273579;1285.0554842190982;948.5304774136708;964.0841200859212;972.9562169702381;989.3865803202061;1003.5684655598017;5939.3763654816485;6080.969595151996;6164.250146090024;6171.413715697002;6257.56197066201;996.875390576178;1001.3991605037065;1022.7647641042602;1050.9211809114347;1051.2063392138887;3435.934860193348;4032.072623296658;4083.571225021389;4109.547949725527;4183.644390226865;10525;10903.727406814893;11016.449177541092;11075;11093.389863557582;8843.955780221058;10922.508487118099;10959.945200274107;10996.28524145928;11004.779904401867;7152.427805775629;8001.639926203335;8362.163783621589;8483.660653573912;8547.700830470903;5981.7906373278465;6029.60807547508;6165;6188.721507532082;6306.684665766602;10098.899011009797;10116.342437741523;10159.085682288629;10278.691639250834;10322.896771032194;10147.695569132939;10352.275340726077;10515.211359147941;10659.20055995819;10689.984451477098;7139.036230108869;7324.523905946096;7339.559626422431;7750.728724494616;7865.803354915944;7812.53124812513;8645.91354086451;8649.005364382925;8659.956700216459;8691;7534.020577324913;7747.49641273338;7802;7842.254985776342;7844.058712954254;7470.103587569526;7486.775396738107;7527.2849079337375;7624.466287359832;7723.227677232232;7161.355478007004;7252.347288744038;7258.129024517092;7357.2642735726;7368.521046131984;4924.704517728947;4930.112579735539;5056.873578160576;5123.897522049613;5134.3325367703455;5060.595152387874;5131.179011358165;5148.665336753099;5160.122779127632;5239.580833533232 08:01:12 INFO - PROCESS | 1967 | |4;prototype.html;326.1211036257286;330.80151908854685;340.9897703068908;342.2368119094421;344.796570023686;5468.261784659075;6075.605085669434;6300.723623715671;6404.775832845851;6419.454346380563;5968.7314070866805;6118.632882027082;6161.845953851156;6301.212348456443;6302.653354065525;4775.379200703921;4791.712497250159;4799.18413869643;4802;4822.348982887318;4808.519148085198;4817.590504807078;4817.831375901844;4820.807167713305;4830.4203495580405;4515.63874890008;4569.702969307001;4691.648126390517;4711.670183087185;4787.71273723576;4681.812727490897;4702.153612349775;4706;4709.693869898446;4720.527947205286;4088.2845502037026;4089.795510224477;4091.97954010228;4093.263212621727;4098.241825262336;6045.727942242565;6045.879082418371;6052.425019623129;6068.878622427571;6073.939260607426;5502.2296878437055;5511.53151982082;5519.613627046108;5528.889422211573;5532.972335138339;6400.9039864402075;6658.400743933069;6708.228553716336;6728.93271067288;6747.831304217385;4479.081788233404;4493.887652808673;4497.123061003105;4500.8649740507835;4501.594856462902;7049.964750176267;7129.394001509878;7131.89302160468;7144.285571442866;7165.104361954755;4539.523350048264;4556.794944227518;4564.863054108382;4565.0641618468135;4579.129965306581;4641.628669706415;4641.837535686234;4642.558956899089;4642.744649044267;4648.48866624671;5262.473752624784;5475.72621368938;5485.094959331665;5501.889962200814;5510.614257001971;6756.898646520208;6810.978353247053;6825.829354266084;6831.760888368884;6835.974603809468;1529.258309719785;1575.5745948594044;1610.5344136835424;1614.9434769783002;1616.0869108953405;900.243795212025;982.9311948163703;1025.0825511167614;1044.1959691037857;1045.0542259255385;6293.905591416133;6424.3254458282145;6465.4827613790785;6480.449161821298;6482.546221764431;6922.646300257937;6963.373296403247;6969.47728920333;6974.511784175059;6978.90632810155;5201.479852014768;6253.96873015632;6436.613803171825;6451.9354806452275;6457.2896981332015;3623.8188090595363;3680.153564680085;3683.4843121962945;3694.18727879866;3698.223373091681;7398.778036658909;7424.257574242641;7426;7430.405567554582;7439.628018599048;5711.742971566289;7099.538529995534;7129.928700713031;7153.3919616833155;7184.568925864465;7203.135623725187;7406.222346653632;7554.206808285161;7571.734989275459;7587.051618547682;7011.719531218694;7059.152901651834;7062.752803651848;7088.539244949062;7126.893096603659;6966.686499107654;6984.4063254623925;6994.790156295319;7002.579845209304;7005.299470053158;7544.434167437574;7545.320921117126;7552.509086909553;7576.4317676173405;7582.962085189539;4362.23660859342;4569.702969306984;4584.19776539111;4587.42657167854;4604.286335617984;6949.548279361826;6983.790486285419;7002.684879180551;7007.089078419773;7015.807312756741;6774.729010839708;6795.694193761194;6799.048133261248;6802.14973128359;6805.829854253683;5649.700568869101;6606.6366349849295;6768.018637297466;6776.424003959719;6799.150106236721;5867.885101830639;6142.570020098729;6229.345918678474;6352.809415717536;6650.600963941985;6745;6773.762918297836;6813;6823.28355522663;6833.145856767904;5813.76744930198;6254.4996400286955;6666.799996000128;6685.565438246693;6705.698243578953 08:01:12 INFO - PROCESS | 1967 | |5;yui.html;716.6273537760364;768.8423873106007;793.2939683681528;795.2087672765596;798.0742338886893;12860.421281042352;15424.845751542496;15763.133027683472;15764.132972686526;15786.605334866634;14292.571222863331;14404.927975360135;14417.351219195136;14453.92773036136;14476.348564314605;767.7926959720872;788.0976282156927;912.7489940266413;946.8011717539325;948.648999870049;934.9392289501195;940.6049459227107;944.8582712593131;947.327397547742;947.3794664494733;810.9513429194267;1007.6825799873017;1008.6016023670645;1009.4246279620619;1009.8889122196553;993.3791380387258;1016.1464369929221;1018.6689325969089;1019.5157300282381;1019.5819713917258;760.3916866506772;762.142589586715;762.5310434082999;762.8245503534218;763.263450770004;15699.37202511898;15759.369625214978;15761.211939403098;15766.842331576767;15814.367425302975;13189.934050329783;13425.798613020812;13496.190228586316;13547.187168769906;13779.724405511934;10363.896361036368;10406.895931040744;10591.682249532527;10753;10821.945890270577;3296.8186749728757;3656.8902932912056;3676.2279921216577;3693.7229707772026;3730.3285408626434;61636;80384.39231215343;82263.58868205741;85973.14026859714;87046.56476717576;9922.107010369102;10187.134093601979;10200.38797672142;10225.233107516966;10412.635557755593;23333.533329333317;23353.065877364716;23363.532729345658;23373.7662623375;23392.883035584713;7815.960920195363;7891.763247102596;7926.445148839526;7979.48133371329;8026.237507436784;4260.190563792869;4287.386377786079;4290.334998075304;4338.6312163466455;4524.864254072383;3917.3144699678014;3948.664363529132;3951.881443556698;3951.9012024699614;3958.346872766019;637.757652092202;670.4368330602317;670.9228438729608;698.3016983016983;715.4419552748864;594.9702514874239;601.8555546668855;605.7007718443913;608.6165715599144;612.5344737999153;8208.753737387888;8219.54792486419;8372.408563960362;8451.704190353432;8796.692115775917;530.1993989076445;589.2310534752189;597.8475488750428;599.0744300056423;600.3456232706371;3773.7735735855936;3912.9021774455296;3942.4086387042175;3982.104026594051;4132.2561938851295;60057;91399.5430022859;93839.53080234556;93973.53013235026;101541.47687784689;81208;81815.59092204501;83322.16677833266;84483.57758211292;85154.72267915987;72268.55462890712;76155;76418;77559.83660244988;77687.61156194183;7556.131044929683;8284.337253019865;8320.167983201873;8540.658373664985;8884.466931984101;50894.47316580509;51655;52468.212976804614;52691.73654131705;52924.47075529349;56218.71890640521;69340;73602.26397735954;73696.63151684207;74537.2546274552;10926.890731092906;11177.888221117684;11368.886311137114;11471.598494052669;11669.124815638692;12014.279143251433;12168.087393445705;12272.956798672212;12537.970198659277;12645.304508252135;11233.157513186381;11270.774584508428;11294.94352528265;11318.434078296217;11329.490172942073;11595.188336816342;11652.417379131179;11950;12093.455794489093;12279.44742486608;11433.085353171893;11457.484413201593;11607.883921161017;11615.419229038345;11725.706857328634;9769.16962058233;9975.20198384142;9989.650362237287;10004.85528284479;10121.848172277274;7619.733309334147;9815.754606134904;9866.55600497965;9872.40765554069;9967.651132210338 08:01:12 INFO - PROCESS | 1967 | __end_tp_report 08:01:12 INFO - PROCESS | 1967 | __start_cc_report 08:01:12 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,1199 08:01:12 INFO - PROCESS | 1967 | __end_cc_report 08:01:12 INFO - PROCESS | 1967 | __startTimestamp1466521272090__endTimestamp 08:01:12 INFO - PROCESS | 1967 | 08:01:12 INFO - PROCESS | 1967 | ------- Summary: start ------- 08:01:12 INFO - PROCESS | 1967 | Number of tests: 6 08:01:12 INFO - PROCESS | 1967 | 08:01:12 INFO - PROCESS | 1967 | [#0] dojo.html Cycles:165 Average:5808.73 Median:6016.79 stddev:648.70 (10.8%) stddev-sans-first:613.78 08:01:12 INFO - PROCESS | 1967 | Values: 3058.8 3613.2 3615.2 3634.0 3676.4 5750.1 5754.1 5762.2 5769.5 5778.7 5756.8 5805.2 5809.7 5809.7 5814.7 4179.0 5237.6 5247.7 5355.2 5360.5 5359.2 5412.4 5413.8 5416.1 5420.0 5201.7 5281.3 5320.9 5331.4 5362.7 5350.3 5372.1 5377.4 5379.3 5411.3 4204.5 5188.3 5221.4 5299.0 5301.4 5588.2 5630.2 5648.5 5648.5 5663.7 6276.9 6321.7 6332.1 6332.3 6338.5 5242.7 6221.2 6223.1 6331.1 6356.2 5906.2 5917.9 5921.8 5930.9 5936.5 6329.3 6334.7 6336.1 6338.5 6345.8 5047.3 6006.9 6113.4 6229.3 6241.7 6326.6 6333.5 6340.3 6346.4 6348.4 6242.2 6276.3 6287.2 6299.1 6299.4 6156.6 6218.1 6340.9 6354.1 6371.7 4933.4 4987.6 4992.0 5000.3 5018.3 4527.0 4541.7 4544.7 4551.7 4575.8 5815.7 5912.2 5920.2 5935.0 5942.5 6205.2 6216.8 6281.7 6298.5 6312.4 5996.0 6012.6 6018.0 6031.3 6057.5 5499.0 5501.8 5506.9 5507.4 5521.1 6311.0 6386.4 6387.1 6431.2 6460.4 6314.7 6331.0 6331.5 6357.3 6357.8 6429.5 6456.0 6466.7 6479.3 6480.7 6117.4 6161.1 6226.3 6264.0 6283.0 6335.3 6373.4 6373.4 6374.3 6375.3 6176.4 6199.4 6201.3 6201.9 6207.6 6006.3 6093.5 6135.9 6174.4 6174.4 5975.5 6043.3 6052.4 6054.6 6054.6 6016.8 6172.9 6185.1 6201.5 6215.0 5651.4 5702.1 5742.3 5742.5 5985.6 08:01:12 INFO - PROCESS | 1967 | 08:01:12 INFO - PROCESS | 1967 | [#1] ext.html Cycles:180 Average:67618.76 Median:32330.95 stddev:146287.30 (452.5%) stddev-sans-first:146610.94 08:01:12 INFO - PROCESS | 1967 | Values: 526.2 536.4 564.7 607.9 625.1 31594.1 32238.7 32239.8 32251.5 32293.0 39114.6 39964.4 39968.6 40140.6 40149.0 9793.6 9980.8 9986.6 9997.1 10007.3 9153.0 9433.4 9750.3 9889.9 9900.9 11941.9 12193.5 12195.3 12202.3 12217.6 11739.4 11917.3 11919.8 11922.5 11928.8 11723.4 11850.8 11862.9 11872.6 11896.2 39084.4 39503.6 39513.8 41395.6 41425.0 3347.5 3464.2 3544.3 3648.9 3674.4 29428.7 29532.9 29743.7 30098.8 30233.4 2776.5 2810.6 2818.6 2828.7 2910.4 374319.1 558971.0 559639.2 561266.0 570703.0 61278.7 61557.7 62066.7 62182.8 62235.0 65361.3 71873.6 72185.0 72604.3 72716.9 18397.4 18619.9 18633.8 18649.8 18660.8 13406.0 13408.5 13434.4 13445.0 13445.6 18401.0 18640.0 18654.5 18698.6 18704.5 6812.6 7180.4 7456.5 8033.4 8649.7 948.7 1037.4 1058.2 1094.1 1106.4 23996.0 30555.8 30853.4 31168.0 31486.5 896.4 1017.9 1142.9 1147.0 1305.1 15619.4 15707.7 15767.8 15835.4 16203.6 557546.0 631424.0 631796.0 634121.0 640576.0 56075.7 56612.0 56726.4 56799.7 61479.7 1539.7 1586.1 1593.7 1595.5 1638.0 24016.9 28967.3 29501.6 29810.9 30513.0 40870.6 47849.0 48802.8 48910.0 48937.8 429966.0 433100.0 435287.0 438916.0 644028.0 27480.2 27932.4 28212.9 28242.2 28266.9 43360.8 44694.9 44831.6 45062.3 45226.3 29728.0 35419.9 36989.6 37068.4 37764.6 32304.2 32357.7 36951.0 38055.8 38670.4 37630.2 37948.8 38268.6 38358.2 38399.8 28572.7 28619.9 29253.6 29279.4 29662.9 24830.8 25107.6 25141.6 25473.9 25506.5 08:01:12 INFO - PROCESS | 1967 | 08:01:12 INFO - PROCESS | 1967 | [#2] jquery.html Cycles:180 Average:36701.61 Median:21011.39 stddev:108550.77 (516.6%) stddev-sans-first:108820.96 08:01:12 INFO - PROCESS | 1967 | Values: 347.7 417.2 422.3 422.8 431.6 20676.7 21015.8 21712.3 21745.9 21752.7 20630.6 20716.9 20995.4 21007.0 21030.7 5283.7 5952.6 5956.0 6201.6 6226.5 6058.7 6140.5 6176.1 6179.8 6191.6 5999.0 6036.5 6203.3 6205.8 6210.6 6028.8 6071.7 6089.1 6091.7 6099.3 5235.6 5833.3 5838.8 5840.5 5842.3 11341.2 15297.5 26227.2 26438.0 26514.9 2249.5 2313.2 2361.4 2592.5 2890.7 7912.7 10502.1 10633.3 13418.8 14867.7 1628.6 1744.7 1810.5 1827.3 1843.9 120541.4 124285.0 124402.4 124801.0 127282.0 11734.9 11832.3 11835.6 11862.5 11927.5 15325.2 15403.5 15404.8 15428.8 15442.4 9013.0 9047.5 9074.8 9184.0 9192.9 9022.9 9041.5 9042.1 9133.0 9136.5 4613.7 4700.0 4703.7 4705.7 4761.2 1832.9 1837.3 1879.5 1979.3 2064.9 842.6 1013.7 1014.5 1077.7 1083.3 16564.8 17798.8 19016.3 19943.7 20047.7 1001.7 1007.3 1022.2 1024.8 1073.1 10475.1 10742.0 10768.2 10794.9 10898.3 621033.0 647717.0 651548.0 666862.0 673050.0 92624.1 128957.1 131587.0 135858.0 138153.0 977.8 978.9 1002.3 1003.4 1021.6 18025.7 18255.3 18337.8 18463.0 18468.5 38325.8 54593.9 55088.0 55755.7 56500.7 81191.0 81374.8 81537.6 82579.0 84725.0 8240.9 8301.8 8359.5 8392.7 8665.2 10633.3 12027.4 12452.4 12610.6 12949.4 10825.2 10925.2 11246.0 11389.4 11400.8 10725.8 10772.1 10835.2 11025.7 11269.3 10859.5 11136.8 11224.3 11241.7 11249.1 8192.1 8284.0 8357.5 8361.0 8530.6 7479.5 11199.7 11492.5 11782.7 11834.9 08:01:12 INFO - PROCESS | 1967 | 08:01:12 INFO - PROCESS | 1967 | [#3] mootools.html Cycles:180 Average:5875.13 Median:4850.28 stddev:3245.02 (66.9%) stddev-sans-first:3237.17 08:01:12 INFO - PROCESS | 1967 | Values: 1461.7 1609.5 1628.6 1886.0 1997.6 8217.3 8812.0 8961.1 8982.0 8982.4 8795.2 8825.2 8934.9 8943.1 8947.3 2548.5 2565.9 2570.1 2570.3 2573.8 2470.4 2531.2 2535.4 2538.3 2543.7 2503.2 2532.1 2545.5 2547.7 2550.8 2445.3 2508.3 2548.7 2550.5 2557.8 2507.0 2555.0 2556.3 2558.8 2561.7 8672.3 8982.6 9067.7 9075.9 9077.7 5586.7 5689.9 5700.0 5740.7 5746.3 3588.9 3638.4 3683.0 3738.9 3778.9 1069.1 1086.3 1090.2 1107.4 1127.4 12199.9 12308.8 12512.3 12518.9 12526.9 4806.4 4838.5 4843.4 4857.1 4931.9 9749.2 9774.5 9774.9 9790.6 9823.0 5616.4 5616.6 5625.7 5628.2 5633.5 4649.0 4744.8 4748.8 4759.7 5198.9 3651.6 3972.8 4072.0 4079.6 4084.7 1235.2 1263.9 1270.4 1274.2 1285.1 948.5 964.1 973.0 989.4 1003.6 5939.4 6081.0 6164.3 6171.4 6257.6 996.9 1001.4 1022.8 1050.9 1051.2 3435.9 4032.1 4083.6 4109.5 4183.6 10525.0 10903.7 11016.4 11075.0 11093.4 8844.0 10922.5 10959.9 10996.3 11004.8 7152.4 8001.6 8362.2 8483.7 8547.7 5981.8 6029.6 6165.0 6188.7 6306.7 10098.9 10116.3 10159.1 10278.7 10322.9 10147.7 10352.3 10515.2 10659.2 10690.0 7139.0 7324.5 7339.6 7750.7 7865.8 7812.5 8645.9 8649.0 8660.0 8691.0 7534.0 7747.5 7802.0 7842.3 7844.1 7470.1 7486.8 7527.3 7624.5 7723.2 7161.4 7252.3 7258.1 7357.3 7368.5 4924.7 4930.1 5056.9 5123.9 5134.3 5060.6 5131.2 5148.7 5160.1 5239.6 08:01:12 INFO - PROCESS | 1967 | 08:01:12 INFO - PROCESS | 1967 | [#4] prototype.html Cycles:180 Average:5569.99 Median:6254.23 stddev:1760.92 (28.2%) stddev-sans-first:1721.31 08:01:12 INFO - PROCESS | 1967 | Values: 326.1 330.8 341.0 342.2 344.8 5468.3 6075.6 6300.7 6404.8 6419.5 5968.7 6118.6 6161.8 6301.2 6302.7 4775.4 4791.7 4799.2 4802.0 4822.3 4808.5 4817.6 4817.8 4820.8 4830.4 4515.6 4569.7 4691.6 4711.7 4787.7 4681.8 4702.2 4706.0 4709.7 4720.5 4088.3 4089.8 4092.0 4093.3 4098.2 6045.7 6045.9 6052.4 6068.9 6073.9 5502.2 5511.5 5519.6 5528.9 5533.0 6400.9 6658.4 6708.2 6728.9 6747.8 4479.1 4493.9 4497.1 4500.9 4501.6 7050.0 7129.4 7131.9 7144.3 7165.1 4539.5 4556.8 4564.9 4565.1 4579.1 4641.6 4641.8 4642.6 4642.7 4648.5 5262.5 5475.7 5485.1 5501.9 5510.6 6756.9 6811.0 6825.8 6831.8 6836.0 1529.3 1575.6 1610.5 1614.9 1616.1 900.2 982.9 1025.1 1044.2 1045.1 6293.9 6424.3 6465.5 6480.4 6482.5 6922.6 6963.4 6969.5 6974.5 6978.9 5201.5 6254.0 6436.6 6451.9 6457.3 3623.8 3680.2 3683.5 3694.2 3698.2 7398.8 7424.3 7426.0 7430.4 7439.6 5711.7 7099.5 7129.9 7153.4 7184.6 7203.1 7406.2 7554.2 7571.7 7587.1 7011.7 7059.2 7062.8 7088.5 7126.9 6966.7 6984.4 6994.8 7002.6 7005.3 7544.4 7545.3 7552.5 7576.4 7583.0 4362.2 4569.7 4584.2 4587.4 4604.3 6949.5 6983.8 7002.7 7007.1 7015.8 6774.7 6795.7 6799.0 6802.1 6805.8 5649.7 6606.6 6768.0 6776.4 6799.2 5867.9 6142.6 6229.3 6352.8 6650.6 6745.0 6773.8 6813.0 6823.3 6833.1 5813.8 6254.5 6666.8 6685.6 6705.7 08:01:12 INFO - PROCESS | 1967 | 08:01:12 INFO - PROCESS | 1967 | [#5] yui.html Cycles:180 Average:18802.37 Median:51274.74 stddev:26281.31 (51.3%) stddev-sans-first:26319.95 08:01:12 INFO - PROCESS | 1967 | Values: 716.6 768.8 793.3 795.2 798.1 12860.4 15424.8 15763.1 15764.1 15786.6 14292.6 14404.9 14417.4 14453.9 14476.3 767.8 788.1 912.7 946.8 948.6 934.9 940.6 944.9 947.3 947.4 811.0 1007.7 1008.6 1009.4 1009.9 993.4 1016.1 1018.7 1019.5 1019.6 760.4 762.1 762.5 762.8 763.3 15699.4 15759.4 15761.2 15766.8 15814.4 13189.9 13425.8 13496.2 13547.2 13779.7 10363.9 10406.9 10591.7 10753.0 10821.9 3296.8 3656.9 3676.2 3693.7 3730.3 61636.0 80384.4 82263.6 85973.1 87046.6 9922.1 10187.1 10200.4 10225.2 10412.6 23333.5 23353.1 23363.5 23373.8 23392.9 7816.0 7891.8 7926.4 7979.5 8026.2 4260.2 4287.4 4290.3 4338.6 4524.9 3917.3 3948.7 3951.9 3951.9 3958.3 637.8 670.4 670.9 698.3 715.4 595.0 601.9 605.7 608.6 612.5 8208.8 8219.5 8372.4 8451.7 8796.7 530.2 589.2 597.8 599.1 600.3 3773.8 3912.9 3942.4 3982.1 4132.3 60057.0 91399.5 93839.5 93973.5 101541.5 81208.0 81815.6 83322.2 84483.6 85154.7 72268.6 76155.0 76418.0 77559.8 77687.6 7556.1 8284.3 8320.2 8540.7 8884.5 50894.5 51655.0 52468.2 52691.7 52924.5 56218.7 69340.0 73602.3 73696.6 74537.3 10926.9 11177.9 11368.9 11471.6 11669.1 12014.3 12168.1 12273.0 12538.0 12645.3 11233.2 11270.8 11294.9 11318.4 11329.5 11595.2 11652.4 11950.0 12093.5 12279.4 11433.1 11457.5 11607.9 11615.4 11725.7 9769.2 9975.2 9989.7 10004.9 10121.8 7619.7 9815.8 9866.6 9872.4 9967.7 08:01:12 INFO - PROCESS | 1967 | -------- Summary: end -------- 08:01:12 INFO - PROCESS | 1967 | 08:01:12 INFO - TEST-INFO | 1967: exit 0 08:01:12 INFO - TEST-OK | dromaeo_css | took 1112668ms 08:01:12 INFO - TEST-START | kraken 08:01:12 INFO - operating with platform_type : mac_ 08:01:12 INFO - Initialising browser for kraken test... 08:01:12 INFO - TEST-INFO | started process 1972 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpvPdtZ2/profile http://localhost:49727/getInfo.html) 08:01:14 INFO - PROCESS | 1972 | __metrics Screen width/height:1600/1200 08:01:14 INFO - PROCESS | 1972 | colorDepth:24 08:01:14 INFO - PROCESS | 1972 | Browser inner width/height: 1024/689 08:01:14 INFO - PROCESS | 1972 | __metrics 08:01:14 INFO - PROCESS | 1972 | 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" 08:01:14 ERROR - PROCESS | 1972 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:01:15 INFO - TEST-INFO | 1972: exit 0 08:01:15 INFO - Browser initialized. 08:01:15 INFO - Running cycle 1/1 for kraken test... 08:01:15 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/T/tmpvPdtZ2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:27 INFO - PROCESS | 1975 | RSS: Main: 161390592 08:01:27 INFO - PROCESS | 1975 | 08:01:29 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49727/tests/kraken/driver.html?testName=audio-beat-detection) 08:01:30 INFO - PROCESS | 1975 | RSS: Main: 223526912 08:01:30 INFO - PROCESS | 1975 | 08:01:33 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49727/tests/kraken/driver.html?testName=audio-dft) 08:01:34 INFO - PROCESS | 1975 | RSS: Main: 238776320 08:01:34 INFO - PROCESS | 1975 | 08:01:37 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49727/tests/kraken/driver.html?testName=audio-fft) 08:01:37 INFO - PROCESS | 1975 | RSS: Main: 323739648 08:01:37 INFO - PROCESS | 1975 | 08:01:39 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49727/tests/kraken/driver.html?testName=audio-oscillator) 08:01:40 INFO - PROCESS | 1975 | RSS: Main: 230756352 08:01:40 INFO - PROCESS | 1975 | 08:01:42 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49727/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:01:42 INFO - PROCESS | 1975 | RSS: Main: 232202240 08:01:42 INFO - PROCESS | 1975 | 08:01:45 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49727/tests/kraken/driver.html?testName=imaging-darkroom) 08:01:46 INFO - PROCESS | 1975 | RSS: Main: 271089664 08:01:46 INFO - PROCESS | 1975 | 08:01:49 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49727/tests/kraken/driver.html?testName=imaging-desaturate) 08:01:49 INFO - PROCESS | 1975 | RSS: Main: 270290944 08:01:49 INFO - PROCESS | 1975 | 08:01:52 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49727/tests/kraken/driver.html?testName=json-parse-financial) 08:01:53 INFO - PROCESS | 1975 | RSS: Main: 270385152 08:01:53 INFO - PROCESS | 1975 | 08:01:54 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49727/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:01:55 INFO - PROCESS | 1975 | RSS: Main: 260165632 08:01:55 INFO - PROCESS | 1975 | 08:01:57 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:01:57 INFO - PROCESS | 1975 | RSS: Main: 266506240 08:01:57 INFO - PROCESS | 1975 | 08:01:59 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:02:00 INFO - PROCESS | 1975 | RSS: Main: 270479360 08:02:00 INFO - PROCESS | 1975 | 08:02:03 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:02:03 INFO - PROCESS | 1975 | RSS: Main: 277520384 08:02:03 INFO - PROCESS | 1975 | 08:02:06 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:02:07 INFO - PROCESS | 1975 | RSS: Main: 274436096 08:02:07 INFO - PROCESS | 1975 | 08:02:08 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:49727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49727/tests/kraken/driver.html?testName=ai-astar) 08:02:09 INFO - PROCESS | 1975 | RSS: Main: 335421440 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | __start_tp_report 08:02:09 INFO - PROCESS | 1975 | _x_x_mozilla_page_load 08:02:09 INFO - PROCESS | 1975 | _x_x_mozilla_page_load_details 08:02:09 INFO - PROCESS | 1975 | |i|pagename|runs| 08:02:09 INFO - PROCESS | 1975 | |0;ai-astar;113;113;117;111;113;113;113;112;113;133 08:02:09 INFO - PROCESS | 1975 | |1;audio-beat-detection;158;122;141;164;117;139;141;116;170;115 08:02:09 INFO - PROCESS | 1975 | |2;audio-dft;182;186;184;183;184;184;182;184;182;184 08:02:09 INFO - PROCESS | 1975 | |3;audio-fft;70;79;77;156;56;56;56;62;127;55 08:02:09 INFO - PROCESS | 1975 | |4;audio-oscillator;91;91;144;78;77;89;123;79;75;124 08:02:09 INFO - PROCESS | 1975 | |5;imaging-gaussian-blur;91;86;88;85;89;85;89;86;89;86 08:02:09 INFO - PROCESS | 1975 | |6;imaging-darkroom;93;94;93;93;92;93;93;93;93;93 08:02:09 INFO - PROCESS | 1975 | |7;imaging-desaturate;88;87;89;87;87;89;86;90;89;82 08:02:09 INFO - PROCESS | 1975 | |8;json-parse-financial;59;61;63;60;63;62;62;79;58;55 08:02:09 INFO - PROCESS | 1975 | |9;json-stringify-tinderbox;59;62;61;68;67;70;71;65;65;62 08:02:09 INFO - PROCESS | 1975 | |10;stanford-crypto-aes;80;79;79;78;79;79;79;79;81;81 08:02:09 INFO - PROCESS | 1975 | |11;stanford-crypto-ccm;142;136;149;127;123;128;126;130;159;151 08:02:09 INFO - PROCESS | 1975 | |12;stanford-crypto-pbkdf2;163;163;164;161;165;163;177;161;161;160 08:02:09 INFO - PROCESS | 1975 | |13;stanford-crypto-sha256-iterative;67;68;67;68;67;66;66;68;63;87 08:02:09 INFO - PROCESS | 1975 | __end_tp_report 08:02:09 INFO - PROCESS | 1975 | __start_cc_report 08:02:09 INFO - PROCESS | 1975 | _x_x_mozilla_cycle_collect,1962 08:02:09 INFO - PROCESS | 1975 | __end_cc_report 08:02:09 INFO - PROCESS | 1975 | __startTimestamp1466521329176__endTimestamp 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | ------- Summary: start ------- 08:02:09 INFO - PROCESS | 1975 | Number of tests: 14 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | [#0] ai-astar Cycles:10 Average:115.10 Median:113.00 stddev:6.47 (5.7%) stddev-sans-first:6.82 08:02:09 INFO - PROCESS | 1975 | Values: 113.0 113.0 117.0 111.0 113.0 113.0 113.0 112.0 113.0 133.0 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:141.00 stddev:20.62 (14.6%) stddev-sans-first:20.61 08:02:09 INFO - PROCESS | 1975 | Values: 158.0 122.0 141.0 164.0 117.0 139.0 141.0 116.0 170.0 115.0 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.27 (0.7%) stddev-sans-first:1.22 08:02:09 INFO - PROCESS | 1975 | Values: 182.0 186.0 184.0 183.0 184.0 184.0 182.0 184.0 182.0 184.0 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | [#3] audio-fft Cycles:10 Average:79.40 Median:59.00 stddev:34.59 (58.6%) stddev-sans-first:36.52 08:02:09 INFO - PROCESS | 1975 | Values: 70.0 79.0 77.0 156.0 56.0 56.0 56.0 62.0 127.0 55.0 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:78.50 stddev:24.31 (31.0%) stddev-sans-first:25.68 08:02:09 INFO - PROCESS | 1975 | Values: 91.0 91.0 144.0 78.0 77.0 89.0 123.0 79.0 75.0 124.0 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.50 stddev:2.07 (2.3%) stddev-sans-first:1.73 08:02:09 INFO - PROCESS | 1975 | Values: 91.0 86.0 88.0 85.0 89.0 85.0 89.0 86.0 89.0 86.0 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | [#6] imaging-darkroom Cycles:10 Average:93.00 Median:93.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 08:02:09 INFO - PROCESS | 1975 | Values: 93.0 94.0 93.0 93.0 92.0 93.0 93.0 93.0 93.0 93.0 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | [#7] imaging-desaturate Cycles:10 Average:87.40 Median:88.50 stddev:2.27 (2.6%) stddev-sans-first:2.40 08:02:09 INFO - PROCESS | 1975 | Values: 88.0 87.0 89.0 87.0 87.0 89.0 86.0 90.0 89.0 82.0 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.00 stddev:6.41 (10.3%) stddev-sans-first:6.69 08:02:09 INFO - PROCESS | 1975 | Values: 59.0 61.0 63.0 60.0 63.0 62.0 62.0 79.0 58.0 55.0 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:66.00 stddev:4.00 (6.1%) stddev-sans-first:3.61 08:02:09 INFO - PROCESS | 1975 | Values: 59.0 62.0 61.0 68.0 67.0 70.0 71.0 65.0 65.0 62.0 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:0.97 (1.2%) stddev-sans-first:1.00 08:02:09 INFO - PROCESS | 1975 | Values: 80.0 79.0 79.0 78.0 79.0 79.0 79.0 79.0 81.0 81.0 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:139.00 stddev:12.46 (9.0%) stddev-sans-first:13.09 08:02:09 INFO - PROCESS | 1975 | Values: 142.0 136.0 149.0 127.0 123.0 128.0 126.0 130.0 159.0 151.0 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:163.00 stddev:4.89 (3.0%) stddev-sans-first:5.18 08:02:09 INFO - PROCESS | 1975 | Values: 163.0 163.0 164.0 161.0 165.0 163.0 177.0 161.0 161.0 160.0 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - PROCESS | 1975 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:67.50 stddev:6.60 (9.8%) stddev-sans-first:6.97 08:02:09 INFO - PROCESS | 1975 | Values: 67.0 68.0 67.0 68.0 67.0 66.0 66.0 68.0 63.0 87.0 08:02:09 INFO - PROCESS | 1975 | -------- Summary: end -------- 08:02:09 INFO - PROCESS | 1975 | 08:02:09 INFO - TEST-INFO | 1975: exit 0 08:02:09 INFO - TEST-OK | kraken | took 57239ms 08:02:09 INFO - SUITE-END | took 1169s 08:02:10 INFO - Completed test suite (00:19:30) 08:02:10 INFO - javascript benchmark 08:02:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3058.801177923435, 3613.241219343939, 3615.2407994321193, 3633.963660363396, 3676.3566375884216, 5750.137479378095, 5754.136879468071, 5762.222100016496, 5769.509591684701, 5778.711064446771, 5756.827295181151, 5805.216295800065, 5809.680467574292, 5809.7385617647205, 5814.651120932736, 4179.0, 5237.554807841338, 5247.737613119329, 5355.169948657965, 5360.463953604647, 5359.222912677659, 5412.404635490093, 5413.837584872441, 5416.0792665247, 5419.972900135514, 5201.661891977009, 5281.339832520935, 5320.920186197211, 5331.386890507602, 5362.705051222181, 5350.2777125088005, 5372.140457526816, 5377.354717433894, 5379.273798037254, 5411.269478620376, 4204.516480604709, 5188.325517682677, 5221.4256431792855, 5299.046171689094, 5301.390340110859, 5588.189712491707, 5630.15547667849, 5648.4633959773755, 5648.548116150698, 5663.716814159276, 6276.905846412307, 6321.6523091229965, 6332.1135041094285, 6332.271788744308, 6338.461230795388, 5242.659227150223, 6221.191245138149, 6223.097650840648, 6331.050342448623, 6356.2054743157105, 5906.232189815297, 5917.881642367129, 5921.792737254218, 5930.9406905931255, 5936.5250779937505, 6329.335419780857, 6334.746610135635, 6336.081268216175, 6338.461230795342, 6345.809625711236, 5047.318611987408, 6006.909896351558, 6113.354685976905, 6229.283632382243, 6241.7191226394925, 6326.588771729823, 6333.524985626096, 6340.270868850049, 6346.428821406095, 6348.428641422294, 6242.15730876335, 6276.278228003746, 6287.2140982377205, 6299.118123462719, 6299.370062993756, 6156.569040167145, 6218.129461875341, 6340.873182536416, 6354.110424540568, 6371.713272902731, 4933.383327084114, 4987.551120399182, 4992.0, 5000.349954505891, 5018.272350509155, 4527.0493196429115, 4541.68208225421, 4544.681872268976, 4551.658625603093, 4575.771211439414, 5815.73829177688, 5912.17229587858, 5920.2007728956905, 5934.970325148347, 5942.494887934487, 6205.162303089115, 6216.844578885473, 6281.7173227203975, 6298.464630506367, 6312.368763123743, 5995.970020149872, 6012.6392416455155, 6018.0, 6031.276246850406, 6057.545684073712, 5499.0, 5501.807436739695, 5506.944930550723, 5507.421720719347, 5521.1442226454965, 6310.968445157745, 6386.393292637192, 6387.073874288295, 6431.163948686641, 6460.418562329319, 6314.684265786784, 6330.968345158245, 6331.461825744863, 6357.300696923242, 6357.841053973688, 6429.4856411486035, 6455.9677201613695, 6466.741330346922, 6479.287278399278, 6480.675966201766, 6117.357677443804, 6161.106639537332, 6226.25284965807, 6264.0, 6283.02613094971, 6335.303116657072, 6373.362663733589, 6373.426391624776, 6374.26695929974, 6375.330590287953, 6176.3514830943905, 6199.442050215503, 6201.2868520118955, 6201.906971395523, 6207.596506227081, 6006.339302676614, 6093.512518998558, 6135.875804921915, 6174.44430001302, 6174.44430001302, 5975.492083172979, 6043.2748070231855, 6052.364501727256, 6054.606450580698, 6054.606450580698, 6016.789412370546, 6172.932067757351, 6185.094609334978, 6201.503879689704, 6214.968925155526, 5651.378348381592, 5702.116171993348, 5742.253507044057, 5742.5405967521665, 5985.6408615483215], "value": 5769.177989744126, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.1975487381744, 536.3885170905168, 564.6809552602779, 607.9300880398755, 625.1466747889133, 31594.052178434627, 32238.67761322386, 32239.83880080602, 32251.51622725661, 32293.031209063705, 39114.60885391145, 39964.40053399201, 39968.60031399685, 40140.59859401405, 40149.0, 9793.608255669764, 9980.750481237954, 9986.550605222747, 9997.100260976511, 10007.349522281065, 9153.0, 9433.386829856072, 9750.317477776558, 9889.851652225223, 9900.900990990105, 11941.880581194164, 12193.512259509609, 12195.329256890867, 12202.267863928148, 12217.633470995885, 11739.354335511543, 11917.34454604992, 11919.821202681967, 11922.463489143009, 11928.821067683992, 11723.355215463145, 11850.762984740342, 11862.881371186264, 11872.643820685393, 11896.167268291223, 39084.41373379373, 39503.604963950565, 39513.80243098795, 41395.586044139774, 41425.0, 3347.4811404232382, 3464.1685995361186, 3544.2734239480847, 3648.945265821015, 3674.356987527172, 29428.70571294281, 29532.8523357384, 29743.70256297431, 30098.84950575255, 30233.395332093456, 2776.5141100307364, 2810.5784132380104, 2818.6194863693345, 2828.6747024092083, 2910.447015067152, 374319.12840435625, 558971.0, 559639.2018039925, 561266.0, 570703.0, 61278.693606531684, 61557.692211538655, 62066.68966655138, 62182.75634487285, 62235.0, 65361.346386536476, 71873.6406317965, 72185.0, 72604.27395725975, 72716.90924636135, 18397.356092536964, 18619.906900465412, 18633.81366186321, 18649.81350186508, 18660.81339186618, 13406.0, 13408.463661453628, 13434.395452204673, 13445.0, 13445.596632101053, 18401.0, 18640.0, 18654.53363665919, 18698.626027479375, 18704.50363970879, 6812.591244525344, 7180.3537681608905, 7456.50869826037, 8033.357331413473, 8649.697260595849, 948.672707915768, 1037.408677054087, 1058.2010582010532, 1094.141099237095, 1106.43571778392, 23996.0, 30555.847220764197, 30853.38293234123, 31168.0, 31486.527702084488, 896.408370475483, 1017.877854657431, 1142.8914253145938, 1146.9619993905528, 1305.1190446448609, 15619.375224990874, 15707.68584628301, 15767.842321576867, 15835.445759398595, 16203.594910127342, 557546.0, 631424.0, 631796.0, 634121.0, 640576.0, 56075.71962140163, 56612.0, 56726.43273567294, 56799.71600141973, 61479.692601536706, 1539.7074555834356, 1586.0721477935538, 1593.6573636668172, 1595.4974183132276, 1637.9672406551801, 24016.87991560031, 28967.275818104717, 29501.557476637438, 29810.850945745133, 30513.0, 40870.59129408787, 47849.04301914012, 48802.75598621984, 48910.0, 48937.75531122321, 429966.0, 433100.0, 435287.0, 438916.0, 644028.0, 27480.17559473219, 27932.44135117327, 28212.85893570519, 28242.15273541797, 28266.85866570654, 43360.78319608508, 44694.88262793456, 44831.551684482736, 45062.3240651384, 45226.32160517529, 29728.0, 35419.937401877985, 36989.630103699696, 37068.44397334096, 37764.62235377721, 32304.192395190308, 32357.705691772066, 36951.0, 38055.80972095122, 38670.419943700304, 37630.247395052495, 37948.81025594854, 38268.61731382762, 38358.2328353437, 38399.80800095982, 28572.714272857007, 28619.85520579237, 29253.561196581642, 29279.414411712074, 29662.851685741432, 24830.751692483565, 25107.623385649596, 25141.622875657245, 25473.872630636728, 25506.489870202862], "value": 20222.5145375937, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.6783974823288, 417.1927320634571, 422.30109169324777, 422.8118487273164, 431.5921454225756, 20676.689849652266, 21015.789842101574, 21712.34862954112, 21745.91270436478, 21752.673709894363, 20630.587388252265, 20716.896415517902, 20995.370138895818, 21007.0, 21030.684539731916, 5283.735813209343, 5952.553558483099, 5955.9702201488935, 6201.596896201755, 6226.501879849624, 6058.666773327465, 6140.53945954053, 6176.104464852594, 6179.81460556184, 6191.628502289855, 5998.97000514999, 6036.547258955574, 6203.2866220384785, 6205.844853878644, 6210.596311239778, 6028.7588496460085, 6071.696415179245, 6089.0866370044405, 6091.725872335755, 6099.298580663214, 5235.633505654606, 5833.32916714579, 5838.824835254949, 5840.474357307863, 5842.269716285465, 11341.206115571913, 15297.541073767805, 26227.213183604523, 26438.0, 26514.86742566275, 2249.5275992041693, 2313.236631911482, 2361.374235827507, 2592.4555843272933, 2890.6675732290846, 7912.683492660287, 10502.054815066604, 10633.308834925705, 13418.798718019238, 14867.736242419407, 1628.6091338078895, 1744.738289256609, 1810.5383127302453, 1827.250827160871, 1843.9170237339217, 120541.39729301386, 124285.0, 124402.37798811038, 124801.0, 127282.0, 11734.88265117355, 11832.290062596272, 11835.644930652094, 11862.466189021514, 11927.463264153133, 15325.233738313264, 15403.460878869186, 15404.845951540565, 15428.768568471482, 15442.382304707686, 9013.008569057398, 9047.502387368626, 9074.818503630022, 9183.989761126271, 9192.908070919339, 9022.93967714518, 9041.457512549268, 9042.140996605312, 9133.041030691682, 9136.451812891248, 4613.677042606985, 4699.95300047002, 4703.741294228782, 4705.717656940595, 4761.166795810719, 1832.9460560177952, 1837.2926423327115, 1879.5489082620072, 1979.3171355882198, 2064.9380518584167, 842.5955541340192, 1013.7262939006574, 1014.5434554450527, 1077.719792853848, 1083.2533410258654, 16564.83435165657, 17798.822011779976, 19016.33442829522, 19943.7036592621, 20047.699284510745, 1001.6794625719846, 1007.2848277722752, 1022.2128960700219, 1024.7899180667946, 1073.1146803886668, 10475.057244848, 10742.033217010507, 10768.186536772377, 10794.946025269823, 10898.291611045257, 621033.0, 647717.0, 651548.0, 666862.0, 673050.0, 92624.07375926155, 128957.06564401541, 131587.02619460717, 135858.0, 138153.0, 977.7751117243074, 978.8531720242021, 1002.2633364477103, 1003.3879333606494, 1021.5862575656722, 18025.729614055537, 18255.269789208814, 18337.816621833612, 18462.984535850657, 18468.459462161565, 38325.808370957966, 54593.90812183813, 55088.0, 55755.72122139364, 56500.71749641225, 81191.0, 81374.77937830819, 81537.59231203806, 82579.0, 84725.0, 8240.876386854321, 8301.83396332058, 8359.540225287668, 8392.748217553482, 8665.17680820321, 10633.255672102878, 12027.398630068637, 12452.439640216393, 12610.558630447891, 12949.41727622278, 10825.242233043926, 10925.180611454332, 11245.98786109254, 11389.373584452604, 11400.771984560428, 10725.839112413163, 10772.084372828398, 10835.187360947803, 11025.724356891142, 11269.267497612629, 10859.511321990687, 11136.777264454828, 11224.326540407601, 11241.66275011751, 11249.13561944379, 8192.057913339804, 8284.0, 8357.456765310235, 8360.958195209229, 8530.573471326534, 7479.4764366496, 11199.66401007971, 11492.54029838797, 11782.705432364259, 11834.940825296162], "value": 9762.194478270749, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.685737566423, 1609.5090997245838, 1628.6009927567743, 1885.9811401885986, 1997.6116598963708, 8217.342612590986, 8811.986621538525, 8961.103889611035, 8982.0, 8982.416142950704, 8795.164459376349, 8825.161609647073, 8934.91065089349, 8943.060978597252, 8947.284217262619, 2548.5412625727317, 2565.9486810263784, 2570.0876188952934, 2570.318865500644, 2573.819832611718, 2470.419451428913, 2531.227975467482, 2535.4422027153996, 2538.2639034680014, 2543.694756629198, 2503.198976327567, 2532.075792335803, 2545.529077120729, 2547.745225477456, 2550.821442499026, 2445.315311712723, 2508.272600945714, 2548.719640839506, 2550.5409026375246, 2557.7825884799813, 2506.987465062681, 2554.961675574868, 2556.322574517754, 2558.756918092778, 2561.705403878559, 8672.306215502746, 8982.640694372218, 9067.68263110788, 9075.909240907573, 9077.68228112013, 5586.692731899744, 5689.886202275973, 5700.030994730864, 5740.712964351766, 5746.310442746855, 3588.910277243064, 3638.43604241343, 3683.0055884911194, 3738.8691395801015, 3778.886633401002, 1069.0592278794688, 1086.256558224047, 1090.2422816142785, 1107.3521989636072, 1127.3912087472754, 12199.878001220051, 12308.75382492354, 12512.311822849832, 12518.937405313007, 12526.874731252661, 4806.375171227718, 4838.491958344393, 4843.418789745253, 4857.149998750205, 4931.876703082452, 9749.220062394992, 9774.462404567676, 9774.853377199348, 9790.5594248259, 9822.950885245527, 5616.438356164351, 5616.606837521416, 5625.746841392065, 5628.212050312959, 5633.464820842013, 4649.0, 4744.833930812405, 4748.810047598126, 4759.6668233223345, 5198.870028249324, 3651.6348365163803, 3972.8013599320498, 4072.0430698785763, 4079.551759125527, 4084.7344922579937, 1235.1971218707731, 1263.9431225594687, 1270.358468973181, 1274.20362273579, 1285.0554842190982, 948.5304774136708, 964.0841200859212, 972.9562169702381, 989.3865803202061, 1003.5684655598017, 5939.3763654816485, 6080.969595151996, 6164.250146090024, 6171.413715697002, 6257.56197066201, 996.875390576178, 1001.3991605037065, 1022.7647641042602, 1050.9211809114347, 1051.2063392138887, 3435.934860193348, 4032.072623296658, 4083.571225021389, 4109.547949725527, 4183.644390226865, 10525.0, 10903.727406814893, 11016.449177541092, 11075.0, 11093.389863557582, 8843.955780221058, 10922.508487118099, 10959.945200274107, 10996.28524145928, 11004.779904401867, 7152.427805775629, 8001.639926203335, 8362.163783621589, 8483.660653573912, 8547.700830470903, 5981.7906373278465, 6029.60807547508, 6165.0, 6188.721507532082, 6306.684665766602, 10098.899011009797, 10116.342437741523, 10159.085682288629, 10278.691639250834, 10322.896771032194, 10147.695569132939, 10352.275340726077, 10515.211359147941, 10659.20055995819, 10689.984451477098, 7139.036230108869, 7324.523905946096, 7339.559626422431, 7750.728724494616, 7865.803354915944, 7812.53124812513, 8645.91354086451, 8649.005364382925, 8659.956700216459, 8691.0, 7534.020577324913, 7747.49641273338, 7802.0, 7842.254985776342, 7844.058712954254, 7470.103587569526, 7486.775396738107, 7527.2849079337375, 7624.466287359832, 7723.227677232232, 7161.355478007004, 7252.347288744038, 7258.129024517092, 7357.2642735726, 7368.521046131984, 4924.704517728947, 4930.112579735539, 5056.873578160576, 5123.897522049613, 5134.3325367703455, 5060.595152387874, 5131.179011358165, 5148.665336753099, 5160.122779127632, 5239.580833533232], "value": 4759.174143875128, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.1211036257286, 330.80151908854685, 340.9897703068908, 342.2368119094421, 344.796570023686, 5468.261784659075, 6075.605085669434, 6300.723623715671, 6404.775832845851, 6419.454346380563, 5968.7314070866805, 6118.632882027082, 6161.845953851156, 6301.212348456443, 6302.653354065525, 4775.379200703921, 4791.712497250159, 4799.18413869643, 4802.0, 4822.348982887318, 4808.519148085198, 4817.590504807078, 4817.831375901844, 4820.807167713305, 4830.4203495580405, 4515.63874890008, 4569.702969307001, 4691.648126390517, 4711.670183087185, 4787.71273723576, 4681.812727490897, 4702.153612349775, 4706.0, 4709.693869898446, 4720.527947205286, 4088.2845502037026, 4089.795510224477, 4091.97954010228, 4093.263212621727, 4098.241825262336, 6045.727942242565, 6045.879082418371, 6052.425019623129, 6068.878622427571, 6073.939260607426, 5502.2296878437055, 5511.53151982082, 5519.613627046108, 5528.889422211573, 5532.972335138339, 6400.9039864402075, 6658.400743933069, 6708.228553716336, 6728.93271067288, 6747.831304217385, 4479.081788233404, 4493.887652808673, 4497.123061003105, 4500.8649740507835, 4501.594856462902, 7049.964750176267, 7129.394001509878, 7131.89302160468, 7144.285571442866, 7165.104361954755, 4539.523350048264, 4556.794944227518, 4564.863054108382, 4565.0641618468135, 4579.129965306581, 4641.628669706415, 4641.837535686234, 4642.558956899089, 4642.744649044267, 4648.48866624671, 5262.473752624784, 5475.72621368938, 5485.094959331665, 5501.889962200814, 5510.614257001971, 6756.898646520208, 6810.978353247053, 6825.829354266084, 6831.760888368884, 6835.974603809468, 1529.258309719785, 1575.5745948594044, 1610.5344136835424, 1614.9434769783002, 1616.0869108953405, 900.243795212025, 982.9311948163703, 1025.0825511167614, 1044.1959691037857, 1045.0542259255385, 6293.905591416133, 6424.3254458282145, 6465.4827613790785, 6480.449161821298, 6482.546221764431, 6922.646300257937, 6963.373296403247, 6969.47728920333, 6974.511784175059, 6978.90632810155, 5201.479852014768, 6253.96873015632, 6436.613803171825, 6451.9354806452275, 6457.2896981332015, 3623.8188090595363, 3680.153564680085, 3683.4843121962945, 3694.18727879866, 3698.223373091681, 7398.778036658909, 7424.257574242641, 7426.0, 7430.405567554582, 7439.628018599048, 5711.742971566289, 7099.538529995534, 7129.928700713031, 7153.3919616833155, 7184.568925864465, 7203.135623725187, 7406.222346653632, 7554.206808285161, 7571.734989275459, 7587.051618547682, 7011.719531218694, 7059.152901651834, 7062.752803651848, 7088.539244949062, 7126.893096603659, 6966.686499107654, 6984.4063254623925, 6994.790156295319, 7002.579845209304, 7005.299470053158, 7544.434167437574, 7545.320921117126, 7552.509086909553, 7576.4317676173405, 7582.962085189539, 4362.23660859342, 4569.702969306984, 4584.19776539111, 4587.42657167854, 4604.286335617984, 6949.548279361826, 6983.790486285419, 7002.684879180551, 7007.089078419773, 7015.807312756741, 6774.729010839708, 6795.694193761194, 6799.048133261248, 6802.14973128359, 6805.829854253683, 5649.700568869101, 6606.6366349849295, 6768.018637297466, 6776.424003959719, 6799.150106236721, 5867.885101830639, 6142.570020098729, 6229.345918678474, 6352.809415717536, 6650.600963941985, 6745.0, 6773.762918297836, 6813.0, 6823.28355522663, 6833.145856767904, 5813.76744930198, 6254.4996400286955, 6666.799996000128, 6685.565438246693, 6705.698243578953], "value": 4984.510863215087, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.6273537760364, 768.8423873106007, 793.2939683681528, 795.2087672765596, 798.0742338886893, 12860.421281042352, 15424.845751542496, 15763.133027683472, 15764.132972686526, 15786.605334866634, 14292.571222863331, 14404.927975360135, 14417.351219195136, 14453.92773036136, 14476.348564314605, 767.7926959720872, 788.0976282156927, 912.7489940266413, 946.8011717539325, 948.648999870049, 934.9392289501195, 940.6049459227107, 944.8582712593131, 947.327397547742, 947.3794664494733, 810.9513429194267, 1007.6825799873017, 1008.6016023670645, 1009.4246279620619, 1009.8889122196553, 993.3791380387258, 1016.1464369929221, 1018.6689325969089, 1019.5157300282381, 1019.5819713917258, 760.3916866506772, 762.142589586715, 762.5310434082999, 762.8245503534218, 763.263450770004, 15699.37202511898, 15759.369625214978, 15761.211939403098, 15766.842331576767, 15814.367425302975, 13189.934050329783, 13425.798613020812, 13496.190228586316, 13547.187168769906, 13779.724405511934, 10363.896361036368, 10406.895931040744, 10591.682249532527, 10753.0, 10821.945890270577, 3296.8186749728757, 3656.8902932912056, 3676.2279921216577, 3693.7229707772026, 3730.3285408626434, 61636.0, 80384.39231215343, 82263.58868205741, 85973.14026859714, 87046.56476717576, 9922.107010369102, 10187.134093601979, 10200.38797672142, 10225.233107516966, 10412.635557755593, 23333.533329333317, 23353.065877364716, 23363.532729345658, 23373.7662623375, 23392.883035584713, 7815.960920195363, 7891.763247102596, 7926.445148839526, 7979.48133371329, 8026.237507436784, 4260.190563792869, 4287.386377786079, 4290.334998075304, 4338.6312163466455, 4524.864254072383, 3917.3144699678014, 3948.664363529132, 3951.881443556698, 3951.9012024699614, 3958.346872766019, 637.757652092202, 670.4368330602317, 670.9228438729608, 698.3016983016983, 715.4419552748864, 594.9702514874239, 601.8555546668855, 605.7007718443913, 608.6165715599144, 612.5344737999153, 8208.753737387888, 8219.54792486419, 8372.408563960362, 8451.704190353432, 8796.692115775917, 530.1993989076445, 589.2310534752189, 597.8475488750428, 599.0744300056423, 600.3456232706371, 3773.7735735855936, 3912.9021774455296, 3942.4086387042175, 3982.104026594051, 4132.2561938851295, 60057.0, 91399.5430022859, 93839.53080234556, 93973.53013235026, 101541.47687784689, 81208.0, 81815.59092204501, 83322.16677833266, 84483.57758211292, 85154.72267915987, 72268.55462890712, 76155.0, 76418.0, 77559.83660244988, 77687.61156194183, 7556.131044929683, 8284.337253019865, 8320.167983201873, 8540.658373664985, 8884.466931984101, 50894.47316580509, 51655.0, 52468.212976804614, 52691.73654131705, 52924.47075529349, 56218.71890640521, 69340.0, 73602.26397735954, 73696.63151684207, 74537.2546274552, 10926.890731092906, 11177.888221117684, 11368.886311137114, 11471.598494052669, 11669.124815638692, 12014.279143251433, 12168.087393445705, 12272.956798672212, 12537.970198659277, 12645.304508252135, 11233.157513186381, 11270.774584508428, 11294.94352528265, 11318.434078296217, 11329.490172942073, 11595.188336816342, 11652.417379131179, 11950.0, 12093.455794489093, 12279.44742486608, 11433.085353171893, 11457.484413201593, 11607.883921161017, 11615.419229038345, 11725.706857328634, 9769.16962058233, 9975.20198384142, 9989.650362237287, 10004.85528284479, 10121.848172277274, 7619.733309334147, 9815.754606134904, 9866.55600497965, 9872.40765554069, 9967.651132210338], "value": 7159.633605141951, "unit": "score"}], "name": "dromaeo_css", "value": 7604.952759144654, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 117.0, 111.0, 113.0, 113.0, 113.0, 112.0, 113.0, 133.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 122.0, 141.0, 164.0, 117.0, 139.0, 141.0, 116.0, 170.0, 115.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 186.0, 184.0, 183.0, 184.0, 184.0, 182.0, 184.0, 182.0, 184.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 79.0, 77.0, 156.0, 56.0, 56.0, 56.0, 62.0, 127.0, 55.0], "value": 79.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 144.0, 78.0, 77.0, 89.0, 123.0, 79.0, 75.0, 124.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 88.0, 85.0, 89.0, 85.0, 89.0, 86.0, 89.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 93.0, 92.0, 93.0, 93.0, 93.0, 93.0, 93.0], "value": 93.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 89.0, 87.0, 87.0, 89.0, 86.0, 90.0, 89.0, 82.0], "value": 87.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 63.0, 60.0, 63.0, 62.0, 62.0, 79.0, 58.0, 55.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 61.0, 68.0, 67.0, 70.0, 71.0, 65.0, 65.0, 62.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 78.0, 79.0, 79.0, 79.0, 79.0, 81.0, 81.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 136.0, 149.0, 127.0, 123.0, 128.0, 126.0, 130.0, 159.0, 151.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 161.0, 165.0, 163.0, 177.0, 161.0, 161.0, 160.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 66.0, 66.0, 68.0, 63.0, 87.0], "value": 68.7, "unit": "score"}], "name": "kraken", "value": 1457.3999999999999, "alertThreshold": 2.0}]} 08:02:10 INFO - Return code: 0 08:02:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:02:10 ERROR - # TBPL SUCCESS # 08:02:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:02:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:02:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:02:10 INFO - 2016-06-21 08:02:10.481 screenresolution[1979:14530] starting screenresolution argv=screenresolution get 08:02:10 INFO - 2016-06-21 08:02:10.483 screenresolution[1979:14530] Display 0: 1600x1200x32@60 08:02:10 INFO - 2016-06-21 08:02:10.489 screenresolution[1980:14533] starting screenresolution argv=screenresolution list 08:02:10 INFO - Available Modes on Display 0 08:02:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:02:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:02:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:02:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:02:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:02:10 INFO - Intel Iris: 08:02:10 INFO - Chipset Model: Intel Iris 08:02:10 INFO - Type: GPU 08:02:10 INFO - Bus: Built-In 08:02:10 INFO - VRAM (Dynamic, Max): 1536 MB 08:02:10 INFO - Vendor: Intel (0x8086) 08:02:10 INFO - Device ID: 0x0a2e 08:02:10 INFO - Revision ID: 0x0009 08:02:10 INFO - Displays: 08:02:10 INFO - Display: 08:02:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:02:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:02:10 INFO - Display Serial Number: 1600x1200 60 08:02:10 INFO - Main Display: Yes 08:02:10 INFO - Mirror: Off 08:02:10 INFO - Online: Yes 08:02:10 INFO - Rotation: Supported 08:02:10 INFO - Return code: 0 08:02:10 INFO - Running post-action listener: _resource_record_post_action 08:02:10 INFO - Running post-run listener: _resource_record_post_run 08:02:11 INFO - Total resource usage - Wall time: 1194s; CPU: 52.0%; Read bytes: 479232; Write bytes: 495252992; Read time: 7; Write time: 1551 08:02:11 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194607616; Write bytes: 194584576; Read time: 17688; Write time: 448 08:02:11 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 479232; Write bytes: 299771392; Read time: 7; Write time: 1097 08:02:11 INFO - Running post-run listener: _upload_blobber_files 08:02:11 INFO - Blob upload gear active. 08:02:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:02:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:02:12 INFO - (blobuploader) - INFO - Open directory for files ... 08:02:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:02:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:02:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:13 INFO - (blobuploader) - INFO - Done attempting. 08:02:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:02:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:02:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:14 INFO - (blobuploader) - INFO - Done attempting. 08:02:14 INFO - (blobuploader) - INFO - Iteration through files over. 08:02:14 INFO - Return code: 0 08:02:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:02:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:02:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ceeb9fbd40b3ed68772316b20c3b2293a008d82161c0288a88e37aad7a8d9483771e630aa5a22b959fc5e9dff258166d6d4fef5738f30b6c8fe0d70e303b2ed9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ed4fdd10195c6151c26cd2f0c6354a50814ed9057601ca6b67232591798da0c64c66d2c6daff668f98e811d4350bd654d2337b3223a054da9f62a8a6851eadfa"} 08:02:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:02:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:02:14 INFO - Contents: 08:02:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ceeb9fbd40b3ed68772316b20c3b2293a008d82161c0288a88e37aad7a8d9483771e630aa5a22b959fc5e9dff258166d6d4fef5738f30b6c8fe0d70e303b2ed9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ed4fdd10195c6151c26cd2f0c6354a50814ed9057601ca6b67232591798da0c64c66d2c6daff668f98e811d4350bd654d2337b3223a054da9f62a8a6851eadfa"} 08:02:14 INFO - Running post-run listener: copy_logs_to_upload_dir 08:02:14 INFO - Copying logs to upload dir... 08:02:14 INFO - mkdir: /builds/slave/test/build/upload/logs 08:02:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.563034 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-21 08:02:14.225884) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 08:02:14.229170) ========= 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.LlfvfJQX7P/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.Xwl9kRFBFC/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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/ceeb9fbd40b3ed68772316b20c3b2293a008d82161c0288a88e37aad7a8d9483771e630aa5a22b959fc5e9dff258166d6d4fef5738f30b6c8fe0d70e303b2ed9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ed4fdd10195c6151c26cd2f0c6354a50814ed9057601ca6b67232591798da0c64c66d2c6daff668f98e811d4350bd654d2337b3223a054da9f62a8a6851eadfa"} build_url:https://queue.taskcluster.net/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011467 build_url: 'https://queue.taskcluster.net/v1/task/MnhHhppYSlucR9C6H5jlBQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ceeb9fbd40b3ed68772316b20c3b2293a008d82161c0288a88e37aad7a8d9483771e630aa5a22b959fc5e9dff258166d6d4fef5738f30b6c8fe0d70e303b2ed9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ed4fdd10195c6151c26cd2f0c6354a50814ed9057601ca6b67232591798da0c64c66d2c6daff668f98e811d4350bd654d2337b3223a054da9f62a8a6851eadfa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 08:02:14.261375) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:02:14.261712) ========= 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.LlfvfJQX7P/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.Xwl9kRFBFC/Listeners TMPDIR=/var/folders/5j/jj83rdp553n_19cbd8hk96b400000w/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.005114 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 08:02:14.310468) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 08:02:14.310820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 08:02:14.311159) ========= ========= Total master_lag: 0.21 =========